builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1465744744.76 results: success (0) buildid: 20160612053002 builduid: 83b7ddd59e9740c7b30a32cc1f4b2b96 revision: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.758407) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.758933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.759317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.809342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.809622) ========= 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=d2a8c569965ab8367867b893000001a1-1465732130.390052-722053112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 08:19:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 137M=0s 2016-06-12 08:19:05 (137 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.953585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:04.953877) ========= 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=d2a8c569965ab8367867b893000001a1-1465732130.390052-722053112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.003671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.004103) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d --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 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d --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=d2a8c569965ab8367867b893000001a1-1465732130.390052-722053112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 08:19:05,629 truncating revision to first 12 chars 2016-06-12 08:19:05,629 Setting DEBUG logging. 2016-06-12 08:19:05,629 attempt 1/10 2016-06-12 08:19:05,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/016e0f47e8ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 08:19:05,944 unpacking tar archive at: fx-team-016e0f47e8ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.671732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.672070) ========= script_repo_revision: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.672608) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.672918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 08:19:05.691085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-12 08:19:05.691413) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=d2a8c569965ab8367867b893000001a1-1465732130.390052-722053112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:19:06 INFO - MultiFileLogger online at 20160612 08:19:06 in /builds/slave/test 08:19:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:19:06 INFO - {'append_to_log': False, 08:19:06 INFO - 'base_work_dir': '/builds/slave/test', 08:19:06 INFO - 'blob_upload_branch': 'Fx-Team', 08:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:19:06 INFO - 'branch': 'Fx-Team', 08:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:06 INFO - 'config_files': ('talos/linux_config.py',), 08:19:06 INFO - 'default_actions': ('clobber', 08:19:06 INFO - 'read-buildbot-config', 08:19:06 INFO - 'download-and-extract', 08:19:06 INFO - 'populate-webroot', 08:19:06 INFO - 'create-virtualenv', 08:19:06 INFO - 'install', 08:19:06 INFO - 'run-tests'), 08:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:06 INFO - 'download_minidump_stackwalk': True, 08:19:06 INFO - 'download_symbols': 'ondemand', 08:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:06 INFO - 'installer_path': 'installer.exe', 08:19:06 INFO - 'log_level': 'info', 08:19:06 INFO - 'log_name': 'talos', 08:19:06 INFO - 'log_to_console': True, 08:19:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:19:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:19:06 INFO - 'opt_config_files': (), 08:19:06 INFO - 'pip_index': False, 08:19:06 INFO - 'sps_profile': False, 08:19:06 INFO - 'sps_profile_interval': 0, 08:19:06 INFO - 'suite': 'dromaeojs-e10s', 08:19:06 INFO - 'system_bits': '32', 08:19:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:06 INFO - 'title': 'talos-linux64-ix-043', 08:19:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:06 INFO - 'use_talos_json': True, 08:19:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:19:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:06 INFO - 'work_dir': 'build'} 08:19:06 INFO - ##### 08:19:06 INFO - ##### Running clobber step. 08:19:06 INFO - ##### 08:19:06 INFO - Running pre-action listener: _resource_record_pre_action 08:19:06 INFO - Running main action method: clobber 08:19:06 INFO - rmtree: /builds/slave/test/build 08:19:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:19:07 INFO - Running post-action listener: _resource_record_post_action 08:19:07 INFO - ##### 08:19:07 INFO - ##### Finished clobber step (success) 08:19:07 INFO - ##### 08:19:07 INFO - ##### 08:19:07 INFO - ##### Running read-buildbot-config step. 08:19:07 INFO - ##### 08:19:07 INFO - Running pre-action listener: _resource_record_pre_action 08:19:07 INFO - Running main action method: read_buildbot_config 08:19:07 INFO - Using buildbot properties: 08:19:07 INFO - { 08:19:07 INFO - "project": "", 08:19:07 INFO - "product": "firefox", 08:19:07 INFO - "script_repo_revision": "production", 08:19:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:19:07 INFO - "repository": "", 08:19:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:19:07 INFO - "buildid": "20160612053002", 08:19:07 INFO - "pgo_build": "True", 08:19:07 INFO - "basedir": "/builds/slave/test", 08:19:07 INFO - "buildnumber": 554, 08:19:07 INFO - "slavename": "talos-linux64-ix-043", 08:19:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:19:07 INFO - "platform": "ubuntu64_hw", 08:19:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:19:07 INFO - "branch": "fx-team", 08:19:07 INFO - "repo_path": "integration/fx-team", 08:19:07 INFO - "revision": "016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d", 08:19:07 INFO - "stage_platform": "linux64-pgo", 08:19:07 INFO - "builduid": "83b7ddd59e9740c7b30a32cc1f4b2b96", 08:19:07 INFO - "slavebuilddir": "test" 08:19:07 INFO - } 08:19:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:19:07 INFO - Running post-action listener: _resource_record_post_action 08:19:07 INFO - ##### 08:19:07 INFO - ##### Finished read-buildbot-config step (success) 08:19:07 INFO - ##### 08:19:07 INFO - ##### 08:19:07 INFO - ##### Running download-and-extract step. 08:19:07 INFO - ##### 08:19:07 INFO - Running pre-action listener: _resource_record_pre_action 08:19:07 INFO - Running main action method: download_and_extract 08:19:07 INFO - mkdir: /builds/slave/test/build/tests 08:19: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')]} 08:19:07 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:10 INFO - Downloaded 1361 bytes. 08:19:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:19:10 INFO - Using the following test package requirements: 08:19:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:19:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:19:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'jsshell-linux-x86_64.zip'], 08:19:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:19:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:19:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:19:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:19:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:19:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:19: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')]} 08:19:10 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:19:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:19:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:11 INFO - Downloaded 24465105 bytes. 08:19:11 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'] 08:19:11 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 08:19:12 INFO - Return code: 0 08:19:12 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 08:19:12 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')]} 08:19:12 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:19:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:19:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:14 INFO - Downloaded 24465105 bytes. 08:19:14 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'] 08:19:14 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 08:19:15 INFO - Return code: 0 08:19:15 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')]} 08:19:15 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:16 INFO - Downloaded 10833377 bytes. 08:19:16 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'] 08:19:16 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 08:19:16 INFO - Return code: 0 08:19:16 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')]} 08:19:16 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:19:18 INFO - Downloaded 59338985 bytes. 08:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:18 INFO - mkdir: /builds/slave/test/properties 08:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:18 INFO - Contents: 08:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:19 INFO - Running post-action listener: _resource_record_post_action 08:19:19 INFO - Running post-action listener: set_extra_try_arguments 08:19:19 INFO - ##### 08:19:19 INFO - ##### Finished download-and-extract step (success) 08:19:19 INFO - ##### 08:19:19 INFO - ##### 08:19:19 INFO - ##### Running populate-webroot step. 08:19:19 INFO - ##### 08:19:19 INFO - Running pre-action listener: _resource_record_pre_action 08:19:19 INFO - Running main action method: populate_webroot 08:19:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:19 INFO - '--tppagecycles', 08:19:19 INFO - '7'], 08:19:19 INFO - 'tests': ['tsvgm']}}, 08:19:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:19:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:19:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['damp', 'tps']}, 08:19:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'tests': ['damp', 'tps']}, 08:19:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['dromaeo_dom']}, 08:19:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tsvgx', 08:19:19 INFO - 'tsvgr_opacity', 08:19:19 INFO - 'tart', 08:19:19 INFO - 'tscrollx', 08:19:19 INFO - 'cart']}, 08:19:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:19:19 INFO - 'tsvgr_opacity', 08:19:19 INFO - 'tart', 08:19:19 INFO - 'tscrollx', 08:19:19 INFO - 'cart']}, 08:19:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tp5o']}, 08:19:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'tests': ['tp5o']}, 08:19:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s', 08:19:19 INFO - '--xperf_path', 08:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:19 INFO - 'tests': ['tp5n']}, 08:19:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:19 INFO - 'talos_options': ['--xperf_path', 08:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:19 INFO - 'tests': ['tp5n']}}, 08:19:19 INFO - 'talos.zip': {'path': '', 08:19:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:19 INFO - Running post-action listener: _resource_record_post_action 08:19:19 INFO - ##### 08:19:19 INFO - ##### Finished populate-webroot step (success) 08:19:19 INFO - ##### 08:19:19 INFO - ##### 08:19:19 INFO - ##### Running create-virtualenv step. 08:19:19 INFO - ##### 08:19:19 INFO - Running pre-action listener: _resource_record_pre_action 08:19:19 INFO - Running main action method: create_virtualenv 08:19:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:19 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 08:19:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:19 INFO - Using real prefix '/usr' 08:19:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:21 INFO - Installing pip.................done. 08:19:21 INFO - Return code: 0 08:19:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19: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', 'pip>=1.5'] in /builds/slave/test/build 08:19: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 pip>=1.5 08:19:21 INFO - Using env: {'DISPLAY': ':0', 08:19:21 INFO - 'HOME': '/home/cltbld', 08:19:21 INFO - 'LANG': 'en_US.UTF-8', 08:19:21 INFO - 'LANGUAGE': 'en_US:en', 08:19:21 INFO - 'LOGNAME': 'cltbld', 08:19:21 INFO - 'MAIL': '/var/mail/cltbld', 08:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:21 INFO - 'MOZ_NO_REMOTE': '1', 08:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:21 INFO - 'NO_EM_RESTART': '1', 08:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:21 INFO - 'PWD': '/builds/slave/test', 08:19:21 INFO - 'SHELL': '/bin/bash', 08:19:21 INFO - 'SHLVL': '1', 08:19:21 INFO - 'TERM': 'linux', 08:19:21 INFO - 'TMOUT': '86400', 08:19:21 INFO - 'USER': 'cltbld', 08:19:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:21 INFO - '_': '/tools/buildbot/bin/python'} 08:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:21 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 08:19:21 INFO - Cleaning up... 08:19:21 INFO - Return code: 0 08:19:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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', '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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:19: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 psutil>=3.1.1 08:19:21 INFO - Using env: {'DISPLAY': ':0', 08:19:21 INFO - 'HOME': '/home/cltbld', 08:19:21 INFO - 'LANG': 'en_US.UTF-8', 08:19:21 INFO - 'LANGUAGE': 'en_US:en', 08:19:21 INFO - 'LOGNAME': 'cltbld', 08:19:21 INFO - 'MAIL': '/var/mail/cltbld', 08:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:21 INFO - 'MOZ_NO_REMOTE': '1', 08:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:21 INFO - 'NO_EM_RESTART': '1', 08:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:21 INFO - 'PWD': '/builds/slave/test', 08:19:21 INFO - 'SHELL': '/bin/bash', 08:19:21 INFO - 'SHLVL': '1', 08:19:21 INFO - 'TERM': 'linux', 08:19:21 INFO - 'TMOUT': '86400', 08:19:21 INFO - 'USER': 'cltbld', 08:19:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:21 INFO - '_': '/tools/buildbot/bin/python'} 08:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:22 INFO - Downloading/unpacking psutil>=3.1.1 08:19:22 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 08:19:22 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 08:19:22 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 08:19:22 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 08:19:22 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 08:19:22 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 08:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:24 INFO - Installing collected packages: psutil 08:19:24 INFO - Running setup.py install for psutil 08:19:24 INFO - building 'psutil._psutil_linux' extension 08:19:24 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 08:19:24 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 08:19:24 INFO - building 'psutil._psutil_posix' extension 08:19:24 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 08:19:24 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 08:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:24 INFO - Successfully installed psutil 08:19:24 INFO - Cleaning up... 08:19:24 INFO - Return code: 0 08:19:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:24 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')]} 08:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:24 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')]} 08:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:24 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:24 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 08:19:24 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 08:19:24 INFO - Using env: {'DISPLAY': ':0', 08:19:24 INFO - 'HOME': '/home/cltbld', 08:19:24 INFO - 'LANG': 'en_US.UTF-8', 08:19:24 INFO - 'LANGUAGE': 'en_US:en', 08:19:24 INFO - 'LOGNAME': 'cltbld', 08:19:24 INFO - 'MAIL': '/var/mail/cltbld', 08:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:24 INFO - 'MOZ_NO_REMOTE': '1', 08:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:24 INFO - 'NO_EM_RESTART': '1', 08:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:24 INFO - 'PWD': '/builds/slave/test', 08:19:24 INFO - 'SHELL': '/bin/bash', 08:19:24 INFO - 'SHLVL': '1', 08:19:24 INFO - 'TERM': 'linux', 08:19:24 INFO - 'TMOUT': '86400', 08:19:24 INFO - 'USER': 'cltbld', 08:19:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:24 INFO - '_': '/tools/buildbot/bin/python'} 08:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:26 INFO - Installing collected packages: mozsystemmonitor 08:19:26 INFO - Running setup.py install for mozsystemmonitor 08:19:26 INFO - Successfully installed mozsystemmonitor 08:19:26 INFO - Cleaning up... 08:19:26 INFO - Return code: 0 08:19:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:26 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')]} 08:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:26 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')]} 08:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:26 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:26 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 08:19:26 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 08:19:26 INFO - Using env: {'DISPLAY': ':0', 08:19:26 INFO - 'HOME': '/home/cltbld', 08:19:26 INFO - 'LANG': 'en_US.UTF-8', 08:19:26 INFO - 'LANGUAGE': 'en_US:en', 08:19:26 INFO - 'LOGNAME': 'cltbld', 08:19:26 INFO - 'MAIL': '/var/mail/cltbld', 08:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:26 INFO - 'MOZ_NO_REMOTE': '1', 08:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:26 INFO - 'NO_EM_RESTART': '1', 08:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:26 INFO - 'PWD': '/builds/slave/test', 08:19:26 INFO - 'SHELL': '/bin/bash', 08:19:26 INFO - 'SHLVL': '1', 08:19:26 INFO - 'TERM': 'linux', 08:19:26 INFO - 'TMOUT': '86400', 08:19:26 INFO - 'USER': 'cltbld', 08:19:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:26 INFO - '_': '/tools/buildbot/bin/python'} 08:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:27 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 08:19:27 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 08:19:27 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 08:19:27 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 08:19:27 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 08:19:27 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 08:19:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:29 INFO - warning: no files found matching '*.txt' 08:19:29 INFO - no previously-included directories found matching 'build' 08:19:29 INFO - no previously-included directories found matching 'dist' 08:19:29 INFO - no previously-included directories found matching '.git*' 08:19:29 INFO - Installing collected packages: jsonschema, functools32 08:19:29 INFO - Running setup.py install for functools32 08:19:29 INFO - warning: no files found matching '*.txt' 08:19:29 INFO - no previously-included directories found matching 'build' 08:19:29 INFO - no previously-included directories found matching 'dist' 08:19:29 INFO - no previously-included directories found matching '.git*' 08:19:29 INFO - Successfully installed jsonschema functools32 08:19:29 INFO - Cleaning up... 08:19:29 INFO - Return code: 0 08:19:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:29 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')]} 08:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:29 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')]} 08:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:29 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:29 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 08:19:29 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 08:19:29 INFO - Using env: {'DISPLAY': ':0', 08:19:29 INFO - 'HOME': '/home/cltbld', 08:19:29 INFO - 'LANG': 'en_US.UTF-8', 08:19:29 INFO - 'LANGUAGE': 'en_US:en', 08:19:29 INFO - 'LOGNAME': 'cltbld', 08:19:29 INFO - 'MAIL': '/var/mail/cltbld', 08:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:29 INFO - 'MOZ_NO_REMOTE': '1', 08:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:29 INFO - 'NO_EM_RESTART': '1', 08:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:29 INFO - 'PWD': '/builds/slave/test', 08:19:29 INFO - 'SHELL': '/bin/bash', 08:19:29 INFO - 'SHLVL': '1', 08:19:29 INFO - 'TERM': 'linux', 08:19:29 INFO - 'TMOUT': '86400', 08:19:29 INFO - 'USER': 'cltbld', 08:19:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:29 INFO - '_': '/tools/buildbot/bin/python'} 08:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 INFO - Downloading docopt-0.6.1.tar.gz 08:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:32 INFO - Running setup.py install for blobuploader 08:19:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:32 INFO - Running setup.py install for requests 08:19:32 INFO - Running setup.py install for docopt 08:19:32 INFO - Successfully installed blobuploader requests docopt 08:19:32 INFO - Cleaning up... 08:19:32 INFO - Return code: 0 08:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:32 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')]} 08:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:32 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')]} 08:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:32 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:32 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 08:19:32 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 08:19:32 INFO - Using env: {'DISPLAY': ':0', 08:19:32 INFO - 'HOME': '/home/cltbld', 08:19:32 INFO - 'LANG': 'en_US.UTF-8', 08:19:32 INFO - 'LANGUAGE': 'en_US:en', 08:19:32 INFO - 'LOGNAME': 'cltbld', 08:19:32 INFO - 'MAIL': '/var/mail/cltbld', 08:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:32 INFO - 'MOZ_NO_REMOTE': '1', 08:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:32 INFO - 'NO_EM_RESTART': '1', 08:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:32 INFO - 'PWD': '/builds/slave/test', 08:19:32 INFO - 'SHELL': '/bin/bash', 08:19:32 INFO - 'SHLVL': '1', 08:19:32 INFO - 'TERM': 'linux', 08:19:32 INFO - 'TMOUT': '86400', 08:19:32 INFO - 'USER': 'cltbld', 08:19:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:32 INFO - '_': '/tools/buildbot/bin/python'} 08:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:33 INFO - Running setup.py (path:/tmp/pip-t7G627-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:33 INFO - Running setup.py (path:/tmp/pip-dn4CB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:33 INFO - Running setup.py (path:/tmp/pip-TD1ZY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:33 INFO - Running setup.py (path:/tmp/pip-OrrgY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:33 INFO - Running setup.py (path:/tmp/pip-vMyckZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:33 INFO - Running setup.py (path:/tmp/pip-qnvu5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:33 INFO - Running setup.py (path:/tmp/pip-jAgLQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:33 INFO - Running setup.py (path:/tmp/pip-0eoLNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:33 INFO - Running setup.py (path:/tmp/pip-mGs2fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:33 INFO - Running setup.py (path:/tmp/pip-GpC2zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:33 INFO - Running setup.py (path:/tmp/pip-U8dNEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:33 INFO - Running setup.py (path:/tmp/pip-EA1pTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:34 INFO - Running setup.py (path:/tmp/pip-lKHyDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:34 INFO - Running setup.py (path:/tmp/pip-Z9dk6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:34 INFO - Running setup.py (path:/tmp/pip-6lbvJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:34 INFO - Running setup.py (path:/tmp/pip-7ITJ0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:34 INFO - Running setup.py (path:/tmp/pip-9asyyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:34 INFO - Running setup.py install for manifestparser 08:19:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:34 INFO - Running setup.py install for mozcrash 08:19:34 INFO - Running setup.py install for mozdebug 08:19:34 INFO - Running setup.py install for mozdevice 08:19:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:34 INFO - Running setup.py install for mozfile 08:19:34 INFO - Running setup.py install for mozhttpd 08:19:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for mozinfo 08:19:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for mozInstall 08:19:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for mozleak 08:19:35 INFO - Running setup.py install for mozlog 08:19:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for moznetwork 08:19:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for mozprocess 08:19:35 INFO - Running setup.py install for mozprofile 08:19:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for mozrunner 08:19:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:35 INFO - Running setup.py install for mozscreenshot 08:19:35 INFO - Running setup.py install for moztest 08:19:36 INFO - Running setup.py install for mozversion 08:19:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:36 INFO - Cleaning up... 08:19:36 INFO - Return code: 0 08:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:36 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')]} 08:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:36 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')]} 08:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:36 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:36 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 08:19:36 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 08:19:36 INFO - Using env: {'DISPLAY': ':0', 08:19:36 INFO - 'HOME': '/home/cltbld', 08:19:36 INFO - 'LANG': 'en_US.UTF-8', 08:19:36 INFO - 'LANGUAGE': 'en_US:en', 08:19:36 INFO - 'LOGNAME': 'cltbld', 08:19:36 INFO - 'MAIL': '/var/mail/cltbld', 08:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:36 INFO - 'MOZ_NO_REMOTE': '1', 08:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:36 INFO - 'NO_EM_RESTART': '1', 08:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:36 INFO - 'PWD': '/builds/slave/test', 08:19:36 INFO - 'SHELL': '/bin/bash', 08:19:36 INFO - 'SHLVL': '1', 08:19:36 INFO - 'TERM': 'linux', 08:19:36 INFO - 'TMOUT': '86400', 08:19:36 INFO - 'USER': 'cltbld', 08:19:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:36 INFO - '_': '/tools/buildbot/bin/python'} 08:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:36 INFO - Running setup.py (path:/tmp/pip-mpch_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:36 INFO - Running setup.py (path:/tmp/pip-jiEYO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:36 INFO - Running setup.py (path:/tmp/pip-zj41be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:36 INFO - Running setup.py (path:/tmp/pip-goUZIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:36 INFO - Running setup.py (path:/tmp/pip-vUpx4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:36 INFO - Running setup.py (path:/tmp/pip-LSevCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:36 INFO - Running setup.py (path:/tmp/pip-QkQ411-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:36 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)) 08:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:36 INFO - Running setup.py (path:/tmp/pip-yvEkr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:37 INFO - Running setup.py (path:/tmp/pip-SGcX7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:37 INFO - Running setup.py (path:/tmp/pip-HvRerv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:37 INFO - Running setup.py (path:/tmp/pip-KYdCwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:37 INFO - Running setup.py (path:/tmp/pip-fKTKX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:37 INFO - Running setup.py (path:/tmp/pip-9dFc0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:37 INFO - Running setup.py (path:/tmp/pip-7Cr4io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:37 INFO - Running setup.py (path:/tmp/pip-pB0jo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:37 INFO - Running setup.py (path:/tmp/pip-jxf3yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:37 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)) 08:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:37 INFO - Running setup.py (path:/tmp/pip-qLTP2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:37 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)) 08:19:37 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)) 08:19:37 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)) 08:19:37 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)) 08:19:37 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)) 08:19:37 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)) 08:19:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:37 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 08:19:37 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 08:19:37 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 08:19:37 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 08:19:37 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 08:19:37 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 08:19:39 INFO - Downloading blessings-1.6.tar.gz 08:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:39 INFO - Installing collected packages: blessings 08:19:39 INFO - Running setup.py install for blessings 08:19:39 INFO - Successfully installed blessings 08:19:39 INFO - Cleaning up... 08:19:39 INFO - Return code: 0 08:19:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:40 INFO - Reading from file tmpfile_stdout 08:19:40 INFO - Current package versions: 08:19:40 INFO - argparse == 1.2.1 08:19:40 INFO - blessings == 1.6 08:19:40 INFO - blobuploader == 1.2.4 08:19:40 INFO - docopt == 0.6.1 08:19:40 INFO - functools32 == 3.2.3-2 08:19:40 INFO - jsonschema == 2.5.1 08:19:40 INFO - manifestparser == 1.1 08:19:40 INFO - mozInstall == 1.12 08:19:40 INFO - mozcrash == 0.17 08:19:40 INFO - mozdebug == 0.1 08:19:40 INFO - mozdevice == 0.48 08:19:40 INFO - mozfile == 1.2 08:19:40 INFO - mozhttpd == 0.7 08:19:40 INFO - mozinfo == 0.9 08:19:40 INFO - mozleak == 0.1 08:19:40 INFO - mozlog == 3.2 08:19:40 INFO - moznetwork == 0.27 08:19:40 INFO - mozprocess == 0.22 08:19:40 INFO - mozprofile == 0.28 08:19:40 INFO - mozrunner == 6.11 08:19:40 INFO - mozscreenshot == 0.1 08:19:40 INFO - mozsystemmonitor == 0.3 08:19:40 INFO - moztest == 0.7 08:19:40 INFO - mozversion == 1.4 08:19:40 INFO - psutil == 3.1.1 08:19:40 INFO - requests == 1.2.3 08:19:40 INFO - wsgiref == 0.1.2 08:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:40 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')]} 08:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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')]} 08:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:40 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 08:19:40 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 08:19:40 INFO - Using env: {'DISPLAY': ':0', 08:19:40 INFO - 'HOME': '/home/cltbld', 08:19:40 INFO - 'LANG': 'en_US.UTF-8', 08:19:40 INFO - 'LANGUAGE': 'en_US:en', 08:19:40 INFO - 'LOGNAME': 'cltbld', 08:19:40 INFO - 'MAIL': '/var/mail/cltbld', 08:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:40 INFO - 'MOZ_NO_REMOTE': '1', 08:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:40 INFO - 'NO_EM_RESTART': '1', 08:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:40 INFO - 'PWD': '/builds/slave/test', 08:19:40 INFO - 'SHELL': '/bin/bash', 08:19:40 INFO - 'SHLVL': '1', 08:19:40 INFO - 'TERM': 'linux', 08:19:40 INFO - 'TMOUT': '86400', 08:19:40 INFO - 'USER': 'cltbld', 08:19:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:40 INFO - '_': '/tools/buildbot/bin/python'} 08:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 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)) 08:19:40 INFO - Cleaning up... 08:19:40 INFO - Return code: 0 08:19:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19:40 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')]} 08:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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')]} 08:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:40 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 08:19:40 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 08:19:40 INFO - Using env: {'DISPLAY': ':0', 08:19:40 INFO - 'HOME': '/home/cltbld', 08:19:40 INFO - 'LANG': 'en_US.UTF-8', 08:19:40 INFO - 'LANGUAGE': 'en_US:en', 08:19:40 INFO - 'LOGNAME': 'cltbld', 08:19:40 INFO - 'MAIL': '/var/mail/cltbld', 08:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:40 INFO - 'MOZ_NO_REMOTE': '1', 08:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:40 INFO - 'NO_EM_RESTART': '1', 08:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:40 INFO - 'PWD': '/builds/slave/test', 08:19:40 INFO - 'SHELL': '/bin/bash', 08:19:40 INFO - 'SHLVL': '1', 08:19:40 INFO - 'TERM': 'linux', 08:19:40 INFO - 'TMOUT': '86400', 08:19:40 INFO - 'USER': 'cltbld', 08:19:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:40 INFO - '_': '/tools/buildbot/bin/python'} 08:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:40 INFO - Cleaning up... 08:19:40 INFO - Return code: 0 08:19:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:19:40 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')]} 08:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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')]} 08:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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 0x7f29e9842f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1571350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, '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': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', '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 08:19:40 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 08:19:40 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 08:19:40 INFO - Using env: {'DISPLAY': ':0', 08:19:40 INFO - 'HOME': '/home/cltbld', 08:19:40 INFO - 'LANG': 'en_US.UTF-8', 08:19:40 INFO - 'LANGUAGE': 'en_US:en', 08:19:40 INFO - 'LOGNAME': 'cltbld', 08:19:40 INFO - 'MAIL': '/var/mail/cltbld', 08:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:40 INFO - 'MOZ_NO_REMOTE': '1', 08:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:40 INFO - 'NO_EM_RESTART': '1', 08:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:40 INFO - 'PWD': '/builds/slave/test', 08:19:40 INFO - 'SHELL': '/bin/bash', 08:19:40 INFO - 'SHLVL': '1', 08:19:40 INFO - 'TERM': 'linux', 08:19:40 INFO - 'TMOUT': '86400', 08:19:40 INFO - 'USER': 'cltbld', 08:19:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:40 INFO - '_': '/tools/buildbot/bin/python'} 08:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:40 INFO - Downloading/unpacking flake8 08:19:40 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 08:19:40 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 08:19:40 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 08:19:40 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 08:19:40 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 08:19:40 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 08:19:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:42 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 08:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:43 INFO - no previously-included directories found matching 'docs/_build' 08:19:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:43 INFO - Running setup.py install for pep8 08:19:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:43 INFO - no previously-included directories found matching 'docs/_build' 08:19:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:19:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:43 INFO - Cleaning up... 08:19:43 INFO - Return code: 0 08:19:43 INFO - Running post-action listener: _resource_record_post_action 08:19:43 INFO - Running post-action listener: _start_resource_monitoring 08:19:43 INFO - Starting resource monitoring. 08:19:43 INFO - ##### 08:19:43 INFO - ##### Finished create-virtualenv step (success) 08:19:43 INFO - ##### 08:19:43 INFO - ##### 08:19:43 INFO - ##### Running install step. 08:19:43 INFO - ##### 08:19:43 INFO - Running pre-action listener: _resource_record_pre_action 08:19:43 INFO - Running main action method: install 08:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:43 INFO - Reading from file tmpfile_stdout 08:19:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:43 INFO - Reading from file tmpfile_stdout 08:19:43 INFO - Output received: 08:19:43 INFO - Usage: mozinstall [options] installer 08:19:43 INFO - Options: 08:19:43 INFO - -h, --help show this help message and exit 08:19:43 INFO - -d DEST, --destination=DEST 08:19:43 INFO - Directory to install application into. [default: 08:19:43 INFO - "/builds/slave/test"] 08:19:43 INFO - --app=APP Application being installed. [default: firefox] 08:19:43 INFO - mkdir: /builds/slave/test/build/application 08:19:43 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'] 08:19:43 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 08:20:00 INFO - Reading from file tmpfile_stdout 08:20:00 INFO - Output received: 08:20:00 INFO - /builds/slave/test/build/application/firefox/firefox 08:20:00 INFO - Running post-action listener: _resource_record_post_action 08:20:00 INFO - ##### 08:20:00 INFO - ##### Finished install step (success) 08:20:00 INFO - ##### 08:20:00 INFO - ##### 08:20:00 INFO - ##### Running run-tests step. 08:20:00 INFO - ##### 08:20:00 INFO - Running pre-action listener: _resource_record_pre_action 08:20:00 INFO - Running main action method: run_tests 08:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:20:00 INFO - Python 2.7.3 08:20:00 INFO - Return code: 0 08:20:00 INFO - grabbing minidump binary from tooltool 08:20:00 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')]} 08:20:00 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 0x16001c0>, '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 0x16010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1601550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:20:00 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 08:20:00 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 08:20:00 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 08:20:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:00 INFO - Return code: 0 08:20:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:20:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:20:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:20:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:20:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:20:01 INFO - Return code: 0 08:20:01 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:20:01 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:20:01 INFO - Using env: {'DISPLAY': ':0', 08:20:01 INFO - 'HOME': '/home/cltbld', 08:20:01 INFO - 'LANG': 'en_US.UTF-8', 08:20:01 INFO - 'LANGUAGE': 'en_US:en', 08:20:01 INFO - 'LOGNAME': 'cltbld', 08:20:01 INFO - 'MAIL': '/var/mail/cltbld', 08:20:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:20:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:01 INFO - 'MOZ_NO_REMOTE': '1', 08:20:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:01 INFO - 'NO_EM_RESTART': '1', 08:20:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:01 INFO - 'PWD': '/builds/slave/test', 08:20:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:20:01 INFO - 'SHELL': '/bin/bash', 08:20:01 INFO - 'SHLVL': '1', 08:20:01 INFO - 'TERM': 'linux', 08:20:01 INFO - 'TMOUT': '86400', 08:20:01 INFO - 'USER': 'cltbld', 08:20:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465732130.390052-722053112', 08:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:01 INFO - '_': '/tools/buildbot/bin/python'} 08:20:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:20:01 INFO - mozversion application_buildid: 20160612053002 08:20:01 INFO - mozversion application_changeset: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d 08:20:01 INFO - mozversion application_display_name: Nightly 08:20:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:01 INFO - mozversion application_name: Firefox 08:20:01 INFO - mozversion application_remotingname: firefox 08:20:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:20:01 INFO - mozversion application_vendor: Mozilla 08:20:01 INFO - mozversion application_version: 50.0a1 08:20:01 INFO - mozversion platform_buildid: 20160612053002 08:20:01 INFO - mozversion platform_changeset: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d 08:20:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:20:01 INFO - mozversion platform_version: 50.0a1 08:20:01 INFO - using testdate: 1465744801 08:20:01 INFO - actual date: 1465744801 08:20:01 INFO - starting webserver on 'localhost:51617' 08:20:01 INFO - SUITE-START | Running 2 tests 08:20:01 INFO - TEST-START | dromaeo_css 08:20:01 INFO - operating with platform_type : linux_ 08:20:01 INFO - Initialising browser for dromaeo_css test... 08:20:01 INFO - TEST-INFO | started process 10334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzUY7g/profile http://localhost:51617/getInfo.html) 08:20:06 INFO - PROCESS | 10334 | __metrics Screen width/height:1600/1200 08:20:06 INFO - PROCESS | 10334 | colorDepth:24 08:20:06 INFO - PROCESS | 10334 | Browser inner width/height: 1024/697 08:20:06 INFO - PROCESS | 10334 | __metrics 08:20:07 ERROR - PROCESS | 10334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:20:08 INFO - TEST-INFO | 10334: exit 0 08:20:08 INFO - Browser initialized. 08:20:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:20:08 INFO - TEST-INFO | started process 10456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzUY7g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:20 INFO - PROCESS | 10456 | RSS: Main: 184655872 08:20:20 INFO - PROCESS | 10456 | 08:21:10 INFO - PROCESS | 10456 | 1465744870204 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] 08:23:18 INFO - PROCESS | 10456 | Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51617/tests/dromaeo/cssquery-ext.html) 08:23:19 INFO - PROCESS | 10456 | RSS: Main: 188891136 08:23:19 INFO - PROCESS | 10456 | 08:26:21 INFO - PROCESS | 10456 | Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-ext.html (next: http://localhost:51617/tests/dromaeo/cssquery-jquery.html) 08:26:21 INFO - PROCESS | 10456 | RSS: Main: 188149760 08:26:21 INFO - PROCESS | 10456 | 08:29:23 INFO - PROCESS | 10456 | Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51617/tests/dromaeo/cssquery-mootools.html) 08:29:24 INFO - PROCESS | 10456 | RSS: Main: 189263872 08:29:24 INFO - PROCESS | 10456 | 08:32:26 INFO - PROCESS | 10456 | Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51617/tests/dromaeo/cssquery-prototype.html) 08:32:26 INFO - PROCESS | 10456 | RSS: Main: 186920960 08:32:26 INFO - PROCESS | 10456 | 08:35:29 INFO - PROCESS | 10456 | Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51617/tests/dromaeo/cssquery-yui.html) 08:35:29 INFO - PROCESS | 10456 | RSS: Main: 188661760 08:35:29 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | Cycle 1(1): loaded http://localhost:51617/tests/dromaeo/cssquery-yui.html (next: http://localhost:51617/tests/dromaeo/cssquery-dojo.html) 08:38:32 INFO - PROCESS | 10456 | RSS: Main: 189743104 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | __start_tp_report 08:38:32 INFO - PROCESS | 10456 | _x_x_mozilla_page_load 08:38:32 INFO - PROCESS | 10456 | _x_x_mozilla_page_load_details 08:38:32 INFO - PROCESS | 10456 | |i|pagename|runs| 08:38:32 INFO - PROCESS | 10456 | |0;dojo.html;3043.5586839908215;3096.53551967205;3106.130283520614;3114.268146985459;3128.5150801625755;5302.8144014959435;5303.257543943851;5346.144616861303;5367.087595108831;5389.892202155965;5166.5866730661555;5263.631545791796;5306.151015837457;5309.707966061865;5328.573714102872;4762.190427627312;4839.05638400512;4899.118158731427;5007.949920500803;5029.547340739333;760.3152526657392;4835;4934.728589927553;4935.0376676548085;4978.103941290567;4912.336834527328;4923.335349727795;4935.1116798976345;4940.752962351886;4951.43058548268;4759.405074365704;4943.6539442239055;4951.653384263103;4963.6277279204205;4986.950130498685;4738.64460165489;4749.382580264578;4770.475247722748;4776.450708168571;4799.904001919942;5218.739063046871;5259.3951695555115;5260.447652996419;5272.525472707474;5289.365276166846;5523.502884740353;5557.444255574451;5583.302087239095;5595.356533998602;5598.272224610774;5689.089745640677;5691.402402747734;5697.9715101424645;5717.628354157008;5723.055695810186;5258.1849813279005;5331.786728530854;5336.439673834269;5350.491703288181;5397.8110766123;5616.438356164433;5667;5727.5990680652785;5742.655440673573;5817.621854579439;5513.917291240635;5544.500994910478;5549.084401073777;5550.250716153268;5553.527950124204;5596.720163991784;5617.38208797032;5621.690807005654;5626;5627.549796016309;5458.836234912959;5478.616496845262;5523.751431185526;5555.972220138873;5646;5532.280803495601;5606.6916319602815;5615.213870058195;5670;5683.914741278884;4269.615734583902;4327.459067616548;4331.913361732811;4332.848350307724;4356.150550642595;3751.2872554214614;3807.790571518593;3808.0479880029993;3859.6526312632;3871;5410.48600382963;5435.402105768362;5440.401555828856;5452.6183167177915;5485.424030476823;5569;5667.518260947783;5678.063119585305;5712.600117991784;5715.914261286084;5408.675479471244;5446.2375267462585;5446.782128714886;5470.042742520043;5497.8075767347955;4883.072216278895;4930.975345123323;4943.703377797272;4968.577670897942;4981.576565991932;5695;5823.854403639858;5955.315138759098;5955.7617695292565;5959.344472108065;5655.4344565543115;5730.627509212055;5732.34078081026;5743.224664670216;5752.511036561939;5911.586188966903;5983.760649573968;5989.3112292085225;5990.760369585168;5996.070609055603;5438.864028399322;5554.777808887599;5591.832245032656;5653;5657.2928383952;5722.313322401338;5759.337676167294;5761.02062649359;5766.192733017465;5797.826065218051;5574.693391863487;5580.274564306615;5586.301712285965;5594.356648985418;5601.103823388238;5330.8933821324135;5460.645058071213;5463.153211252262;5500.80747173847;5586;5299.993001329735;5417.620766546304;5446.1558458439;5466.617336786546;5486.259354987185;5590.804321848878;5608.411116832837;5611.214429979725;5612.7193640317;5617.859553511195;5299.973500132629;5354.518093371616;5378.462153784591;5471.343438787371;5502 08:38:32 INFO - PROCESS | 10456 | |1;ext.html;569.2116418760016;608.902575587906;609.1776102261947;637.1112298343811;638.6232123047402;42336.153276934485;43616.563834361645;43860.78069609655;44120.11759764803;47635.52364476354;44770.77614611931;45262.09475810482;45277.64167074993;45404.545954540445;45495.317570236475;8913.1086891311;9033;9059;9075.909240907606;9077.773055673628;8834.514101724402;8933.062028487013;8958.37291389603;8959.328050396214;8959.5968181432;8881.777955551099;8934.55327233639;8939.64241430342;8940.955295223515;8960.148785865333;8831.116888311182;8867.113288671113;8875.334349923782;8875.866861997076;8881.467111973303;8721.956390218073;8779.122087791233;8800.119988001212;8805.075467075992;8831.293496520262;42156.578434215575;42203.36694949578;42488.57511424877;42566.36150457746;42640.78679606613;3513.2797776455764;3762.0406796267052;3779.338615742234;4111.465509483748;4208.431861698662;32810.343793124244;32957.3408531828;33215.501767473506;33299.500507492165;34286.48570271448;4007.0984028593625;4083.122128742305;4086.6934979876332;4098.118904435531;4236.449261596003;342827.28586357157;345658;345988;346311.9999999975;346393;58685.41314586885;58866.41133588695;59257.40742592519;59324.11013834796;59510.70244648749;35913.46129808055;38166.80916595399;38419.6158038416;40320.39519407211;62708;17766.20052097633;17947.73078403825;17948.192331345123;17985.7302140468;18065;13587.456501740018;13600.38798254081;13702.177869327872;13728;13848.09987350819;18960.336388226347;18961;19046.619172603423;19081.90459047696;19342.02074422274;6628.734850606018;6960.721571137098;7143.607101609461;7182.42540596751;7270.854582908312;945.7351941456403;1011.4993078426226;1044.5351818440872;1086.9347839129678;1105.867295924494;30981.380372392425;31084.378312434077;31251.84374078115;31376.372472550876;31550.842245788623;1105.2484310668822;1117.6144230240554;1124.1849658997326;1189.3102000839492;1212.3998620682642;16728.41450549225;16757.748633770505;16810.32758689663;16861;17114.400995965083;531626;540616;541058;798461;802561;57925;58694.7065264671;58919.41080589225;59018;59288.40711592915;1346.8989825763108;1347.6496111011209;1352.2022007015908;1352.6753579141132;1354.9187048777105;30479.238019049702;32639;32823;32861.50707739338;33410.16474588155;51965;52170.739146304026;52221.7388913053;52237;52868.471315286355;511255;511352;511734;515424;516796;29100.563491547222;30529.54205686961;30534.236644084074;30548.389032219675;30599.388012240077;47014.76492617515;48603.756981214865;48865.51134488752;49320;49513.75243123761;41419.37870931878;42123;42307.1538569233;42804.78597606992;43244;40803.38794918019;41155.82499102687;41329.58670413258;41428.79285603553;41774;34707.652923471454;39261;41154.1769164621;41713.79143104265;43251.35122973095;34817;37344.62655373412;37499.43750843794;37923;37961.620383796915;27694.44611107726;28004.85997569999;28100.718992810627;28212.71787282101;28353 08:38:32 INFO - PROCESS | 10456 | |2;jquery.html;395.4522985664854;402.4144869215292;404.2823987422325;406.50000499385754;412.5523806669763;18028.18873150708;19686.01569921502;19850.305239316625;19862.503437414052;20764.169433222654;19071.809281907175;19423.708644370345;19599.90200048998;19719.802801971975;19759.308424205155;5628.774849006035;5711.942880571203;5762.53899688026;5839.8540036499;5840.97079514604;5737.454941780545;5767.538596912258;5767.653940763546;5776.682282474462;5781.566382521307;5500.119980803072;5666.235058267122;5692.800751973682;5720.399358067405;5737.196792449061;5595;5622.044252477068;5632.577556683224;5651.2935883014625;5663.2637757091725;5033.597312215051;5103.4896510349035;5128.692278463304;5153.819616313449;5161.329027226474;23527.529449411086;23668;23746.64380034301;23819.285421437384;23858.880705596534;2187.660912558556;2231.7433495148102;2266.331432227497;2584.224732580218;2944.05790147153;14283.357248923823;14548.1998490083;14784.482543111048;14839.925800371037;15053.698926021527;1917.8753381030187;1959.9706004409945;1962;1971.7239586457908;1984.7022946557988;53345;73110;77587.99999999943;79051.6047419765;80458.19541804565;10055.095041446304;10106.545205465625;10316.587336506456;10581.259311848251;10643.94678026605;14113.2237726926;14161.716765664629;14305.070170438888;14343.56969290923;14465.421383144767;7333.963330183315;7954.125046244909;8132.105468398471;8195.918040819635;8198.303144232688;7835.5690437026515;7840.627890119206;7845.764627061198;7943;8050.396220283385;6500.577462464925;6597.175353080865;6671.099401580725;6695.665216739144;6717.865642687118;1906.418542344598;1935.8257756801956;1936.4287535177157;1943.689009758432;1958.990205048994;942.9104235097655;970.9853203402321;988.6984469736656;1027.7944411117805;1081.7169889385677;19831.801681983285;20051.899740501205;20098.296559620634;20446.284380046625;20673.379798606067;977.6969139566758;993.6820217530466;1025.5026312238558;1038.8389799581078;1074.7098283463422;10555;11426.600068997544;11725.941370293094;11767.88232117685;11769.705757356134;417801;423187;425225;427182;427663;75271;77816.2218377809;78203;79656;80468;1012.8757079641445;1019.8215312320315;1024.6516184497307;1026.1226651213105;1046.100353695821;17604.50361719268;17660.823391766433;18087;18105.094745262948;18111.637767244843;38231.808840955615;38790.41814372843;39323.410148848365;40411.595884040784;40869.38695919504;52812.735936320074;52845.471545285596;52855.47144528505;53187.46812531825;53245.46754532405;8349.624266908126;8526.232639062515;8641.956790216009;8728.825423491622;8729.432586881832;13340.066195366619;13792.310384480936;13846.653833653836;14265.358058887583;14489.710205796036;11980.940095299467;12365.814512782496;12428.502859885864;12448.377581121089;12520.812187817008;11599.710007249887;11689.590864319707;11703.882961170279;12142.635720928387;12275.754484910072;11937.641870743892;12089.335086570323;12460.750784984431;12699.36503174856;13000.154989925624;8449.788755281168;8523.445976011539;8690.695825646071;8814.779630509289;8924.375293729636;11351.205415620827;12194.451249693962;12426.689332766391;12539.749205015665;12548.749025019266 08:38:32 INFO - PROCESS | 10456 | |3;mootools.html;1484.9851501484986;1487.9776803347952;1623.8376162383763;1737.9826201737978;1743.3636722596257;7992;8756.562171891404;8761.649534018632;9352.438853668777;9396.0603939606;8777.824443511126;8908.242799362062;9057.320700947423;9060.04869488704;9079.909200907989;2400.7719266669637;2422.8304018718695;2425.5027719317586;2426.4419183587784;2436.9025238990507;2385.1413491143176;2394.0543485323287;2414.4929564791414;2414.9517009659885;2424.5514579802707;2414.408469924871;2414.6619473273668;2423.4910668759494;2447.339218411028;2453.9263822085277;2363.2673871100014;2369.988150059256;2370.0519792083132;2376.417777644471;2377.0372998935372;2278.943026424336;2300.091463871778;2301.1830800065904;2313.7686231376897;2322.790948814598;9063;9118.133777291214;9139.588718507683;9191;9205.079492050741;5280.234366016906;5401.108817045222;5422.701751403672;5426;5429.4570542945785;3456.4815277708294;3569.411047177213;3597.874074407383;3631.2011357501306;3649.3613617617075;1208.480353448017;1210.2556927489618;1218.3116539155349;1233.9814902776466;1234.1299383934304;12805.423755930913;12812.359382030954;12833.614991550268;12861.099723019392;12870.549530766379;4541.477730061085;4714.4342678878065;4717.669763116617;4726.432828060586;4777.163996300634;10791.83812242817;10809.0812280957;10812.78374432507;10826.025657690845;10837.67486975392;5302.628815982845;5304.92042619361;5306.495882891119;5342.572594192533;5356.062689029404;4470.776461176928;4829.082474329866;4948.925766113512;4968.627352948543;4981.42713587942;4107.9114034780805;4114.855980040684;4159.521655009652;4184.430838435586;4205.810738516774;1227.9079069069855;1248.2448118888124;1264.7723409786142;1268.7716211081909;1290.270996886756;911.7447114807865;1006.3861044762689;1007.6372505897871;1027.5632856036304;1030.553163101231;6164.352742962014;6205.720742566596;6215.658138802319;6287.371262873676;6295.150154729145;442.7786106946527;448.32974702819496;449.9482559505699;453.605363333895;454.811253329871;4287.185434767384;4368.628666563378;4375.124975004948;4409.404730361424;4415.470143582791;10774.353538787698;10929.453527323602;10948.945255273831;10963.287386320024;10998;10564.788704225872;10800.351978881135;10821.458927053616;10826.40454774995;10881.510332035077;8300.377471689526;8558;8563.957180214184;8587.355948303777;8619.569021548898;6140.754369825336;6491.545591808528;6520.445762110084;6525.934740652722;6542.771003014872;10426.478676066317;10490.737731556772;10643.94678026605;10645.627403040857;10676.46617669098;10339.327943683636;10630.096441802225;10791.730206744895;10853.457327133454;10872.184586156229;7235.927640723526;7657.693692252247;7889.763307100796;7930.881036784568;8121.228483294078;8868.600912959062;8874.112588741333;8893.199612034949;8986.68546600892;9016.053314401894;7831.451798374287;7946.205379462239;8073.475224110414;8088.092281452511;8132.796680083045;7809.258120478546;7844.6077696113825;7971.92028079735;7989.480683755537;7994.84010319802;7210.567365958059;7258.383037441666;7266.164391095092;7343.4492413068165;7368.226336234832;5333.253344531846;5368.060589396918;5403.783848646168;5417;5512.118061110203;5416.9729151353995;5457.399686034453;5480.451954804487;5508.9724551376985;5603.943960560342 08:38:32 INFO - PROCESS | 10456 | |4;prototype.html;314.9967353977583;315.96524382317943;317.4270441852456;318.1267420929548;318.4474935986064;5561.165825126228;5621.40975197604;5623.971880140603;5635.549156067515;5655;5468.91796623051;5530.400711665521;5543.25166102576;5552.41699621539;5599.160125981105;4129.855455059073;4193;4291.506476755167;4294.699371044028;4317.503487098992;4296.548862369453;4316.6546676265825;4322.4164737760475;4339.327404252346;4359.520452750195;4319.546447622985;4332.458442694663;4344.804483798237;4362.956370436303;4365;4054.797260136996;4276.866630342962;4280.315149576084;4292.30453970683;4358.912821743564;3706.314331848617;3725.5343082114737;3735.570409402926;3742.925141497155;3752.66226039655;5478.58910581704;5498.945010549924;5533.944660553423;5535.501804837544;5554.638948468377;4838.975805120987;4876.975615121937;4918.262260660894;4937.432195297515;4950.529699678525;5805.258422473241;5813.912791308134;5845.970770146122;5851.444112809277;5887.470127688486;4025.295573274665;4049.5747946465785;4068.572799856002;4072.9592704072875;4094.1197642507004;5848.88302233953;5983.611065280743;6034.24571928509;6055.818325450244;6084.756609735606;4103.856365027269;4120.670346372283;4143.606357396043;4146.606072423115;4165.375193720966;4174.645155161785;4203.873883783492;4239.851605193803;4241.748684138187;4248;4753.643476739258;4833.130036593377;4869.342638743795;4910.288008238786;4928.753562321869;5798.246227990334;5819.272590926134;5836.678982655994;5863.2670916135485;5911.083782013795;1427.4432971141264;1430.1562078373809;1432.5917113622568;1438.6547228665254;1448.6740483391152;917.6788124156625;921.7741653294852;924.306769922558;940.9952950235205;980.7352014956065;5562.276904002454;5575.526080283222;5579.9163012554845;5589.552835773128;5592.468715472105;5812.709364531756;5858.648481091148;6006.879862402815;6048.76195807554;6062.727177277033;5332.360116786011;5561.77752889888;5589;5597.720113994284;5649.180868774005;3132.577102091234;3168.287135394518;3170.302533442639;3176.4600017996995;3207.615086189672;5849.473547380756;6119.5410344224365;6141.723622437001;6163.476104531075;6223.813285601439;6068.908966365508;6089.725962331706;6102.199851043953;6124.938750612526;6127.632342059491;6145.754169833157;6156.199694039746;6160.383961603804;6171.9691401543605;6198.0702894566175;5721.57088218377;5958.433948774859;5964.642121472725;5969.970150149222;5983.790567330123;5908.675022873611;5924.696566755307;5952.255968003999;5959.612625179349;6005.90991135142;6010.188624535632;6153.938460615336;6170.197874276315;6182.629042257479;6224.62652240867;4140.855070072533;4154.854580089683;4174.77038762871;4175.749455032707;4178.958210417978;6034;6043.2748070231855;6046.788362407295;6065.60573562717;6086.665233412028;5673.631213971079;5770.819420741544;5788.044972579477;5804.361520232856;5815.354013923739;5617.494425501724;5669.6314739541795;5690.630109042899;5710.428957104256;5744.770209191753;5511.972440137773;5605.663660180402;5703.743331550173;5706.657600543981;5721.313442386941;5877.647341159544;5877.735501902339;5886.793962211302;5898.498627616529;5919.460940155504;5599.692016939108;5760.8271751847515;5792.6966432552335;5809.970950145223;5852.634735027291 08:38:32 INFO - PROCESS | 10456 | |5;yui.html;690.3131384272647;700.4711442860639;707.5365635508743;778.2645400096907;789.1398375770411;15199.772003419957;15648.139352335616;15875.126868022255;16053.839461605381;16068.116253606047;14089.788653170184;14306.427742890271;14457.78313325301;14488.2755862207;14509;797.8045378882182;798.5168972771477;809.4050872608628;816.2205094135116;819.6434550970317;811.813282944923;813.2883726739103;816.5549775372436;817.9918200818005;821.6466919224731;842.0358689300747;848.516345682961;848.7156802471148;849.817289282804;852.1989330029783;843.8312337532487;845.0662018469595;849.7790574450687;852.1904191018496;853.7694822397917;610.5512448350458;616.5591602004544;616.7532986805314;617.0251003414639;619.7397093220858;13456.730865382637;13498.797518037238;13535.59393218205;13573.59279221625;13580.592582222549;14229.928850355682;14353.78469322961;14627.78058329126;14722.263886805724;14870.256487175599;11835.940820295844;12034.277943323428;12195.695107622381;12223.449944752507;12354.011679065654;3788.962110378916;3801.8669346573015;3897.337452633059;3977.5028121484816;3981.7212795104065;77856.61071694661;78161;78845;79017;80117.19882801156;10645.414502202453;10686;10719.624813131659;10876.184286178568;10981.12151027916;21272;21406.57186856254;21436.24973125933;21699;21979.560408792055;8226.712065077812;8509.064002959669;8563.657453701906;8801.163889430494;8844.778880527909;4665.253559430543;4801.207800712913;4879.024195160982;4926.318716237718;4942.20924652054;3327.5507806446303;3428.8285585720614;3437.05480992729;3442.638522955104;3468.8612455501498;573.5497634357093;575.579826726492;579.4784693775636;583.9912401313984;586.7887560478309;517.4515014085082;526.8419474157737;535.3388565122071;570.3554982869414;580.2398857496693;8834.514101724468;8841.60212790426;8892.110788921185;9000.59497322622;9018.549072546346;555.089652969131;557.3840905799115;569.9116636921284;592.3099588978878;602.3133627664466;3962.187751510991;4027.979860100739;4264.637505811978;4338.219120558329;4378.737275763465;94896;96994.51502742582;99159;111590;121430;99600.50199748955;99795.50102249443;100110.4994475023;100378.49810751046;100584.49707751561;85528;87849.56075219711;88489.11510884938;89621.55189224142;90361.54819225862;9388.718338449857;9423.717288481357;9790.559424826042;10095;10173;36526.26947460983;42157.57842421659;49052.75473622609;49301.75349123232;51542;73876.63061684872;74220.25779742349;77162;77475;78693.60653196697;12278.631641050782;12580.370981451073;12774.425150868048;12826.003786090807;13035.543755968874;14561.199134047729;14580.343884525433;14616.269186540418;14950.775738364151;15313.923430382776;13665.521706740217;13688.45246190181;13823;14040.508582199574;14204;12597.622071337875;13022.4139913706;13352.532661356807;13387.933060335026;13750;13358.532451364155;13816.654583635489;13904.443822247402;14043.1574105554;14301.785473217702;10652.57389704403;10974.176936729937;11138.164637652046;11237.438128093727;11491.942540287246;10473.371597704163;10700.250982431155;10735.570577176826;10811.189160812813;10837.783244335227 08:38:32 INFO - PROCESS | 10456 | __end_tp_report 08:38:32 INFO - PROCESS | 10456 | __start_cc_report 08:38:32 INFO - PROCESS | 10456 | _x_x_mozilla_cycle_collect,355 08:38:32 INFO - PROCESS | 10456 | __end_cc_report 08:38:32 INFO - PROCESS | 10456 | __startTimestamp1465745912782__endTimestamp 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | ------- Summary: start ------- 08:38:32 INFO - PROCESS | 10456 | Number of tests: 6 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | [#0] dojo.html Cycles:165 Average:5251.11 Median:5466.62 stddev:687.10 (12.6%) stddev-sans-first:667.02 08:38:32 INFO - PROCESS | 10456 | Values: 3043.6 3096.5 3106.1 3114.3 3128.5 5302.8 5303.3 5346.1 5367.1 5389.9 5166.6 5263.6 5306.2 5309.7 5328.6 4762.2 4839.1 4899.1 5007.9 5029.5 760.3 4835.0 4934.7 4935.0 4978.1 4912.3 4923.3 4935.1 4940.8 4951.4 4759.4 4943.7 4951.7 4963.6 4987.0 4738.6 4749.4 4770.5 4776.5 4799.9 5218.7 5259.4 5260.4 5272.5 5289.4 5523.5 5557.4 5583.3 5595.4 5598.3 5689.1 5691.4 5698.0 5717.6 5723.1 5258.2 5331.8 5336.4 5350.5 5397.8 5616.4 5667.0 5727.6 5742.7 5817.6 5513.9 5544.5 5549.1 5550.3 5553.5 5596.7 5617.4 5621.7 5626.0 5627.5 5458.8 5478.6 5523.8 5556.0 5646.0 5532.3 5606.7 5615.2 5670.0 5683.9 4269.6 4327.5 4331.9 4332.8 4356.2 3751.3 3807.8 3808.0 3859.7 3871.0 5410.5 5435.4 5440.4 5452.6 5485.4 5569.0 5667.5 5678.1 5712.6 5715.9 5408.7 5446.2 5446.8 5470.0 5497.8 4883.1 4931.0 4943.7 4968.6 4981.6 5695.0 5823.9 5955.3 5955.8 5959.3 5655.4 5730.6 5732.3 5743.2 5752.5 5911.6 5983.8 5989.3 5990.8 5996.1 5438.9 5554.8 5591.8 5653.0 5657.3 5722.3 5759.3 5761.0 5766.2 5797.8 5574.7 5580.3 5586.3 5594.4 5601.1 5330.9 5460.6 5463.2 5500.8 5586.0 5300.0 5417.6 5446.2 5466.6 5486.3 5590.8 5608.4 5611.2 5612.7 5617.9 5300.0 5354.5 5378.5 5471.3 5502.0 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | [#1] ext.html Cycles:180 Average:65082.38 Median:22991.22 stddev:139130.45 (605.1%) stddev-sans-first:139436.43 08:38:32 INFO - PROCESS | 10456 | Values: 569.2 608.9 609.2 637.1 638.6 42336.2 43616.6 43860.8 44120.1 47635.5 44770.8 45262.1 45277.6 45404.5 45495.3 8913.1 9033.0 9059.0 9075.9 9077.8 8834.5 8933.1 8958.4 8959.3 8959.6 8881.8 8934.6 8939.6 8941.0 8960.1 8831.1 8867.1 8875.3 8875.9 8881.5 8722.0 8779.1 8800.1 8805.1 8831.3 42156.6 42203.4 42488.6 42566.4 42640.8 3513.3 3762.0 3779.3 4111.5 4208.4 32810.3 32957.3 33215.5 33299.5 34286.5 4007.1 4083.1 4086.7 4098.1 4236.4 342827.3 345658.0 345988.0 346312.0 346393.0 58685.4 58866.4 59257.4 59324.1 59510.7 35913.5 38166.8 38419.6 40320.4 62708.0 17766.2 17947.7 17948.2 17985.7 18065.0 13587.5 13600.4 13702.2 13728.0 13848.1 18960.3 18961.0 19046.6 19081.9 19342.0 6628.7 6960.7 7143.6 7182.4 7270.9 945.7 1011.5 1044.5 1086.9 1105.9 30981.4 31084.4 31251.8 31376.4 31550.8 1105.2 1117.6 1124.2 1189.3 1212.4 16728.4 16757.7 16810.3 16861.0 17114.4 531626.0 540616.0 541058.0 798461.0 802561.0 57925.0 58694.7 58919.4 59018.0 59288.4 1346.9 1347.6 1352.2 1352.7 1354.9 30479.2 32639.0 32823.0 32861.5 33410.2 51965.0 52170.7 52221.7 52237.0 52868.5 511255.0 511352.0 511734.0 515424.0 516796.0 29100.6 30529.5 30534.2 30548.4 30599.4 47014.8 48603.8 48865.5 49320.0 49513.8 41419.4 42123.0 42307.2 42804.8 43244.0 40803.4 41155.8 41329.6 41428.8 41774.0 34707.7 39261.0 41154.2 41713.8 43251.4 34817.0 37344.6 37499.4 37923.0 37961.6 27694.4 28004.9 28100.7 28212.7 28353.0 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | [#2] jquery.html Cycles:180 Average:26662.08 Median:23782.96 stddev:69770.17 (293.4%) stddev-sans-first:69938.02 08:38:32 INFO - PROCESS | 10456 | Values: 395.5 402.4 404.3 406.5 412.6 18028.2 19686.0 19850.3 19862.5 20764.2 19071.8 19423.7 19599.9 19719.8 19759.3 5628.8 5711.9 5762.5 5839.9 5841.0 5737.5 5767.5 5767.7 5776.7 5781.6 5500.1 5666.2 5692.8 5720.4 5737.2 5595.0 5622.0 5632.6 5651.3 5663.3 5033.6 5103.5 5128.7 5153.8 5161.3 23527.5 23668.0 23746.6 23819.3 23858.9 2187.7 2231.7 2266.3 2584.2 2944.1 14283.4 14548.2 14784.5 14839.9 15053.7 1917.9 1960.0 1962.0 1971.7 1984.7 53345.0 73110.0 77588.0 79051.6 80458.2 10055.1 10106.5 10316.6 10581.3 10643.9 14113.2 14161.7 14305.1 14343.6 14465.4 7334.0 7954.1 8132.1 8195.9 8198.3 7835.6 7840.6 7845.8 7943.0 8050.4 6500.6 6597.2 6671.1 6695.7 6717.9 1906.4 1935.8 1936.4 1943.7 1959.0 942.9 971.0 988.7 1027.8 1081.7 19831.8 20051.9 20098.3 20446.3 20673.4 977.7 993.7 1025.5 1038.8 1074.7 10555.0 11426.6 11725.9 11767.9 11769.7 417801.0 423187.0 425225.0 427182.0 427663.0 75271.0 77816.2 78203.0 79656.0 80468.0 1012.9 1019.8 1024.7 1026.1 1046.1 17604.5 17660.8 18087.0 18105.1 18111.6 38231.8 38790.4 39323.4 40411.6 40869.4 52812.7 52845.5 52855.5 53187.5 53245.5 8349.6 8526.2 8642.0 8728.8 8729.4 13340.1 13792.3 13846.7 14265.4 14489.7 11980.9 12365.8 12428.5 12448.4 12520.8 11599.7 11689.6 11703.9 12142.6 12275.8 11937.6 12089.3 12460.8 12699.4 13000.2 8449.8 8523.4 8690.7 8814.8 8924.4 11351.2 12194.5 12426.7 12539.7 12548.7 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | [#3] mootools.html Cycles:180 Average:5984.96 Median:2459.55 stddev:3413.91 (138.8%) stddev-sans-first:3406.74 08:38:32 INFO - PROCESS | 10456 | Values: 1485.0 1488.0 1623.8 1738.0 1743.4 7992.0 8756.6 8761.6 9352.4 9396.1 8777.8 8908.2 9057.3 9060.0 9079.9 2400.8 2422.8 2425.5 2426.4 2436.9 2385.1 2394.1 2414.5 2415.0 2424.6 2414.4 2414.7 2423.5 2447.3 2453.9 2363.3 2370.0 2370.1 2376.4 2377.0 2278.9 2300.1 2301.2 2313.8 2322.8 9063.0 9118.1 9139.6 9191.0 9205.1 5280.2 5401.1 5422.7 5426.0 5429.5 3456.5 3569.4 3597.9 3631.2 3649.4 1208.5 1210.3 1218.3 1234.0 1234.1 12805.4 12812.4 12833.6 12861.1 12870.5 4541.5 4714.4 4717.7 4726.4 4777.2 10791.8 10809.1 10812.8 10826.0 10837.7 5302.6 5304.9 5306.5 5342.6 5356.1 4470.8 4829.1 4948.9 4968.6 4981.4 4107.9 4114.9 4159.5 4184.4 4205.8 1227.9 1248.2 1264.8 1268.8 1290.3 911.7 1006.4 1007.6 1027.6 1030.6 6164.4 6205.7 6215.7 6287.4 6295.2 442.8 448.3 449.9 453.6 454.8 4287.2 4368.6 4375.1 4409.4 4415.5 10774.4 10929.5 10948.9 10963.3 10998.0 10564.8 10800.4 10821.5 10826.4 10881.5 8300.4 8558.0 8564.0 8587.4 8619.6 6140.8 6491.5 6520.4 6525.9 6542.8 10426.5 10490.7 10643.9 10645.6 10676.5 10339.3 10630.1 10791.7 10853.5 10872.2 7235.9 7657.7 7889.8 7930.9 8121.2 8868.6 8874.1 8893.2 8986.7 9016.1 7831.5 7946.2 8073.5 8088.1 8132.8 7809.3 7844.6 7971.9 7989.5 7994.8 7210.6 7258.4 7266.2 7343.4 7368.2 5333.3 5368.1 5403.8 5417.0 5512.1 5417.0 5457.4 5480.5 5509.0 5603.9 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | [#4] prototype.html Cycles:180 Average:4882.39 Median:5599.43 stddev:1461.17 (26.1%) stddev-sans-first:1424.48 08:38:32 INFO - PROCESS | 10456 | Values: 315.0 316.0 317.4 318.1 318.4 5561.2 5621.4 5624.0 5635.5 5655.0 5468.9 5530.4 5543.3 5552.4 5599.2 4129.9 4193.0 4291.5 4294.7 4317.5 4296.5 4316.7 4322.4 4339.3 4359.5 4319.5 4332.5 4344.8 4363.0 4365.0 4054.8 4276.9 4280.3 4292.3 4358.9 3706.3 3725.5 3735.6 3742.9 3752.7 5478.6 5498.9 5533.9 5535.5 5554.6 4839.0 4877.0 4918.3 4937.4 4950.5 5805.3 5813.9 5846.0 5851.4 5887.5 4025.3 4049.6 4068.6 4073.0 4094.1 5848.9 5983.6 6034.2 6055.8 6084.8 4103.9 4120.7 4143.6 4146.6 4165.4 4174.6 4203.9 4239.9 4241.7 4248.0 4753.6 4833.1 4869.3 4910.3 4928.8 5798.2 5819.3 5836.7 5863.3 5911.1 1427.4 1430.2 1432.6 1438.7 1448.7 917.7 921.8 924.3 941.0 980.7 5562.3 5575.5 5579.9 5589.6 5592.5 5812.7 5858.6 6006.9 6048.8 6062.7 5332.4 5561.8 5589.0 5597.7 5649.2 3132.6 3168.3 3170.3 3176.5 3207.6 5849.5 6119.5 6141.7 6163.5 6223.8 6068.9 6089.7 6102.2 6124.9 6127.6 6145.8 6156.2 6160.4 6172.0 6198.1 5721.6 5958.4 5964.6 5970.0 5983.8 5908.7 5924.7 5952.3 5959.6 6005.9 6010.2 6153.9 6170.2 6182.6 6224.6 4140.9 4154.9 4174.8 4175.7 4179.0 6034.0 6043.3 6046.8 6065.6 6086.7 5673.6 5770.8 5788.0 5804.4 5815.4 5617.5 5669.6 5690.6 5710.4 5744.8 5512.0 5605.7 5703.7 5706.7 5721.3 5877.6 5877.7 5886.8 5898.5 5919.5 5599.7 5760.8 5792.7 5810.0 5852.6 08:38:32 INFO - PROCESS | 10456 | 08:38:32 INFO - PROCESS | 10456 | [#5] yui.html Cycles:180 Average:20474.52 Median:23211.11 stddev:29455.81 (126.9%) stddev-sans-first:29500.98 08:38:32 INFO - PROCESS | 10456 | Values: 690.3 700.5 707.5 778.3 789.1 15199.8 15648.1 15875.1 16053.8 16068.1 14089.8 14306.4 14457.8 14488.3 14509.0 797.8 798.5 809.4 816.2 819.6 811.8 813.3 816.6 818.0 821.6 842.0 848.5 848.7 849.8 852.2 843.8 845.1 849.8 852.2 853.8 610.6 616.6 616.8 617.0 619.7 13456.7 13498.8 13535.6 13573.6 13580.6 14229.9 14353.8 14627.8 14722.3 14870.3 11835.9 12034.3 12195.7 12223.4 12354.0 3789.0 3801.9 3897.3 3977.5 3981.7 77856.6 78161.0 78845.0 79017.0 80117.2 10645.4 10686.0 10719.6 10876.2 10981.1 21272.0 21406.6 21436.2 21699.0 21979.6 8226.7 8509.1 8563.7 8801.2 8844.8 4665.3 4801.2 4879.0 4926.3 4942.2 3327.6 3428.8 3437.1 3442.6 3468.9 573.5 575.6 579.5 584.0 586.8 517.5 526.8 535.3 570.4 580.2 8834.5 8841.6 8892.1 9000.6 9018.5 555.1 557.4 569.9 592.3 602.3 3962.2 4028.0 4264.6 4338.2 4378.7 94896.0 96994.5 99159.0 111590.0 121430.0 99600.5 99795.5 100110.5 100378.5 100584.5 85528.0 87849.6 88489.1 89621.6 90361.5 9388.7 9423.7 9790.6 10095.0 10173.0 36526.3 42157.6 49052.8 49301.8 51542.0 73876.6 74220.3 77162.0 77475.0 78693.6 12278.6 12580.4 12774.4 12826.0 13035.5 14561.2 14580.3 14616.3 14950.8 15313.9 13665.5 13688.5 13823.0 14040.5 14204.0 12597.6 13022.4 13352.5 13387.9 13750.0 13358.5 13816.7 13904.4 14043.2 14301.8 10652.6 10974.2 11138.2 11237.4 11491.9 10473.4 10700.3 10735.6 10811.2 10837.8 08:38:32 INFO - PROCESS | 10456 | -------- Summary: end -------- 08:38:32 INFO - PROCESS | 10456 | 08:38:33 INFO - TEST-INFO | 10456: exit 0 08:38:33 INFO - TEST-OK | dromaeo_css | took 1111705ms 08:38:33 INFO - TEST-START | kraken 08:38:33 INFO - operating with platform_type : linux_ 08:38:33 INFO - Initialising browser for kraken test... 08:38:33 INFO - TEST-INFO | started process 10685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8DdKh1/profile http://localhost:51617/getInfo.html) 08:38:38 INFO - PROCESS | 10685 | __metrics Screen width/height:1600/1200 08:38:38 INFO - PROCESS | 10685 | colorDepth:24 08:38:38 INFO - PROCESS | 10685 | Browser inner width/height: 1024/697 08:38:38 INFO - PROCESS | 10685 | __metrics 08:38:39 ERROR - PROCESS | 10685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:38:39 INFO - TEST-INFO | 10685: exit 0 08:38:39 INFO - Browser initialized. 08:38:39 INFO - Running cycle 1/1 for kraken test... 08:38:39 INFO - TEST-INFO | started process 10805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8DdKh1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:51 INFO - PROCESS | 10805 | RSS: Main: 185020416 08:38:51 INFO - PROCESS | 10805 | 08:38:54 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:55 INFO - PROCESS | 10805 | RSS: Main: 191008768 08:38:55 INFO - PROCESS | 10805 | 08:38:58 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-dft) 08:38:58 INFO - PROCESS | 10805 | RSS: Main: 190586880 08:38:58 INFO - PROCESS | 10805 | 08:39:01 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-fft) 08:39:02 INFO - PROCESS | 10805 | RSS: Main: 185311232 08:39:02 INFO - PROCESS | 10805 | 08:39:04 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51617/tests/kraken/driver.html?testName=audio-oscillator) 08:39:04 INFO - PROCESS | 10805 | RSS: Main: 186081280 08:39:04 INFO - PROCESS | 10805 | 08:39:07 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:39:07 INFO - PROCESS | 10805 | RSS: Main: 186163200 08:39:07 INFO - PROCESS | 10805 | 08:39:10 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51617/tests/kraken/driver.html?testName=imaging-darkroom) 08:39:11 INFO - PROCESS | 10805 | RSS: Main: 186355712 08:39:11 INFO - PROCESS | 10805 | 08:39:15 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51617/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:15 INFO - PROCESS | 10805 | RSS: Main: 184143872 08:39:15 INFO - PROCESS | 10805 | 08:39:18 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51617/tests/kraken/driver.html?testName=json-parse-financial) 08:39:19 INFO - PROCESS | 10805 | RSS: Main: 185241600 08:39:19 INFO - PROCESS | 10805 | 08:39:20 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:21 INFO - PROCESS | 10805 | RSS: Main: 185749504 08:39:21 INFO - PROCESS | 10805 | 08:39:23 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:23 INFO - PROCESS | 10805 | RSS: Main: 185786368 08:39:23 INFO - PROCESS | 10805 | 08:39:25 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:26 INFO - PROCESS | 10805 | RSS: Main: 186404864 08:39:26 INFO - PROCESS | 10805 | 08:39:29 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:29 INFO - PROCESS | 10805 | RSS: Main: 186642432 08:39:29 INFO - PROCESS | 10805 | 08:39:32 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:33 INFO - PROCESS | 10805 | RSS: Main: 186314752 08:39:33 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:51617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51617/tests/kraken/driver.html?testName=ai-astar) 08:39:34 INFO - PROCESS | 10805 | RSS: Main: 187658240 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | __start_tp_report 08:39:34 INFO - PROCESS | 10805 | _x_x_mozilla_page_load 08:39:34 INFO - PROCESS | 10805 | _x_x_mozilla_page_load_details 08:39:34 INFO - PROCESS | 10805 | |i|pagename|runs| 08:39:34 INFO - PROCESS | 10805 | |0;ai-astar;113;107;112;112;113;113;111;114;113;112 08:39:34 INFO - PROCESS | 10805 | |1;audio-beat-detection;165;127;153;185;127;165;155;128;186;125 08:39:34 INFO - PROCESS | 10805 | |2;audio-dft;162;162;161;163;166;170;163;161;162;162 08:39:34 INFO - PROCESS | 10805 | |3;audio-fft;75;77;75;163;76;75;76;75;184;75 08:39:34 INFO - PROCESS | 10805 | |4;audio-oscillator;86;85;145;87;85;85;149;85;86;141 08:39:34 INFO - PROCESS | 10805 | |5;imaging-gaussian-blur;119;117;117;117;117;117;118;118;121;117 08:39:34 INFO - PROCESS | 10805 | |6;imaging-darkroom;147;148;148;149;148;146;146;147;147;147 08:39:34 INFO - PROCESS | 10805 | |7;imaging-desaturate;96;96;95;96;95;96;96;95;95;96 08:39:34 INFO - PROCESS | 10805 | |8;json-parse-financial;55;55;53;53;55;52;53;55;52;53 08:39:34 INFO - PROCESS | 10805 | |9;json-stringify-tinderbox;62;61;61;61;62;62;62;61;61;62 08:39:34 INFO - PROCESS | 10805 | |10;stanford-crypto-aes;80;81;80;80;85;86;81;83;103;82 08:39:34 INFO - PROCESS | 10805 | |11;stanford-crypto-ccm;135;132;121;122;137;126;122;124;136;129 08:39:34 INFO - PROCESS | 10805 | |12;stanford-crypto-pbkdf2;158;162;158;162;162;160;160;160;164;161 08:39:34 INFO - PROCESS | 10805 | |13;stanford-crypto-sha256-iterative;65;64;67;63;63;65;65;63;63;61 08:39:34 INFO - PROCESS | 10805 | __end_tp_report 08:39:34 INFO - PROCESS | 10805 | __start_cc_report 08:39:34 INFO - PROCESS | 10805 | _x_x_mozilla_cycle_collect,920 08:39:34 INFO - PROCESS | 10805 | __end_cc_report 08:39:34 INFO - PROCESS | 10805 | __startTimestamp1465745974970__endTimestamp 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | ------- Summary: start ------- 08:39:34 INFO - PROCESS | 10805 | Number of tests: 14 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:1.94 (1.7%) stddev-sans-first:2.03 08:39:34 INFO - PROCESS | 10805 | Values: 113.0 107.0 112.0 112.0 113.0 113.0 111.0 114.0 113.0 112.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:160.00 stddev:23.91 (14.9%) stddev-sans-first:24.87 08:39:34 INFO - PROCESS | 10805 | Values: 165.0 127.0 153.0 185.0 127.0 165.0 155.0 128.0 186.0 125.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.78 (1.7%) stddev-sans-first:2.92 08:39:34 INFO - PROCESS | 10805 | Values: 162.0 162.0 161.0 163.0 166.0 170.0 163.0 161.0 162.0 162.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:41.62 (55.5%) stddev-sans-first:43.51 08:39:34 INFO - PROCESS | 10805 | Values: 75.0 77.0 75.0 163.0 76.0 75.0 76.0 75.0 184.0 75.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:28.78 (33.9%) stddev-sans-first:29.82 08:39:34 INFO - PROCESS | 10805 | Values: 86.0 85.0 145.0 87.0 85.0 85.0 149.0 85.0 86.0 141.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.32 (1.1%) stddev-sans-first:1.32 08:39:34 INFO - PROCESS | 10805 | Values: 119.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 121.0 117.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 08:39:34 INFO - PROCESS | 10805 | Values: 147.0 148.0 148.0 149.0 148.0 146.0 146.0 147.0 147.0 147.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:39:34 INFO - PROCESS | 10805 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.26 (2.3%) stddev-sans-first:1.24 08:39:34 INFO - PROCESS | 10805 | Values: 55.0 55.0 53.0 53.0 55.0 52.0 53.0 55.0 52.0 53.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:39:34 INFO - PROCESS | 10805 | Values: 62.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 62.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.50 stddev:6.97 (8.5%) stddev-sans-first:7.23 08:39:34 INFO - PROCESS | 10805 | Values: 80.0 81.0 80.0 80.0 85.0 86.0 81.0 83.0 103.0 82.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:130.50 stddev:6.24 (4.8%) stddev-sans-first:6.14 08:39:34 INFO - PROCESS | 10805 | Values: 135.0 132.0 121.0 122.0 137.0 126.0 122.0 124.0 136.0 129.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.50 stddev:1.89 (1.2%) stddev-sans-first:1.73 08:39:34 INFO - PROCESS | 10805 | Values: 158.0 162.0 158.0 162.0 162.0 160.0 160.0 160.0 164.0 161.0 08:39:34 INFO - PROCESS | 10805 | 08:39:34 INFO - PROCESS | 10805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.66 (2.6%) stddev-sans-first:1.72 08:39:34 INFO - PROCESS | 10805 | Values: 65.0 64.0 67.0 63.0 63.0 65.0 65.0 63.0 63.0 61.0 08:39:34 INFO - PROCESS | 10805 | -------- Summary: end -------- 08:39:34 INFO - PROCESS | 10805 | 08:39:35 INFO - TEST-INFO | 10805: exit 0 08:39:35 INFO - TEST-OK | kraken | took 62376ms 08:39:35 INFO - SUITE-END | took 1174s 08:39:36 INFO - Completed test suite (00:19:34) 08:39:36 INFO - javascript benchmark 08:39:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7294.861463639842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.5586839908215, 3096.53551967205, 3106.130283520614, 3114.268146985459, 3128.5150801625755, 5302.8144014959435, 5303.257543943851, 5346.144616861303, 5367.087595108831, 5389.892202155965, 5166.5866730661555, 5263.631545791796, 5306.151015837457, 5309.707966061865, 5328.573714102872, 4762.190427627312, 4839.05638400512, 4899.118158731427, 5007.949920500803, 5029.547340739333, 760.3152526657392, 4835.0, 4934.728589927553, 4935.0376676548085, 4978.103941290567, 4912.336834527328, 4923.335349727795, 4935.1116798976345, 4940.752962351886, 4951.43058548268, 4759.405074365704, 4943.6539442239055, 4951.653384263103, 4963.6277279204205, 4986.950130498685, 4738.64460165489, 4749.382580264578, 4770.475247722748, 4776.450708168571, 4799.904001919942, 5218.739063046871, 5259.3951695555115, 5260.447652996419, 5272.525472707474, 5289.365276166846, 5523.502884740353, 5557.444255574451, 5583.302087239095, 5595.356533998602, 5598.272224610774, 5689.089745640677, 5691.402402747734, 5697.9715101424645, 5717.628354157008, 5723.055695810186, 5258.1849813279005, 5331.786728530854, 5336.439673834269, 5350.491703288181, 5397.8110766123, 5616.438356164433, 5667.0, 5727.5990680652785, 5742.655440673573, 5817.621854579439, 5513.917291240635, 5544.500994910478, 5549.084401073777, 5550.250716153268, 5553.527950124204, 5596.720163991784, 5617.38208797032, 5621.690807005654, 5626.0, 5627.549796016309, 5458.836234912959, 5478.616496845262, 5523.751431185526, 5555.972220138873, 5646.0, 5532.280803495601, 5606.6916319602815, 5615.213870058195, 5670.0, 5683.914741278884, 4269.615734583902, 4327.459067616548, 4331.913361732811, 4332.848350307724, 4356.150550642595, 3751.2872554214614, 3807.790571518593, 3808.0479880029993, 3859.6526312632, 3871.0, 5410.48600382963, 5435.402105768362, 5440.401555828856, 5452.6183167177915, 5485.424030476823, 5569.0, 5667.518260947783, 5678.063119585305, 5712.600117991784, 5715.914261286084, 5408.675479471244, 5446.2375267462585, 5446.782128714886, 5470.042742520043, 5497.8075767347955, 4883.072216278895, 4930.975345123323, 4943.703377797272, 4968.577670897942, 4981.576565991932, 5695.0, 5823.854403639858, 5955.315138759098, 5955.7617695292565, 5959.344472108065, 5655.4344565543115, 5730.627509212055, 5732.34078081026, 5743.224664670216, 5752.511036561939, 5911.586188966903, 5983.760649573968, 5989.3112292085225, 5990.760369585168, 5996.070609055603, 5438.864028399322, 5554.777808887599, 5591.832245032656, 5653.0, 5657.2928383952, 5722.313322401338, 5759.337676167294, 5761.02062649359, 5766.192733017465, 5797.826065218051, 5574.693391863487, 5580.274564306615, 5586.301712285965, 5594.356648985418, 5601.103823388238, 5330.8933821324135, 5460.645058071213, 5463.153211252262, 5500.80747173847, 5586.0, 5299.993001329735, 5417.620766546304, 5446.1558458439, 5466.617336786546, 5486.259354987185, 5590.804321848878, 5608.411116832837, 5611.214429979725, 5612.7193640317, 5617.859553511195, 5299.973500132629, 5354.518093371616, 5378.462153784591, 5471.343438787371, 5502.0], "value": 5207.525990019955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2116418760016, 608.902575587906, 609.1776102261947, 637.1112298343811, 638.6232123047402, 42336.153276934485, 43616.563834361645, 43860.78069609655, 44120.11759764803, 47635.52364476354, 44770.77614611931, 45262.09475810482, 45277.64167074993, 45404.545954540445, 45495.317570236475, 8913.1086891311, 9033.0, 9059.0, 9075.909240907606, 9077.773055673628, 8834.514101724402, 8933.062028487013, 8958.37291389603, 8959.328050396214, 8959.5968181432, 8881.777955551099, 8934.55327233639, 8939.64241430342, 8940.955295223515, 8960.148785865333, 8831.116888311182, 8867.113288671113, 8875.334349923782, 8875.866861997076, 8881.467111973303, 8721.956390218073, 8779.122087791233, 8800.119988001212, 8805.075467075992, 8831.293496520262, 42156.578434215575, 42203.36694949578, 42488.57511424877, 42566.36150457746, 42640.78679606613, 3513.2797776455764, 3762.0406796267052, 3779.338615742234, 4111.465509483748, 4208.431861698662, 32810.343793124244, 32957.3408531828, 33215.501767473506, 33299.500507492165, 34286.48570271448, 4007.0984028593625, 4083.122128742305, 4086.6934979876332, 4098.118904435531, 4236.449261596003, 342827.28586357157, 345658.0, 345988.0, 346311.9999999975, 346393.0, 58685.41314586885, 58866.41133588695, 59257.40742592519, 59324.11013834796, 59510.70244648749, 35913.46129808055, 38166.80916595399, 38419.6158038416, 40320.39519407211, 62708.0, 17766.20052097633, 17947.73078403825, 17948.192331345123, 17985.7302140468, 18065.0, 13587.456501740018, 13600.38798254081, 13702.177869327872, 13728.0, 13848.09987350819, 18960.336388226347, 18961.0, 19046.619172603423, 19081.90459047696, 19342.02074422274, 6628.734850606018, 6960.721571137098, 7143.607101609461, 7182.42540596751, 7270.854582908312, 945.7351941456403, 1011.4993078426226, 1044.5351818440872, 1086.9347839129678, 1105.867295924494, 30981.380372392425, 31084.378312434077, 31251.84374078115, 31376.372472550876, 31550.842245788623, 1105.2484310668822, 1117.6144230240554, 1124.1849658997326, 1189.3102000839492, 1212.3998620682642, 16728.41450549225, 16757.748633770505, 16810.32758689663, 16861.0, 17114.400995965083, 531626.0, 540616.0, 541058.0, 798461.0, 802561.0, 57925.0, 58694.7065264671, 58919.41080589225, 59018.0, 59288.40711592915, 1346.8989825763108, 1347.6496111011209, 1352.2022007015908, 1352.6753579141132, 1354.9187048777105, 30479.238019049702, 32639.0, 32823.0, 32861.50707739338, 33410.16474588155, 51965.0, 52170.739146304026, 52221.7388913053, 52237.0, 52868.471315286355, 511255.0, 511352.0, 511734.0, 515424.0, 516796.0, 29100.563491547222, 30529.54205686961, 30534.236644084074, 30548.389032219675, 30599.388012240077, 47014.76492617515, 48603.756981214865, 48865.51134488752, 49320.0, 49513.75243123761, 41419.37870931878, 42123.0, 42307.1538569233, 42804.78597606992, 43244.0, 40803.38794918019, 41155.82499102687, 41329.58670413258, 41428.79285603553, 41774.0, 34707.652923471454, 39261.0, 41154.1769164621, 41713.79143104265, 43251.35122973095, 34817.0, 37344.62655373412, 37499.43750843794, 37923.0, 37961.620383796915, 27694.44611107726, 28004.85997569999, 28100.718992810627, 28212.71787282101, 28353.0], "value": 20381.4126306938, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.4522985664854, 402.4144869215292, 404.2823987422325, 406.50000499385754, 412.5523806669763, 18028.18873150708, 19686.01569921502, 19850.305239316625, 19862.503437414052, 20764.169433222654, 19071.809281907175, 19423.708644370345, 19599.90200048998, 19719.802801971975, 19759.308424205155, 5628.774849006035, 5711.942880571203, 5762.53899688026, 5839.8540036499, 5840.97079514604, 5737.454941780545, 5767.538596912258, 5767.653940763546, 5776.682282474462, 5781.566382521307, 5500.119980803072, 5666.235058267122, 5692.800751973682, 5720.399358067405, 5737.196792449061, 5595.0, 5622.044252477068, 5632.577556683224, 5651.2935883014625, 5663.2637757091725, 5033.597312215051, 5103.4896510349035, 5128.692278463304, 5153.819616313449, 5161.329027226474, 23527.529449411086, 23668.0, 23746.64380034301, 23819.285421437384, 23858.880705596534, 2187.660912558556, 2231.7433495148102, 2266.331432227497, 2584.224732580218, 2944.05790147153, 14283.357248923823, 14548.1998490083, 14784.482543111048, 14839.925800371037, 15053.698926021527, 1917.8753381030187, 1959.9706004409945, 1962.0, 1971.7239586457908, 1984.7022946557988, 53345.0, 73110.0, 77587.99999999943, 79051.6047419765, 80458.19541804565, 10055.095041446304, 10106.545205465625, 10316.587336506456, 10581.259311848251, 10643.94678026605, 14113.2237726926, 14161.716765664629, 14305.070170438888, 14343.56969290923, 14465.421383144767, 7333.963330183315, 7954.125046244909, 8132.105468398471, 8195.918040819635, 8198.303144232688, 7835.5690437026515, 7840.627890119206, 7845.764627061198, 7943.0, 8050.396220283385, 6500.577462464925, 6597.175353080865, 6671.099401580725, 6695.665216739144, 6717.865642687118, 1906.418542344598, 1935.8257756801956, 1936.4287535177157, 1943.689009758432, 1958.990205048994, 942.9104235097655, 970.9853203402321, 988.6984469736656, 1027.7944411117805, 1081.7169889385677, 19831.801681983285, 20051.899740501205, 20098.296559620634, 20446.284380046625, 20673.379798606067, 977.6969139566758, 993.6820217530466, 1025.5026312238558, 1038.8389799581078, 1074.7098283463422, 10555.0, 11426.600068997544, 11725.941370293094, 11767.88232117685, 11769.705757356134, 417801.0, 423187.0, 425225.0, 427182.0, 427663.0, 75271.0, 77816.2218377809, 78203.0, 79656.0, 80468.0, 1012.8757079641445, 1019.8215312320315, 1024.6516184497307, 1026.1226651213105, 1046.100353695821, 17604.50361719268, 17660.823391766433, 18087.0, 18105.094745262948, 18111.637767244843, 38231.808840955615, 38790.41814372843, 39323.410148848365, 40411.595884040784, 40869.38695919504, 52812.735936320074, 52845.471545285596, 52855.47144528505, 53187.46812531825, 53245.46754532405, 8349.624266908126, 8526.232639062515, 8641.956790216009, 8728.825423491622, 8729.432586881832, 13340.066195366619, 13792.310384480936, 13846.653833653836, 14265.358058887583, 14489.710205796036, 11980.940095299467, 12365.814512782496, 12428.502859885864, 12448.377581121089, 12520.812187817008, 11599.710007249887, 11689.590864319707, 11703.882961170279, 12142.635720928387, 12275.754484910072, 11937.641870743892, 12089.335086570323, 12460.750784984431, 12699.36503174856, 13000.154989925624, 8449.788755281168, 8523.445976011539, 8690.695825646071, 8814.779630509289, 8924.375293729636, 11351.205415620827, 12194.451249693962, 12426.689332766391, 12539.749205015665, 12548.749025019266], "value": 9341.208944129967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.9851501484986, 1487.9776803347952, 1623.8376162383763, 1737.9826201737978, 1743.3636722596257, 7992.0, 8756.562171891404, 8761.649534018632, 9352.438853668777, 9396.0603939606, 8777.824443511126, 8908.242799362062, 9057.320700947423, 9060.04869488704, 9079.909200907989, 2400.7719266669637, 2422.8304018718695, 2425.5027719317586, 2426.4419183587784, 2436.9025238990507, 2385.1413491143176, 2394.0543485323287, 2414.4929564791414, 2414.9517009659885, 2424.5514579802707, 2414.408469924871, 2414.6619473273668, 2423.4910668759494, 2447.339218411028, 2453.9263822085277, 2363.2673871100014, 2369.988150059256, 2370.0519792083132, 2376.417777644471, 2377.0372998935372, 2278.943026424336, 2300.091463871778, 2301.1830800065904, 2313.7686231376897, 2322.790948814598, 9063.0, 9118.133777291214, 9139.588718507683, 9191.0, 9205.079492050741, 5280.234366016906, 5401.108817045222, 5422.701751403672, 5426.0, 5429.4570542945785, 3456.4815277708294, 3569.411047177213, 3597.874074407383, 3631.2011357501306, 3649.3613617617075, 1208.480353448017, 1210.2556927489618, 1218.3116539155349, 1233.9814902776466, 1234.1299383934304, 12805.423755930913, 12812.359382030954, 12833.614991550268, 12861.099723019392, 12870.549530766379, 4541.477730061085, 4714.4342678878065, 4717.669763116617, 4726.432828060586, 4777.163996300634, 10791.83812242817, 10809.0812280957, 10812.78374432507, 10826.025657690845, 10837.67486975392, 5302.628815982845, 5304.92042619361, 5306.495882891119, 5342.572594192533, 5356.062689029404, 4470.776461176928, 4829.082474329866, 4948.925766113512, 4968.627352948543, 4981.42713587942, 4107.9114034780805, 4114.855980040684, 4159.521655009652, 4184.430838435586, 4205.810738516774, 1227.9079069069855, 1248.2448118888124, 1264.7723409786142, 1268.7716211081909, 1290.270996886756, 911.7447114807865, 1006.3861044762689, 1007.6372505897871, 1027.5632856036304, 1030.553163101231, 6164.352742962014, 6205.720742566596, 6215.658138802319, 6287.371262873676, 6295.150154729145, 442.7786106946527, 448.32974702819496, 449.9482559505699, 453.605363333895, 454.811253329871, 4287.185434767384, 4368.628666563378, 4375.124975004948, 4409.404730361424, 4415.470143582791, 10774.353538787698, 10929.453527323602, 10948.945255273831, 10963.287386320024, 10998.0, 10564.788704225872, 10800.351978881135, 10821.458927053616, 10826.40454774995, 10881.510332035077, 8300.377471689526, 8558.0, 8563.957180214184, 8587.355948303777, 8619.569021548898, 6140.754369825336, 6491.545591808528, 6520.445762110084, 6525.934740652722, 6542.771003014872, 10426.478676066317, 10490.737731556772, 10643.94678026605, 10645.627403040857, 10676.46617669098, 10339.327943683636, 10630.096441802225, 10791.730206744895, 10853.457327133454, 10872.184586156229, 7235.927640723526, 7657.693692252247, 7889.763307100796, 7930.881036784568, 8121.228483294078, 8868.600912959062, 8874.112588741333, 8893.199612034949, 8986.68546600892, 9016.053314401894, 7831.451798374287, 7946.205379462239, 8073.475224110414, 8088.092281452511, 8132.796680083045, 7809.258120478546, 7844.6077696113825, 7971.92028079735, 7989.480683755537, 7994.84010319802, 7210.567365958059, 7258.383037441666, 7266.164391095092, 7343.4492413068165, 7368.226336234832, 5333.253344531846, 5368.060589396918, 5403.783848646168, 5417.0, 5512.118061110203, 5416.9729151353995, 5457.399686034453, 5480.451954804487, 5508.9724551376985, 5603.943960560342], "value": 4703.492829398734, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9967353977583, 315.96524382317943, 317.4270441852456, 318.1267420929548, 318.4474935986064, 5561.165825126228, 5621.40975197604, 5623.971880140603, 5635.549156067515, 5655.0, 5468.91796623051, 5530.400711665521, 5543.25166102576, 5552.41699621539, 5599.160125981105, 4129.855455059073, 4193.0, 4291.506476755167, 4294.699371044028, 4317.503487098992, 4296.548862369453, 4316.6546676265825, 4322.4164737760475, 4339.327404252346, 4359.520452750195, 4319.546447622985, 4332.458442694663, 4344.804483798237, 4362.956370436303, 4365.0, 4054.797260136996, 4276.866630342962, 4280.315149576084, 4292.30453970683, 4358.912821743564, 3706.314331848617, 3725.5343082114737, 3735.570409402926, 3742.925141497155, 3752.66226039655, 5478.58910581704, 5498.945010549924, 5533.944660553423, 5535.501804837544, 5554.638948468377, 4838.975805120987, 4876.975615121937, 4918.262260660894, 4937.432195297515, 4950.529699678525, 5805.258422473241, 5813.912791308134, 5845.970770146122, 5851.444112809277, 5887.470127688486, 4025.295573274665, 4049.5747946465785, 4068.572799856002, 4072.9592704072875, 4094.1197642507004, 5848.88302233953, 5983.611065280743, 6034.24571928509, 6055.818325450244, 6084.756609735606, 4103.856365027269, 4120.670346372283, 4143.606357396043, 4146.606072423115, 4165.375193720966, 4174.645155161785, 4203.873883783492, 4239.851605193803, 4241.748684138187, 4248.0, 4753.643476739258, 4833.130036593377, 4869.342638743795, 4910.288008238786, 4928.753562321869, 5798.246227990334, 5819.272590926134, 5836.678982655994, 5863.2670916135485, 5911.083782013795, 1427.4432971141264, 1430.1562078373809, 1432.5917113622568, 1438.6547228665254, 1448.6740483391152, 917.6788124156625, 921.7741653294852, 924.306769922558, 940.9952950235205, 980.7352014956065, 5562.276904002454, 5575.526080283222, 5579.9163012554845, 5589.552835773128, 5592.468715472105, 5812.709364531756, 5858.648481091148, 6006.879862402815, 6048.76195807554, 6062.727177277033, 5332.360116786011, 5561.77752889888, 5589.0, 5597.720113994284, 5649.180868774005, 3132.577102091234, 3168.287135394518, 3170.302533442639, 3176.4600017996995, 3207.615086189672, 5849.473547380756, 6119.5410344224365, 6141.723622437001, 6163.476104531075, 6223.813285601439, 6068.908966365508, 6089.725962331706, 6102.199851043953, 6124.938750612526, 6127.632342059491, 6145.754169833157, 6156.199694039746, 6160.383961603804, 6171.9691401543605, 6198.0702894566175, 5721.57088218377, 5958.433948774859, 5964.642121472725, 5969.970150149222, 5983.790567330123, 5908.675022873611, 5924.696566755307, 5952.255968003999, 5959.612625179349, 6005.90991135142, 6010.188624535632, 6153.938460615336, 6170.197874276315, 6182.629042257479, 6224.62652240867, 4140.855070072533, 4154.854580089683, 4174.77038762871, 4175.749455032707, 4178.958210417978, 6034.0, 6043.2748070231855, 6046.788362407295, 6065.60573562717, 6086.665233412028, 5673.631213971079, 5770.819420741544, 5788.044972579477, 5804.361520232856, 5815.354013923739, 5617.494425501724, 5669.6314739541795, 5690.630109042899, 5710.428957104256, 5744.770209191753, 5511.972440137773, 5605.663660180402, 5703.743331550173, 5706.657600543981, 5721.313442386941, 5877.647341159544, 5877.735501902339, 5886.793962211302, 5898.498627616529, 5919.460940155504, 5599.692016939108, 5760.8271751847515, 5792.6966432552335, 5809.970950145223, 5852.634735027291], "value": 4402.368360042488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3131384272647, 700.4711442860639, 707.5365635508743, 778.2645400096907, 789.1398375770411, 15199.772003419957, 15648.139352335616, 15875.126868022255, 16053.839461605381, 16068.116253606047, 14089.788653170184, 14306.427742890271, 14457.78313325301, 14488.2755862207, 14509.0, 797.8045378882182, 798.5168972771477, 809.4050872608628, 816.2205094135116, 819.6434550970317, 811.813282944923, 813.2883726739103, 816.5549775372436, 817.9918200818005, 821.6466919224731, 842.0358689300747, 848.516345682961, 848.7156802471148, 849.817289282804, 852.1989330029783, 843.8312337532487, 845.0662018469595, 849.7790574450687, 852.1904191018496, 853.7694822397917, 610.5512448350458, 616.5591602004544, 616.7532986805314, 617.0251003414639, 619.7397093220858, 13456.730865382637, 13498.797518037238, 13535.59393218205, 13573.59279221625, 13580.592582222549, 14229.928850355682, 14353.78469322961, 14627.78058329126, 14722.263886805724, 14870.256487175599, 11835.940820295844, 12034.277943323428, 12195.695107622381, 12223.449944752507, 12354.011679065654, 3788.962110378916, 3801.8669346573015, 3897.337452633059, 3977.5028121484816, 3981.7212795104065, 77856.61071694661, 78161.0, 78845.0, 79017.0, 80117.19882801156, 10645.414502202453, 10686.0, 10719.624813131659, 10876.184286178568, 10981.12151027916, 21272.0, 21406.57186856254, 21436.24973125933, 21699.0, 21979.560408792055, 8226.712065077812, 8509.064002959669, 8563.657453701906, 8801.163889430494, 8844.778880527909, 4665.253559430543, 4801.207800712913, 4879.024195160982, 4926.318716237718, 4942.20924652054, 3327.5507806446303, 3428.8285585720614, 3437.05480992729, 3442.638522955104, 3468.8612455501498, 573.5497634357093, 575.579826726492, 579.4784693775636, 583.9912401313984, 586.7887560478309, 517.4515014085082, 526.8419474157737, 535.3388565122071, 570.3554982869414, 580.2398857496693, 8834.514101724468, 8841.60212790426, 8892.110788921185, 9000.59497322622, 9018.549072546346, 555.089652969131, 557.3840905799115, 569.9116636921284, 592.3099588978878, 602.3133627664466, 3962.187751510991, 4027.979860100739, 4264.637505811978, 4338.219120558329, 4378.737275763465, 94896.0, 96994.51502742582, 99159.0, 111590.0, 121430.0, 99600.50199748955, 99795.50102249443, 100110.4994475023, 100378.49810751046, 100584.49707751561, 85528.0, 87849.56075219711, 88489.11510884938, 89621.55189224142, 90361.54819225862, 9388.718338449857, 9423.717288481357, 9790.559424826042, 10095.0, 10173.0, 36526.26947460983, 42157.57842421659, 49052.75473622609, 49301.75349123232, 51542.0, 73876.63061684872, 74220.25779742349, 77162.0, 77475.0, 78693.60653196697, 12278.631641050782, 12580.370981451073, 12774.425150868048, 12826.003786090807, 13035.543755968874, 14561.199134047729, 14580.343884525433, 14616.269186540418, 14950.775738364151, 15313.923430382776, 13665.521706740217, 13688.45246190181, 13823.0, 14040.508582199574, 14204.0, 12597.622071337875, 13022.4139913706, 13352.532661356807, 13387.933060335026, 13750.0, 13358.532451364155, 13816.654583635489, 13904.443822247402, 14043.1574105554, 14301.785473217702, 10652.57389704403, 10974.176936729937, 11138.164637652046, 11237.438128093727, 11491.942540287246, 10473.371597704163, 10700.250982431155, 10735.570577176826, 10811.189160812813, 10837.783244335227], "value": 7339.770446563908, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 112.0, 113.0, 113.0, 111.0, 114.0, 113.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 127.0, 153.0, 185.0, 127.0, 165.0, 155.0, 128.0, 186.0, 125.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 166.0, 170.0, 163.0, 161.0, 162.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 163.0, 76.0, 75.0, 76.0, 75.0, 184.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 145.0, 87.0, 85.0, 85.0, 149.0, 85.0, 86.0, 141.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 121.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 149.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 55.0, 52.0, 53.0, 55.0, 52.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 80.0, 85.0, 86.0, 81.0, 83.0, 103.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 121.0, 122.0, 137.0, 126.0, 122.0, 124.0, 136.0, 129.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 158.0, 162.0, 162.0, 160.0, 160.0, 160.0, 164.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 63.0, 63.0, 65.0, 65.0, 63.0, 63.0, 61.0], "value": 63.9, "unit": "score"}]}]} 08:39:36 INFO - Return code: 0 08:39:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:36 ERROR - # TBPL SUCCESS # 08:39:36 INFO - Running post-action listener: _resource_record_post_action 08:39:36 INFO - ##### 08:39:36 INFO - ##### Finished run-tests step (success) 08:39:36 INFO - ##### 08:39:36 INFO - Running post-run listener: _resource_record_post_run 08:39:36 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554209280; Read time: 16; Write time: 518280 08:39:36 INFO - TinderboxPrint: CPU usage
13.5% 08:39:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:39:36 INFO - TinderboxPrint: I/O write bytes / time
554,209,280 / 518,280 08:39:36 INFO - TinderboxPrint: CPU idle
8,227.7 (86.5%) 08:39:36 INFO - TinderboxPrint: CPU user
1,221.7 (12.8%) 08:39:36 INFO - TinderboxPrint: Swap in / out
0 / 0 08:39:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261029888; Read time: 0; Write time: 270412 08:39:36 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293179392; Read time: 16; Write time: 247868 08:39:36 INFO - Running post-run listener: _upload_blobber_files 08:39:36 INFO - Blob upload gear active. 08:39:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:36 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 08:39:36 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'] 08:39:36 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 08:39:37 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:38 INFO - (blobuploader) - INFO - Done attempting. 08:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:42 INFO - (blobuploader) - INFO - Done attempting. 08:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:43 INFO - (blobuploader) - INFO - Done attempting. 08:39:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:43 INFO - Return code: 0 08:39:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9149ed2932bca9d75b9cbb2ba55d5b23b288bd8152bb4721bfcdd7a3610a9f8aad7f9743947bce1c8bf17f9806c66496f8ab8bd063ac46235013644e773f1bc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766c3463e1fb246eea86aec540774676a79cbd5c304be02b422f33e0384cd464e4770b26f557dc521bdafe7dc10d82f18c05d67679d6b0b96eb2d59f0dc03ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b50d0e41a7f75cc4b5314221f3f992b427205b4c8ca29542bc79889f2d7f26abae2d3b7a41163454f9ccc6c8482c778dfbb18388027f225607c1af3badea3a"} 08:39:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:43 INFO - Contents: 08:39:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9149ed2932bca9d75b9cbb2ba55d5b23b288bd8152bb4721bfcdd7a3610a9f8aad7f9743947bce1c8bf17f9806c66496f8ab8bd063ac46235013644e773f1bc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766c3463e1fb246eea86aec540774676a79cbd5c304be02b422f33e0384cd464e4770b26f557dc521bdafe7dc10d82f18c05d67679d6b0b96eb2d59f0dc03ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b50d0e41a7f75cc4b5314221f3f992b427205b4c8ca29542bc79889f2d7f26abae2d3b7a41163454f9ccc6c8482c778dfbb18388027f225607c1af3badea3a"} 08:39:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:43 INFO - Copying logs to upload dir... 08:39:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.383317 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-12 08:39:43.101868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 08:39:43.106027) ========= 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=d2a8c569965ab8367867b893000001a1-1465732130.390052-722053112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9149ed2932bca9d75b9cbb2ba55d5b23b288bd8152bb4721bfcdd7a3610a9f8aad7f9743947bce1c8bf17f9806c66496f8ab8bd063ac46235013644e773f1bc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766c3463e1fb246eea86aec540774676a79cbd5c304be02b422f33e0384cd464e4770b26f557dc521bdafe7dc10d82f18c05d67679d6b0b96eb2d59f0dc03ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b50d0e41a7f75cc4b5314221f3f992b427205b4c8ca29542bc79889f2d7f26abae2d3b7a41163454f9ccc6c8482c778dfbb18388027f225607c1af3badea3a"} build_url:https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9149ed2932bca9d75b9cbb2ba55d5b23b288bd8152bb4721bfcdd7a3610a9f8aad7f9743947bce1c8bf17f9806c66496f8ab8bd063ac46235013644e773f1bc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766c3463e1fb246eea86aec540774676a79cbd5c304be02b422f33e0384cd464e4770b26f557dc521bdafe7dc10d82f18c05d67679d6b0b96eb2d59f0dc03ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b50d0e41a7f75cc4b5314221f3f992b427205b4c8ca29542bc79889f2d7f26abae2d3b7a41163454f9ccc6c8482c778dfbb18388027f225607c1af3badea3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 08:39:43.138419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:39:43.139012) ========= 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=d2a8c569965ab8367867b893000001a1-1465732130.390052-722053112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:39:43.220750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 08:39:43.221091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 08:39:43.221704) ========= ========= Total master_lag: 0.19 =========