builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1466834965.45 results: success (0) buildid: 20160624203031 builduid: 5dc204d9dc1a437c8d1c2bb3dec4709b revision: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.449672) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.450233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.450551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.480046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.480341) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 23:09:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-24 23:09:26 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120172 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.636296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.636657) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021135 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.711168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:25.711518) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6de5b59dbcf95bb561d3c60f63743311f3f5d653 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6de5b59dbcf95bb561d3c60f63743311f3f5d653 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 23:09:26,440 truncating revision to first 12 chars 2016-06-24 23:09:26,440 Setting DEBUG logging. 2016-06-24 23:09:26,440 attempt 1/10 2016-06-24 23:09:26,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6de5b59dbcf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 23:09:26,780 unpacking tar archive at: fx-team-6de5b59dbcf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:26.402806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:26.403120) ========= script_repo_revision: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:26.403540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:26.403823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 23:09:26.418092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-24 23:09:26.418453) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:27 INFO - MultiFileLogger online at 20160624 23:09:27 in /builds/slave/test 23:09:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:27 INFO - {'append_to_log': False, 23:09:27 INFO - 'base_work_dir': '/builds/slave/test', 23:09:27 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:27 INFO - 'branch': 'Fx-Team', 23:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:27 INFO - 'config_files': ('talos/linux_config.py',), 23:09:27 INFO - 'default_actions': ('clobber', 23:09:27 INFO - 'read-buildbot-config', 23:09:27 INFO - 'download-and-extract', 23:09:27 INFO - 'populate-webroot', 23:09:27 INFO - 'create-virtualenv', 23:09:27 INFO - 'install', 23:09:27 INFO - 'run-tests'), 23:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:27 INFO - 'download_minidump_stackwalk': True, 23:09:27 INFO - 'download_symbols': 'ondemand', 23:09:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:27 INFO - 'installer_path': 'installer.exe', 23:09:27 INFO - 'log_level': 'info', 23:09:27 INFO - 'log_name': 'talos', 23:09:27 INFO - 'log_to_console': True, 23:09:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:27 INFO - 'opt_config_files': (), 23:09:27 INFO - 'pip_index': False, 23:09:27 INFO - 'sps_profile': False, 23:09:27 INFO - 'sps_profile_interval': 0, 23:09:27 INFO - 'suite': 'dromaeojs', 23:09:27 INFO - 'system_bits': '32', 23:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:27 INFO - 'title': 'talos-linux64-ix-050', 23:09:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:27 INFO - 'use_talos_json': True, 23:09:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:27 INFO - 'work_dir': 'build'} 23:09:27 INFO - ##### 23:09:27 INFO - ##### Running clobber step. 23:09:27 INFO - ##### 23:09:27 INFO - Running pre-action listener: _resource_record_pre_action 23:09:27 INFO - Running main action method: clobber 23:09:27 INFO - rmtree: /builds/slave/test/build 23:09:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:27 INFO - Running post-action listener: _resource_record_post_action 23:09:27 INFO - ##### 23:09:27 INFO - ##### Finished clobber step (success) 23:09:27 INFO - ##### 23:09:27 INFO - ##### 23:09:27 INFO - ##### Running read-buildbot-config step. 23:09:27 INFO - ##### 23:09:27 INFO - Running pre-action listener: _resource_record_pre_action 23:09:27 INFO - Running main action method: read_buildbot_config 23:09:27 INFO - Using buildbot properties: 23:09:27 INFO - { 23:09:27 INFO - "project": "", 23:09:27 INFO - "product": "firefox", 23:09:27 INFO - "script_repo_revision": "production", 23:09:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:09:27 INFO - "repository": "", 23:09:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:09:27 INFO - "buildid": "20160624203031", 23:09:27 INFO - "pgo_build": "True", 23:09:27 INFO - "basedir": "/builds/slave/test", 23:09:27 INFO - "buildnumber": 212, 23:09:27 INFO - "slavename": "talos-linux64-ix-050", 23:09:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:09:27 INFO - "platform": "ubuntu64_hw", 23:09:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:27 INFO - "branch": "fx-team", 23:09:27 INFO - "repo_path": "integration/fx-team", 23:09:27 INFO - "revision": "6de5b59dbcf95bb561d3c60f63743311f3f5d653", 23:09:27 INFO - "stage_platform": "linux64-pgo", 23:09:27 INFO - "builduid": "5dc204d9dc1a437c8d1c2bb3dec4709b", 23:09:27 INFO - "slavebuilddir": "test" 23:09:27 INFO - } 23:09:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:09:27 INFO - Running post-action listener: _resource_record_post_action 23:09:27 INFO - ##### 23:09:27 INFO - ##### Finished read-buildbot-config step (success) 23:09:27 INFO - ##### 23:09:27 INFO - ##### 23:09:27 INFO - ##### Running download-and-extract step. 23:09:27 INFO - ##### 23:09:27 INFO - Running pre-action listener: _resource_record_pre_action 23:09:27 INFO - Running main action method: download_and_extract 23:09:27 INFO - mkdir: /builds/slave/test/build/tests 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:09:31 INFO - Downloaded 1361 bytes. 23:09:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:31 INFO - Using the following test package requirements: 23:09:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'jsshell-linux-x86_64.zip'], 23:09:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:31 INFO - https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:41 INFO - Downloaded 24279741 bytes. 23:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:42 INFO - Return code: 0 23:09:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:42 INFO - https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:54 INFO - Downloaded 24279741 bytes. 23:09:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:56 INFO - Return code: 0 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:56 INFO - https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:09:57 INFO - Downloaded 14405188 bytes. 23:09:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:09:57 INFO - Return code: 0 23:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:57 INFO - https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:09:59 INFO - Downloaded 60161470 bytes. 23:09:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:59 INFO - mkdir: /builds/slave/test/properties 23:09:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:59 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:59 INFO - Contents: 23:09:59 INFO - build_url:https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:10:00 INFO - Running post-action listener: _resource_record_post_action 23:10:00 INFO - Running post-action listener: set_extra_try_arguments 23:10:00 INFO - ##### 23:10:00 INFO - ##### Finished download-and-extract step (success) 23:10:00 INFO - ##### 23:10:00 INFO - ##### 23:10:00 INFO - ##### Running populate-webroot step. 23:10:00 INFO - ##### 23:10:00 INFO - Running pre-action listener: _resource_record_pre_action 23:10:00 INFO - Running main action method: populate_webroot 23:10:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:10:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:10:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:10:00 INFO - '--tppagecycles', 23:10:00 INFO - '7'], 23:10:00 INFO - 'tests': ['tsvgm']}}, 23:10:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:10:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:10:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:10:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:10:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:10:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:10:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['damp', 'tps']}, 23:10:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'tests': ['damp', 'tps']}, 23:10:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['dromaeo_dom']}, 23:10:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:10:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['basic_compositor_video']}, 23:10:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:10:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['a11yr', 23:10:00 INFO - 'ts_paint', 23:10:00 INFO - 'tpaint', 23:10:00 INFO - 'sessionrestore', 23:10:00 INFO - 'sessionrestore_no_auto_restore', 23:10:00 INFO - 'tabpaint']}, 23:10:00 INFO - 'other-e10s': {'tests': ['a11yr', 23:10:00 INFO - 'ts_paint', 23:10:00 INFO - 'tpaint', 23:10:00 INFO - 'sessionrestore', 23:10:00 INFO - 'sessionrestore_no_auto_restore', 23:10:00 INFO - 'tabpaint']}, 23:10:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:10:00 INFO - 'ts_paint', 23:10:00 INFO - 'tpaint', 23:10:00 INFO - 'sessionrestore', 23:10:00 INFO - 'sessionrestore_no_auto_restore', 23:10:00 INFO - 'tabpaint']}, 23:10:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:10:00 INFO - 'ts_paint', 23:10:00 INFO - 'tpaint', 23:10:00 INFO - 'sessionrestore', 23:10:00 INFO - 'sessionrestore_no_auto_restore', 23:10:00 INFO - 'tabpaint']}, 23:10:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['a11yr', 23:10:00 INFO - 'ts_paint', 23:10:00 INFO - 'tpaint', 23:10:00 INFO - 'sessionrestore', 23:10:00 INFO - 'sessionrestore_no_auto_restore', 23:10:00 INFO - 'tabpaint']}, 23:10:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['a11yr', 23:10:00 INFO - 'ts_paint', 23:10:00 INFO - 'tpaint', 23:10:00 INFO - 'sessionrestore', 23:10:00 INFO - 'sessionrestore_no_auto_restore', 23:10:00 INFO - 'tabpaint']}, 23:10:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['tsvgx', 23:10:00 INFO - 'tsvgr_opacity', 23:10:00 INFO - 'tart', 23:10:00 INFO - 'tscrollx', 23:10:00 INFO - 'cart']}, 23:10:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:10:00 INFO - 'tsvgr_opacity', 23:10:00 INFO - 'tart', 23:10:00 INFO - 'tscrollx', 23:10:00 INFO - 'cart']}, 23:10:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'talos_options': ['--disable-e10s'], 23:10:00 INFO - 'tests': ['tp5o']}, 23:10:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'tests': ['tp5o']}, 23:10:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'talos_options': ['--disable-e10s', 23:10:00 INFO - '--xperf_path', 23:10:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:10:00 INFO - 'tests': ['tp5n']}, 23:10:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:10:00 INFO - 'talos_options': ['--xperf_path', 23:10:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:10:00 INFO - 'tests': ['tp5n']}}, 23:10:00 INFO - 'talos.zip': {'path': '', 23:10:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:10:00 INFO - Running post-action listener: _resource_record_post_action 23:10:00 INFO - ##### 23:10:00 INFO - ##### Finished populate-webroot step (success) 23:10:00 INFO - ##### 23:10:00 INFO - ##### 23:10:00 INFO - ##### Running create-virtualenv step. 23:10:00 INFO - ##### 23:10:00 INFO - Running pre-action listener: _resource_record_pre_action 23:10:00 INFO - Running main action method: create_virtualenv 23:10:00 INFO - Creating virtualenv /builds/slave/test/build/venv 23:10:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:10:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:10:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:10:00 INFO - Using real prefix '/usr' 23:10:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:10:00 INFO - Installing distribute.............................................................................................................................................................................................done. 23:10:02 INFO - Installing pip.................done. 23:10:02 INFO - Return code: 0 23:10:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:10:02 INFO - Using env: {'DISPLAY': ':0', 23:10:02 INFO - 'HOME': '/home/cltbld', 23:10:02 INFO - 'LANG': 'en_US.UTF-8', 23:10:02 INFO - 'LANGUAGE': 'en_US:en', 23:10:02 INFO - 'LOGNAME': 'cltbld', 23:10:02 INFO - 'MAIL': '/var/mail/cltbld', 23:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:02 INFO - 'MOZ_NO_REMOTE': '1', 23:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:02 INFO - 'NO_EM_RESTART': '1', 23:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:02 INFO - 'PWD': '/builds/slave/test', 23:10:02 INFO - 'SHELL': '/bin/bash', 23:10:02 INFO - 'SHLVL': '1', 23:10:02 INFO - 'TERM': 'linux', 23:10:02 INFO - 'TMOUT': '86400', 23:10:02 INFO - 'USER': 'cltbld', 23:10:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:02 INFO - '_': '/tools/buildbot/bin/python'} 23:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:10:02 INFO - Cleaning up... 23:10:02 INFO - Return code: 0 23:10:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:10:02 INFO - Using env: {'DISPLAY': ':0', 23:10:02 INFO - 'HOME': '/home/cltbld', 23:10:02 INFO - 'LANG': 'en_US.UTF-8', 23:10:02 INFO - 'LANGUAGE': 'en_US:en', 23:10:02 INFO - 'LOGNAME': 'cltbld', 23:10:02 INFO - 'MAIL': '/var/mail/cltbld', 23:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:02 INFO - 'MOZ_NO_REMOTE': '1', 23:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:02 INFO - 'NO_EM_RESTART': '1', 23:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:02 INFO - 'PWD': '/builds/slave/test', 23:10:02 INFO - 'SHELL': '/bin/bash', 23:10:02 INFO - 'SHLVL': '1', 23:10:02 INFO - 'TERM': 'linux', 23:10:02 INFO - 'TMOUT': '86400', 23:10:02 INFO - 'USER': 'cltbld', 23:10:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:02 INFO - '_': '/tools/buildbot/bin/python'} 23:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:03 INFO - Downloading/unpacking psutil>=3.1.1 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:05 INFO - Installing collected packages: psutil 23:10:05 INFO - Running setup.py install for psutil 23:10:05 INFO - building 'psutil._psutil_linux' extension 23:10:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:10:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:10:05 INFO - building 'psutil._psutil_posix' extension 23:10:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:10:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:05 INFO - Successfully installed psutil 23:10:05 INFO - Cleaning up... 23:10:05 INFO - Return code: 0 23:10:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:10:05 INFO - Using env: {'DISPLAY': ':0', 23:10:05 INFO - 'HOME': '/home/cltbld', 23:10:05 INFO - 'LANG': 'en_US.UTF-8', 23:10:05 INFO - 'LANGUAGE': 'en_US:en', 23:10:05 INFO - 'LOGNAME': 'cltbld', 23:10:05 INFO - 'MAIL': '/var/mail/cltbld', 23:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:05 INFO - 'MOZ_NO_REMOTE': '1', 23:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:05 INFO - 'NO_EM_RESTART': '1', 23:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:05 INFO - 'PWD': '/builds/slave/test', 23:10:05 INFO - 'SHELL': '/bin/bash', 23:10:05 INFO - 'SHLVL': '1', 23:10:05 INFO - 'TERM': 'linux', 23:10:05 INFO - 'TMOUT': '86400', 23:10:05 INFO - 'USER': 'cltbld', 23:10:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:05 INFO - '_': '/tools/buildbot/bin/python'} 23:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:10:07 INFO - Installing collected packages: mozsystemmonitor 23:10:07 INFO - Running setup.py install for mozsystemmonitor 23:10:07 INFO - Successfully installed mozsystemmonitor 23:10:07 INFO - Cleaning up... 23:10:07 INFO - Return code: 0 23:10:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:10:07 INFO - Using env: {'DISPLAY': ':0', 23:10:07 INFO - 'HOME': '/home/cltbld', 23:10:07 INFO - 'LANG': 'en_US.UTF-8', 23:10:07 INFO - 'LANGUAGE': 'en_US:en', 23:10:07 INFO - 'LOGNAME': 'cltbld', 23:10:07 INFO - 'MAIL': '/var/mail/cltbld', 23:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:07 INFO - 'MOZ_NO_REMOTE': '1', 23:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:07 INFO - 'NO_EM_RESTART': '1', 23:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:07 INFO - 'PWD': '/builds/slave/test', 23:10:07 INFO - 'SHELL': '/bin/bash', 23:10:07 INFO - 'SHLVL': '1', 23:10:07 INFO - 'TERM': 'linux', 23:10:07 INFO - 'TMOUT': '86400', 23:10:07 INFO - 'USER': 'cltbld', 23:10:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:07 INFO - '_': '/tools/buildbot/bin/python'} 23:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:08 INFO - Downloading/unpacking jsonschema==2.5.1 23:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:10 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:10 INFO - warning: no files found matching '*.txt' 23:10:10 INFO - no previously-included directories found matching 'build' 23:10:10 INFO - no previously-included directories found matching 'dist' 23:10:10 INFO - no previously-included directories found matching '.git*' 23:10:10 INFO - Installing collected packages: jsonschema, functools32 23:10:10 INFO - Running setup.py install for functools32 23:10:10 INFO - warning: no files found matching '*.txt' 23:10:10 INFO - no previously-included directories found matching 'build' 23:10:10 INFO - no previously-included directories found matching 'dist' 23:10:10 INFO - no previously-included directories found matching '.git*' 23:10:10 INFO - Successfully installed jsonschema functools32 23:10:10 INFO - Cleaning up... 23:10:10 INFO - Return code: 0 23:10:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:10:10 INFO - Using env: {'DISPLAY': ':0', 23:10:10 INFO - 'HOME': '/home/cltbld', 23:10:10 INFO - 'LANG': 'en_US.UTF-8', 23:10:10 INFO - 'LANGUAGE': 'en_US:en', 23:10:10 INFO - 'LOGNAME': 'cltbld', 23:10:10 INFO - 'MAIL': '/var/mail/cltbld', 23:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:10 INFO - 'MOZ_NO_REMOTE': '1', 23:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:10 INFO - 'NO_EM_RESTART': '1', 23:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:10 INFO - 'PWD': '/builds/slave/test', 23:10:10 INFO - 'SHELL': '/bin/bash', 23:10:10 INFO - 'SHLVL': '1', 23:10:10 INFO - 'TERM': 'linux', 23:10:10 INFO - 'TMOUT': '86400', 23:10:10 INFO - 'USER': 'cltbld', 23:10:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:10 INFO - '_': '/tools/buildbot/bin/python'} 23:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - Downloading blobuploader-1.2.4.tar.gz 23:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:10:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:10:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:13 INFO - Downloading docopt-0.6.1.tar.gz 23:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:10:13 INFO - Installing collected packages: blobuploader, requests, docopt 23:10:13 INFO - Running setup.py install for blobuploader 23:10:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:10:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:10:13 INFO - Running setup.py install for requests 23:10:13 INFO - Running setup.py install for docopt 23:10:13 INFO - Successfully installed blobuploader requests docopt 23:10:13 INFO - Cleaning up... 23:10:14 INFO - Return code: 0 23:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:10:14 INFO - Using env: {'DISPLAY': ':0', 23:10:14 INFO - 'HOME': '/home/cltbld', 23:10:14 INFO - 'LANG': 'en_US.UTF-8', 23:10:14 INFO - 'LANGUAGE': 'en_US:en', 23:10:14 INFO - 'LOGNAME': 'cltbld', 23:10:14 INFO - 'MAIL': '/var/mail/cltbld', 23:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:14 INFO - 'MOZ_NO_REMOTE': '1', 23:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:14 INFO - 'NO_EM_RESTART': '1', 23:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:14 INFO - 'PWD': '/builds/slave/test', 23:10:14 INFO - 'SHELL': '/bin/bash', 23:10:14 INFO - 'SHLVL': '1', 23:10:14 INFO - 'TERM': 'linux', 23:10:14 INFO - 'TMOUT': '86400', 23:10:14 INFO - 'USER': 'cltbld', 23:10:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:14 INFO - '_': '/tools/buildbot/bin/python'} 23:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:14 INFO - Running setup.py (path:/tmp/pip-tQyo3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:14 INFO - Running setup.py (path:/tmp/pip-a0gb_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:14 INFO - Running setup.py (path:/tmp/pip-c20ajh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:14 INFO - Running setup.py (path:/tmp/pip-ku2Prg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:14 INFO - Running setup.py (path:/tmp/pip-bKDH69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:14 INFO - Running setup.py (path:/tmp/pip-8FFf0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:14 INFO - Running setup.py (path:/tmp/pip-3BDIsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:14 INFO - Running setup.py (path:/tmp/pip-9ybLz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:14 INFO - Running setup.py (path:/tmp/pip-VHf8MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:14 INFO - Running setup.py (path:/tmp/pip-p48MFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:14 INFO - Running setup.py (path:/tmp/pip-bdkVnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:15 INFO - Running setup.py (path:/tmp/pip-OOvgzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:15 INFO - Running setup.py (path:/tmp/pip-GuqSlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:15 INFO - Running setup.py (path:/tmp/pip-rKORnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:15 INFO - Running setup.py (path:/tmp/pip-m4ZrlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:15 INFO - Running setup.py (path:/tmp/pip-JVtVcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:15 INFO - Running setup.py (path:/tmp/pip-rl14XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:10:15 INFO - Running setup.py install for manifestparser 23:10:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:10:15 INFO - Running setup.py install for mozcrash 23:10:15 INFO - Running setup.py install for mozdebug 23:10:15 INFO - Running setup.py install for mozdevice 23:10:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:10:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:10:15 INFO - Running setup.py install for mozfile 23:10:15 INFO - Running setup.py install for mozhttpd 23:10:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for mozinfo 23:10:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for mozInstall 23:10:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for mozleak 23:10:16 INFO - Running setup.py install for mozlog 23:10:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for moznetwork 23:10:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for mozprocess 23:10:16 INFO - Running setup.py install for mozprofile 23:10:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for mozrunner 23:10:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:10:16 INFO - Running setup.py install for mozscreenshot 23:10:17 INFO - Running setup.py install for moztest 23:10:17 INFO - Running setup.py install for mozversion 23:10:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:10:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:17 INFO - Cleaning up... 23:10:17 INFO - Return code: 0 23:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:10:17 INFO - Using env: {'DISPLAY': ':0', 23:10:17 INFO - 'HOME': '/home/cltbld', 23:10:17 INFO - 'LANG': 'en_US.UTF-8', 23:10:17 INFO - 'LANGUAGE': 'en_US:en', 23:10:17 INFO - 'LOGNAME': 'cltbld', 23:10:17 INFO - 'MAIL': '/var/mail/cltbld', 23:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:17 INFO - 'MOZ_NO_REMOTE': '1', 23:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:17 INFO - 'NO_EM_RESTART': '1', 23:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:17 INFO - 'PWD': '/builds/slave/test', 23:10:17 INFO - 'SHELL': '/bin/bash', 23:10:17 INFO - 'SHLVL': '1', 23:10:17 INFO - 'TERM': 'linux', 23:10:17 INFO - 'TMOUT': '86400', 23:10:17 INFO - 'USER': 'cltbld', 23:10:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:17 INFO - '_': '/tools/buildbot/bin/python'} 23:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:17 INFO - Running setup.py (path:/tmp/pip-mgu1R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:17 INFO - Running setup.py (path:/tmp/pip-qrW3ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:17 INFO - Running setup.py (path:/tmp/pip-roP0wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:17 INFO - Running setup.py (path:/tmp/pip-oR33fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:17 INFO - Running setup.py (path:/tmp/pip-eQURxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:17 INFO - Running setup.py (path:/tmp/pip-OmtZP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:17 INFO - Running setup.py (path:/tmp/pip-YVCzIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:17 INFO - Running setup.py (path:/tmp/pip-oGG64u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:18 INFO - Running setup.py (path:/tmp/pip-FijS4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:18 INFO - Running setup.py (path:/tmp/pip-JWrk6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:18 INFO - Running setup.py (path:/tmp/pip-owyBZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:18 INFO - Running setup.py (path:/tmp/pip-5lTdka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:18 INFO - Running setup.py (path:/tmp/pip-UO_uJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:18 INFO - Running setup.py (path:/tmp/pip-31dOMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:18 INFO - Running setup.py (path:/tmp/pip-VmUR1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:18 INFO - Running setup.py (path:/tmp/pip-116goY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:18 INFO - Running setup.py (path:/tmp/pip-ZhlF0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:10:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:20 INFO - Downloading blessings-1.6.tar.gz 23:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:20 INFO - Installing collected packages: blessings 23:10:20 INFO - Running setup.py install for blessings 23:10:20 INFO - Successfully installed blessings 23:10:20 INFO - Cleaning up... 23:10:20 INFO - Return code: 0 23:10:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:21 INFO - Reading from file tmpfile_stdout 23:10:21 INFO - Current package versions: 23:10:21 INFO - argparse == 1.2.1 23:10:21 INFO - blessings == 1.6 23:10:21 INFO - blobuploader == 1.2.4 23:10:21 INFO - docopt == 0.6.1 23:10:21 INFO - functools32 == 3.2.3-2 23:10:21 INFO - jsonschema == 2.5.1 23:10:21 INFO - manifestparser == 1.1 23:10:21 INFO - mozInstall == 1.12 23:10:21 INFO - mozcrash == 0.17 23:10:21 INFO - mozdebug == 0.1 23:10:21 INFO - mozdevice == 0.48 23:10:21 INFO - mozfile == 1.2 23:10:21 INFO - mozhttpd == 0.7 23:10:21 INFO - mozinfo == 0.9 23:10:21 INFO - mozleak == 0.1 23:10:21 INFO - mozlog == 3.2 23:10:21 INFO - moznetwork == 0.27 23:10:21 INFO - mozprocess == 0.22 23:10:21 INFO - mozprofile == 0.28 23:10:21 INFO - mozrunner == 6.11 23:10:21 INFO - mozscreenshot == 0.1 23:10:21 INFO - mozsystemmonitor == 0.3 23:10:21 INFO - moztest == 0.7 23:10:21 INFO - mozversion == 1.4 23:10:21 INFO - psutil == 3.1.1 23:10:21 INFO - requests == 1.2.3 23:10:21 INFO - wsgiref == 0.1.2 23:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:10:21 INFO - Using env: {'DISPLAY': ':0', 23:10:21 INFO - 'HOME': '/home/cltbld', 23:10:21 INFO - 'LANG': 'en_US.UTF-8', 23:10:21 INFO - 'LANGUAGE': 'en_US:en', 23:10:21 INFO - 'LOGNAME': 'cltbld', 23:10:21 INFO - 'MAIL': '/var/mail/cltbld', 23:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:21 INFO - 'MOZ_NO_REMOTE': '1', 23:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:21 INFO - 'NO_EM_RESTART': '1', 23:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:21 INFO - 'PWD': '/builds/slave/test', 23:10:21 INFO - 'SHELL': '/bin/bash', 23:10:21 INFO - 'SHLVL': '1', 23:10:21 INFO - 'TERM': 'linux', 23:10:21 INFO - 'TMOUT': '86400', 23:10:21 INFO - 'USER': 'cltbld', 23:10:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:21 INFO - '_': '/tools/buildbot/bin/python'} 23:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:10:21 INFO - Cleaning up... 23:10:21 INFO - Return code: 0 23:10:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:10:21 INFO - Using env: {'DISPLAY': ':0', 23:10:21 INFO - 'HOME': '/home/cltbld', 23:10:21 INFO - 'LANG': 'en_US.UTF-8', 23:10:21 INFO - 'LANGUAGE': 'en_US:en', 23:10:21 INFO - 'LOGNAME': 'cltbld', 23:10:21 INFO - 'MAIL': '/var/mail/cltbld', 23:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:21 INFO - 'MOZ_NO_REMOTE': '1', 23:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:21 INFO - 'NO_EM_RESTART': '1', 23:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:21 INFO - 'PWD': '/builds/slave/test', 23:10:21 INFO - 'SHELL': '/bin/bash', 23:10:21 INFO - 'SHLVL': '1', 23:10:21 INFO - 'TERM': 'linux', 23:10:21 INFO - 'TMOUT': '86400', 23:10:21 INFO - 'USER': 'cltbld', 23:10:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:21 INFO - '_': '/tools/buildbot/bin/python'} 23:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:10:21 INFO - Cleaning up... 23:10:21 INFO - Return code: 0 23:10:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1478eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:10:21 INFO - Using env: {'DISPLAY': ':0', 23:10:21 INFO - 'HOME': '/home/cltbld', 23:10:21 INFO - 'LANG': 'en_US.UTF-8', 23:10:21 INFO - 'LANGUAGE': 'en_US:en', 23:10:21 INFO - 'LOGNAME': 'cltbld', 23:10:21 INFO - 'MAIL': '/var/mail/cltbld', 23:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:21 INFO - 'MOZ_NO_REMOTE': '1', 23:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:21 INFO - 'NO_EM_RESTART': '1', 23:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:21 INFO - 'PWD': '/builds/slave/test', 23:10:21 INFO - 'SHELL': '/bin/bash', 23:10:21 INFO - 'SHLVL': '1', 23:10:21 INFO - 'TERM': 'linux', 23:10:21 INFO - 'TMOUT': '86400', 23:10:21 INFO - 'USER': 'cltbld', 23:10:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:21 INFO - '_': '/tools/buildbot/bin/python'} 23:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:21 INFO - Downloading/unpacking flake8 23:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:24 INFO - no previously-included directories found matching 'docs/_build' 23:10:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:24 INFO - Running setup.py install for pep8 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:24 INFO - no previously-included directories found matching 'docs/_build' 23:10:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:24 INFO - Cleaning up... 23:10:24 INFO - Return code: 0 23:10:24 INFO - Running post-action listener: _resource_record_post_action 23:10:24 INFO - Running post-action listener: _start_resource_monitoring 23:10:24 INFO - Starting resource monitoring. 23:10:24 INFO - ##### 23:10:24 INFO - ##### Finished create-virtualenv step (success) 23:10:24 INFO - ##### 23:10:24 INFO - ##### 23:10:24 INFO - ##### Running install step. 23:10:24 INFO - ##### 23:10:24 INFO - Running pre-action listener: _resource_record_pre_action 23:10:24 INFO - Running main action method: install 23:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:24 INFO - Reading from file tmpfile_stdout 23:10:24 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:24 INFO - Reading from file tmpfile_stdout 23:10:24 INFO - Output received: 23:10:24 INFO - Usage: mozinstall [options] installer 23:10:24 INFO - Options: 23:10:24 INFO - -h, --help show this help message and exit 23:10:24 INFO - -d DEST, --destination=DEST 23:10:24 INFO - Directory to install application into. [default: 23:10:24 INFO - "/builds/slave/test"] 23:10:24 INFO - --app=APP Application being installed. [default: firefox] 23:10:24 INFO - mkdir: /builds/slave/test/build/application 23:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:10:42 INFO - Reading from file tmpfile_stdout 23:10:42 INFO - Output received: 23:10:42 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:42 INFO - Running post-action listener: _resource_record_post_action 23:10:42 INFO - ##### 23:10:42 INFO - ##### Finished install step (success) 23:10:42 INFO - ##### 23:10:42 INFO - ##### 23:10:42 INFO - ##### Running run-tests step. 23:10:42 INFO - ##### 23:10:42 INFO - Running pre-action listener: _resource_record_pre_action 23:10:42 INFO - Running main action method: run_tests 23:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:42 INFO - Python 2.7.3 23:10:42 INFO - Return code: 0 23:10:42 INFO - grabbing minidump binary from tooltool 23:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ae550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:10:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:10:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:10:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:42 INFO - Return code: 0 23:10:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:43 INFO - Return code: 0 23:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:10:43 INFO - Using env: {'DISPLAY': ':0', 23:10:43 INFO - 'HOME': '/home/cltbld', 23:10:43 INFO - 'LANG': 'en_US.UTF-8', 23:10:43 INFO - 'LANGUAGE': 'en_US:en', 23:10:43 INFO - 'LOGNAME': 'cltbld', 23:10:43 INFO - 'MAIL': '/var/mail/cltbld', 23:10:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:43 INFO - 'MOZ_NO_REMOTE': '1', 23:10:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:43 INFO - 'NO_EM_RESTART': '1', 23:10:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:43 INFO - 'PWD': '/builds/slave/test', 23:10:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:43 INFO - 'SHELL': '/bin/bash', 23:10:43 INFO - 'SHLVL': '1', 23:10:43 INFO - 'TERM': 'linux', 23:10:43 INFO - 'TMOUT': '86400', 23:10:43 INFO - 'USER': 'cltbld', 23:10:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571', 23:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:43 INFO - '_': '/tools/buildbot/bin/python'} 23:10:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:10:43 INFO - mozversion application_buildid: 20160624203031 23:10:43 INFO - mozversion application_changeset: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 23:10:43 INFO - mozversion application_display_name: Nightly 23:10:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:43 INFO - mozversion application_name: Firefox 23:10:43 INFO - mozversion application_remotingname: firefox 23:10:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:10:43 INFO - mozversion application_vendor: Mozilla 23:10:43 INFO - mozversion application_version: 50.0a1 23:10:43 INFO - mozversion platform_buildid: 20160624203031 23:10:43 INFO - mozversion platform_changeset: 6de5b59dbcf95bb561d3c60f63743311f3f5d653 23:10:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:10:43 INFO - mozversion platform_version: 50.0a1 23:10:43 INFO - using testdate: 1466835043 23:10:43 INFO - actual date: 1466835043 23:10:43 INFO - starting webserver on 'localhost:33807' 23:10:43 INFO - SUITE-START | Running 2 tests 23:10:43 INFO - TEST-START | dromaeo_css 23:10:43 INFO - operating with platform_type : linux_ 23:10:43 INFO - Initialising browser for dromaeo_css test... 23:10:43 INFO - TEST-INFO | started process 17300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQc6jXn/profile http://localhost:33807/getInfo.html) 23:10:47 INFO - PROCESS | 17300 | __metrics Screen width/height:1600/1200 23:10:47 INFO - PROCESS | 17300 | colorDepth:24 23:10:47 INFO - PROCESS | 17300 | Browser inner width/height: 1024/697 23:10:47 INFO - PROCESS | 17300 | __metrics 23:10:48 INFO - PROCESS | 17300 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:49 INFO - TEST-INFO | 17300: exit 0 23:10:49 INFO - Browser initialized. 23:10:49 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:49 INFO - TEST-INFO | started process 17385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQc6jXn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:01 INFO - PROCESS | 17385 | RSS: Main: 173350912 23:11:01 INFO - PROCESS | 17385 | 23:11:52 INFO - PROCESS | 17385 | 1466835112157 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:14:00 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33807/tests/dromaeo/cssquery-ext.html) 23:14:02 INFO - PROCESS | 17385 | RSS: Main: 297865216 23:14:02 INFO - PROCESS | 17385 | 23:17:04 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-ext.html (next: http://localhost:33807/tests/dromaeo/cssquery-jquery.html) 23:17:05 INFO - PROCESS | 17385 | RSS: Main: 264495104 23:17:05 INFO - PROCESS | 17385 | 23:20:07 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33807/tests/dromaeo/cssquery-mootools.html) 23:20:07 INFO - PROCESS | 17385 | RSS: Main: 261869568 23:20:07 INFO - PROCESS | 17385 | 23:23:09 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33807/tests/dromaeo/cssquery-prototype.html) 23:23:10 INFO - PROCESS | 17385 | RSS: Main: 255905792 23:23:10 INFO - PROCESS | 17385 | 23:26:13 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33807/tests/dromaeo/cssquery-yui.html) 23:26:13 INFO - PROCESS | 17385 | RSS: Main: 224501760 23:26:13 INFO - PROCESS | 17385 | 23:29:16 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-yui.html (next: http://localhost:33807/tests/dromaeo/cssquery-dojo.html) 23:29:17 INFO - PROCESS | 17385 | RSS: Main: 289800192 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | __start_tp_report 23:29:17 INFO - PROCESS | 17385 | _x_x_mozilla_page_load 23:29:17 INFO - PROCESS | 17385 | _x_x_mozilla_page_load_details 23:29:17 INFO - PROCESS | 17385 | |i|pagename|runs| 23:29:17 INFO - PROCESS | 17385 | |0;dojo.html;3064.187990182602;3072.493038648623;3085.706857848504;3125.624925008999;3139.387819375221;5248.160294352904;5307.893842123155;5368.516833484986;5393.4336894626085;5415.566754659628;5275.235090911816;5308.150695888658;5354.2771725817;5404.513593776559;5459.535939445152;4884.731339776302;4939.8024079036795;4948.257761335793;4962.379702537183;4974.328465657144;4980.377452818398;5002.399712034561;5002.59979201663;5046.470120637336;5054.039732450841;4755.64332675049;4789.904201915977;4812.51874812516;4942.975285123569;4945.332380128691;4863.221884498499;4878.951210487885;4879.219324907997;4880.389951256093;4885.2427873679635;4835.202191638376;4841.903161936777;4849.587785038276;4850.83022094225;4858.927116093261;5244;5286.07493688603;5310.946890531122;5313.0967735485065;5316.415194328621;5587.217789509472;5611.242482264883;5617.21359009739;5656.123300888369;5672.092465205547;5648.661080335193;5724.828255152311;5744.368119506851;5770.88458230833;5794.101914203306;5265.341832270966;5348.759305831208;5389.622726409153;5395.406505284415;5397.028534863723;5754.251947246831;5790.594658373873;5822.010258256107;5856.736446859902;5857.384974577693;5649.745761440745;5672.914906276409;5673.00722373583;5673.631213971079;5675.489205971482;5539.639923404966;5607.635503692247;5723.570732195102;5763.106718458645;5770.971145144332;5641.548676105902;5677.545796336366;5679.914801277984;5681.886362272731;5734.799282025109;5685.687287199161;5695.40198279183;5700.743466544015;5700.857478563069;5701.572382071361;4255.936160957588;4316.093620339764;4319.740815551014;4351.760653164107;4392.2752745797225;3886.1644746379097;3899.922001559953;3901.7073719471155;3939.4681717967705;3966.2265858157384;5457.590680698963;5471.644343117685;5472.288602481732;5474;5474.151506516497;5482.725863706799;5666.9716651416475;5740.167675687002;5802.984477716383;5850.180974663551;5428.45715428454;5444.455554444524;5446.046941785251;5450.264214331094;5485.972570137204;4938.209886418156;4956.430010548761;4958.776855041532;4959.0329885671945;4990.226514890198;5752.223449834302;5853.5317174625925;5889.833678278535;5902.793402230901;5914.260717410238;5770.653760774367;5771.307443106854;5773.595848290579;5779.393163717749;5780.248567686174;5948.048312270016;5957.7319020645045;5958.255218097738;5964.433378829004;5967.403259673998;5412.702301373462;5417.187421886749;5430.5384042356845;5488.094464413487;5521.282233309644;5598.608097433304;5602.691851948182;5603.943960560342;5609.326880774333;5610.298712660918;5437.13005919051;5461;5467.234587157722;5470.042742519963;5514.476124768141;5465.043617366865;5509.338879334506;5538.86152846166;5569.832905012856;5571.331440227199;5441.211024401518;5468.91796623059;5474.206240095244;5480.890382192413;5497.917531236954;5357.919631205613;5520.585956053232;5604.971975140098;5649.5762817789655;5659.943400565941;5323.653962492425;5388.54197393226;5389.0299746046085;5446.809361672323;5573.8606534835335 23:29:17 INFO - PROCESS | 17385 | |1;ext.html;577.4225774225774;616.1066453642219;624.790695117136;632.6899819088646;644.2462319086668;41941.79029104854;43206;43209.78395108028;43217;46894.296585551245;43845.561544384545;44364.778176109154;44412;44489.33266001013;44631.330530042076;8936;9067.546622668873;9078.546072696372;9092.136247056518;9095.818083638324;8958.686445974392;9044.14080662336;9044.773880653003;9051.954740226323;9056.184943355096;8999.325050621197;9008.234300084501;9036.367454278203;9037.18665320121;9037.18665320121;9037.593308301142;9064;9073.954630226872;9077.500737459437;9083.818323633523;8972.327075469366;9039.593218305126;9041.864372034424;9044.8643270351;9050;41228.38157427641;41351.7932410336;41366;41418.378724318856;41466.585334146876;3633.454981752758;3647.379945409287;3770.773753574767;3798.4112462568346;3946.2699400610977;32572.837135814407;32802.6719732802;32805.83597082023;32878.19169945652;34156;4164.167166566668;4215.3887686285625;4299.226139294926;4303.677224208197;4367.475902891673;341916;342048;342263;343255.2837235823;344187;58435.70782146062;58712.706436467546;58906.41093589009;59057.11414328789;59151;35171.824140879646;36391.454128188096;36482;56378.43621563814;56506.50175229901;14005.5098071567;14128.788068178985;14194.716105677828;14204.573862784133;14205.573832785032;11023.503942322615;11193.16051296156;11195.832062519068;11207.38359390225;11222.494987725571;19644.214231430582;19804.50488737793;19869.30457433983;19888.50278743043;19999.200031998556;7194.309337305729;7215.206327303992;7294.8176295591975;7314.975903373532;7390.187079421259;950.273041123541;1038.0346277961416;1056.804491169136;1104.100158370925;1152.838253903408;31946.680533194834;32559.674403256136;32560.67439325624;32736;32777.57255673285;1091;1098.9340639561492;1111.7554138089608;1119.3339962722168;1123.966281011571;16717.498475045526;16982.23579938906;17058.57353566146;17174.656506870044;17315.65368692619;573666;575439;575831;577224;581341;57039.429605704245;57542;57553;57687;57720;1211.618340222827;1319.7888337865895;1367.7743172376447;1368.3021658954005;1392.276016471429;32414.513782293758;33793.83103084469;33805.66194338124;33890.830545847115;34062.829685851415;50175.985921125495;50406;50657;50869.98260034853;50872.236916445545;319077;320582;321742;322685;322901;25056.749432505443;28322;44811.55188448074;45551;45603.54396455993;45719;49482.50517494923;49652.138785403644;50005.49994500154;50640.74679626578;40584.59415405808;41511;41744.79127604343;42154.789226053676;43031;40949.59050409458;41487;42375.57624423716;43026.139477210905;43312.133757325304;41933.58066419297;42257.154856902074;42653.57346426496;42931.7853410731;43709.78145109254;35239.47140792839;37664.62335376611;37768.62231377651;37995.62004379921;38300.6169938297;27311;27845.860770696017;27871.581926271527;27996;28178.85910570434 23:29:17 INFO - PROCESS | 17385 | |2;jquery.html;391.74536551241687;395.203664615799;400.0818122409071;404.6398705152414;420.84849454196484;14135.222562759043;16676.249568769403;18012;19469.610607787836;19503.60992780145;14970.25148742564;15684.921575392107;17417.82582174178;18263;18624.441266761984;5679.204911312419;5830.591858569902;5881.2354393928945;5882.323532793719;5887.35239123696;4293.48478182617;5748.971255143719;5851.297844258695;5855.443732845373;6124.785632502863;6542.41118299353;6549.967250163766;6596.142501474802;6625.701843417034;6636.435902948231;6300.779472718433;6459.289478157399;6475.352464753534;6477.093206951031;6593.53845230834;5468.234447177399;5631.1271752878365;5635.0138725723245;5636.323641163087;5654.717264136777;22473.101075956944;22983.54032919349;23036.193733219425;23119.88440057806;23349.949252283688;2296.9655455168186;2309.7459279479244;2367.124164059309;2368.7512811154925;2373.371056669984;15148.621284467867;15395.228169098642;15505.302261398265;15783.921080394639;15865.603359915978;2059.6704527275565;2068.141721185706;2084.218418093215;2155.461134716321;2204.6141925163033;82493.9999999994;85678;86006.56996715038;88405.55797221037;90882.5455872723;16800.57998550046;16979.49061528156;17002.744958825628;17117.914410427868;17311.740323895152;31008.379832403225;31160.220994474865;31452.842735786173;31669.683303167134;31698.841505792323;8940.418872773249;9352.859707104399;9439.575219115157;9472.336936414385;9473.668421605349;7562.735304264324;7580.204078571781;7677.961610191914;7795.259450352208;7800.843983120306;7150.946606070896;8083.353331733447;8563.486190828571;8754.168354006359;8855.822883542292;3181.2683082891062;3190.489521676567;3219.710226079664;3342.38165939302;3455.481677748358;897.1701176411923;926.4719110107309;950.4202436513721;954.5418199264253;991.5884907763198;18347.55101122923;19278.32525861616;19281.325153619837;19407.320743774184;19510.5122371939;981.4847205217318;984.4388698441819;992.4343124419156;997.4713401897006;1029.2897900448665;10507.947460262803;10902.727431814268;10924.945375273073;10966.945165274123;11014.44927753609;455115;461014;467326;467487;467814;90532;90905.54547227222;91653;92020;92782.53608731914;976.7948730766476;982.7985263021063;996.1731762636994;1000.3447741729179;1002.8946960569181;16756.916215418845;16896.23966921467;16896.32414703398;17172.22724977354;17530.824691752918;40826.387604185365;41485.58514414817;42123;42141.36787948122;43041.354379684955;56000.719996399755;56762.14856777234;57865.13202302053;58126;58533.70733146307;7513.4740568159705;7535.698572057276;7670.156282808998;8320.708775193081;8827.911720882708;9620.615175392906;9709.951450242703;9813.803723925339;12406.751864962831;13311.80032299497;11395.943020284845;11560.01739852122;11910.166288359731;11943.343116128348;12097;11315.603953861575;11663.88336116628;11751.412429378326;11777.528898844294;11801.822972655245;12014.459349329127;12089.15375923712;12117.27296362221;12204;12248;8235.258826705625;8608.827823443371;8662.35032372562;8701.47791132534;8833.69082082124;10583.894161058292;11084.224104312621;11101.444927753742;11162.218644695118;11253.71865703364 23:29:17 INFO - PROCESS | 17385 | |3;mootools.html;1355.1598009234276;1499.9325030373636;1546.6597348583311;1640.4811678948656;1770.0795586295126;8545.871811922818;8972.282217422608;9006.86489702655;9310.581023853925;9312.627494900196;8964.103589641032;9159.496227707474;9203.953980230106;9217;9217.76955576111;2354.5173239485907;2400.50789588134;2401.1595941420537;2401.1955994741784;2409.3494756415757;2328.52265285616;2339.4034521197073;2376.1327115602767;2376.2158487699016;2383.1063351243283;2324.1400681747778;2344;2358.516504116652;2360.7875291223786;2360.9881950590225;2288.6795848581214;2304.83866129371;2313.9884300578474;2316.0967222783042;2331.219041621059;2236.8322375821876;2238.664200369941;2238.697775800262;2244.0238496254183;2247.8426510144295;8737.126287371211;9073.047330030384;9149.31380146485;9198.448093114435;9234.953825230898;5272.31459910213;5390.6226564140525;5393.352797664266;5403.567714582863;5418.810341638064;3326.085326535198;3333.8333083345738;3390;3421;3439.1917899293644;1074.3661239868516;1077.3751224289892;1087.34215799441;1089.128697042363;1094.7208461842179;12776.425060872283;12901.096923215378;12929.418176182095;12943.805842912363;12962.22226666403;4513.887152821206;4599.793009314589;4692.1084993851055;4693.882652933636;4705.270683044134;10082.04220599042;10094.293399461967;10103.898961010444;10113.747156321151;10152.39085654863;5239.659422137549;5282.867928301746;5330.92003619946;5340.172273297645;5347.25138480613;4349.28236840924;4678.719276843332;4931.654784165074;4943.233798761198;4978.954419571858;4005.2790497710107;4025.275450418953;4144.109016561454;4186.35111557709;4214.072903961123;1267.7718010758151;1279.9360031998363;1285.7685616589104;1301.342821874947;1313.8029295605545;777.9144294127641;974.1086905481405;1002.2683441088046;1007.7178390050651;1008.8738907636546;6120.296165940885;6331.240251169889;6408.7756928508215;6453.1610890583925;6459.321771214049;500.2870908954725;510.82121257559555;517.1183132758638;518.9532942035235;665.1054331923555;4017.979910100431;4411.823527058946;4458.130664520388;4477.238869392211;4570.497245303014;11127.276727012719;11617.419129043514;11698.06415486759;11703.23928944616;11713.707157321136;11178.888211117785;11511.48198331077;11514.53941842317;11528.36593987322;11562.30626162433;8441.409101362968;8455.74632761018;8645.13548645143;8668.349873759493;8670.783230419163;6292.119103325446;6299.6535190564955;6321.905171422341;6406.135171751754;6416.358364163546;10456.215783816093;10575.735606609589;10602.204834637587;10652.242380007521;10735.248532602644;10699.197560182862;10811.297265677706;11063.280886742335;11077;11100.833487497532;7444.73943411978;7886.093099293655;7903.604819758874;8011.919880801117;8111.026676798822;8946.776330591787;9068.093190680878;9096.727098187064;9157.358984871262;9167.633294668138;7872.606369681607;7985.800354991172;8098.75703728889;8191.631376588187;8230.876536852073;7725.884111738216;7903.68385264583;7913.44605877583;7984.520928744294;8201.097879233399;6662.966685166737;6904.102466679299;7004.474664400089;7093.2197458278515;7098.787036388917;5154.278401023785;5210.322658054429;5455.18172274162;5546.4453554644215;5622.803201887914;5492.340919089735;5543.556515478671;5564.666120032811;5610.922516539947;5725.456081672234 23:29:17 INFO - PROCESS | 17385 | |4;prototype.html;329.8466213210858;335.4816808031591;343.6082865533294;343.71986830732953;343.80918590182455;5155;5173.974130129344;5188.403333616626;5209.296744939436;5228.346456692913;5097.821576244833;5119.1809310510325;5124.308218390516;5133.307003554519;5145.478715429441;3821.9235615287676;4042.393640953851;4109.116539943911;4113.465249517559;4125.257453658341;4041.7777022263763;4063.8374465021366;4067.877963661095;4070.796460176994;4120.505539335284;4062.7765472898977;4071.4707088078508;4082.2243773683053;4099.426080348753;4109.157622687342;3900.2589507993675;3927;4054.5742697016976;4100.979495102535;4124.216398884202;3671.8714844980295;3675.6140605236333;3696.8336424860945;3697.2605478904325;3699.408094704861;4906.2640603909695;4969.77636006377;4981.178105612569;5056.280864506086;5058.140116180221;4402.273624851896;4492.61812745917;4633.837815676435;4656.930146047778;4692.718436893763;5351.357837059578;5365.302510673588;5398.973005134989;5409.756560954766;5426.294581704393;3921.8235179416993;3942.9748265450903;3948.7828169450668;3975.662068724162;3999.7000224983244;5283.762230699589;5530.419305972895;5565.193047008202;5574.777008919679;5578.135389014709;4033.588244114595;4046.393041043867;4050.5746896576024;4055.797210139481;4068.6541643960595;4100.446439730598;4101.733387329874;4104.281750693616;4108.5275193352545;4123.60825721556;4504.234280172379;4552.726836389827;4561.612262957686;4572.7713614319155;4617.953820461752;5329.973350133302;5336.479103455496;5339.81310654133;5361.865953351197;5378.542823859937;1417.4330267892926;1428.1859340176209;1432.3697573067816;1447.7683570628649;1450.3183503753219;849.5635770997891;900.6982660808571;904.1546154345708;906.8594367872859;928.7879317490739;4639.768011599406;4641.466231383367;4656.2295434216585;4673.485916549177;4674.509176536482;4904.558589726942;4939.715673924806;4952.331435256267;4963.032208719265;4972.776225069881;4675;4757.690750101232;4768.499307572724;5060.746962651852;5082.74586270685;2790.720927907193;2837.4041451295047;2843.4170994945985;2846.4591727571697;2899.9710002900124;5670.319561652628;5687.374388817227;5703.657780533182;5726.484616384545;5736.971315143398;5437;5454.181872719124;5574.749136288877;5575.916361254584;5579.246801681802;5640.32316122068;5652.123920792202;5666.405027472221;5677.886442271214;5702.372738998707;5213.687178769286;5328.960852633699;5476.7535460903555;5488.368837583569;5495.6153069284765;5391.838244852661;5442.775375540472;5462.562994960473;5495.697736624365;5522;5409.296791417248;5721.971390143189;5722.8569285766525;5723.456271654186;5747.913781293368;3983.521977362735;3984.86052988144;3999.9800000999808;4009.8195581199498;4017.216642754635;5504.4770746778995;5517.69652669107;5527.39198688152;5534.418886016911;5571.303587051619;5174.430812610685;5357.8392648220615;5410.675359478444;5416.7020813855615;5417.810376636957;5348.652337598043;5371.892562148813;5390.97304513475;5392.894456636459;5407.297051383295;5260.500757284309;5284.603654725834;5297.761600727899;5317.787288508416;5327.680339179662;5209;5374.220737992891;5390.083685773507;5430.755615997368;5451.56387488992;5086.3896332440345;5148.22386276734;5302.806868454567;5308.601854860978;5337.572994160536 23:29:17 INFO - PROCESS | 17385 | |5;yui.html;751.594139164851;778.9376849852013;785.956772377519;808.8422757562275;844.2359664503624;13539.323033848317;14794.260286985647;15260.38958441661;15350.53948381549;15354.539363819089;15772.290246938886;16453.34186632536;16461.25924333405;16482.83517164828;16495.422660206896;670.286145255304;799.0451410564378;807.3339494916688;816.8774683797449;817.5912043978011;822.7120507822244;826.0665448043702;827.2017503109498;830.1366578758084;831.0816547714779;855.3328403845011;857.0486759696731;860.0926023045685;860.2386887604483;860.7288704058233;705.2911823617283;822.7943014246439;855.3627547477138;857.7941294089436;857.7984173719171;618.8886000519905;624.9312575616678;625.8998560230341;626.764963138823;628.3057221769924;14749.483768068067;14810.925945370313;14830.406783728638;14831.48089816862;14836.777448338284;13946.51187208453;14420.783688244685;14490.492832750908;14559.12645241289;14669.48656797007;12751;12963.805542916863;13014.479420823156;13233.801492977613;13345.466181352735;4541.8410355637725;4589.5639914208095;4639.211334073216;4724.763761811896;4784.212596269204;76121.61939190268;77307.6134619329;77579.6121019397;77655;77849;11372.886271137348;11410.486528106256;11501.597444089417;11540.711482213012;11841;21525.67711484329;21576;21585.89207053986;21597.67603485949;21618.135274589156;8581.570921453902;8618.439801412887;8686.131386861389;8739.868901966476;8806.515641639771;4406.825071570018;4627.282771170474;4726.598239149642;4874.195757699939;4941.530554597308;3562.5724913010604;3651.8904432867057;3667.1748856507074;3672.8714494992546;3679.4848721179055;635.5995722694673;653.970571324282;661.8411581220472;665.7769647168157;667.5260564998808;571.6398668838605;685.6229074009375;691.3777600159897;703.9612821294878;704.1725971983002;9496.525173741285;9500.524973751284;9561.808763824685;9663.565139568736;9724.222062235005;679.4937771360368;682.6920691622673;684.3635419060222;693.143967200507;700.4746440169872;4532.229520981441;4737.265723812815;4752.5485078917445;4772.785224664898;4781.880452988634;93287.53356233175;96516;97321.513392434;103568;105905;94423;95270;97200.51399742956;98244;98300.50849745705;84450;84777.57611211904;85020.57489712512;85420.7186892197;85963;10090.192784577363;10146.340487868265;10373.118284945864;10383.688489345332;10463.424511651932;48313.75843120762;50592.241116382545;50855;51049.48950510447;51968.740156298976;69644;75113.62443187748;76671;76880;76890.61554692191;12972;13133.934330328288;13284.335783210994;13588.524401645895;13729.45082196741;14950.626234344229;15175.848241517444;15244.847551524343;15510.612234694223;16210.027398356136;14310.785338220143;14445.277736113363;14463.421463141356;14957.04800867976;15136.470223542563;13106.410211540695;13463.798043029166;13590.524331648345;13692.520761773689;13956.511522096678;12805.423755930819;13616.38726257301;13740.541291045765;13815.930920345736;14754.778678320048;10222.948885255526;10602.204834637587;10702.518386672462;10960.671179864297;11211.327320360804;10606.416647084485;10823.67528974132;10937.945310273397;11166.162537809534;11177.217594768288 23:29:17 INFO - PROCESS | 17385 | __end_tp_report 23:29:17 INFO - PROCESS | 17385 | __start_cc_report 23:29:17 INFO - PROCESS | 17385 | _x_x_mozilla_cycle_collect,1004 23:29:17 INFO - PROCESS | 17385 | __end_cc_report 23:29:17 INFO - PROCESS | 17385 | __startTimestamp1466836157196__endTimestamp 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | ------- Summary: start ------- 23:29:17 INFO - PROCESS | 17385 | Number of tests: 6 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | [#0] dojo.html Cycles:165 Average:5298.50 Median:5467.23 stddev:588.62 (10.8%) stddev-sans-first:563.73 23:29:17 INFO - PROCESS | 17385 | Values: 3064.2 3072.5 3085.7 3125.6 3139.4 5248.2 5307.9 5368.5 5393.4 5415.6 5275.2 5308.2 5354.3 5404.5 5459.5 4884.7 4939.8 4948.3 4962.4 4974.3 4980.4 5002.4 5002.6 5046.5 5054.0 4755.6 4789.9 4812.5 4943.0 4945.3 4863.2 4879.0 4879.2 4880.4 4885.2 4835.2 4841.9 4849.6 4850.8 4858.9 5244.0 5286.1 5310.9 5313.1 5316.4 5587.2 5611.2 5617.2 5656.1 5672.1 5648.7 5724.8 5744.4 5770.9 5794.1 5265.3 5348.8 5389.6 5395.4 5397.0 5754.3 5790.6 5822.0 5856.7 5857.4 5649.7 5672.9 5673.0 5673.6 5675.5 5539.6 5607.6 5723.6 5763.1 5771.0 5641.5 5677.5 5679.9 5681.9 5734.8 5685.7 5695.4 5700.7 5700.9 5701.6 4255.9 4316.1 4319.7 4351.8 4392.3 3886.2 3899.9 3901.7 3939.5 3966.2 5457.6 5471.6 5472.3 5474.0 5474.2 5482.7 5667.0 5740.2 5803.0 5850.2 5428.5 5444.5 5446.0 5450.3 5486.0 4938.2 4956.4 4958.8 4959.0 4990.2 5752.2 5853.5 5889.8 5902.8 5914.3 5770.7 5771.3 5773.6 5779.4 5780.2 5948.0 5957.7 5958.3 5964.4 5967.4 5412.7 5417.2 5430.5 5488.1 5521.3 5598.6 5602.7 5603.9 5609.3 5610.3 5437.1 5461.0 5467.2 5470.0 5514.5 5465.0 5509.3 5538.9 5569.8 5571.3 5441.2 5468.9 5474.2 5480.9 5497.9 5357.9 5520.6 5605.0 5649.6 5659.9 5323.7 5388.5 5389.0 5446.8 5573.9 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | [#1] ext.html Cycles:180 Average:57953.24 Median:41937.69 stddev:114050.57 (272.0%) stddev-sans-first:114289.16 23:29:17 INFO - PROCESS | 17385 | Values: 577.4 616.1 624.8 632.7 644.2 41941.8 43206.0 43209.8 43217.0 46894.3 43845.6 44364.8 44412.0 44489.3 44631.3 8936.0 9067.5 9078.5 9092.1 9095.8 8958.7 9044.1 9044.8 9052.0 9056.2 8999.3 9008.2 9036.4 9037.2 9037.2 9037.6 9064.0 9074.0 9077.5 9083.8 8972.3 9039.6 9041.9 9044.9 9050.0 41228.4 41351.8 41366.0 41418.4 41466.6 3633.5 3647.4 3770.8 3798.4 3946.3 32572.8 32802.7 32805.8 32878.2 34156.0 4164.2 4215.4 4299.2 4303.7 4367.5 341916.0 342048.0 342263.0 343255.3 344187.0 58435.7 58712.7 58906.4 59057.1 59151.0 35171.8 36391.5 36482.0 56378.4 56506.5 14005.5 14128.8 14194.7 14204.6 14205.6 11023.5 11193.2 11195.8 11207.4 11222.5 19644.2 19804.5 19869.3 19888.5 19999.2 7194.3 7215.2 7294.8 7315.0 7390.2 950.3 1038.0 1056.8 1104.1 1152.8 31946.7 32559.7 32560.7 32736.0 32777.6 1091.0 1098.9 1111.8 1119.3 1124.0 16717.5 16982.2 17058.6 17174.7 17315.7 573666.0 575439.0 575831.0 577224.0 581341.0 57039.4 57542.0 57553.0 57687.0 57720.0 1211.6 1319.8 1367.8 1368.3 1392.3 32414.5 33793.8 33805.7 33890.8 34062.8 50176.0 50406.0 50657.0 50870.0 50872.2 319077.0 320582.0 321742.0 322685.0 322901.0 25056.7 28322.0 44811.6 45551.0 45603.5 45719.0 49482.5 49652.1 50005.5 50640.7 40584.6 41511.0 41744.8 42154.8 43031.0 40949.6 41487.0 42375.6 43026.1 43312.1 41933.6 42257.2 42653.6 42931.8 43709.8 35239.5 37664.6 37768.6 37995.6 38300.6 27311.0 27845.9 27871.6 27996.0 28178.9 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | [#2] jquery.html Cycles:180 Average:29183.66 Median:20953.22 stddev:76598.96 (365.6%) stddev-sans-first:76783.34 23:29:17 INFO - PROCESS | 17385 | Values: 391.7 395.2 400.1 404.6 420.8 14135.2 16676.2 18012.0 19469.6 19503.6 14970.3 15684.9 17417.8 18263.0 18624.4 5679.2 5830.6 5881.2 5882.3 5887.4 4293.5 5749.0 5851.3 5855.4 6124.8 6542.4 6550.0 6596.1 6625.7 6636.4 6300.8 6459.3 6475.4 6477.1 6593.5 5468.2 5631.1 5635.0 5636.3 5654.7 22473.1 22983.5 23036.2 23119.9 23349.9 2297.0 2309.7 2367.1 2368.8 2373.4 15148.6 15395.2 15505.3 15783.9 15865.6 2059.7 2068.1 2084.2 2155.5 2204.6 82494.0 85678.0 86006.6 88405.6 90882.5 16800.6 16979.5 17002.7 17117.9 17311.7 31008.4 31160.2 31452.8 31669.7 31698.8 8940.4 9352.9 9439.6 9472.3 9473.7 7562.7 7580.2 7678.0 7795.3 7800.8 7150.9 8083.4 8563.5 8754.2 8855.8 3181.3 3190.5 3219.7 3342.4 3455.5 897.2 926.5 950.4 954.5 991.6 18347.6 19278.3 19281.3 19407.3 19510.5 981.5 984.4 992.4 997.5 1029.3 10507.9 10902.7 10924.9 10966.9 11014.4 455115.0 461014.0 467326.0 467487.0 467814.0 90532.0 90905.5 91653.0 92020.0 92782.5 976.8 982.8 996.2 1000.3 1002.9 16756.9 16896.2 16896.3 17172.2 17530.8 40826.4 41485.6 42123.0 42141.4 43041.4 56000.7 56762.1 57865.1 58126.0 58533.7 7513.5 7535.7 7670.2 8320.7 8827.9 9620.6 9710.0 9813.8 12406.8 13311.8 11395.9 11560.0 11910.2 11943.3 12097.0 11315.6 11663.9 11751.4 11777.5 11801.8 12014.5 12089.2 12117.3 12204.0 12248.0 8235.3 8608.8 8662.4 8701.5 8833.7 10583.9 11084.2 11101.4 11162.2 11253.7 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | [#3] mootools.html Cycles:180 Average:6003.60 Median:4639.26 stddev:3487.91 (75.2%) stddev-sans-first:3480.20 23:29:17 INFO - PROCESS | 17385 | Values: 1355.2 1499.9 1546.7 1640.5 1770.1 8545.9 8972.3 9006.9 9310.6 9312.6 8964.1 9159.5 9204.0 9217.0 9217.8 2354.5 2400.5 2401.2 2401.2 2409.3 2328.5 2339.4 2376.1 2376.2 2383.1 2324.1 2344.0 2358.5 2360.8 2361.0 2288.7 2304.8 2314.0 2316.1 2331.2 2236.8 2238.7 2238.7 2244.0 2247.8 8737.1 9073.0 9149.3 9198.4 9235.0 5272.3 5390.6 5393.4 5403.6 5418.8 3326.1 3333.8 3390.0 3421.0 3439.2 1074.4 1077.4 1087.3 1089.1 1094.7 12776.4 12901.1 12929.4 12943.8 12962.2 4513.9 4599.8 4692.1 4693.9 4705.3 10082.0 10094.3 10103.9 10113.7 10152.4 5239.7 5282.9 5330.9 5340.2 5347.3 4349.3 4678.7 4931.7 4943.2 4979.0 4005.3 4025.3 4144.1 4186.4 4214.1 1267.8 1279.9 1285.8 1301.3 1313.8 777.9 974.1 1002.3 1007.7 1008.9 6120.3 6331.2 6408.8 6453.2 6459.3 500.3 510.8 517.1 519.0 665.1 4018.0 4411.8 4458.1 4477.2 4570.5 11127.3 11617.4 11698.1 11703.2 11713.7 11178.9 11511.5 11514.5 11528.4 11562.3 8441.4 8455.7 8645.1 8668.3 8670.8 6292.1 6299.7 6321.9 6406.1 6416.4 10456.2 10575.7 10602.2 10652.2 10735.2 10699.2 10811.3 11063.3 11077.0 11100.8 7444.7 7886.1 7903.6 8011.9 8111.0 8946.8 9068.1 9096.7 9157.4 9167.6 7872.6 7985.8 8098.8 8191.6 8230.9 7725.9 7903.7 7913.4 7984.5 8201.1 6663.0 6904.1 7004.5 7093.2 7098.8 5154.3 5210.3 5455.2 5546.4 5622.8 5492.3 5543.6 5564.7 5610.9 5725.5 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | [#4] prototype.html Cycles:180 Average:4508.54 Median:5092.11 stddev:1298.93 (25.5%) stddev-sans-first:1264.14 23:29:17 INFO - PROCESS | 17385 | Values: 329.8 335.5 343.6 343.7 343.8 5155.0 5174.0 5188.4 5209.3 5228.3 5097.8 5119.2 5124.3 5133.3 5145.5 3821.9 4042.4 4109.1 4113.5 4125.3 4041.8 4063.8 4067.9 4070.8 4120.5 4062.8 4071.5 4082.2 4099.4 4109.2 3900.3 3927.0 4054.6 4101.0 4124.2 3671.9 3675.6 3696.8 3697.3 3699.4 4906.3 4969.8 4981.2 5056.3 5058.1 4402.3 4492.6 4633.8 4656.9 4692.7 5351.4 5365.3 5399.0 5409.8 5426.3 3921.8 3943.0 3948.8 3975.7 3999.7 5283.8 5530.4 5565.2 5574.8 5578.1 4033.6 4046.4 4050.6 4055.8 4068.7 4100.4 4101.7 4104.3 4108.5 4123.6 4504.2 4552.7 4561.6 4572.8 4618.0 5330.0 5336.5 5339.8 5361.9 5378.5 1417.4 1428.2 1432.4 1447.8 1450.3 849.6 900.7 904.2 906.9 928.8 4639.8 4641.5 4656.2 4673.5 4674.5 4904.6 4939.7 4952.3 4963.0 4972.8 4675.0 4757.7 4768.5 5060.7 5082.7 2790.7 2837.4 2843.4 2846.5 2900.0 5670.3 5687.4 5703.7 5726.5 5737.0 5437.0 5454.2 5574.7 5575.9 5579.2 5640.3 5652.1 5666.4 5677.9 5702.4 5213.7 5329.0 5476.8 5488.4 5495.6 5391.8 5442.8 5462.6 5495.7 5522.0 5409.3 5722.0 5722.9 5723.5 5747.9 3983.5 3984.9 4000.0 4009.8 4017.2 5504.5 5517.7 5527.4 5534.4 5571.3 5174.4 5357.8 5410.7 5416.7 5417.8 5348.7 5371.9 5391.0 5392.9 5407.3 5260.5 5284.6 5297.8 5317.8 5327.7 5209.0 5374.2 5390.1 5430.8 5451.6 5086.4 5148.2 5302.8 5308.6 5337.6 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - PROCESS | 17385 | [#5] yui.html Cycles:180 Average:20446.30 Median:4744.91 stddev:28406.89 (598.7%) stddev-sans-first:28448.09 23:29:17 INFO - PROCESS | 17385 | Values: 751.6 778.9 786.0 808.8 844.2 13539.3 14794.3 15260.4 15350.5 15354.5 15772.3 16453.3 16461.3 16482.8 16495.4 670.3 799.0 807.3 816.9 817.6 822.7 826.1 827.2 830.1 831.1 855.3 857.0 860.1 860.2 860.7 705.3 822.8 855.4 857.8 857.8 618.9 624.9 625.9 626.8 628.3 14749.5 14810.9 14830.4 14831.5 14836.8 13946.5 14420.8 14490.5 14559.1 14669.5 12751.0 12963.8 13014.5 13233.8 13345.5 4541.8 4589.6 4639.2 4724.8 4784.2 76121.6 77307.6 77579.6 77655.0 77849.0 11372.9 11410.5 11501.6 11540.7 11841.0 21525.7 21576.0 21585.9 21597.7 21618.1 8581.6 8618.4 8686.1 8739.9 8806.5 4406.8 4627.3 4726.6 4874.2 4941.5 3562.6 3651.9 3667.2 3672.9 3679.5 635.6 654.0 661.8 665.8 667.5 571.6 685.6 691.4 704.0 704.2 9496.5 9500.5 9561.8 9663.6 9724.2 679.5 682.7 684.4 693.1 700.5 4532.2 4737.3 4752.5 4772.8 4781.9 93287.5 96516.0 97321.5 103568.0 105905.0 94423.0 95270.0 97200.5 98244.0 98300.5 84450.0 84777.6 85020.6 85420.7 85963.0 10090.2 10146.3 10373.1 10383.7 10463.4 48313.8 50592.2 50855.0 51049.5 51968.7 69644.0 75113.6 76671.0 76880.0 76890.6 12972.0 13133.9 13284.3 13588.5 13729.5 14950.6 15175.8 15244.8 15510.6 16210.0 14310.8 14445.3 14463.4 14957.0 15136.5 13106.4 13463.8 13590.5 13692.5 13956.5 12805.4 13616.4 13740.5 13815.9 14754.8 10222.9 10602.2 10702.5 10960.7 11211.3 10606.4 10823.7 10937.9 11166.2 11177.2 23:29:17 INFO - PROCESS | 17385 | -------- Summary: end -------- 23:29:17 INFO - PROCESS | 17385 | 23:29:17 INFO - TEST-INFO | 17385: exit 0 23:29:17 INFO - TEST-OK | dromaeo_css | took 1114767ms 23:29:17 INFO - TEST-START | kraken 23:29:17 INFO - operating with platform_type : linux_ 23:29:17 INFO - Initialising browser for kraken test... 23:29:17 INFO - TEST-INFO | started process 17574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCf67r/profile http://localhost:33807/getInfo.html) 23:29:21 INFO - PROCESS | 17574 | __metrics Screen width/height:1600/1200 23:29:21 INFO - PROCESS | 17574 | colorDepth:24 23:29:21 INFO - PROCESS | 17574 | Browser inner width/height: 1024/697 23:29:21 INFO - PROCESS | 17574 | __metrics 23:29:22 INFO - PROCESS | 17574 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:29:23 INFO - TEST-INFO | 17574: exit 0 23:29:23 INFO - Browser initialized. 23:29:23 INFO - Running cycle 1/1 for kraken test... 23:29:23 INFO - TEST-INFO | started process 17655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCf67r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:35 INFO - PROCESS | 17655 | RSS: Main: 173850624 23:29:35 INFO - PROCESS | 17655 | 23:29:38 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:39 INFO - PROCESS | 17655 | RSS: Main: 231608320 23:29:39 INFO - PROCESS | 17655 | 23:29:41 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-dft) 23:29:42 INFO - PROCESS | 17655 | RSS: Main: 215126016 23:29:42 INFO - PROCESS | 17655 | 23:29:45 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-fft) 23:29:46 INFO - PROCESS | 17655 | RSS: Main: 285339648 23:29:46 INFO - PROCESS | 17655 | 23:29:48 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-oscillator) 23:29:48 INFO - PROCESS | 17655 | RSS: Main: 196395008 23:29:48 INFO - PROCESS | 17655 | 23:29:50 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:51 INFO - PROCESS | 17655 | RSS: Main: 200388608 23:29:51 INFO - PROCESS | 17655 | 23:29:54 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33807/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:55 INFO - PROCESS | 17655 | RSS: Main: 235282432 23:29:55 INFO - PROCESS | 17655 | 23:29:58 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33807/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:59 INFO - PROCESS | 17655 | RSS: Main: 237879296 23:29:59 INFO - PROCESS | 17655 | 23:30:01 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33807/tests/kraken/driver.html?testName=json-parse-financial) 23:30:02 INFO - PROCESS | 17655 | RSS: Main: 238071808 23:30:02 INFO - PROCESS | 17655 | 23:30:04 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:30:04 INFO - PROCESS | 17655 | RSS: Main: 224280576 23:30:04 INFO - PROCESS | 17655 | 23:30:06 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:30:07 INFO - PROCESS | 17655 | RSS: Main: 228171776 23:30:07 INFO - PROCESS | 17655 | 23:30:09 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:30:09 INFO - PROCESS | 17655 | RSS: Main: 237363200 23:30:09 INFO - PROCESS | 17655 | 23:30:12 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:30:12 INFO - PROCESS | 17655 | RSS: Main: 240590848 23:30:12 INFO - PROCESS | 17655 | 23:30:15 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:30:16 INFO - PROCESS | 17655 | RSS: Main: 242642944 23:30:16 INFO - PROCESS | 17655 | 23:30:17 INFO - PROCESS | 17655 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33807/tests/kraken/driver.html?testName=ai-astar) 23:30:18 INFO - PROCESS | 17655 | RSS: Main: 284962816 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | __start_tp_report 23:30:18 INFO - PROCESS | 17655 | _x_x_mozilla_page_load 23:30:18 INFO - PROCESS | 17655 | _x_x_mozilla_page_load_details 23:30:18 INFO - PROCESS | 17655 | |i|pagename|runs| 23:30:18 INFO - PROCESS | 17655 | |0;ai-astar;101;112;111;110;111;109;110;110;111;109 23:30:18 INFO - PROCESS | 17655 | |1;audio-beat-detection;157;133;127;183;126;134;152;126;159;127 23:30:18 INFO - PROCESS | 17655 | |2;audio-dft;161;161;161;161;161;162;162;162;163;161 23:30:18 INFO - PROCESS | 17655 | |3;audio-fft;75;74;75;104;75;76;73;75;100;75 23:30:18 INFO - PROCESS | 17655 | |4;audio-oscillator;85;86;116;85;88;87;120;85;85;122 23:30:18 INFO - PROCESS | 17655 | |5;imaging-gaussian-blur;117;119;118;116;117;117;117;116;117;116 23:30:18 INFO - PROCESS | 17655 | |6;imaging-darkroom;146;146;146;147;146;145;145;146;146;146 23:30:18 INFO - PROCESS | 17655 | |7;imaging-desaturate;94;95;94;95;95;95;94;95;95;95 23:30:18 INFO - PROCESS | 17655 | |8;json-parse-financial;55;53;53;53;54;54;55;53;55;54 23:30:18 INFO - PROCESS | 17655 | |9;json-stringify-tinderbox;61;61;61;62;62;62;61;61;62;62 23:30:18 INFO - PROCESS | 17655 | |10;stanford-crypto-aes;85;79;78;78;79;80;86;80;105;80 23:30:18 INFO - PROCESS | 17655 | |11;stanford-crypto-ccm;126;125;138;121;125;122;119;125;139;131 23:30:18 INFO - PROCESS | 17655 | |12;stanford-crypto-pbkdf2;163;159;160;162;158;158;160;159;159;160 23:30:18 INFO - PROCESS | 17655 | |13;stanford-crypto-sha256-iterative;63;63;63;62;62;61;63;65;62;60 23:30:18 INFO - PROCESS | 17655 | __end_tp_report 23:30:18 INFO - PROCESS | 17655 | __start_cc_report 23:30:18 INFO - PROCESS | 17655 | _x_x_mozilla_cycle_collect,1613 23:30:18 INFO - PROCESS | 17655 | __end_cc_report 23:30:18 INFO - PROCESS | 17655 | __startTimestamp1466836218104__endTimestamp 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | ------- Summary: start ------- 23:30:18 INFO - PROCESS | 17655 | Number of tests: 14 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.10 (2.8%) stddev-sans-first:1.00 23:30:18 INFO - PROCESS | 17655 | Values: 101.0 112.0 111.0 110.0 111.0 109.0 110.0 110.0 111.0 109.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:143.00 stddev:19.44 (13.6%) stddev-sans-first:19.89 23:30:18 INFO - PROCESS | 17655 | Values: 157.0 133.0 127.0 183.0 126.0 134.0 152.0 126.0 159.0 127.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 23:30:18 INFO - PROCESS | 17655 | Values: 161.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 163.0 161.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.55 (15.4%) stddev-sans-first:12.10 23:30:18 INFO - PROCESS | 17655 | Values: 75.0 74.0 75.0 104.0 75.0 76.0 73.0 75.0 100.0 75.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:16.26 (19.1%) stddev-sans-first:16.77 23:30:18 INFO - PROCESS | 17655 | Values: 85.0 86.0 116.0 85.0 88.0 87.0 120.0 85.0 85.0 122.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 23:30:18 INFO - PROCESS | 17655 | Values: 117.0 119.0 118.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 23:30:18 INFO - PROCESS | 17655 | Values: 146.0 146.0 146.0 147.0 146.0 145.0 145.0 146.0 146.0 146.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 23:30:18 INFO - PROCESS | 17655 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.83 23:30:18 INFO - PROCESS | 17655 | Values: 55.0 53.0 53.0 53.0 54.0 54.0 55.0 53.0 55.0 54.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 23:30:18 INFO - PROCESS | 17655 | Values: 61.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 62.0 62.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:8.21 (10.3%) stddev-sans-first:8.67 23:30:18 INFO - PROCESS | 17655 | Values: 85.0 79.0 78.0 78.0 79.0 80.0 86.0 80.0 105.0 80.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:125.50 stddev:6.82 (5.4%) stddev-sans-first:7.22 23:30:18 INFO - PROCESS | 17655 | Values: 126.0 125.0 138.0 121.0 125.0 122.0 119.0 125.0 139.0 131.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:1.62 (1.0%) stddev-sans-first:1.24 23:30:18 INFO - PROCESS | 17655 | Values: 163.0 159.0 160.0 162.0 158.0 158.0 160.0 159.0 159.0 160.0 23:30:18 INFO - PROCESS | 17655 | 23:30:18 INFO - PROCESS | 17655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.41 23:30:18 INFO - PROCESS | 17655 | Values: 63.0 63.0 63.0 62.0 62.0 61.0 63.0 65.0 62.0 60.0 23:30:18 INFO - PROCESS | 17655 | -------- Summary: end -------- 23:30:18 INFO - PROCESS | 17655 | 23:30:19 INFO - TEST-INFO | 17655: exit 0 23:30:19 INFO - TEST-OK | kraken | took 61138ms 23:30:19 INFO - SUITE-END | took 1175s 23:30:19 INFO - Completed test suite (00:19:36) 23:30:19 INFO - javascript benchmark 23:30:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.187990182602, 3072.493038648623, 3085.706857848504, 3125.624925008999, 3139.387819375221, 5248.160294352904, 5307.893842123155, 5368.516833484986, 5393.4336894626085, 5415.566754659628, 5275.235090911816, 5308.150695888658, 5354.2771725817, 5404.513593776559, 5459.535939445152, 4884.731339776302, 4939.8024079036795, 4948.257761335793, 4962.379702537183, 4974.328465657144, 4980.377452818398, 5002.399712034561, 5002.59979201663, 5046.470120637336, 5054.039732450841, 4755.64332675049, 4789.904201915977, 4812.51874812516, 4942.975285123569, 4945.332380128691, 4863.221884498499, 4878.951210487885, 4879.219324907997, 4880.389951256093, 4885.2427873679635, 4835.202191638376, 4841.903161936777, 4849.587785038276, 4850.83022094225, 4858.927116093261, 5244.0, 5286.07493688603, 5310.946890531122, 5313.0967735485065, 5316.415194328621, 5587.217789509472, 5611.242482264883, 5617.21359009739, 5656.123300888369, 5672.092465205547, 5648.661080335193, 5724.828255152311, 5744.368119506851, 5770.88458230833, 5794.101914203306, 5265.341832270966, 5348.759305831208, 5389.622726409153, 5395.406505284415, 5397.028534863723, 5754.251947246831, 5790.594658373873, 5822.010258256107, 5856.736446859902, 5857.384974577693, 5649.745761440745, 5672.914906276409, 5673.00722373583, 5673.631213971079, 5675.489205971482, 5539.639923404966, 5607.635503692247, 5723.570732195102, 5763.106718458645, 5770.971145144332, 5641.548676105902, 5677.545796336366, 5679.914801277984, 5681.886362272731, 5734.799282025109, 5685.687287199161, 5695.40198279183, 5700.743466544015, 5700.857478563069, 5701.572382071361, 4255.936160957588, 4316.093620339764, 4319.740815551014, 4351.760653164107, 4392.2752745797225, 3886.1644746379097, 3899.922001559953, 3901.7073719471155, 3939.4681717967705, 3966.2265858157384, 5457.590680698963, 5471.644343117685, 5472.288602481732, 5474.0, 5474.151506516497, 5482.725863706799, 5666.9716651416475, 5740.167675687002, 5802.984477716383, 5850.180974663551, 5428.45715428454, 5444.455554444524, 5446.046941785251, 5450.264214331094, 5485.972570137204, 4938.209886418156, 4956.430010548761, 4958.776855041532, 4959.0329885671945, 4990.226514890198, 5752.223449834302, 5853.5317174625925, 5889.833678278535, 5902.793402230901, 5914.260717410238, 5770.653760774367, 5771.307443106854, 5773.595848290579, 5779.393163717749, 5780.248567686174, 5948.048312270016, 5957.7319020645045, 5958.255218097738, 5964.433378829004, 5967.403259673998, 5412.702301373462, 5417.187421886749, 5430.5384042356845, 5488.094464413487, 5521.282233309644, 5598.608097433304, 5602.691851948182, 5603.943960560342, 5609.326880774333, 5610.298712660918, 5437.13005919051, 5461.0, 5467.234587157722, 5470.042742519963, 5514.476124768141, 5465.043617366865, 5509.338879334506, 5538.86152846166, 5569.832905012856, 5571.331440227199, 5441.211024401518, 5468.91796623059, 5474.206240095244, 5480.890382192413, 5497.917531236954, 5357.919631205613, 5520.585956053232, 5604.971975140098, 5649.5762817789655, 5659.943400565941, 5323.653962492425, 5388.54197393226, 5389.0299746046085, 5446.809361672323, 5573.8606534835335], "value": 5259.4568836117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4225774225774, 616.1066453642219, 624.790695117136, 632.6899819088646, 644.2462319086668, 41941.79029104854, 43206.0, 43209.78395108028, 43217.0, 46894.296585551245, 43845.561544384545, 44364.778176109154, 44412.0, 44489.33266001013, 44631.330530042076, 8936.0, 9067.546622668873, 9078.546072696372, 9092.136247056518, 9095.818083638324, 8958.686445974392, 9044.14080662336, 9044.773880653003, 9051.954740226323, 9056.184943355096, 8999.325050621197, 9008.234300084501, 9036.367454278203, 9037.18665320121, 9037.18665320121, 9037.593308301142, 9064.0, 9073.954630226872, 9077.500737459437, 9083.818323633523, 8972.327075469366, 9039.593218305126, 9041.864372034424, 9044.8643270351, 9050.0, 41228.38157427641, 41351.7932410336, 41366.0, 41418.378724318856, 41466.585334146876, 3633.454981752758, 3647.379945409287, 3770.773753574767, 3798.4112462568346, 3946.2699400610977, 32572.837135814407, 32802.6719732802, 32805.83597082023, 32878.19169945652, 34156.0, 4164.167166566668, 4215.3887686285625, 4299.226139294926, 4303.677224208197, 4367.475902891673, 341916.0, 342048.0, 342263.0, 343255.2837235823, 344187.0, 58435.70782146062, 58712.706436467546, 58906.41093589009, 59057.11414328789, 59151.0, 35171.824140879646, 36391.454128188096, 36482.0, 56378.43621563814, 56506.50175229901, 14005.5098071567, 14128.788068178985, 14194.716105677828, 14204.573862784133, 14205.573832785032, 11023.503942322615, 11193.16051296156, 11195.832062519068, 11207.38359390225, 11222.494987725571, 19644.214231430582, 19804.50488737793, 19869.30457433983, 19888.50278743043, 19999.200031998556, 7194.309337305729, 7215.206327303992, 7294.8176295591975, 7314.975903373532, 7390.187079421259, 950.273041123541, 1038.0346277961416, 1056.804491169136, 1104.100158370925, 1152.838253903408, 31946.680533194834, 32559.674403256136, 32560.67439325624, 32736.0, 32777.57255673285, 1091.0, 1098.9340639561492, 1111.7554138089608, 1119.3339962722168, 1123.966281011571, 16717.498475045526, 16982.23579938906, 17058.57353566146, 17174.656506870044, 17315.65368692619, 573666.0, 575439.0, 575831.0, 577224.0, 581341.0, 57039.429605704245, 57542.0, 57553.0, 57687.0, 57720.0, 1211.618340222827, 1319.7888337865895, 1367.7743172376447, 1368.3021658954005, 1392.276016471429, 32414.513782293758, 33793.83103084469, 33805.66194338124, 33890.830545847115, 34062.829685851415, 50175.985921125495, 50406.0, 50657.0, 50869.98260034853, 50872.236916445545, 319077.0, 320582.0, 321742.0, 322685.0, 322901.0, 25056.749432505443, 28322.0, 44811.55188448074, 45551.0, 45603.54396455993, 45719.0, 49482.50517494923, 49652.138785403644, 50005.49994500154, 50640.74679626578, 40584.59415405808, 41511.0, 41744.79127604343, 42154.789226053676, 43031.0, 40949.59050409458, 41487.0, 42375.57624423716, 43026.139477210905, 43312.133757325304, 41933.58066419297, 42257.154856902074, 42653.57346426496, 42931.7853410731, 43709.78145109254, 35239.47140792839, 37664.62335376611, 37768.62231377651, 37995.62004379921, 38300.6169938297, 27311.0, 27845.860770696017, 27871.581926271527, 27996.0, 28178.85910570434], "value": 20045.586250735647, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.74536551241687, 395.203664615799, 400.0818122409071, 404.6398705152414, 420.84849454196484, 14135.222562759043, 16676.249568769403, 18012.0, 19469.610607787836, 19503.60992780145, 14970.25148742564, 15684.921575392107, 17417.82582174178, 18263.0, 18624.441266761984, 5679.204911312419, 5830.591858569902, 5881.2354393928945, 5882.323532793719, 5887.35239123696, 4293.48478182617, 5748.971255143719, 5851.297844258695, 5855.443732845373, 6124.785632502863, 6542.41118299353, 6549.967250163766, 6596.142501474802, 6625.701843417034, 6636.435902948231, 6300.779472718433, 6459.289478157399, 6475.352464753534, 6477.093206951031, 6593.53845230834, 5468.234447177399, 5631.1271752878365, 5635.0138725723245, 5636.323641163087, 5654.717264136777, 22473.101075956944, 22983.54032919349, 23036.193733219425, 23119.88440057806, 23349.949252283688, 2296.9655455168186, 2309.7459279479244, 2367.124164059309, 2368.7512811154925, 2373.371056669984, 15148.621284467867, 15395.228169098642, 15505.302261398265, 15783.921080394639, 15865.603359915978, 2059.6704527275565, 2068.141721185706, 2084.218418093215, 2155.461134716321, 2204.6141925163033, 82493.9999999994, 85678.0, 86006.56996715038, 88405.55797221037, 90882.5455872723, 16800.57998550046, 16979.49061528156, 17002.744958825628, 17117.914410427868, 17311.740323895152, 31008.379832403225, 31160.220994474865, 31452.842735786173, 31669.683303167134, 31698.841505792323, 8940.418872773249, 9352.859707104399, 9439.575219115157, 9472.336936414385, 9473.668421605349, 7562.735304264324, 7580.204078571781, 7677.961610191914, 7795.259450352208, 7800.843983120306, 7150.946606070896, 8083.353331733447, 8563.486190828571, 8754.168354006359, 8855.822883542292, 3181.2683082891062, 3190.489521676567, 3219.710226079664, 3342.38165939302, 3455.481677748358, 897.1701176411923, 926.4719110107309, 950.4202436513721, 954.5418199264253, 991.5884907763198, 18347.55101122923, 19278.32525861616, 19281.325153619837, 19407.320743774184, 19510.5122371939, 981.4847205217318, 984.4388698441819, 992.4343124419156, 997.4713401897006, 1029.2897900448665, 10507.947460262803, 10902.727431814268, 10924.945375273073, 10966.945165274123, 11014.44927753609, 455115.0, 461014.0, 467326.0, 467487.0, 467814.0, 90532.0, 90905.54547227222, 91653.0, 92020.0, 92782.53608731914, 976.7948730766476, 982.7985263021063, 996.1731762636994, 1000.3447741729179, 1002.8946960569181, 16756.916215418845, 16896.23966921467, 16896.32414703398, 17172.22724977354, 17530.824691752918, 40826.387604185365, 41485.58514414817, 42123.0, 42141.36787948122, 43041.354379684955, 56000.719996399755, 56762.14856777234, 57865.13202302053, 58126.0, 58533.70733146307, 7513.4740568159705, 7535.698572057276, 7670.156282808998, 8320.708775193081, 8827.911720882708, 9620.615175392906, 9709.951450242703, 9813.803723925339, 12406.751864962831, 13311.80032299497, 11395.943020284845, 11560.01739852122, 11910.166288359731, 11943.343116128348, 12097.0, 11315.603953861575, 11663.88336116628, 11751.412429378326, 11777.528898844294, 11801.822972655245, 12014.459349329127, 12089.15375923712, 12117.27296362221, 12204.0, 12248.0, 8235.258826705625, 8608.827823443371, 8662.35032372562, 8701.47791132534, 8833.69082082124, 10583.894161058292, 11084.224104312621, 11101.444927753742, 11162.218644695118, 11253.71865703364], "value": 9902.994020463619, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.1598009234276, 1499.9325030373636, 1546.6597348583311, 1640.4811678948656, 1770.0795586295126, 8545.871811922818, 8972.282217422608, 9006.86489702655, 9310.581023853925, 9312.627494900196, 8964.103589641032, 9159.496227707474, 9203.953980230106, 9217.0, 9217.76955576111, 2354.5173239485907, 2400.50789588134, 2401.1595941420537, 2401.1955994741784, 2409.3494756415757, 2328.52265285616, 2339.4034521197073, 2376.1327115602767, 2376.2158487699016, 2383.1063351243283, 2324.1400681747778, 2344.0, 2358.516504116652, 2360.7875291223786, 2360.9881950590225, 2288.6795848581214, 2304.83866129371, 2313.9884300578474, 2316.0967222783042, 2331.219041621059, 2236.8322375821876, 2238.664200369941, 2238.697775800262, 2244.0238496254183, 2247.8426510144295, 8737.126287371211, 9073.047330030384, 9149.31380146485, 9198.448093114435, 9234.953825230898, 5272.31459910213, 5390.6226564140525, 5393.352797664266, 5403.567714582863, 5418.810341638064, 3326.085326535198, 3333.8333083345738, 3390.0, 3421.0, 3439.1917899293644, 1074.3661239868516, 1077.3751224289892, 1087.34215799441, 1089.128697042363, 1094.7208461842179, 12776.425060872283, 12901.096923215378, 12929.418176182095, 12943.805842912363, 12962.22226666403, 4513.887152821206, 4599.793009314589, 4692.1084993851055, 4693.882652933636, 4705.270683044134, 10082.04220599042, 10094.293399461967, 10103.898961010444, 10113.747156321151, 10152.39085654863, 5239.659422137549, 5282.867928301746, 5330.92003619946, 5340.172273297645, 5347.25138480613, 4349.28236840924, 4678.719276843332, 4931.654784165074, 4943.233798761198, 4978.954419571858, 4005.2790497710107, 4025.275450418953, 4144.109016561454, 4186.35111557709, 4214.072903961123, 1267.7718010758151, 1279.9360031998363, 1285.7685616589104, 1301.342821874947, 1313.8029295605545, 777.9144294127641, 974.1086905481405, 1002.2683441088046, 1007.7178390050651, 1008.8738907636546, 6120.296165940885, 6331.240251169889, 6408.7756928508215, 6453.1610890583925, 6459.321771214049, 500.2870908954725, 510.82121257559555, 517.1183132758638, 518.9532942035235, 665.1054331923555, 4017.979910100431, 4411.823527058946, 4458.130664520388, 4477.238869392211, 4570.497245303014, 11127.276727012719, 11617.419129043514, 11698.06415486759, 11703.23928944616, 11713.707157321136, 11178.888211117785, 11511.48198331077, 11514.53941842317, 11528.36593987322, 11562.30626162433, 8441.409101362968, 8455.74632761018, 8645.13548645143, 8668.349873759493, 8670.783230419163, 6292.119103325446, 6299.6535190564955, 6321.905171422341, 6406.135171751754, 6416.358364163546, 10456.215783816093, 10575.735606609589, 10602.204834637587, 10652.242380007521, 10735.248532602644, 10699.197560182862, 10811.297265677706, 11063.280886742335, 11077.0, 11100.833487497532, 7444.73943411978, 7886.093099293655, 7903.604819758874, 8011.919880801117, 8111.026676798822, 8946.776330591787, 9068.093190680878, 9096.727098187064, 9157.358984871262, 9167.633294668138, 7872.606369681607, 7985.800354991172, 8098.75703728889, 8191.631376588187, 8230.876536852073, 7725.884111738216, 7903.68385264583, 7913.44605877583, 7984.520928744294, 8201.097879233399, 6662.966685166737, 6904.102466679299, 7004.474664400089, 7093.2197458278515, 7098.787036388917, 5154.278401023785, 5210.322658054429, 5455.18172274162, 5546.4453554644215, 5622.803201887914, 5492.340919089735, 5543.556515478671, 5564.666120032811, 5610.922516539947, 5725.456081672234], "value": 4695.251571997277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.8466213210858, 335.4816808031591, 343.6082865533294, 343.71986830732953, 343.80918590182455, 5155.0, 5173.974130129344, 5188.403333616626, 5209.296744939436, 5228.346456692913, 5097.821576244833, 5119.1809310510325, 5124.308218390516, 5133.307003554519, 5145.478715429441, 3821.9235615287676, 4042.393640953851, 4109.116539943911, 4113.465249517559, 4125.257453658341, 4041.7777022263763, 4063.8374465021366, 4067.877963661095, 4070.796460176994, 4120.505539335284, 4062.7765472898977, 4071.4707088078508, 4082.2243773683053, 4099.426080348753, 4109.157622687342, 3900.2589507993675, 3927.0, 4054.5742697016976, 4100.979495102535, 4124.216398884202, 3671.8714844980295, 3675.6140605236333, 3696.8336424860945, 3697.2605478904325, 3699.408094704861, 4906.2640603909695, 4969.77636006377, 4981.178105612569, 5056.280864506086, 5058.140116180221, 4402.273624851896, 4492.61812745917, 4633.837815676435, 4656.930146047778, 4692.718436893763, 5351.357837059578, 5365.302510673588, 5398.973005134989, 5409.756560954766, 5426.294581704393, 3921.8235179416993, 3942.9748265450903, 3948.7828169450668, 3975.662068724162, 3999.7000224983244, 5283.762230699589, 5530.419305972895, 5565.193047008202, 5574.777008919679, 5578.135389014709, 4033.588244114595, 4046.393041043867, 4050.5746896576024, 4055.797210139481, 4068.6541643960595, 4100.446439730598, 4101.733387329874, 4104.281750693616, 4108.5275193352545, 4123.60825721556, 4504.234280172379, 4552.726836389827, 4561.612262957686, 4572.7713614319155, 4617.953820461752, 5329.973350133302, 5336.479103455496, 5339.81310654133, 5361.865953351197, 5378.542823859937, 1417.4330267892926, 1428.1859340176209, 1432.3697573067816, 1447.7683570628649, 1450.3183503753219, 849.5635770997891, 900.6982660808571, 904.1546154345708, 906.8594367872859, 928.7879317490739, 4639.768011599406, 4641.466231383367, 4656.2295434216585, 4673.485916549177, 4674.509176536482, 4904.558589726942, 4939.715673924806, 4952.331435256267, 4963.032208719265, 4972.776225069881, 4675.0, 4757.690750101232, 4768.499307572724, 5060.746962651852, 5082.74586270685, 2790.720927907193, 2837.4041451295047, 2843.4170994945985, 2846.4591727571697, 2899.9710002900124, 5670.319561652628, 5687.374388817227, 5703.657780533182, 5726.484616384545, 5736.971315143398, 5437.0, 5454.181872719124, 5574.749136288877, 5575.916361254584, 5579.246801681802, 5640.32316122068, 5652.123920792202, 5666.405027472221, 5677.886442271214, 5702.372738998707, 5213.687178769286, 5328.960852633699, 5476.7535460903555, 5488.368837583569, 5495.6153069284765, 5391.838244852661, 5442.775375540472, 5462.562994960473, 5495.697736624365, 5522.0, 5409.296791417248, 5721.971390143189, 5722.8569285766525, 5723.456271654186, 5747.913781293368, 3983.521977362735, 3984.86052988144, 3999.9800000999808, 4009.8195581199498, 4017.216642754635, 5504.4770746778995, 5517.69652669107, 5527.39198688152, 5534.418886016911, 5571.303587051619, 5174.430812610685, 5357.8392648220615, 5410.675359478444, 5416.7020813855615, 5417.810376636957, 5348.652337598043, 5371.892562148813, 5390.97304513475, 5392.894456636459, 5407.297051383295, 5260.500757284309, 5284.603654725834, 5297.761600727899, 5317.787288508416, 5327.680339179662, 5209.0, 5374.220737992891, 5390.083685773507, 5430.755615997368, 5451.56387488992, 5086.3896332440345, 5148.22386276734, 5302.806868454567, 5308.601854860978, 5337.572994160536], "value": 4099.897946144384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.594139164851, 778.9376849852013, 785.956772377519, 808.8422757562275, 844.2359664503624, 13539.323033848317, 14794.260286985647, 15260.38958441661, 15350.53948381549, 15354.539363819089, 15772.290246938886, 16453.34186632536, 16461.25924333405, 16482.83517164828, 16495.422660206896, 670.286145255304, 799.0451410564378, 807.3339494916688, 816.8774683797449, 817.5912043978011, 822.7120507822244, 826.0665448043702, 827.2017503109498, 830.1366578758084, 831.0816547714779, 855.3328403845011, 857.0486759696731, 860.0926023045685, 860.2386887604483, 860.7288704058233, 705.2911823617283, 822.7943014246439, 855.3627547477138, 857.7941294089436, 857.7984173719171, 618.8886000519905, 624.9312575616678, 625.8998560230341, 626.764963138823, 628.3057221769924, 14749.483768068067, 14810.925945370313, 14830.406783728638, 14831.48089816862, 14836.777448338284, 13946.51187208453, 14420.783688244685, 14490.492832750908, 14559.12645241289, 14669.48656797007, 12751.0, 12963.805542916863, 13014.479420823156, 13233.801492977613, 13345.466181352735, 4541.8410355637725, 4589.5639914208095, 4639.211334073216, 4724.763761811896, 4784.212596269204, 76121.61939190268, 77307.6134619329, 77579.6121019397, 77655.0, 77849.0, 11372.886271137348, 11410.486528106256, 11501.597444089417, 11540.711482213012, 11841.0, 21525.67711484329, 21576.0, 21585.89207053986, 21597.67603485949, 21618.135274589156, 8581.570921453902, 8618.439801412887, 8686.131386861389, 8739.868901966476, 8806.515641639771, 4406.825071570018, 4627.282771170474, 4726.598239149642, 4874.195757699939, 4941.530554597308, 3562.5724913010604, 3651.8904432867057, 3667.1748856507074, 3672.8714494992546, 3679.4848721179055, 635.5995722694673, 653.970571324282, 661.8411581220472, 665.7769647168157, 667.5260564998808, 571.6398668838605, 685.6229074009375, 691.3777600159897, 703.9612821294878, 704.1725971983002, 9496.525173741285, 9500.524973751284, 9561.808763824685, 9663.565139568736, 9724.222062235005, 679.4937771360368, 682.6920691622673, 684.3635419060222, 693.143967200507, 700.4746440169872, 4532.229520981441, 4737.265723812815, 4752.5485078917445, 4772.785224664898, 4781.880452988634, 93287.53356233175, 96516.0, 97321.513392434, 103568.0, 105905.0, 94423.0, 95270.0, 97200.51399742956, 98244.0, 98300.50849745705, 84450.0, 84777.57611211904, 85020.57489712512, 85420.7186892197, 85963.0, 10090.192784577363, 10146.340487868265, 10373.118284945864, 10383.688489345332, 10463.424511651932, 48313.75843120762, 50592.241116382545, 50855.0, 51049.48950510447, 51968.740156298976, 69644.0, 75113.62443187748, 76671.0, 76880.0, 76890.61554692191, 12972.0, 13133.934330328288, 13284.335783210994, 13588.524401645895, 13729.45082196741, 14950.626234344229, 15175.848241517444, 15244.847551524343, 15510.612234694223, 16210.027398356136, 14310.785338220143, 14445.277736113363, 14463.421463141356, 14957.04800867976, 15136.470223542563, 13106.410211540695, 13463.798043029166, 13590.524331648345, 13692.520761773689, 13956.511522096678, 12805.423755930819, 13616.38726257301, 13740.541291045765, 13815.930920345736, 14754.778678320048, 10222.948885255526, 10602.204834637587, 10702.518386672462, 10960.671179864297, 11211.327320360804, 10606.416647084485, 10823.67528974132, 10937.945310273397, 11166.162537809534, 11177.217594768288], "value": 7633.002101268594, "unit": "score"}], "name": "dromaeo_css", "value": 7316.725965836117, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 110.0, 111.0, 109.0, 110.0, 110.0, 111.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 133.0, 127.0, 183.0, 126.0, 134.0, 152.0, 126.0, 159.0, 127.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 104.0, 75.0, 76.0, 73.0, 75.0, 100.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 116.0, 85.0, 88.0, 87.0, 120.0, 85.0, 85.0, 122.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 53.0, 55.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 78.0, 78.0, 79.0, 80.0, 86.0, 80.0, 105.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 138.0, 121.0, 125.0, 122.0, 119.0, 125.0, 139.0, 131.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 160.0, 162.0, 158.0, 158.0, 160.0, 159.0, 159.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 62.0, 61.0, 63.0, 65.0, 62.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1494.7, "alertThreshold": 2.0}]} 23:30:19 INFO - Return code: 0 23:30:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:30:19 INFO - # TBPL SUCCESS # 23:30:19 INFO - Running post-action listener: _resource_record_post_action 23:30:19 INFO - ##### 23:30:19 INFO - ##### Finished run-tests step (success) 23:30:19 INFO - ##### 23:30:19 INFO - Running post-run listener: _resource_record_post_run 23:30:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552132608; Read time: 8; Write time: 404464 23:30:19 INFO - TinderboxPrint: CPU usage
13.2% 23:30:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:30:19 INFO - TinderboxPrint: I/O write bytes / time
552,132,608 / 404,464 23:30:19 INFO - TinderboxPrint: CPU idle
8,269.2 (86.8%) 23:30:19 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 23:30:19 INFO - TinderboxPrint: Swap in / out
0 / 0 23:30:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256724992; Read time: 0; Write time: 195836 23:30:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288927744; Read time: 8; Write time: 207184 23:30:20 INFO - Running post-run listener: _upload_blobber_files 23:30:20 INFO - Blob upload gear active. 23:30:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:30:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:30:20 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:21 INFO - (blobuploader) - INFO - Done attempting. 23:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:24 INFO - (blobuploader) - INFO - Done attempting. 23:30:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:25 INFO - (blobuploader) - INFO - Done attempting. 23:30:25 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:25 INFO - Return code: 0 23:30:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9f5fd89de5ab7b4a23bdd9f2aa9eca8858fb6ba5904e81397dd6c2254917995de4658ffe321ce3ab9187c9907986c8e71c806eb6ce688b24e0c261ca4d8be1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f688eb4d56963babbeb7473b9e592593952a830d920f27025581b32aa642305dbb8c1aa9106127873529ce188812fc4b70d900bfb89c25d865eca0dbb1f0b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83221eaadb0572c9832abbb158a0539aa69d7cf87f2c04e944209f563a397419c74c42193918362e37a3ed5fb6da5368873315bf15fcbc5a776d856bc23e16e"} 23:30:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:25 INFO - Contents: 23:30:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9f5fd89de5ab7b4a23bdd9f2aa9eca8858fb6ba5904e81397dd6c2254917995de4658ffe321ce3ab9187c9907986c8e71c806eb6ce688b24e0c261ca4d8be1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f688eb4d56963babbeb7473b9e592593952a830d920f27025581b32aa642305dbb8c1aa9106127873529ce188812fc4b70d900bfb89c25d865eca0dbb1f0b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83221eaadb0572c9832abbb158a0539aa69d7cf87f2c04e944209f563a397419c74c42193918362e37a3ed5fb6da5368873315bf15fcbc5a776d856bc23e16e"} 23:30:25 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:25 INFO - Copying logs to upload dir... 23:30:25 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.406257 ========= master_lag: 3.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-24 23:30:28.610924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 23:30:28.614967) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9f5fd89de5ab7b4a23bdd9f2aa9eca8858fb6ba5904e81397dd6c2254917995de4658ffe321ce3ab9187c9907986c8e71c806eb6ce688b24e0c261ca4d8be1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f688eb4d56963babbeb7473b9e592593952a830d920f27025581b32aa642305dbb8c1aa9106127873529ce188812fc4b70d900bfb89c25d865eca0dbb1f0b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83221eaadb0572c9832abbb158a0539aa69d7cf87f2c04e944209f563a397419c74c42193918362e37a3ed5fb6da5368873315bf15fcbc5a776d856bc23e16e"} build_url:https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/bHnSa4QQSX2ppGsMmRnvzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9f5fd89de5ab7b4a23bdd9f2aa9eca8858fb6ba5904e81397dd6c2254917995de4658ffe321ce3ab9187c9907986c8e71c806eb6ce688b24e0c261ca4d8be1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f688eb4d56963babbeb7473b9e592593952a830d920f27025581b32aa642305dbb8c1aa9106127873529ce188812fc4b70d900bfb89c25d865eca0dbb1f0b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83221eaadb0572c9832abbb158a0539aa69d7cf87f2c04e944209f563a397419c74c42193918362e37a3ed5fb6da5368873315bf15fcbc5a776d856bc23e16e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 23:30:28.641342) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:30:28.641900) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466832347.967118-1525173571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 23:30:28.696833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 23:30:28.697729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 23:30:28.698546) ========= ========= Total master_lag: 3.96 =========