builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1466910724.71 results: success (0) buildid: 20160625173005 builduid: 8e08e983ca394de9ad0933396bdbd64d revision: 076e176ce22e2602f63781027b0b18c1977cddd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.712860) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.713340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.713656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.790139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.790519) ========= 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=00204705a9daa57ed339a427000001b9-1466910234.356435-315723272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 20:12: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.3M=0s 2016-06-25 20:12:05 (26.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.928899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.929234) ========= 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=00204705a9daa57ed339a427000001b9-1466910234.356435-315723272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015386 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:04.981989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 20:12:04.982823) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 076e176ce22e2602f63781027b0b18c1977cddd0 --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 076e176ce22e2602f63781027b0b18c1977cddd0 --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=00204705a9daa57ed339a427000001b9-1466910234.356435-315723272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 20:12:05,268 truncating revision to first 12 chars 2016-06-25 20:12:05,269 Setting DEBUG logging. 2016-06-25 20:12:05,269 attempt 1/10 2016-06-25 20:12:05,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/076e176ce22e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 20:12:06,332 unpacking tar archive at: fx-team-076e176ce22e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.404468 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 20:12:06.403844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:06.404197) ========= script_repo_revision: 076e176ce22e2602f63781027b0b18c1977cddd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:06.404686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:06.404995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 20:12:06.416072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-06-25 20:12:06.416420) ========= /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=00204705a9daa57ed339a427000001b9-1466910234.356435-315723272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:12:06 INFO - MultiFileLogger online at 20160625 20:12:06 in /builds/slave/test 20:12: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 20:12:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:12:06 INFO - {'append_to_log': False, 20:12:06 INFO - 'base_work_dir': '/builds/slave/test', 20:12:06 INFO - 'blob_upload_branch': 'Fx-Team', 20:12:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:12:06 INFO - 'branch': 'Fx-Team', 20:12:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:12:06 INFO - 'config_files': ('talos/linux_config.py',), 20:12:06 INFO - 'default_actions': ('clobber', 20:12:06 INFO - 'read-buildbot-config', 20:12:06 INFO - 'download-and-extract', 20:12:06 INFO - 'populate-webroot', 20:12:06 INFO - 'create-virtualenv', 20:12:06 INFO - 'install', 20:12:06 INFO - 'run-tests'), 20:12:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:12:06 INFO - 'download_minidump_stackwalk': True, 20:12:06 INFO - 'download_symbols': 'ondemand', 20:12:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:12:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:12:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:12:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:12:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:12:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:12:06 INFO - 'installer_path': 'installer.exe', 20:12:06 INFO - 'log_level': 'info', 20:12:06 INFO - 'log_name': 'talos', 20:12:06 INFO - 'log_to_console': True, 20:12:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:12:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:12:06 INFO - 'opt_config_files': (), 20:12:06 INFO - 'pip_index': False, 20:12:06 INFO - 'sps_profile': False, 20:12:06 INFO - 'sps_profile_interval': 0, 20:12:06 INFO - 'suite': 'dromaeojs-e10s', 20:12:06 INFO - 'system_bits': '32', 20:12:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:12:06 INFO - 'title': 'talos-linux64-ix-016', 20:12:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:12:06 INFO - 'use_talos_json': True, 20:12:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:12:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:12:06 INFO - 'work_dir': 'build'} 20:12:06 INFO - ##### 20:12:06 INFO - ##### Running clobber step. 20:12:06 INFO - ##### 20:12:06 INFO - Running pre-action listener: _resource_record_pre_action 20:12:06 INFO - Running main action method: clobber 20:12:06 INFO - rmtree: /builds/slave/test/build 20:12:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:12:07 INFO - Running post-action listener: _resource_record_post_action 20:12:07 INFO - ##### 20:12:07 INFO - ##### Finished clobber step (success) 20:12:07 INFO - ##### 20:12:07 INFO - ##### 20:12:07 INFO - ##### Running read-buildbot-config step. 20:12:07 INFO - ##### 20:12:07 INFO - Running pre-action listener: _resource_record_pre_action 20:12:07 INFO - Running main action method: read_buildbot_config 20:12:07 INFO - Using buildbot properties: 20:12:07 INFO - { 20:12:07 INFO - "project": "", 20:12:07 INFO - "product": "firefox", 20:12:07 INFO - "script_repo_revision": "production", 20:12:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:12:07 INFO - "repository": "", 20:12:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:12:07 INFO - "buildid": "20160625173005", 20:12:07 INFO - "pgo_build": "True", 20:12:07 INFO - "basedir": "/builds/slave/test", 20:12:07 INFO - "buildnumber": 573, 20:12:07 INFO - "slavename": "talos-linux64-ix-016", 20:12:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:12:07 INFO - "platform": "ubuntu64_hw", 20:12:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:12:07 INFO - "branch": "fx-team", 20:12:07 INFO - "repo_path": "integration/fx-team", 20:12:07 INFO - "revision": "076e176ce22e2602f63781027b0b18c1977cddd0", 20:12:07 INFO - "stage_platform": "linux64-pgo", 20:12:07 INFO - "builduid": "8e08e983ca394de9ad0933396bdbd64d", 20:12:07 INFO - "slavebuilddir": "test" 20:12:07 INFO - } 20:12:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:12:07 INFO - Running post-action listener: _resource_record_post_action 20:12:07 INFO - ##### 20:12:07 INFO - ##### Finished read-buildbot-config step (success) 20:12:07 INFO - ##### 20:12:07 INFO - ##### 20:12:07 INFO - ##### Running download-and-extract step. 20:12:07 INFO - ##### 20:12:07 INFO - Running pre-action listener: _resource_record_pre_action 20:12:07 INFO - Running main action method: download_and_extract 20:12:07 INFO - mkdir: /builds/slave/test/build/tests 20:12: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')]} 20:12:07 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:12:20 INFO - Downloaded 1361 bytes. 20:12:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:20 INFO - Using the following test package requirements: 20:12:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:12:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:12:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:12:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'jsshell-linux-x86_64.zip'], 20:12:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:12:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:12:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:12:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:12:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:12:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:12:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:12:20 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')]} 20:12:20 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:12:30 INFO - retry: attempt #1 caught exception: '' 20:12:30 INFO - retry: Failed, sleeping 30 seconds before retrying 20:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 #2 20:13:06 INFO - Downloaded 24279375 bytes. 20:13:06 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'] 20:13:06 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 20:13:08 INFO - Return code: 0 20:13:08 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 20:13:08 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')]} 20:13:08 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:13:10 INFO - Downloaded 24279375 bytes. 20:13:10 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'] 20:13:10 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 20:13:11 INFO - Return code: 0 20:13:11 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')]} 20:13:11 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:13:12 INFO - Downloaded 14405240 bytes. 20:13:12 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'] 20:13:12 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 20:13:12 INFO - Return code: 0 20:13: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')]} 20:13:12 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/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 20:13:13 INFO - Downloaded 60153265 bytes. 20:13:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:13 INFO - mkdir: /builds/slave/test/properties 20:13:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:13:13 INFO - Writing to file /builds/slave/test/properties/build_url 20:13:13 INFO - Contents: 20:13:13 INFO - build_url:https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:14 INFO - Running post-action listener: _resource_record_post_action 20:13:14 INFO - Running post-action listener: set_extra_try_arguments 20:13:14 INFO - ##### 20:13:14 INFO - ##### Finished download-and-extract step (success) 20:13:14 INFO - ##### 20:13:14 INFO - ##### 20:13:14 INFO - ##### Running populate-webroot step. 20:13:14 INFO - ##### 20:13:14 INFO - Running pre-action listener: _resource_record_pre_action 20:13:14 INFO - Running main action method: populate_webroot 20:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:13:14 INFO - '--tppagecycles', 20:13:14 INFO - '7'], 20:13:14 INFO - 'tests': ['tsvgm']}}, 20:13:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:13:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:13:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:13:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:13:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['damp', 'tps']}, 20:13:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'tests': ['damp', 'tps']}, 20:13:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['dromaeo_dom']}, 20:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:13:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['basic_compositor_video']}, 20:13:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:13:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['a11yr', 20:13:14 INFO - 'ts_paint', 20:13:14 INFO - 'tpaint', 20:13:14 INFO - 'sessionrestore', 20:13:14 INFO - 'sessionrestore_no_auto_restore', 20:13:14 INFO - 'tabpaint']}, 20:13:14 INFO - 'other-e10s': {'tests': ['a11yr', 20:13:14 INFO - 'ts_paint', 20:13:14 INFO - 'tpaint', 20:13:14 INFO - 'sessionrestore', 20:13:14 INFO - 'sessionrestore_no_auto_restore', 20:13:14 INFO - 'tabpaint']}, 20:13:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:13:14 INFO - 'ts_paint', 20:13:14 INFO - 'tpaint', 20:13:14 INFO - 'sessionrestore', 20:13:14 INFO - 'sessionrestore_no_auto_restore', 20:13:14 INFO - 'tabpaint']}, 20:13:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:13:14 INFO - 'ts_paint', 20:13:14 INFO - 'tpaint', 20:13:14 INFO - 'sessionrestore', 20:13:14 INFO - 'sessionrestore_no_auto_restore', 20:13:14 INFO - 'tabpaint']}, 20:13:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['a11yr', 20:13:14 INFO - 'ts_paint', 20:13:14 INFO - 'tpaint', 20:13:14 INFO - 'sessionrestore', 20:13:14 INFO - 'sessionrestore_no_auto_restore', 20:13:14 INFO - 'tabpaint']}, 20:13:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['a11yr', 20:13:14 INFO - 'ts_paint', 20:13:14 INFO - 'tpaint', 20:13:14 INFO - 'sessionrestore', 20:13:14 INFO - 'sessionrestore_no_auto_restore', 20:13:14 INFO - 'tabpaint']}, 20:13:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['tsvgx', 20:13:14 INFO - 'tsvgr_opacity', 20:13:14 INFO - 'tart', 20:13:14 INFO - 'tscrollx', 20:13:14 INFO - 'cart']}, 20:13:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:13:14 INFO - 'tsvgr_opacity', 20:13:14 INFO - 'tart', 20:13:14 INFO - 'tscrollx', 20:13:14 INFO - 'cart']}, 20:13:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'talos_options': ['--disable-e10s'], 20:13:14 INFO - 'tests': ['tp5o']}, 20:13:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'tests': ['tp5o']}, 20:13:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'talos_options': ['--disable-e10s', 20:13:14 INFO - '--xperf_path', 20:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:14 INFO - 'tests': ['tp5n']}, 20:13:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:14 INFO - 'talos_options': ['--xperf_path', 20:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:14 INFO - 'tests': ['tp5n']}}, 20:13:14 INFO - 'talos.zip': {'path': '', 20:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:13:14 INFO - Running post-action listener: _resource_record_post_action 20:13:14 INFO - ##### 20:13:14 INFO - ##### Finished populate-webroot step (success) 20:13:14 INFO - ##### 20:13:14 INFO - ##### 20:13:14 INFO - ##### Running create-virtualenv step. 20:13:14 INFO - ##### 20:13:14 INFO - Running pre-action listener: _resource_record_pre_action 20:13:14 INFO - Running main action method: create_virtualenv 20:13:14 INFO - Creating virtualenv /builds/slave/test/build/venv 20:13:14 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 20:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:13:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:13:14 INFO - Using real prefix '/usr' 20:13:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 20:13:17 INFO - Installing pip.................done. 20:13:17 INFO - Return code: 0 20:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:17 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:17 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 20:13:17 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 20:13:17 INFO - Using env: {'DISPLAY': ':0', 20:13:17 INFO - 'HOME': '/home/cltbld', 20:13:17 INFO - 'LANG': 'en_US.UTF-8', 20:13:17 INFO - 'LANGUAGE': 'en_US:en', 20:13:17 INFO - 'LOGNAME': 'cltbld', 20:13:17 INFO - 'MAIL': '/var/mail/cltbld', 20:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:17 INFO - 'MOZ_NO_REMOTE': '1', 20:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:17 INFO - 'NO_EM_RESTART': '1', 20:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:17 INFO - 'PWD': '/builds/slave/test', 20:13:17 INFO - 'SHELL': '/bin/bash', 20:13:17 INFO - 'SHLVL': '1', 20:13:17 INFO - 'TERM': 'linux', 20:13:17 INFO - 'TMOUT': '86400', 20:13:17 INFO - 'USER': 'cltbld', 20:13:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:17 INFO - '_': '/tools/buildbot/bin/python'} 20:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:17 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 20:13:17 INFO - Cleaning up... 20:13:17 INFO - Return code: 0 20:13:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:17 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:17 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 20:13:17 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 20:13:17 INFO - Using env: {'DISPLAY': ':0', 20:13:17 INFO - 'HOME': '/home/cltbld', 20:13:17 INFO - 'LANG': 'en_US.UTF-8', 20:13:17 INFO - 'LANGUAGE': 'en_US:en', 20:13:17 INFO - 'LOGNAME': 'cltbld', 20:13:17 INFO - 'MAIL': '/var/mail/cltbld', 20:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:17 INFO - 'MOZ_NO_REMOTE': '1', 20:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:17 INFO - 'NO_EM_RESTART': '1', 20:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:17 INFO - 'PWD': '/builds/slave/test', 20:13:17 INFO - 'SHELL': '/bin/bash', 20:13:17 INFO - 'SHLVL': '1', 20:13:17 INFO - 'TERM': 'linux', 20:13:17 INFO - 'TMOUT': '86400', 20:13:17 INFO - 'USER': 'cltbld', 20:13:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:17 INFO - '_': '/tools/buildbot/bin/python'} 20:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:17 INFO - Downloading/unpacking psutil>=3.1.1 20:13:17 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 20:13:17 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 20:13:17 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 20:13:17 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 20:13:17 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 20:13:17 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 20:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:19 INFO - Installing collected packages: psutil 20:13:19 INFO - Running setup.py install for psutil 20:13:19 INFO - building 'psutil._psutil_linux' extension 20:13:19 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 20:13:20 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 20:13:20 INFO - building 'psutil._psutil_posix' extension 20:13:20 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 20:13:20 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 20:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:20 INFO - Successfully installed psutil 20:13:20 INFO - Cleaning up... 20:13:20 INFO - Return code: 0 20:13:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:13:20 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')]} 20:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:20 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')]} 20:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:20 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:20 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 20:13:20 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 20:13:20 INFO - Using env: {'DISPLAY': ':0', 20:13:20 INFO - 'HOME': '/home/cltbld', 20:13:20 INFO - 'LANG': 'en_US.UTF-8', 20:13:20 INFO - 'LANGUAGE': 'en_US:en', 20:13:20 INFO - 'LOGNAME': 'cltbld', 20:13:20 INFO - 'MAIL': '/var/mail/cltbld', 20:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:20 INFO - 'MOZ_NO_REMOTE': '1', 20:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:20 INFO - 'NO_EM_RESTART': '1', 20:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:20 INFO - 'PWD': '/builds/slave/test', 20:13:20 INFO - 'SHELL': '/bin/bash', 20:13:20 INFO - 'SHLVL': '1', 20:13:20 INFO - 'TERM': 'linux', 20:13:20 INFO - 'TMOUT': '86400', 20:13:20 INFO - 'USER': 'cltbld', 20:13:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:20 INFO - '_': '/tools/buildbot/bin/python'} 20:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:13:20 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 20:13:20 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 20:13:20 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 20:13:20 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 20:13:20 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 20:13:20 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 20:13:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:13:22 INFO - Installing collected packages: mozsystemmonitor 20:13:22 INFO - Running setup.py install for mozsystemmonitor 20:13:22 INFO - Successfully installed mozsystemmonitor 20:13:22 INFO - Cleaning up... 20:13:22 INFO - Return code: 0 20:13:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:13:22 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')]} 20:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:22 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')]} 20:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:22 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:22 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 20:13:22 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 20:13:22 INFO - Using env: {'DISPLAY': ':0', 20:13:22 INFO - 'HOME': '/home/cltbld', 20:13:22 INFO - 'LANG': 'en_US.UTF-8', 20:13:22 INFO - 'LANGUAGE': 'en_US:en', 20:13:22 INFO - 'LOGNAME': 'cltbld', 20:13:22 INFO - 'MAIL': '/var/mail/cltbld', 20:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:22 INFO - 'MOZ_NO_REMOTE': '1', 20:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:22 INFO - 'NO_EM_RESTART': '1', 20:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:22 INFO - 'PWD': '/builds/slave/test', 20:13:22 INFO - 'SHELL': '/bin/bash', 20:13:22 INFO - 'SHLVL': '1', 20:13:22 INFO - 'TERM': 'linux', 20:13:22 INFO - 'TMOUT': '86400', 20:13:22 INFO - 'USER': 'cltbld', 20:13:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:22 INFO - '_': '/tools/buildbot/bin/python'} 20:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:22 INFO - Downloading/unpacking jsonschema==2.5.1 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:13:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13:24 INFO - Downloading functools32-3.2.3-2.tar.gz 20:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:13:25 INFO - warning: no files found matching '*.txt' 20:13:25 INFO - no previously-included directories found matching 'build' 20:13:25 INFO - no previously-included directories found matching 'dist' 20:13:25 INFO - no previously-included directories found matching '.git*' 20:13:25 INFO - Installing collected packages: jsonschema, functools32 20:13:25 INFO - Running setup.py install for functools32 20:13:25 INFO - warning: no files found matching '*.txt' 20:13:25 INFO - no previously-included directories found matching 'build' 20:13:25 INFO - no previously-included directories found matching 'dist' 20:13:25 INFO - no previously-included directories found matching '.git*' 20:13:25 INFO - Successfully installed jsonschema functools32 20:13:25 INFO - Cleaning up... 20:13:25 INFO - Return code: 0 20:13:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:13:25 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')]} 20:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:25 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')]} 20:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:25 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:25 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 20:13:25 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 20:13:25 INFO - Using env: {'DISPLAY': ':0', 20:13:25 INFO - 'HOME': '/home/cltbld', 20:13:25 INFO - 'LANG': 'en_US.UTF-8', 20:13:25 INFO - 'LANGUAGE': 'en_US:en', 20:13:25 INFO - 'LOGNAME': 'cltbld', 20:13:25 INFO - 'MAIL': '/var/mail/cltbld', 20:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:25 INFO - 'MOZ_NO_REMOTE': '1', 20:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:25 INFO - 'NO_EM_RESTART': '1', 20:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:25 INFO - 'PWD': '/builds/slave/test', 20:13:25 INFO - 'SHELL': '/bin/bash', 20:13:25 INFO - 'SHLVL': '1', 20:13:25 INFO - 'TERM': 'linux', 20:13:25 INFO - 'TMOUT': '86400', 20:13:25 INFO - 'USER': 'cltbld', 20:13:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:25 INFO - '_': '/tools/buildbot/bin/python'} 20:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:25 INFO - Downloading/unpacking blobuploader==1.2.4 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:27 INFO - Downloading blobuploader-1.2.4.tar.gz 20:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:13:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:13:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13:28 INFO - Downloading docopt-0.6.1.tar.gz 20:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:13:28 INFO - Installing collected packages: blobuploader, requests, docopt 20:13:28 INFO - Running setup.py install for blobuploader 20:13:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:13:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:13:28 INFO - Running setup.py install for requests 20:13:28 INFO - Running setup.py install for docopt 20:13:28 INFO - Successfully installed blobuploader requests docopt 20:13:28 INFO - Cleaning up... 20:13:28 INFO - Return code: 0 20:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:13:28 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')]} 20:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:28 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')]} 20:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:28 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:28 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 20:13:28 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 20:13:28 INFO - Using env: {'DISPLAY': ':0', 20:13:28 INFO - 'HOME': '/home/cltbld', 20:13:28 INFO - 'LANG': 'en_US.UTF-8', 20:13:28 INFO - 'LANGUAGE': 'en_US:en', 20:13:28 INFO - 'LOGNAME': 'cltbld', 20:13:28 INFO - 'MAIL': '/var/mail/cltbld', 20:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:28 INFO - 'MOZ_NO_REMOTE': '1', 20:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:28 INFO - 'NO_EM_RESTART': '1', 20:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:28 INFO - 'PWD': '/builds/slave/test', 20:13:28 INFO - 'SHELL': '/bin/bash', 20:13:28 INFO - 'SHLVL': '1', 20:13:28 INFO - 'TERM': 'linux', 20:13:28 INFO - 'TMOUT': '86400', 20:13:28 INFO - 'USER': 'cltbld', 20:13:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:28 INFO - '_': '/tools/buildbot/bin/python'} 20:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:13:29 INFO - Running setup.py (path:/tmp/pip-5YYmRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:13:29 INFO - Running setup.py (path:/tmp/pip-ONofHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:13:29 INFO - Running setup.py (path:/tmp/pip-lMRYdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:13:29 INFO - Running setup.py (path:/tmp/pip-UZ4CLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:13:29 INFO - Running setup.py (path:/tmp/pip-Y53C9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:13:29 INFO - Running setup.py (path:/tmp/pip-3_AhGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:13:29 INFO - Running setup.py (path:/tmp/pip-R00O1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:13:29 INFO - Running setup.py (path:/tmp/pip-hVbKCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:13:29 INFO - Running setup.py (path:/tmp/pip-c2oMp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:13:29 INFO - Running setup.py (path:/tmp/pip-BBG_U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:13:29 INFO - Running setup.py (path:/tmp/pip-j6Yfzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:13:29 INFO - Running setup.py (path:/tmp/pip-TKK8g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:13:29 INFO - Running setup.py (path:/tmp/pip-SDvscX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:13:30 INFO - Running setup.py (path:/tmp/pip-iHZve9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:30 INFO - Running setup.py (path:/tmp/pip-YmQlXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:13:30 INFO - Running setup.py (path:/tmp/pip-BwRVe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:13:30 INFO - Running setup.py (path:/tmp/pip-9y6UCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:13:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:13:30 INFO - Running setup.py install for manifestparser 20:13:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:13:30 INFO - Running setup.py install for mozcrash 20:13:30 INFO - Running setup.py install for mozdebug 20:13:30 INFO - Running setup.py install for mozdevice 20:13:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:13:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:13:30 INFO - Running setup.py install for mozfile 20:13:30 INFO - Running setup.py install for mozhttpd 20:13:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:13:30 INFO - Running setup.py install for mozinfo 20:13:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Running setup.py install for mozInstall 20:13:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Running setup.py install for mozleak 20:13:31 INFO - Running setup.py install for mozlog 20:13:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Running setup.py install for moznetwork 20:13:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Running setup.py install for mozprocess 20:13:31 INFO - Running setup.py install for mozprofile 20:13:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Running setup.py install for mozrunner 20:13:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:13:31 INFO - Running setup.py install for mozscreenshot 20:13:31 INFO - Running setup.py install for moztest 20:13:31 INFO - Running setup.py install for mozversion 20:13:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:13:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:13:32 INFO - Cleaning up... 20:13:32 INFO - Return code: 0 20:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:13: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')]} 20:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13: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')]} 20:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:32 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:32 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 20:13:32 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 20:13:32 INFO - Using env: {'DISPLAY': ':0', 20:13:32 INFO - 'HOME': '/home/cltbld', 20:13:32 INFO - 'LANG': 'en_US.UTF-8', 20:13:32 INFO - 'LANGUAGE': 'en_US:en', 20:13:32 INFO - 'LOGNAME': 'cltbld', 20:13:32 INFO - 'MAIL': '/var/mail/cltbld', 20:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:32 INFO - 'MOZ_NO_REMOTE': '1', 20:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:32 INFO - 'NO_EM_RESTART': '1', 20:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:32 INFO - 'PWD': '/builds/slave/test', 20:13:32 INFO - 'SHELL': '/bin/bash', 20:13:32 INFO - 'SHLVL': '1', 20:13:32 INFO - 'TERM': 'linux', 20:13:32 INFO - 'TMOUT': '86400', 20:13:32 INFO - 'USER': 'cltbld', 20:13:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:32 INFO - '_': '/tools/buildbot/bin/python'} 20:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:13:32 INFO - Running setup.py (path:/tmp/pip-bsxrE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:13:32 INFO - Running setup.py (path:/tmp/pip-b4vqSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:13:32 INFO - Running setup.py (path:/tmp/pip-gHTbLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:13:32 INFO - Running setup.py (path:/tmp/pip-WeljHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:13:32 INFO - Running setup.py (path:/tmp/pip-qIrJzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:13:32 INFO - Running setup.py (path:/tmp/pip-H4DmpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:13:32 INFO - Running setup.py (path:/tmp/pip-oVbLaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:13:32 INFO - Running setup.py (path:/tmp/pip-iawK6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:13:32 INFO - Running setup.py (path:/tmp/pip-mshY8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:13:32 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)) 20:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:13:32 INFO - Running setup.py (path:/tmp/pip-IQVbIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:13:33 INFO - Running setup.py (path:/tmp/pip-IvQUFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:13:33 INFO - Running setup.py (path:/tmp/pip-Ni1Shs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:13:33 INFO - Running setup.py (path:/tmp/pip-_3xWVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:13:33 INFO - Running setup.py (path:/tmp/pip-2e_lGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:33 INFO - Running setup.py (path:/tmp/pip-gcpwxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:13:33 INFO - Running setup.py (path:/tmp/pip-848u42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:13:33 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)) 20:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:13:33 INFO - Running setup.py (path:/tmp/pip-Lvxb5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:13:33 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 20:13:33 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 20:13:33 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 20:13:33 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 20:13:33 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 20:13:33 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 20:13:35 INFO - Downloading blessings-1.6.tar.gz 20:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:13:35 INFO - Installing collected packages: blessings 20:13:35 INFO - Running setup.py install for blessings 20:13:35 INFO - Successfully installed blessings 20:13:35 INFO - Cleaning up... 20:13:35 INFO - Return code: 0 20:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:13:35 INFO - Reading from file tmpfile_stdout 20:13:35 INFO - Current package versions: 20:13:35 INFO - argparse == 1.2.1 20:13:35 INFO - blessings == 1.6 20:13:35 INFO - blobuploader == 1.2.4 20:13:35 INFO - docopt == 0.6.1 20:13:35 INFO - functools32 == 3.2.3-2 20:13:35 INFO - jsonschema == 2.5.1 20:13:35 INFO - manifestparser == 1.1 20:13:35 INFO - mozInstall == 1.12 20:13:35 INFO - mozcrash == 0.17 20:13:35 INFO - mozdebug == 0.1 20:13:35 INFO - mozdevice == 0.48 20:13:35 INFO - mozfile == 1.2 20:13:35 INFO - mozhttpd == 0.7 20:13:35 INFO - mozinfo == 0.9 20:13:35 INFO - mozleak == 0.1 20:13:35 INFO - mozlog == 3.2 20:13:35 INFO - moznetwork == 0.27 20:13:35 INFO - mozprocess == 0.22 20:13:35 INFO - mozprofile == 0.28 20:13:35 INFO - mozrunner == 6.11 20:13:35 INFO - mozscreenshot == 0.1 20:13:35 INFO - mozsystemmonitor == 0.3 20:13:35 INFO - moztest == 0.7 20:13:35 INFO - mozversion == 1.4 20:13:35 INFO - psutil == 3.1.1 20:13:35 INFO - requests == 1.2.3 20:13:35 INFO - wsgiref == 0.1.2 20:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:13:35 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')]} 20:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:35 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')]} 20:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:35 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:35 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 20:13:35 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 20:13:35 INFO - Using env: {'DISPLAY': ':0', 20:13:35 INFO - 'HOME': '/home/cltbld', 20:13:35 INFO - 'LANG': 'en_US.UTF-8', 20:13:35 INFO - 'LANGUAGE': 'en_US:en', 20:13:35 INFO - 'LOGNAME': 'cltbld', 20:13:35 INFO - 'MAIL': '/var/mail/cltbld', 20:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:35 INFO - 'MOZ_NO_REMOTE': '1', 20:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:35 INFO - 'NO_EM_RESTART': '1', 20:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:35 INFO - 'PWD': '/builds/slave/test', 20:13:35 INFO - 'SHELL': '/bin/bash', 20:13:35 INFO - 'SHLVL': '1', 20:13:35 INFO - 'TERM': 'linux', 20:13:35 INFO - 'TMOUT': '86400', 20:13:35 INFO - 'USER': 'cltbld', 20:13:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:35 INFO - '_': '/tools/buildbot/bin/python'} 20:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 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)) 20:13:36 INFO - Cleaning up... 20:13:36 INFO - Return code: 0 20:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:13: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')]} 20:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13: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')]} 20:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:36 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:36 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 20:13:36 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 20:13:36 INFO - Using env: {'DISPLAY': ':0', 20:13:36 INFO - 'HOME': '/home/cltbld', 20:13:36 INFO - 'LANG': 'en_US.UTF-8', 20:13:36 INFO - 'LANGUAGE': 'en_US:en', 20:13:36 INFO - 'LOGNAME': 'cltbld', 20:13:36 INFO - 'MAIL': '/var/mail/cltbld', 20:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:36 INFO - 'MOZ_NO_REMOTE': '1', 20:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:36 INFO - 'NO_EM_RESTART': '1', 20:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:36 INFO - 'PWD': '/builds/slave/test', 20:13:36 INFO - 'SHELL': '/bin/bash', 20:13:36 INFO - 'SHLVL': '1', 20:13:36 INFO - 'TERM': 'linux', 20:13:36 INFO - 'TMOUT': '86400', 20:13:36 INFO - 'USER': 'cltbld', 20:13:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:36 INFO - '_': '/tools/buildbot/bin/python'} 20:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:13:36 INFO - Cleaning up... 20:13:36 INFO - Return code: 0 20:13:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:13: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')]} 20:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13: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')]} 20:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:36 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 0x7f4fa7b45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, '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': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', '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 20:13:36 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 20:13:36 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 20:13:36 INFO - Using env: {'DISPLAY': ':0', 20:13:36 INFO - 'HOME': '/home/cltbld', 20:13:36 INFO - 'LANG': 'en_US.UTF-8', 20:13:36 INFO - 'LANGUAGE': 'en_US:en', 20:13:36 INFO - 'LOGNAME': 'cltbld', 20:13:36 INFO - 'MAIL': '/var/mail/cltbld', 20:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:36 INFO - 'MOZ_NO_REMOTE': '1', 20:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:36 INFO - 'NO_EM_RESTART': '1', 20:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:36 INFO - 'PWD': '/builds/slave/test', 20:13:36 INFO - 'SHELL': '/bin/bash', 20:13:36 INFO - 'SHLVL': '1', 20:13:36 INFO - 'TERM': 'linux', 20:13:36 INFO - 'TMOUT': '86400', 20:13:36 INFO - 'USER': 'cltbld', 20:13:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:36 INFO - '_': '/tools/buildbot/bin/python'} 20:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:36 INFO - Downloading/unpacking flake8 20:13:36 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 20:13:36 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 20:13:36 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 20:13:36 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 20:13:36 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 20:13:36 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 20:13:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:13:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:13:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:38 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 20:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:13:39 INFO - no previously-included directories found matching 'docs/_build' 20:13:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:13:39 INFO - Running setup.py install for pep8 20:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:13:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:13:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:13:39 INFO - no previously-included directories found matching 'docs/_build' 20:13:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:13:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:13:39 INFO - Cleaning up... 20:13:39 INFO - Return code: 0 20:13:39 INFO - Running post-action listener: _resource_record_post_action 20:13:39 INFO - Running post-action listener: _start_resource_monitoring 20:13:39 INFO - Starting resource monitoring. 20:13:39 INFO - ##### 20:13:39 INFO - ##### Finished create-virtualenv step (success) 20:13:39 INFO - ##### 20:13:39 INFO - ##### 20:13:39 INFO - ##### Running install step. 20:13:39 INFO - ##### 20:13:39 INFO - Running pre-action listener: _resource_record_pre_action 20:13:39 INFO - Running main action method: install 20:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:13:39 INFO - Reading from file tmpfile_stdout 20:13:39 INFO - Detecting whether we're running mozinstall >=1.0... 20:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:13:39 INFO - Reading from file tmpfile_stdout 20:13:39 INFO - Output received: 20:13:39 INFO - Usage: mozinstall [options] installer 20:13:39 INFO - Options: 20:13:39 INFO - -h, --help show this help message and exit 20:13:39 INFO - -d DEST, --destination=DEST 20:13:39 INFO - Directory to install application into. [default: 20:13:39 INFO - "/builds/slave/test"] 20:13:39 INFO - --app=APP Application being installed. [default: firefox] 20:13:39 INFO - mkdir: /builds/slave/test/build/application 20:13:39 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'] 20:13:39 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 20:13:56 INFO - Reading from file tmpfile_stdout 20:13:56 INFO - Output received: 20:13:56 INFO - /builds/slave/test/build/application/firefox/firefox 20:13:56 INFO - Running post-action listener: _resource_record_post_action 20:13:56 INFO - ##### 20:13:56 INFO - ##### Finished install step (success) 20:13:56 INFO - ##### 20:13:56 INFO - ##### 20:13:56 INFO - ##### Running run-tests step. 20:13:56 INFO - ##### 20:13:56 INFO - Running pre-action listener: _resource_record_pre_action 20:13:56 INFO - Running main action method: run_tests 20:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:13:56 INFO - Python 2.7.3 20:13:56 INFO - Return code: 0 20:13:56 INFO - grabbing minidump binary from tooltool 20:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:56 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 0x2a486f0>, '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 0x2a495f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:13:56 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 20:13:56 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 20:13:56 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 20:13:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:13:56 INFO - Return code: 0 20:13:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:13:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:13:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:13:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:13:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:13:57 INFO - Return code: 0 20:13:57 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/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 20:13:57 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/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 20:13:57 INFO - Using env: {'DISPLAY': ':0', 20:13:57 INFO - 'HOME': '/home/cltbld', 20:13:57 INFO - 'LANG': 'en_US.UTF-8', 20:13:57 INFO - 'LANGUAGE': 'en_US:en', 20:13:57 INFO - 'LOGNAME': 'cltbld', 20:13:57 INFO - 'MAIL': '/var/mail/cltbld', 20:13:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:13:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:57 INFO - 'MOZ_NO_REMOTE': '1', 20:13:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:57 INFO - 'NO_EM_RESTART': '1', 20:13:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:57 INFO - 'PWD': '/builds/slave/test', 20:13:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:13:57 INFO - 'SHELL': '/bin/bash', 20:13:57 INFO - 'SHLVL': '1', 20:13:57 INFO - 'TERM': 'linux', 20:13:57 INFO - 'TMOUT': '86400', 20:13:57 INFO - 'USER': 'cltbld', 20:13:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466910234.356435-315723272', 20:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:57 INFO - '_': '/tools/buildbot/bin/python'} 20:13:57 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/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 20:13:58 INFO - mozversion application_buildid: 20160625173005 20:13:58 INFO - mozversion application_changeset: 076e176ce22e2602f63781027b0b18c1977cddd0 20:13:58 INFO - mozversion application_display_name: Nightly 20:13:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:13:58 INFO - mozversion application_name: Firefox 20:13:58 INFO - mozversion application_remotingname: firefox 20:13:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:13:58 INFO - mozversion application_vendor: Mozilla 20:13:58 INFO - mozversion application_version: 50.0a1 20:13:58 INFO - mozversion platform_buildid: 20160625173005 20:13:58 INFO - mozversion platform_changeset: 076e176ce22e2602f63781027b0b18c1977cddd0 20:13:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:13:58 INFO - mozversion platform_version: 50.0a1 20:13:58 INFO - using testdate: 1466910838 20:13:58 INFO - actual date: 1466910838 20:13:58 INFO - starting webserver on 'localhost:48394' 20:13:58 INFO - SUITE-START | Running 2 tests 20:13:58 INFO - TEST-START | dromaeo_css 20:13:58 INFO - operating with platform_type : linux_ 20:13:58 INFO - Initialising browser for dromaeo_css test... 20:13:58 INFO - TEST-INFO | started process 8588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ6erP_/profile http://localhost:48394/getInfo.html) 20:14:02 INFO - PROCESS | 8588 | __metrics Screen width/height:1600/1200 20:14:02 INFO - PROCESS | 8588 | colorDepth:24 20:14:02 INFO - PROCESS | 8588 | Browser inner width/height: 1024/697 20:14:02 INFO - PROCESS | 8588 | __metrics 20:14:03 ERROR - PROCESS | 8588 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:14:04 INFO - TEST-INFO | 8588: exit 0 20:14:04 INFO - Browser initialized. 20:14:04 INFO - Running cycle 1/1 for dromaeo_css test... 20:14:04 INFO - TEST-INFO | started process 8708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ6erP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:14:16 INFO - PROCESS | 8708 | RSS: Main: 184733696 20:14:16 INFO - PROCESS | 8708 | 20:15:05 INFO - PROCESS | 8708 | 1466910905782 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] 20:17:13 INFO - PROCESS | 8708 | Cycle 1(1): loaded http://localhost:48394/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48394/tests/dromaeo/cssquery-ext.html) 20:17:14 INFO - PROCESS | 8708 | RSS: Main: 188018688 20:17:14 INFO - PROCESS | 8708 | 20:20:16 INFO - PROCESS | 8708 | Cycle 1(1): loaded http://localhost:48394/tests/dromaeo/cssquery-ext.html (next: http://localhost:48394/tests/dromaeo/cssquery-jquery.html) 20:20:17 INFO - PROCESS | 8708 | RSS: Main: 187351040 20:20:17 INFO - PROCESS | 8708 | 20:23:19 INFO - PROCESS | 8708 | Cycle 1(1): loaded http://localhost:48394/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48394/tests/dromaeo/cssquery-mootools.html) 20:23:19 INFO - PROCESS | 8708 | RSS: Main: 188682240 20:23:19 INFO - PROCESS | 8708 | 20:26:21 INFO - PROCESS | 8708 | Cycle 1(1): loaded http://localhost:48394/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48394/tests/dromaeo/cssquery-prototype.html) 20:26:21 INFO - PROCESS | 8708 | RSS: Main: 186314752 20:26:21 INFO - PROCESS | 8708 | 20:29:24 INFO - PROCESS | 8708 | Cycle 1(1): loaded http://localhost:48394/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48394/tests/dromaeo/cssquery-yui.html) 20:29:24 INFO - PROCESS | 8708 | RSS: Main: 188596224 20:29:24 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | Cycle 1(1): loaded http://localhost:48394/tests/dromaeo/cssquery-yui.html (next: http://localhost:48394/tests/dromaeo/cssquery-dojo.html) 20:32:27 INFO - PROCESS | 8708 | RSS: Main: 189595648 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | __start_tp_report 20:32:27 INFO - PROCESS | 8708 | _x_x_mozilla_page_load 20:32:27 INFO - PROCESS | 8708 | _x_x_mozilla_page_load_details 20:32:27 INFO - PROCESS | 8708 | |i|pagename|runs| 20:32:27 INFO - PROCESS | 8708 | |0;dojo.html;3071.063325685666;3107.5960125183738;3134.952975705364;3138.9372212555763;3147.9370412591747;5363.91954120688;5405.0541155297815;5431.782728690852;5470.699111548864;5503.642263252896;5306.814261500838;5366.819299754057;5417.079096553595;5463.945360546393;5474.178873169027;4917.852464426064;4935.457099719028;4987.875303117415;5028.547430731233;5125.103106956286;551.4372268989687;4864.14877396456;4938.777755001016;4986.227134794112;5015.498450154992;4916.803327866899;4934.1611925972675;4935.605151587883;4938.135826230413;4947.208446648537;4863.683860549053;4950.727709975949;4953.628477864138;4974.651774375795;5020.673656212334;4903.289023091632;4916.041371932474;4929.901401971941;4935.703857768545;4980.651354405193;5372.838814835562;5430.402655707869;5450.972745136289;5451.64564303323;5453.7818487260465;5677.403872593401;5742.626729262626;5802.042662960649;5841.211436456109;5848.473637372615;5752.539796816244;5763.876044171347;5772.30732312121;5804.506616937565;5818.854528636775;5441.700706461143;5442.619016668835;5450.127979523297;5456.454354564551;5479.99999999996;5793.246877905845;5849.707514624337;5924.585279030426;5936.347001829795;5960.0761881908375;5648.802291919846;5725.227094342294;5764.510016648548;5781.392953739881;5783.913241301384;5797.2173756542325;5829.271341082364;5855.209546711225;5857.970710146422;5868.706564671749;5595;5651.124075768263;5678.432156784371;5724.79963201286;5755.539556835443;5624.775008999594;5717.857053573611;5730.885382292414;5763.193152958589;5766.625169363978;4359;4389.31965545341;4405.603495685404;4407.228734971367;4443.4445694288215;3890.396988466792;3903.980480097581;3915.6084391560616;3924.4113382992778;3961.960380396159;5518.33779946409;5564.137558678412;5570.053090974544;5576.470235327637;5628.521575666033;5804.154657784188;5818.796342128006;5866.325372582208;5867.530597552186;5874.265716785402;5429.782808687608;5488.69812160327;5500.899820036009;5502.2296878437055;5529.834104976857;4962.702237865739;5000.2749601307605;5001.299818025479;5008;5012.924806127911;6047.667378294148;6057.212562366953;6057.818265452043;6077.908831367533;6089.847753806191;5702.572307076985;5760.222369980167;5789.536837052941;5798.275215598051;5853.356130825691;6022.277326720821;6044.758209671564;6055.031195008777;6061.909071364022;6076.3012253591405;5597.44025597437;5710.2291190690385;5783.306003279633;5784.884302313846;5790.073588225863;5724.484796368347;5744.454276843693;5792.478676918929;5832;5848.093545500455;5638.464345887134;5661.66030038199;5665.716714164358;5673.858153546194;5707;5561.777528898961;5633.718314084197;5658.85852853682;5691.601587888808;5706.172604972338;5432.701201433959;5481.040817856939;5552.50027497511;5582.972085139549;5641.717914104196;5667.631603945731;5706.600537962303;5729.369769325454;5734.910367030251;5734.971325143348;5477.890442191214;5548.472895074961;5600.69196194197;5616.803411880564;5629.408912064175 20:32:27 INFO - PROCESS | 8708 | |1;ext.html;582.6678793087939;623.8097380299008;629.3454807000719;646.9320721324261;650.2944305428613;42630.57369426305;43460.78269608651;43517.56482435175;44352.556474435245;47450.525494745045;44920;45523.31715024269;45684;45691.31463028057;45711.77144114283;8851.070637583074;9033.412828166181;9060;9092.227160691316;9099.454032758023;8836.8674469883;8846.469211847278;8958.596863141174;8961.95519022404;8963.95518022409;8968.686095986643;9014.68448604299;9030.548472576378;9042.186203241707;9054.773630659252;8847.513386763725;8940.552972351357;8948.328875334344;8967.148120928501;8972.147645973622;8964.641414343418;8973.730788076367;9038.774030649221;9039.367244292902;9055.592498337524;42455.57544424547;42496.575034249574;42652.78673606643;42693;42744.3588346175;3506.877259295938;3593.389123848952;3615.7468977171607;3631.4189729643394;3731.776093434403;33034;33637.83181084103;33740.66259337424;33882.83058584716;33897.66102338969;4328.935065974013;4365.367021781855;4414.867553973386;4448.888777780549;4455.1757924784015;355077;361340;362690;485480;486080;60968.695156523936;61505.38494615086;61854;61871.38128618746;61935.69032154811;32842.17894552607;33081.17297067544;33229.83385083059;33457.665423345454;66255.66872165608;17431.302747890197;17510.21204045821;17568.121593920252;17637.559061023578;17759.112044397727;12660.936695316464;12720.93639531815;12722.681932951566;12762.361881905868;12763.425645845959;19711.211551537777;20013.799862001193;20019;20055.799442005686;20102.69845952312;7334.9266507335315;7367.926320736724;7533.530961462572;7577.583232922242;7593.4696161301235;957.6408846682494;979.2215188924822;984.625842179967;992.98715310383;1084.511969613677;31159.688403115677;31162.376752464825;31595.36809263802;32056;32103.357932841212;1070.0476575847501;1116.0736588631416;1124.6850881753123;1126.6338440006866;1139.584051821096;16487.752683709754;16843.83156168447;16908.32366705318;17049.14754262282;17092.145392730563;538766;543731;544214;544595;547024;59172;59682;59773.40226597765;60026.39973600295;60320.69839650774;1333.8732820382047;1343.899207559437;1346.4143097752706;1384.5777038003505;1385.778275475919;29820.10539683813;30444.695553044185;30845.383092338478;31436.685633143377;32060;51417.742911285204;51738;51911.2213316793;51948.22077668914;52145.7392713034;357425;357654;359104;360150;361457;27509.17472475829;28297.717022829507;28540.714592853805;28696.569551456327;28732;48791.26813097877;48998;50118;50992.74503627458;53601.731991339795;41217.38173927453;42320;42827.357589635554;43302.56697432986;43947.12105757803;41375.37936930888;41854;41883.58116418797;42401.78799105985;42535.787321063195;35880;40152.59847401606;40279.39580906348;40434.595654043085;41011.384829228184;35223.82388088146;36140.63859361373;36191.63808361988;36485.27029459343;36897.44653830141;28062;28563.42873142567;28648.283792905346;28719.712802871705;28808.855955720086 20:32:27 INFO - PROCESS | 8708 | |2;jquery.html;389.33618181001395;390.32863474823296;393.18610476314024;399.3769719237989;410.5996653263069;18400;20123.396298111064;20203.39389818308;20253.291134810286;20439.386818395436;18981.525461863424;19477.513062173417;19551;19602.215911363528;19991.200351985903;5695.572832037593;5823.767049318043;5854.619449735754;5871.266091738533;5874.089516124986;5563.638363506379;5727.42725727426;5753.108268218432;5766.0486019806685;5766.826995190151;5656.943430565683;5657.830265092054;5745.080787074069;5799.449052340042;5808.883822323551;5746.626469279484;5773.682447465409;5781.768729250846;5782.132680097977;5833.533317334603;4965.379327584052;5026.67326623772;5035.295058691786;5050.84847454577;5069.746512674352;22956.54086918252;23642.408939776473;23851;23893.641595376084;23941.88029059861;2227.888605569715;2552.7957763378886;2591.7280181959513;2593.948121037569;3022.6977302269815;13593.52422665202;14440.13359198441;14764.335604897806;14983.250837458083;15071.09573425598;1947.9707804382945;1953.433504283756;1976.7627884653934;2052.0252879881937;2092.9162833486644;73542.63228683877;75523;75923.62038189774;78651;85578.14421855765;17642.911785441247;17797.377091801725;17895.37366192177;17902.820971790115;18436.170372333276;31916;32170.35659286801;32502;32969.505457418156;33167;10138.391696498235;10259.640912568024;10544.472776361152;10571.682849514527;10874.619388321371;8177.836443271221;8994.325425593106;9022.639094436281;9152;9163.541822908828;8628.568571571397;8891.377603567687;8967.237784788236;9053.456792592466;9055.68305109318;3496.493008513751;3569.7679650822615;3582.444721068239;3600.837962291703;3664.6518580734787;875.8773771671971;950.3490109275168;970.3401686853008;1003.7390278527489;1023.5701005577527;18400.723989140173;19495.22019119248;19587.80412195888;19813.702794458095;20458.283960061326;940.7648087978006;955.9426434413957;968.6222373274429;985.4235272365603;1039.776448063655;9272.629094836131;11230.15773816967;11282.717932051764;11452.141089418326;11490.13823963206;470494;470932;472275;472646;489345;88428;89979.55010224906;90423.54788226017;90464;90758.54620726855;966.3863446711389;979.9657012004545;988.7824678570703;997.4015590645699;999.5851721535627;17563.736543951596;17660.823391765916;17706.380276690255;17724.55688607795;18178;41626;42378.78810605927;42519.7874010628;42736.57263427326;43688.344674830536;58736.706316468146;59470;59887.70056149692;60004;60996.695016526406;7712.961435193012;8069.636866340911;9143.222826059593;9310.301727370339;9506.144446999802;12786.61640150797;13756.931215343859;13793.448262069405;14218.289085545888;14239.928800355932;11617.128715346214;12130.211536250115;12416.689582760504;12612.369381530703;12818.423170957143;11473.541058357572;11870.109741769575;12006.579769708018;12154.331511766937;12376.75246495083;12138.696532586757;12731.172473789175;12735.55425560101;12749.93625031869;12777.808332874829;7863.135055143815;8232.300254478436;8285.047219569586;8301;8961.372703910663;12241.265524068584;12315.568955086528;12352.3823808811;12440.937795310965;12485.500579977062 20:32:27 INFO - PROCESS | 8708 | |3;mootools.html;1486.2420165715482;1520.141120267049;1648.7526870969352;1761.6388640328742;1774.1395423219744;7623.123340815794;8636.093210212932;8657.567121643924;9212.539373031346;9219.539023048847;8689.217970382664;8968.506732129747;9044.27645788337;9046.86429703555;9089;2344.824138189634;2360.657704632827;2375.3586531636447;2376.0733314007466;2384.380061184096;2316.4324740438533;2321.129576408847;2336.0889253191267;2342.4495243617735;2359.4101474631343;2313.953720925589;2325.430269583954;2327.418145463634;2358.3868194269444;2393.1982785766704;2267.3651377614297;2304.7349554801244;2316.5598536278053;2326.174208156114;2329.04509151248;2265.614845476273;2276.066812606823;2279.8974046167964;2282;2290.209877592228;8958.507282099481;8999.145081217273;9000.77498062547;9020.60180671997;9091.681791137278;5149.9485005149845;5286.286351342558;5318.707471089088;5335.4131045585345;5351.277577527023;3372.7470439717117;3490.4240800267926;3559.857605695769;3591.622879597631;3646.252518233756;1236.5548402575066;1241.472374240953;1263.0716423428773;1264.8932184338703;1281.9230846149167;12293.3238671873;12314;12314.938425307817;12341.93829030858;12390.31853248062;4755.2391617341755;4772.933538983431;4847.903041939141;4891.461939186686;4893.143699852511;10465.947670261752;10541.104006159409;10559.524821383056;10582.841257381146;10589.629362972259;5297.046531624344;5383.569314454834;5384.138537833927;5387.164989426645;5394.406615272317;4216.409702641633;4894.070126675921;4973.602111831045;5051.1413059779925;5060.3927528696795;3948.980255098764;4025.154717509356;4096.344584866407;4103.056297051695;4159.396887451303;1267.2649863079391;1281.8718128187293;1288.7486940046788;1299.564645843653;1316.3813007886279;870.8432482153147;939.5443210043123;976.4092723901937;982.1357205659117;1010.5351538292321;6048.848778780566;6264.718087686065;6309.810705678837;6313.589616674902;6521.673916304166;975.1467465967279;997.7306127345721;1005.703317521333;1016.8627235323137;1030.6598822388594;4401.119776044804;4448.088141930896;4475.888102797456;4542.84100056503;4543.522930092358;11047.171462140372;11355.432228388547;11449.54201831934;11452.083833293316;11455.770884582262;11081.445927703582;11204.66386008421;11210.775784484265;11262.605808796652;11265.493052812642;8223.629936652866;8346.123657016047;8409;8443.53560554163;8456.704015359433;6021.698915054318;6039.879202416015;6046.365131661112;6093.238345206849;6248.4064013918605;10307.519061816354;10355;10361.84457233127;10410.635627752992;10440.843387349349;9873.753156171153;10176.745581360228;10187.847182292124;10436.16510679159;10483.737906552396;7058.858822823618;7730.11103723079;7939.84120317602;7941.364690824836;8154.510729356258;8834.823303533765;8879.955600221958;8905;8905.55472226373;8965.148310910454;7875.84248315042;7982.361411086983;8066.695814619135;8133.186681331819;8135.471194372347;7876.369890408868;7948.165442628672;7980.241877021674;8070.83858322842;8113.269805717514;7365.558066516026;7401.3708834747495;7431.442641801995;7488.363489103487;7494.737684181027;5343.599230057684;5456.836294911159;5497.230387745799;5498.890022199614;5511.476409741068;5051.696898186121;5285.577153827608;5319.601029922694;5379.919301210563;5415.756290966837 20:32:27 INFO - PROCESS | 8708 | |4;prototype.html;339.8885643944302;341.6463959801606;341.70783979697353;348.8866118511484;351.5359725162786;5598.692071936042;5609.663420194791;5616.634918730279;5705.372409035008;5744.138379243115;5581.665100093997;5588.804391846286;5597.328320601534;5599.384067752544;5627.7467513961865;4152.418661387408;4194.727342722713;4306.935395969063;4335.934960975588;4352.586504282104;4319.48166220054;4320.63274621656;4348.630366418858;4384.167008268435;4397.296432570789;4301.26878430666;4333.285007973681;4344.739315641072;4358.498772641139;4364.170807546572;4232.915341693164;4266.573342665724;4333.371661109121;4343.978280108611;4365.781710914442;3747.4378843173467;3777.1690228149764;3777.471154038437;3790.298794722985;3793.487879136309;5412.756425960842;5419.3225846769155;5445.482679145475;5475.72621368934;5485.424030476823;4861.489543597907;4988.351514303117;4989.351384320015;5016.54851063406;5028.446870844205;5830.941690583082;5834.949709052369;5851.941480585182;5910.940890591125;5918.526517878559;4171.833126674929;4182.268103081979;4191.392248124035;4208.011117387411;4219.2194444027955;5674.574406919498;6040.697965101727;6040.909386359208;6066.605670631395;6074.696265186723;4197.979010104991;4209.24233637942;4214.325707886724;4224.746515209097;4242.957570424256;4253.957460425418;4261.9132121309485;4264.360345948071;4280.978595107004;4282.550332215073;4779.761011949388;4952.306677065214;4962.528559786814;4971.304017437562;4975.477574854661;5923.963306421359;5932.377100404396;5933.6352638893295;5953.9282929072315;5980.671063091571;1488.5534339698047;1492.6492274315526;1499.587613406322;1503.88720845937;1511.3652266048286;931.5528546297815;962.9359557688794;993.2897977945659;1024.7694268789612;1027.9023492768324;5567.387587365387;5628.2683251177905;5652.519535839418;5669.206311116447;5669.262995810601;5990.5507086968655;6007.948608993409;6013.1581578579035;6050.183225264533;6090.969545152246;5486.972565137149;5526.723663816793;5541.362743284493;5570.359408667974;5650.468457214241;3191.1064901827526;3202.606866013292;3209.6308924473983;3224.6775322467565;3240.4653232216892;5940.851478713067;6096.451319381277;6122.295935967331;6189.690515474208;6211.9689401552705;6081.756729730761;6093.969530152321;6096.817095487142;6100.450959413585;6112.532992081958;6047.727852246571;6167.876642467215;6215.81352559424;6239.906401403982;6304.716287767062;5937.435943585352;5981.162637230878;5983.730732116978;6002.219711437485;6020.698965051817;5899.144624029577;5904.202932604044;5907.734151963258;5923.259592550931;5927.303077099823;5855.765769369177;6116.602420842631;6121.938780612137;6147.73971335884;6157.230346206724;4225.51406588234;4259.169461954889;4278.80745366453;4280.143971205709;4284.957150428456;5825.970870145622;5878.735456904364;6019.70576326092;6037.309553325076;6040.486558642565;5794.594378393472;5814.790379655873;5816.680082595329;5861.501772349398;5874.7956668883635;5578.214971209336;5845.3570107289015;5847.590668653153;5913.58604897653;5935.465808077293;5709.22925405065;5719.942800572107;5721.542276617944;5721.799737009184;5746.741396637078;5909.586328957103;5910.940890591211;5922.940770592411;5928.318243402064;5955.166276721176;5415.783368665209;5773.960687076366;5778.248827652378;5785.247917770663;5786.566007549535 20:32:27 INFO - PROCESS | 8708 | |5;yui.html;725.3870479444871;770.2374649097395;808.4138999225561;835.1314632781907;838.161838161838;13316;14072.71854562908;14252.358643861025;14333.713325733479;14410.567682969515;14212;14400.855991440083;14408.927955360208;14434.20611866347;14438.278086095706;655.9508036897228;774.5314084978592;779.3764988009598;787.2127872127872;787.5510958753513;793.7975816166869;793.8848866914294;794.4399198564997;795.7214974758846;797.2625321577517;823.5593957232882;825.0965193113531;826.4669288309037;832.3840358134997;836.5399030533182;821.4865708931918;823.6458322921142;828.3042244514577;830.4353039932873;830.8006078541167;596.9761209551613;597.3846937654223;598.500252289339;604.8639056212361;606.6784604159758;13507.729845403135;13537;13566.45734170632;13588;13665.726685466334;15068.54794356171;15300.158491282975;15324.310406031755;15369.154696491689;15577.688446231125;11995.520179192821;12318.384080795924;12337;12507.812382814265;12533.373331333396;3902.824372903226;3924.31324518211;3931.331673615464;3944.4872166618443;4013.3177359848896;74563;77004.61497692532;77130.99999999943;78441;79021;11755.471003804849;11813.291202527877;11862.406879655982;11939.582114625946;12047.096467764954;22347.329580112622;22449.775502245095;22462.213822516132;22545.43636409103;23100.768992310197;8786.209241168326;8825.426347287406;8879.556022198864;8933.731988040368;8959.372843900996;4733.526647335308;4863.586595139382;4870.756462176948;4874.829380971649;4977.352944117241;3662.890113296552;3801.0497375656087;3815.790131542736;3820.121372084436;4010;711.989320160198;716.9749058782918;741.1291732214627;746.2500187311717;749.6214411722045;620.9877899024651;656.5305806348483;740.6963145110478;744.5607091815747;755.267390631087;9743.610255589698;10216.438095904796;10374.17006639467;10420.531076101593;10422.478876056166;563.9266895303584;678.8404724889647;693.5284006875373;702.5995182745786;711.5943911970231;4758.547937945889;4921.9507804922205;5006.211613971896;5039.84880453587;5058.54473097423;124724.37637811752;130565.34717326352;131666;131913;133818.33090834483;113528.43235783934;114670.42664786623;115596;115805.42097289627;116942;72830.63584682043;85233.14766852376;89556.20887582212;95362.52318738362;100490.49754751325;9154.130357616015;9504.762380940532;9539.618415263589;9614;9621.41354815675;55949.72025139848;56382.43617563772;56584.43415565792;56658.433415666965;57054.144187836384;46256.30615540702;75920.62039689987;81488.18511814806;83820;86503;12274.202176858476;12446.43991020388;12669;12904;12929.288889111189;13201.141925774795;13286.069975102037;13292.867071329163;13471.797923030967;13844;12361.196522226026;12456.688582785502;12839.807402888777;13015.674608134872;13487.190768553919;13613.455461781417;13765.724685506435;13789.862101378858;13849.930750346184;14215.928920355333;12555;12806.743865122831;13076.607701768962;13131.934340328236;13238.139520931109;10698.14414846826;10896.564137434414;11015.112348379527;11062.446877656246;11198.272112312674;10982.231243812856;11038.132636992485;11196.552137914392;11242.55029798799;11288.60489882883 20:32:27 INFO - PROCESS | 8708 | __end_tp_report 20:32:27 INFO - PROCESS | 8708 | __start_cc_report 20:32:27 INFO - PROCESS | 8708 | _x_x_mozilla_cycle_collect,355 20:32:27 INFO - PROCESS | 8708 | __end_cc_report 20:32:27 INFO - PROCESS | 8708 | __startTimestamp1466911947570__endTimestamp 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | ------- Summary: start ------- 20:32:27 INFO - PROCESS | 8708 | Number of tests: 6 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | [#0] dojo.html Cycles:165 Average:5362.79 Median:5597.44 stddev:721.17 (12.9%) stddev-sans-first:700.62 20:32:27 INFO - PROCESS | 8708 | Values: 3071.1 3107.6 3135.0 3138.9 3147.9 5363.9 5405.1 5431.8 5470.7 5503.6 5306.8 5366.8 5417.1 5463.9 5474.2 4917.9 4935.5 4987.9 5028.5 5125.1 551.4 4864.1 4938.8 4986.2 5015.5 4916.8 4934.2 4935.6 4938.1 4947.2 4863.7 4950.7 4953.6 4974.7 5020.7 4903.3 4916.0 4929.9 4935.7 4980.7 5372.8 5430.4 5451.0 5451.6 5453.8 5677.4 5742.6 5802.0 5841.2 5848.5 5752.5 5763.9 5772.3 5804.5 5818.9 5441.7 5442.6 5450.1 5456.5 5480.0 5793.2 5849.7 5924.6 5936.3 5960.1 5648.8 5725.2 5764.5 5781.4 5783.9 5797.2 5829.3 5855.2 5858.0 5868.7 5595.0 5651.1 5678.4 5724.8 5755.5 5624.8 5717.9 5730.9 5763.2 5766.6 4359.0 4389.3 4405.6 4407.2 4443.4 3890.4 3904.0 3915.6 3924.4 3962.0 5518.3 5564.1 5570.1 5576.5 5628.5 5804.2 5818.8 5866.3 5867.5 5874.3 5429.8 5488.7 5500.9 5502.2 5529.8 4962.7 5000.3 5001.3 5008.0 5012.9 6047.7 6057.2 6057.8 6077.9 6089.8 5702.6 5760.2 5789.5 5798.3 5853.4 6022.3 6044.8 6055.0 6061.9 6076.3 5597.4 5710.2 5783.3 5784.9 5790.1 5724.5 5744.5 5792.5 5832.0 5848.1 5638.5 5661.7 5665.7 5673.9 5707.0 5561.8 5633.7 5658.9 5691.6 5706.2 5432.7 5481.0 5552.5 5583.0 5641.7 5667.6 5706.6 5729.4 5734.9 5735.0 5477.9 5548.5 5600.7 5616.8 5629.4 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | [#1] ext.html Cycles:180 Average:59836.74 Median:42516.18 stddev:118269.82 (278.2%) stddev-sans-first:118517.92 20:32:27 INFO - PROCESS | 8708 | Values: 582.7 623.8 629.3 646.9 650.3 42630.6 43460.8 43517.6 44352.6 47450.5 44920.0 45523.3 45684.0 45691.3 45711.8 8851.1 9033.4 9060.0 9092.2 9099.5 8836.9 8846.5 8958.6 8962.0 8964.0 8968.7 9014.7 9030.5 9042.2 9054.8 8847.5 8940.6 8948.3 8967.1 8972.1 8964.6 8973.7 9038.8 9039.4 9055.6 42455.6 42496.6 42652.8 42693.0 42744.4 3506.9 3593.4 3615.7 3631.4 3731.8 33034.0 33637.8 33740.7 33882.8 33897.7 4328.9 4365.4 4414.9 4448.9 4455.2 355077.0 361340.0 362690.0 485480.0 486080.0 60968.7 61505.4 61854.0 61871.4 61935.7 32842.2 33081.2 33229.8 33457.7 66255.7 17431.3 17510.2 17568.1 17637.6 17759.1 12660.9 12720.9 12722.7 12762.4 12763.4 19711.2 20013.8 20019.0 20055.8 20102.7 7334.9 7367.9 7533.5 7577.6 7593.5 957.6 979.2 984.6 993.0 1084.5 31159.7 31162.4 31595.4 32056.0 32103.4 1070.0 1116.1 1124.7 1126.6 1139.6 16487.8 16843.8 16908.3 17049.1 17092.1 538766.0 543731.0 544214.0 544595.0 547024.0 59172.0 59682.0 59773.4 60026.4 60320.7 1333.9 1343.9 1346.4 1384.6 1385.8 29820.1 30444.7 30845.4 31436.7 32060.0 51417.7 51738.0 51911.2 51948.2 52145.7 357425.0 357654.0 359104.0 360150.0 361457.0 27509.2 28297.7 28540.7 28696.6 28732.0 48791.3 48998.0 50118.0 50992.7 53601.7 41217.4 42320.0 42827.4 43302.6 43947.1 41375.4 41854.0 41883.6 42401.8 42535.8 35880.0 40152.6 40279.4 40434.6 41011.4 35223.8 36140.6 36191.6 36485.3 36897.4 28062.0 28563.4 28648.3 28719.7 28808.9 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | [#2] jquery.html Cycles:180 Average:29716.63 Median:3632.74 stddev:78166.33 (2151.7%) stddev-sans-first:78354.59 20:32:27 INFO - PROCESS | 8708 | Values: 389.3 390.3 393.2 399.4 410.6 18400.0 20123.4 20203.4 20253.3 20439.4 18981.5 19477.5 19551.0 19602.2 19991.2 5695.6 5823.8 5854.6 5871.3 5874.1 5563.6 5727.4 5753.1 5766.0 5766.8 5656.9 5657.8 5745.1 5799.4 5808.9 5746.6 5773.7 5781.8 5782.1 5833.5 4965.4 5026.7 5035.3 5050.8 5069.7 22956.5 23642.4 23851.0 23893.6 23941.9 2227.9 2552.8 2591.7 2593.9 3022.7 13593.5 14440.1 14764.3 14983.3 15071.1 1948.0 1953.4 1976.8 2052.0 2092.9 73542.6 75523.0 75923.6 78651.0 85578.1 17642.9 17797.4 17895.4 17902.8 18436.2 31916.0 32170.4 32502.0 32969.5 33167.0 10138.4 10259.6 10544.5 10571.7 10874.6 8177.8 8994.3 9022.6 9152.0 9163.5 8628.6 8891.4 8967.2 9053.5 9055.7 3496.5 3569.8 3582.4 3600.8 3664.7 875.9 950.3 970.3 1003.7 1023.6 18400.7 19495.2 19587.8 19813.7 20458.3 940.8 955.9 968.6 985.4 1039.8 9272.6 11230.2 11282.7 11452.1 11490.1 470494.0 470932.0 472275.0 472646.0 489345.0 88428.0 89979.6 90423.5 90464.0 90758.5 966.4 980.0 988.8 997.4 999.6 17563.7 17660.8 17706.4 17724.6 18178.0 41626.0 42378.8 42519.8 42736.6 43688.3 58736.7 59470.0 59887.7 60004.0 60996.7 7713.0 8069.6 9143.2 9310.3 9506.1 12786.6 13756.9 13793.4 14218.3 14239.9 11617.1 12130.2 12416.7 12612.4 12818.4 11473.5 11870.1 12006.6 12154.3 12376.8 12138.7 12731.2 12735.6 12749.9 12777.8 7863.1 8232.3 8285.0 8301.0 8961.4 12241.3 12315.6 12352.4 12440.9 12485.5 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | [#3] mootools.html Cycles:180 Average:5959.21 Median:4810.42 stddev:3362.91 (69.9%) stddev-sans-first:3355.54 20:32:27 INFO - PROCESS | 8708 | Values: 1486.2 1520.1 1648.8 1761.6 1774.1 7623.1 8636.1 8657.6 9212.5 9219.5 8689.2 8968.5 9044.3 9046.9 9089.0 2344.8 2360.7 2375.4 2376.1 2384.4 2316.4 2321.1 2336.1 2342.4 2359.4 2314.0 2325.4 2327.4 2358.4 2393.2 2267.4 2304.7 2316.6 2326.2 2329.0 2265.6 2276.1 2279.9 2282.0 2290.2 8958.5 8999.1 9000.8 9020.6 9091.7 5149.9 5286.3 5318.7 5335.4 5351.3 3372.7 3490.4 3559.9 3591.6 3646.3 1236.6 1241.5 1263.1 1264.9 1281.9 12293.3 12314.0 12314.9 12341.9 12390.3 4755.2 4772.9 4847.9 4891.5 4893.1 10465.9 10541.1 10559.5 10582.8 10589.6 5297.0 5383.6 5384.1 5387.2 5394.4 4216.4 4894.1 4973.6 5051.1 5060.4 3949.0 4025.2 4096.3 4103.1 4159.4 1267.3 1281.9 1288.7 1299.6 1316.4 870.8 939.5 976.4 982.1 1010.5 6048.8 6264.7 6309.8 6313.6 6521.7 975.1 997.7 1005.7 1016.9 1030.7 4401.1 4448.1 4475.9 4542.8 4543.5 11047.2 11355.4 11449.5 11452.1 11455.8 11081.4 11204.7 11210.8 11262.6 11265.5 8223.6 8346.1 8409.0 8443.5 8456.7 6021.7 6039.9 6046.4 6093.2 6248.4 10307.5 10355.0 10361.8 10410.6 10440.8 9873.8 10176.7 10187.8 10436.2 10483.7 7058.9 7730.1 7939.8 7941.4 8154.5 8834.8 8880.0 8905.0 8905.6 8965.1 7875.8 7982.4 8066.7 8133.2 8135.5 7876.4 7948.2 7980.2 8070.8 8113.3 7365.6 7401.4 7431.4 7488.4 7494.7 5343.6 5456.8 5497.2 5498.9 5511.5 5051.7 5285.6 5319.6 5379.9 5415.8 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | [#4] prototype.html Cycles:180 Average:4917.25 Median:5622.19 stddev:1449.24 (25.8%) stddev-sans-first:1411.99 20:32:27 INFO - PROCESS | 8708 | Values: 339.9 341.6 341.7 348.9 351.5 5598.7 5609.7 5616.6 5705.4 5744.1 5581.7 5588.8 5597.3 5599.4 5627.7 4152.4 4194.7 4306.9 4335.9 4352.6 4319.5 4320.6 4348.6 4384.2 4397.3 4301.3 4333.3 4344.7 4358.5 4364.2 4232.9 4266.6 4333.4 4344.0 4365.8 3747.4 3777.2 3777.5 3790.3 3793.5 5412.8 5419.3 5445.5 5475.7 5485.4 4861.5 4988.4 4989.4 5016.5 5028.4 5830.9 5834.9 5851.9 5910.9 5918.5 4171.8 4182.3 4191.4 4208.0 4219.2 5674.6 6040.7 6040.9 6066.6 6074.7 4198.0 4209.2 4214.3 4224.7 4243.0 4254.0 4261.9 4264.4 4281.0 4282.6 4779.8 4952.3 4962.5 4971.3 4975.5 5924.0 5932.4 5933.6 5953.9 5980.7 1488.6 1492.6 1499.6 1503.9 1511.4 931.6 962.9 993.3 1024.8 1027.9 5567.4 5628.3 5652.5 5669.2 5669.3 5990.6 6007.9 6013.2 6050.2 6091.0 5487.0 5526.7 5541.4 5570.4 5650.5 3191.1 3202.6 3209.6 3224.7 3240.5 5940.9 6096.5 6122.3 6189.7 6212.0 6081.8 6094.0 6096.8 6100.5 6112.5 6047.7 6167.9 6215.8 6239.9 6304.7 5937.4 5981.2 5983.7 6002.2 6020.7 5899.1 5904.2 5907.7 5923.3 5927.3 5855.8 6116.6 6121.9 6147.7 6157.2 4225.5 4259.2 4278.8 4280.1 4285.0 5826.0 5878.7 6019.7 6037.3 6040.5 5794.6 5814.8 5816.7 5861.5 5874.8 5578.2 5845.4 5847.6 5913.6 5935.5 5709.2 5719.9 5721.5 5721.8 5746.7 5909.6 5910.9 5922.9 5928.3 5955.2 5415.8 5774.0 5778.2 5785.2 5786.6 20:32:27 INFO - PROCESS | 8708 | 20:32:27 INFO - PROCESS | 8708 | [#5] yui.html Cycles:180 Average:21888.35 Median:3927.82 stddev:33057.87 (841.6%) stddev-sans-first:33112.42 20:32:27 INFO - PROCESS | 8708 | Values: 725.4 770.2 808.4 835.1 838.2 13316.0 14072.7 14252.4 14333.7 14410.6 14212.0 14400.9 14408.9 14434.2 14438.3 656.0 774.5 779.4 787.2 787.6 793.8 793.9 794.4 795.7 797.3 823.6 825.1 826.5 832.4 836.5 821.5 823.6 828.3 830.4 830.8 597.0 597.4 598.5 604.9 606.7 13507.7 13537.0 13566.5 13588.0 13665.7 15068.5 15300.2 15324.3 15369.2 15577.7 11995.5 12318.4 12337.0 12507.8 12533.4 3902.8 3924.3 3931.3 3944.5 4013.3 74563.0 77004.6 77131.0 78441.0 79021.0 11755.5 11813.3 11862.4 11939.6 12047.1 22347.3 22449.8 22462.2 22545.4 23100.8 8786.2 8825.4 8879.6 8933.7 8959.4 4733.5 4863.6 4870.8 4874.8 4977.4 3662.9 3801.0 3815.8 3820.1 4010.0 712.0 717.0 741.1 746.3 749.6 621.0 656.5 740.7 744.6 755.3 9743.6 10216.4 10374.2 10420.5 10422.5 563.9 678.8 693.5 702.6 711.6 4758.5 4922.0 5006.2 5039.8 5058.5 124724.4 130565.3 131666.0 131913.0 133818.3 113528.4 114670.4 115596.0 115805.4 116942.0 72830.6 85233.1 89556.2 95362.5 100490.5 9154.1 9504.8 9539.6 9614.0 9621.4 55949.7 56382.4 56584.4 56658.4 57054.1 46256.3 75920.6 81488.2 83820.0 86503.0 12274.2 12446.4 12669.0 12904.0 12929.3 13201.1 13286.1 13292.9 13471.8 13844.0 12361.2 12456.7 12839.8 13015.7 13487.2 13613.5 13765.7 13789.9 13849.9 14215.9 12555.0 12806.7 13076.6 13131.9 13238.1 10698.1 10896.6 11015.1 11062.4 11198.3 10982.2 11038.1 11196.6 11242.6 11288.6 20:32:27 INFO - PROCESS | 8708 | -------- Summary: end -------- 20:32:27 INFO - PROCESS | 8708 | 20:32:28 INFO - TEST-INFO | 8708: exit 0 20:32:28 INFO - TEST-OK | dromaeo_css | took 1110242ms 20:32:28 INFO - TEST-START | kraken 20:32:28 INFO - operating with platform_type : linux_ 20:32:28 INFO - Initialising browser for kraken test... 20:32:28 INFO - TEST-INFO | started process 8946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfoxdQn/profile http://localhost:48394/getInfo.html) 20:32:33 INFO - PROCESS | 8946 | __metrics Screen width/height:1600/1200 20:32:33 INFO - PROCESS | 8946 | colorDepth:24 20:32:33 INFO - PROCESS | 8946 | Browser inner width/height: 1024/697 20:32:33 INFO - PROCESS | 8946 | __metrics 20:32:33 ERROR - PROCESS | 8946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:32:34 INFO - TEST-INFO | 8946: exit 0 20:32:34 INFO - Browser initialized. 20:32:34 INFO - Running cycle 1/1 for kraken test... 20:32:34 INFO - TEST-INFO | started process 9065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfoxdQn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:32:46 INFO - PROCESS | 9065 | RSS: Main: 184983552 20:32:46 INFO - PROCESS | 9065 | 20:32:48 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48394/tests/kraken/driver.html?testName=audio-beat-detection) 20:32:49 INFO - PROCESS | 9065 | RSS: Main: 190205952 20:32:49 INFO - PROCESS | 9065 | 20:32:52 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48394/tests/kraken/driver.html?testName=audio-dft) 20:32:53 INFO - PROCESS | 9065 | RSS: Main: 189526016 20:32:53 INFO - PROCESS | 9065 | 20:32:56 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48394/tests/kraken/driver.html?testName=audio-fft) 20:32:56 INFO - PROCESS | 9065 | RSS: Main: 184217600 20:32:56 INFO - PROCESS | 9065 | 20:32:58 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48394/tests/kraken/driver.html?testName=audio-oscillator) 20:32:59 INFO - PROCESS | 9065 | RSS: Main: 185257984 20:32:59 INFO - PROCESS | 9065 | 20:33:01 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48394/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:33:02 INFO - PROCESS | 9065 | RSS: Main: 185610240 20:33:02 INFO - PROCESS | 9065 | 20:33:05 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48394/tests/kraken/driver.html?testName=imaging-darkroom) 20:33:05 INFO - PROCESS | 9065 | RSS: Main: 185249792 20:33:05 INFO - PROCESS | 9065 | 20:33:09 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48394/tests/kraken/driver.html?testName=imaging-desaturate) 20:33:10 INFO - PROCESS | 9065 | RSS: Main: 183164928 20:33:10 INFO - PROCESS | 9065 | 20:33:12 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48394/tests/kraken/driver.html?testName=json-parse-financial) 20:33:13 INFO - PROCESS | 9065 | RSS: Main: 184655872 20:33:13 INFO - PROCESS | 9065 | 20:33:15 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48394/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:33:15 INFO - PROCESS | 9065 | RSS: Main: 185098240 20:33:15 INFO - PROCESS | 9065 | 20:33:17 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:33:18 INFO - PROCESS | 9065 | RSS: Main: 185622528 20:33:18 INFO - PROCESS | 9065 | 20:33:20 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:33:20 INFO - PROCESS | 9065 | RSS: Main: 185856000 20:33:20 INFO - PROCESS | 9065 | 20:33:23 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:33:24 INFO - PROCESS | 9065 | RSS: Main: 186413056 20:33:24 INFO - PROCESS | 9065 | 20:33:26 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:33:27 INFO - PROCESS | 9065 | RSS: Main: 186507264 20:33:27 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | Cycle 1(1): loaded http://localhost:48394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48394/tests/kraken/driver.html?testName=ai-astar) 20:33:29 INFO - PROCESS | 9065 | RSS: Main: 187113472 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | __start_tp_report 20:33:29 INFO - PROCESS | 9065 | _x_x_mozilla_page_load 20:33:29 INFO - PROCESS | 9065 | _x_x_mozilla_page_load_details 20:33:29 INFO - PROCESS | 9065 | |i|pagename|runs| 20:33:29 INFO - PROCESS | 9065 | |0;ai-astar;101;111;105;111;111;111;113;109;111;110 20:33:29 INFO - PROCESS | 9065 | |1;audio-beat-detection;157;125;154;183;129;154;161;129;182;134 20:33:29 INFO - PROCESS | 9065 | |2;audio-dft;163;164;161;163;165;172;163;163;161;161 20:33:29 INFO - PROCESS | 9065 | |3;audio-fft;74;75;74;173;76;75;75;75;180;76 20:33:29 INFO - PROCESS | 9065 | |4;audio-oscillator;86;86;144;86;85;84;160;84;85;141 20:33:29 INFO - PROCESS | 9065 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;117;117;118 20:33:29 INFO - PROCESS | 9065 | |6;imaging-darkroom;146;147;148;147;148;147;149;148;148;147 20:33:29 INFO - PROCESS | 9065 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;95;95 20:33:29 INFO - PROCESS | 9065 | |8;json-parse-financial;56;56;58;57;56;57;56;57;58;56 20:33:29 INFO - PROCESS | 9065 | |9;json-stringify-tinderbox;63;62;61;62;62;62;62;62;62;62 20:33:29 INFO - PROCESS | 9065 | |10;stanford-crypto-aes;86;79;79;78;82;82;80;79;88;79 20:33:29 INFO - PROCESS | 9065 | |11;stanford-crypto-ccm;139;133;122;120;140;124;138;127;133;126 20:33:29 INFO - PROCESS | 9065 | |12;stanford-crypto-pbkdf2;162;159;163;156;164;160;166;166;164;164 20:33:29 INFO - PROCESS | 9065 | |13;stanford-crypto-sha256-iterative;66;65;64;64;64;64;68;63;65;61 20:33:29 INFO - PROCESS | 9065 | __end_tp_report 20:33:29 INFO - PROCESS | 9065 | __start_cc_report 20:33:29 INFO - PROCESS | 9065 | _x_x_mozilla_cycle_collect,871 20:33:29 INFO - PROCESS | 9065 | __end_cc_report 20:33:29 INFO - PROCESS | 9065 | __startTimestamp1466912009417__endTimestamp 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | ------- Summary: start ------- 20:33:29 INFO - PROCESS | 9065 | Number of tests: 14 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.59 (3.2%) stddev-sans-first:2.22 20:33:29 INFO - PROCESS | 9065 | Values: 101.0 111.0 105.0 111.0 111.0 111.0 113.0 109.0 111.0 110.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:155.50 stddev:21.27 (13.7%) stddev-sans-first:22.44 20:33:29 INFO - PROCESS | 9065 | Values: 157.0 125.0 154.0 183.0 129.0 154.0 161.0 129.0 182.0 134.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.24 (2.0%) stddev-sans-first:3.43 20:33:29 INFO - PROCESS | 9065 | Values: 163.0 164.0 161.0 163.0 165.0 172.0 163.0 163.0 161.0 161.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:42.83 (57.1%) stddev-sans-first:44.73 20:33:29 INFO - PROCESS | 9065 | Values: 74.0 75.0 74.0 173.0 76.0 75.0 75.0 75.0 180.0 76.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:85.00 stddev:30.91 (36.4%) stddev-sans-first:32.08 20:33:29 INFO - PROCESS | 9065 | Values: 86.0 86.0 144.0 86.0 85.0 84.0 160.0 84.0 85.0 141.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:33:29 INFO - PROCESS | 9065 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 20:33:29 INFO - PROCESS | 9065 | Values: 146.0 147.0 148.0 147.0 148.0 147.0 149.0 148.0 148.0 147.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:33:29 INFO - PROCESS | 9065 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 20:33:29 INFO - PROCESS | 9065 | Values: 56.0 56.0 58.0 57.0 56.0 57.0 56.0 57.0 58.0 56.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 20:33:29 INFO - PROCESS | 9065 | Values: 63.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:3.36 (4.1%) stddev-sans-first:3.08 20:33:29 INFO - PROCESS | 9065 | Values: 86.0 79.0 79.0 78.0 82.0 82.0 80.0 79.0 88.0 79.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:133.00 stddev:7.36 (5.5%) stddev-sans-first:7.08 20:33:29 INFO - PROCESS | 9065 | Values: 139.0 133.0 122.0 120.0 140.0 124.0 138.0 127.0 133.0 126.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:164.00 stddev:3.20 (2.0%) stddev-sans-first:3.40 20:33:29 INFO - PROCESS | 9065 | Values: 162.0 159.0 163.0 156.0 164.0 160.0 166.0 166.0 164.0 164.0 20:33:29 INFO - PROCESS | 9065 | 20:33:29 INFO - PROCESS | 9065 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.84 (2.8%) stddev-sans-first:1.86 20:33:29 INFO - PROCESS | 9065 | Values: 66.0 65.0 64.0 64.0 64.0 64.0 68.0 63.0 65.0 61.0 20:33:29 INFO - PROCESS | 9065 | -------- Summary: end -------- 20:33:29 INFO - PROCESS | 9065 | 20:33:30 INFO - TEST-INFO | 9065: exit 0 20:33:30 INFO - TEST-OK | kraken | took 62034ms 20:33:30 INFO - SUITE-END | took 1172s 20:33:30 INFO - Completed test suite (00:19:32) 20:33:30 INFO - javascript benchmark 20:33:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7494.7984685121655, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.063325685666, 3107.5960125183738, 3134.952975705364, 3138.9372212555763, 3147.9370412591747, 5363.91954120688, 5405.0541155297815, 5431.782728690852, 5470.699111548864, 5503.642263252896, 5306.814261500838, 5366.819299754057, 5417.079096553595, 5463.945360546393, 5474.178873169027, 4917.852464426064, 4935.457099719028, 4987.875303117415, 5028.547430731233, 5125.103106956286, 551.4372268989687, 4864.14877396456, 4938.777755001016, 4986.227134794112, 5015.498450154992, 4916.803327866899, 4934.1611925972675, 4935.605151587883, 4938.135826230413, 4947.208446648537, 4863.683860549053, 4950.727709975949, 4953.628477864138, 4974.651774375795, 5020.673656212334, 4903.289023091632, 4916.041371932474, 4929.901401971941, 4935.703857768545, 4980.651354405193, 5372.838814835562, 5430.402655707869, 5450.972745136289, 5451.64564303323, 5453.7818487260465, 5677.403872593401, 5742.626729262626, 5802.042662960649, 5841.211436456109, 5848.473637372615, 5752.539796816244, 5763.876044171347, 5772.30732312121, 5804.506616937565, 5818.854528636775, 5441.700706461143, 5442.619016668835, 5450.127979523297, 5456.454354564551, 5479.99999999996, 5793.246877905845, 5849.707514624337, 5924.585279030426, 5936.347001829795, 5960.0761881908375, 5648.802291919846, 5725.227094342294, 5764.510016648548, 5781.392953739881, 5783.913241301384, 5797.2173756542325, 5829.271341082364, 5855.209546711225, 5857.970710146422, 5868.706564671749, 5595.0, 5651.124075768263, 5678.432156784371, 5724.79963201286, 5755.539556835443, 5624.775008999594, 5717.857053573611, 5730.885382292414, 5763.193152958589, 5766.625169363978, 4359.0, 4389.31965545341, 4405.603495685404, 4407.228734971367, 4443.4445694288215, 3890.396988466792, 3903.980480097581, 3915.6084391560616, 3924.4113382992778, 3961.960380396159, 5518.33779946409, 5564.137558678412, 5570.053090974544, 5576.470235327637, 5628.521575666033, 5804.154657784188, 5818.796342128006, 5866.325372582208, 5867.530597552186, 5874.265716785402, 5429.782808687608, 5488.69812160327, 5500.899820036009, 5502.2296878437055, 5529.834104976857, 4962.702237865739, 5000.2749601307605, 5001.299818025479, 5008.0, 5012.924806127911, 6047.667378294148, 6057.212562366953, 6057.818265452043, 6077.908831367533, 6089.847753806191, 5702.572307076985, 5760.222369980167, 5789.536837052941, 5798.275215598051, 5853.356130825691, 6022.277326720821, 6044.758209671564, 6055.031195008777, 6061.909071364022, 6076.3012253591405, 5597.44025597437, 5710.2291190690385, 5783.306003279633, 5784.884302313846, 5790.073588225863, 5724.484796368347, 5744.454276843693, 5792.478676918929, 5832.0, 5848.093545500455, 5638.464345887134, 5661.66030038199, 5665.716714164358, 5673.858153546194, 5707.0, 5561.777528898961, 5633.718314084197, 5658.85852853682, 5691.601587888808, 5706.172604972338, 5432.701201433959, 5481.040817856939, 5552.50027497511, 5582.972085139549, 5641.717914104196, 5667.631603945731, 5706.600537962303, 5729.369769325454, 5734.910367030251, 5734.971325143348, 5477.890442191214, 5548.472895074961, 5600.69196194197, 5616.803411880564, 5629.408912064175], "value": 5315.699212354498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.6678793087939, 623.8097380299008, 629.3454807000719, 646.9320721324261, 650.2944305428613, 42630.57369426305, 43460.78269608651, 43517.56482435175, 44352.556474435245, 47450.525494745045, 44920.0, 45523.31715024269, 45684.0, 45691.31463028057, 45711.77144114283, 8851.070637583074, 9033.412828166181, 9060.0, 9092.227160691316, 9099.454032758023, 8836.8674469883, 8846.469211847278, 8958.596863141174, 8961.95519022404, 8963.95518022409, 8968.686095986643, 9014.68448604299, 9030.548472576378, 9042.186203241707, 9054.773630659252, 8847.513386763725, 8940.552972351357, 8948.328875334344, 8967.148120928501, 8972.147645973622, 8964.641414343418, 8973.730788076367, 9038.774030649221, 9039.367244292902, 9055.592498337524, 42455.57544424547, 42496.575034249574, 42652.78673606643, 42693.0, 42744.3588346175, 3506.877259295938, 3593.389123848952, 3615.7468977171607, 3631.4189729643394, 3731.776093434403, 33034.0, 33637.83181084103, 33740.66259337424, 33882.83058584716, 33897.66102338969, 4328.935065974013, 4365.367021781855, 4414.867553973386, 4448.888777780549, 4455.1757924784015, 355077.0, 361340.0, 362690.0, 485480.0, 486080.0, 60968.695156523936, 61505.38494615086, 61854.0, 61871.38128618746, 61935.69032154811, 32842.17894552607, 33081.17297067544, 33229.83385083059, 33457.665423345454, 66255.66872165608, 17431.302747890197, 17510.21204045821, 17568.121593920252, 17637.559061023578, 17759.112044397727, 12660.936695316464, 12720.93639531815, 12722.681932951566, 12762.361881905868, 12763.425645845959, 19711.211551537777, 20013.799862001193, 20019.0, 20055.799442005686, 20102.69845952312, 7334.9266507335315, 7367.926320736724, 7533.530961462572, 7577.583232922242, 7593.4696161301235, 957.6408846682494, 979.2215188924822, 984.625842179967, 992.98715310383, 1084.511969613677, 31159.688403115677, 31162.376752464825, 31595.36809263802, 32056.0, 32103.357932841212, 1070.0476575847501, 1116.0736588631416, 1124.6850881753123, 1126.6338440006866, 1139.584051821096, 16487.752683709754, 16843.83156168447, 16908.32366705318, 17049.14754262282, 17092.145392730563, 538766.0, 543731.0, 544214.0, 544595.0, 547024.0, 59172.0, 59682.0, 59773.40226597765, 60026.39973600295, 60320.69839650774, 1333.8732820382047, 1343.899207559437, 1346.4143097752706, 1384.5777038003505, 1385.778275475919, 29820.10539683813, 30444.695553044185, 30845.383092338478, 31436.685633143377, 32060.0, 51417.742911285204, 51738.0, 51911.2213316793, 51948.22077668914, 52145.7392713034, 357425.0, 357654.0, 359104.0, 360150.0, 361457.0, 27509.17472475829, 28297.717022829507, 28540.714592853805, 28696.569551456327, 28732.0, 48791.26813097877, 48998.0, 50118.0, 50992.74503627458, 53601.731991339795, 41217.38173927453, 42320.0, 42827.357589635554, 43302.56697432986, 43947.12105757803, 41375.37936930888, 41854.0, 41883.58116418797, 42401.78799105985, 42535.787321063195, 35880.0, 40152.59847401606, 40279.39580906348, 40434.595654043085, 41011.384829228184, 35223.82388088146, 36140.63859361373, 36191.63808361988, 36485.27029459343, 36897.44653830141, 28062.0, 28563.42873142567, 28648.283792905346, 28719.712802871705, 28808.855955720086], "value": 20153.082944884056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.33618181001395, 390.32863474823296, 393.18610476314024, 399.3769719237989, 410.5996653263069, 18400.0, 20123.396298111064, 20203.39389818308, 20253.291134810286, 20439.386818395436, 18981.525461863424, 19477.513062173417, 19551.0, 19602.215911363528, 19991.200351985903, 5695.572832037593, 5823.767049318043, 5854.619449735754, 5871.266091738533, 5874.089516124986, 5563.638363506379, 5727.42725727426, 5753.108268218432, 5766.0486019806685, 5766.826995190151, 5656.943430565683, 5657.830265092054, 5745.080787074069, 5799.449052340042, 5808.883822323551, 5746.626469279484, 5773.682447465409, 5781.768729250846, 5782.132680097977, 5833.533317334603, 4965.379327584052, 5026.67326623772, 5035.295058691786, 5050.84847454577, 5069.746512674352, 22956.54086918252, 23642.408939776473, 23851.0, 23893.641595376084, 23941.88029059861, 2227.888605569715, 2552.7957763378886, 2591.7280181959513, 2593.948121037569, 3022.6977302269815, 13593.52422665202, 14440.13359198441, 14764.335604897806, 14983.250837458083, 15071.09573425598, 1947.9707804382945, 1953.433504283756, 1976.7627884653934, 2052.0252879881937, 2092.9162833486644, 73542.63228683877, 75523.0, 75923.62038189774, 78651.0, 85578.14421855765, 17642.911785441247, 17797.377091801725, 17895.37366192177, 17902.820971790115, 18436.170372333276, 31916.0, 32170.35659286801, 32502.0, 32969.505457418156, 33167.0, 10138.391696498235, 10259.640912568024, 10544.472776361152, 10571.682849514527, 10874.619388321371, 8177.836443271221, 8994.325425593106, 9022.639094436281, 9152.0, 9163.541822908828, 8628.568571571397, 8891.377603567687, 8967.237784788236, 9053.456792592466, 9055.68305109318, 3496.493008513751, 3569.7679650822615, 3582.444721068239, 3600.837962291703, 3664.6518580734787, 875.8773771671971, 950.3490109275168, 970.3401686853008, 1003.7390278527489, 1023.5701005577527, 18400.723989140173, 19495.22019119248, 19587.80412195888, 19813.702794458095, 20458.283960061326, 940.7648087978006, 955.9426434413957, 968.6222373274429, 985.4235272365603, 1039.776448063655, 9272.629094836131, 11230.15773816967, 11282.717932051764, 11452.141089418326, 11490.13823963206, 470494.0, 470932.0, 472275.0, 472646.0, 489345.0, 88428.0, 89979.55010224906, 90423.54788226017, 90464.0, 90758.54620726855, 966.3863446711389, 979.9657012004545, 988.7824678570703, 997.4015590645699, 999.5851721535627, 17563.736543951596, 17660.823391765916, 17706.380276690255, 17724.55688607795, 18178.0, 41626.0, 42378.78810605927, 42519.7874010628, 42736.57263427326, 43688.344674830536, 58736.706316468146, 59470.0, 59887.70056149692, 60004.0, 60996.695016526406, 7712.961435193012, 8069.636866340911, 9143.222826059593, 9310.301727370339, 9506.144446999802, 12786.61640150797, 13756.931215343859, 13793.448262069405, 14218.289085545888, 14239.928800355932, 11617.128715346214, 12130.211536250115, 12416.689582760504, 12612.369381530703, 12818.423170957143, 11473.541058357572, 11870.109741769575, 12006.579769708018, 12154.331511766937, 12376.75246495083, 12138.696532586757, 12731.172473789175, 12735.55425560101, 12749.93625031869, 12777.808332874829, 7863.135055143815, 8232.300254478436, 8285.047219569586, 8301.0, 8961.372703910663, 12241.265524068584, 12315.568955086528, 12352.3823808811, 12440.937795310965, 12485.500579977062], "value": 10173.973469803725, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.2420165715482, 1520.141120267049, 1648.7526870969352, 1761.6388640328742, 1774.1395423219744, 7623.123340815794, 8636.093210212932, 8657.567121643924, 9212.539373031346, 9219.539023048847, 8689.217970382664, 8968.506732129747, 9044.27645788337, 9046.86429703555, 9089.0, 2344.824138189634, 2360.657704632827, 2375.3586531636447, 2376.0733314007466, 2384.380061184096, 2316.4324740438533, 2321.129576408847, 2336.0889253191267, 2342.4495243617735, 2359.4101474631343, 2313.953720925589, 2325.430269583954, 2327.418145463634, 2358.3868194269444, 2393.1982785766704, 2267.3651377614297, 2304.7349554801244, 2316.5598536278053, 2326.174208156114, 2329.04509151248, 2265.614845476273, 2276.066812606823, 2279.8974046167964, 2282.0, 2290.209877592228, 8958.507282099481, 8999.145081217273, 9000.77498062547, 9020.60180671997, 9091.681791137278, 5149.9485005149845, 5286.286351342558, 5318.707471089088, 5335.4131045585345, 5351.277577527023, 3372.7470439717117, 3490.4240800267926, 3559.857605695769, 3591.622879597631, 3646.252518233756, 1236.5548402575066, 1241.472374240953, 1263.0716423428773, 1264.8932184338703, 1281.9230846149167, 12293.3238671873, 12314.0, 12314.938425307817, 12341.93829030858, 12390.31853248062, 4755.2391617341755, 4772.933538983431, 4847.903041939141, 4891.461939186686, 4893.143699852511, 10465.947670261752, 10541.104006159409, 10559.524821383056, 10582.841257381146, 10589.629362972259, 5297.046531624344, 5383.569314454834, 5384.138537833927, 5387.164989426645, 5394.406615272317, 4216.409702641633, 4894.070126675921, 4973.602111831045, 5051.1413059779925, 5060.3927528696795, 3948.980255098764, 4025.154717509356, 4096.344584866407, 4103.056297051695, 4159.396887451303, 1267.2649863079391, 1281.8718128187293, 1288.7486940046788, 1299.564645843653, 1316.3813007886279, 870.8432482153147, 939.5443210043123, 976.4092723901937, 982.1357205659117, 1010.5351538292321, 6048.848778780566, 6264.718087686065, 6309.810705678837, 6313.589616674902, 6521.673916304166, 975.1467465967279, 997.7306127345721, 1005.703317521333, 1016.8627235323137, 1030.6598822388594, 4401.119776044804, 4448.088141930896, 4475.888102797456, 4542.84100056503, 4543.522930092358, 11047.171462140372, 11355.432228388547, 11449.54201831934, 11452.083833293316, 11455.770884582262, 11081.445927703582, 11204.66386008421, 11210.775784484265, 11262.605808796652, 11265.493052812642, 8223.629936652866, 8346.123657016047, 8409.0, 8443.53560554163, 8456.704015359433, 6021.698915054318, 6039.879202416015, 6046.365131661112, 6093.238345206849, 6248.4064013918605, 10307.519061816354, 10355.0, 10361.84457233127, 10410.635627752992, 10440.843387349349, 9873.753156171153, 10176.745581360228, 10187.847182292124, 10436.16510679159, 10483.737906552396, 7058.858822823618, 7730.11103723079, 7939.84120317602, 7941.364690824836, 8154.510729356258, 8834.823303533765, 8879.955600221958, 8905.0, 8905.55472226373, 8965.148310910454, 7875.84248315042, 7982.361411086983, 8066.695814619135, 8133.186681331819, 8135.471194372347, 7876.369890408868, 7948.165442628672, 7980.241877021674, 8070.83858322842, 8113.269805717514, 7365.558066516026, 7401.3708834747495, 7431.442641801995, 7488.363489103487, 7494.737684181027, 5343.599230057684, 5456.836294911159, 5497.230387745799, 5498.890022199614, 5511.476409741068, 5051.696898186121, 5285.577153827608, 5319.601029922694, 5379.919301210563, 5415.756290966837], "value": 4776.99627002377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8885643944302, 341.6463959801606, 341.70783979697353, 348.8866118511484, 351.5359725162786, 5598.692071936042, 5609.663420194791, 5616.634918730279, 5705.372409035008, 5744.138379243115, 5581.665100093997, 5588.804391846286, 5597.328320601534, 5599.384067752544, 5627.7467513961865, 4152.418661387408, 4194.727342722713, 4306.935395969063, 4335.934960975588, 4352.586504282104, 4319.48166220054, 4320.63274621656, 4348.630366418858, 4384.167008268435, 4397.296432570789, 4301.26878430666, 4333.285007973681, 4344.739315641072, 4358.498772641139, 4364.170807546572, 4232.915341693164, 4266.573342665724, 4333.371661109121, 4343.978280108611, 4365.781710914442, 3747.4378843173467, 3777.1690228149764, 3777.471154038437, 3790.298794722985, 3793.487879136309, 5412.756425960842, 5419.3225846769155, 5445.482679145475, 5475.72621368934, 5485.424030476823, 4861.489543597907, 4988.351514303117, 4989.351384320015, 5016.54851063406, 5028.446870844205, 5830.941690583082, 5834.949709052369, 5851.941480585182, 5910.940890591125, 5918.526517878559, 4171.833126674929, 4182.268103081979, 4191.392248124035, 4208.011117387411, 4219.2194444027955, 5674.574406919498, 6040.697965101727, 6040.909386359208, 6066.605670631395, 6074.696265186723, 4197.979010104991, 4209.24233637942, 4214.325707886724, 4224.746515209097, 4242.957570424256, 4253.957460425418, 4261.9132121309485, 4264.360345948071, 4280.978595107004, 4282.550332215073, 4779.761011949388, 4952.306677065214, 4962.528559786814, 4971.304017437562, 4975.477574854661, 5923.963306421359, 5932.377100404396, 5933.6352638893295, 5953.9282929072315, 5980.671063091571, 1488.5534339698047, 1492.6492274315526, 1499.587613406322, 1503.88720845937, 1511.3652266048286, 931.5528546297815, 962.9359557688794, 993.2897977945659, 1024.7694268789612, 1027.9023492768324, 5567.387587365387, 5628.2683251177905, 5652.519535839418, 5669.206311116447, 5669.262995810601, 5990.5507086968655, 6007.948608993409, 6013.1581578579035, 6050.183225264533, 6090.969545152246, 5486.972565137149, 5526.723663816793, 5541.362743284493, 5570.359408667974, 5650.468457214241, 3191.1064901827526, 3202.606866013292, 3209.6308924473983, 3224.6775322467565, 3240.4653232216892, 5940.851478713067, 6096.451319381277, 6122.295935967331, 6189.690515474208, 6211.9689401552705, 6081.756729730761, 6093.969530152321, 6096.817095487142, 6100.450959413585, 6112.532992081958, 6047.727852246571, 6167.876642467215, 6215.81352559424, 6239.906401403982, 6304.716287767062, 5937.435943585352, 5981.162637230878, 5983.730732116978, 6002.219711437485, 6020.698965051817, 5899.144624029577, 5904.202932604044, 5907.734151963258, 5923.259592550931, 5927.303077099823, 5855.765769369177, 6116.602420842631, 6121.938780612137, 6147.73971335884, 6157.230346206724, 4225.51406588234, 4259.169461954889, 4278.80745366453, 4280.143971205709, 4284.957150428456, 5825.970870145622, 5878.735456904364, 6019.70576326092, 6037.309553325076, 6040.486558642565, 5794.594378393472, 5814.790379655873, 5816.680082595329, 5861.501772349398, 5874.7956668883635, 5578.214971209336, 5845.3570107289015, 5847.590668653153, 5913.58604897653, 5935.465808077293, 5709.22925405065, 5719.942800572107, 5721.542276617944, 5721.799737009184, 5746.741396637078, 5909.586328957103, 5910.940890591211, 5922.940770592411, 5928.318243402064, 5955.166276721176, 5415.783368665209, 5773.960687076366, 5778.248827652378, 5785.247917770663, 5786.566007549535], "value": 4453.702030844832, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.3870479444871, 770.2374649097395, 808.4138999225561, 835.1314632781907, 838.161838161838, 13316.0, 14072.71854562908, 14252.358643861025, 14333.713325733479, 14410.567682969515, 14212.0, 14400.855991440083, 14408.927955360208, 14434.20611866347, 14438.278086095706, 655.9508036897228, 774.5314084978592, 779.3764988009598, 787.2127872127872, 787.5510958753513, 793.7975816166869, 793.8848866914294, 794.4399198564997, 795.7214974758846, 797.2625321577517, 823.5593957232882, 825.0965193113531, 826.4669288309037, 832.3840358134997, 836.5399030533182, 821.4865708931918, 823.6458322921142, 828.3042244514577, 830.4353039932873, 830.8006078541167, 596.9761209551613, 597.3846937654223, 598.500252289339, 604.8639056212361, 606.6784604159758, 13507.729845403135, 13537.0, 13566.45734170632, 13588.0, 13665.726685466334, 15068.54794356171, 15300.158491282975, 15324.310406031755, 15369.154696491689, 15577.688446231125, 11995.520179192821, 12318.384080795924, 12337.0, 12507.812382814265, 12533.373331333396, 3902.824372903226, 3924.31324518211, 3931.331673615464, 3944.4872166618443, 4013.3177359848896, 74563.0, 77004.61497692532, 77130.99999999943, 78441.0, 79021.0, 11755.471003804849, 11813.291202527877, 11862.406879655982, 11939.582114625946, 12047.096467764954, 22347.329580112622, 22449.775502245095, 22462.213822516132, 22545.43636409103, 23100.768992310197, 8786.209241168326, 8825.426347287406, 8879.556022198864, 8933.731988040368, 8959.372843900996, 4733.526647335308, 4863.586595139382, 4870.756462176948, 4874.829380971649, 4977.352944117241, 3662.890113296552, 3801.0497375656087, 3815.790131542736, 3820.121372084436, 4010.0, 711.989320160198, 716.9749058782918, 741.1291732214627, 746.2500187311717, 749.6214411722045, 620.9877899024651, 656.5305806348483, 740.6963145110478, 744.5607091815747, 755.267390631087, 9743.610255589698, 10216.438095904796, 10374.17006639467, 10420.531076101593, 10422.478876056166, 563.9266895303584, 678.8404724889647, 693.5284006875373, 702.5995182745786, 711.5943911970231, 4758.547937945889, 4921.9507804922205, 5006.211613971896, 5039.84880453587, 5058.54473097423, 124724.37637811752, 130565.34717326352, 131666.0, 131913.0, 133818.33090834483, 113528.43235783934, 114670.42664786623, 115596.0, 115805.42097289627, 116942.0, 72830.63584682043, 85233.14766852376, 89556.20887582212, 95362.52318738362, 100490.49754751325, 9154.130357616015, 9504.762380940532, 9539.618415263589, 9614.0, 9621.41354815675, 55949.72025139848, 56382.43617563772, 56584.43415565792, 56658.433415666965, 57054.144187836384, 46256.30615540702, 75920.62039689987, 81488.18511814806, 83820.0, 86503.0, 12274.202176858476, 12446.43991020388, 12669.0, 12904.0, 12929.288889111189, 13201.141925774795, 13286.069975102037, 13292.867071329163, 13471.797923030967, 13844.0, 12361.196522226026, 12456.688582785502, 12839.807402888777, 13015.674608134872, 13487.190768553919, 13613.455461781417, 13765.724685506435, 13789.862101378858, 13849.930750346184, 14215.928920355333, 12555.0, 12806.743865122831, 13076.607701768962, 13131.934340328236, 13238.139520931109, 10698.14414846826, 10896.564137434414, 11015.112348379527, 11062.446877656246, 11198.272112312674, 10982.231243812856, 11038.132636992485, 11196.552137914392, 11242.55029798799, 11288.60489882883], "value": 7642.715692786014, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 111.0, 111.0, 111.0, 113.0, 109.0, 111.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 154.0, 183.0, 129.0, 154.0, 161.0, 129.0, 182.0, 134.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 163.0, 165.0, 172.0, 163.0, 163.0, 161.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 173.0, 76.0, 75.0, 75.0, 75.0, 180.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 144.0, 86.0, 85.0, 84.0, 160.0, 84.0, 85.0, 141.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 57.0, 58.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 79.0, 78.0, 82.0, 82.0, 80.0, 79.0, 88.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 122.0, 120.0, 140.0, 124.0, 138.0, 127.0, 133.0, 126.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 163.0, 156.0, 164.0, 160.0, 166.0, 166.0, 164.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 64.0, 64.0, 68.0, 63.0, 65.0, 61.0], "value": 64.4, "unit": "score"}]}]} 20:33:30 INFO - Return code: 0 20:33:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:33:30 ERROR - # TBPL SUCCESS # 20:33:30 INFO - Running post-action listener: _resource_record_post_action 20:33:30 INFO - ##### 20:33:30 INFO - ##### Finished run-tests step (success) 20:33:30 INFO - ##### 20:33:30 INFO - Running post-run listener: _resource_record_post_run 20:33:30 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551534592; Read time: 16; Write time: 424528 20:33:30 INFO - TinderboxPrint: CPU usage
13.4% 20:33:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:33:30 INFO - TinderboxPrint: I/O write bytes / time
551,534,592 / 424,528 20:33:30 INFO - TinderboxPrint: CPU idle
8,227.2 (86.6%) 20:33:30 INFO - TinderboxPrint: CPU user
1,215.1 (12.8%) 20:33:30 INFO - TinderboxPrint: Swap in / out
0 / 0 20:33:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262746112; Read time: 0; Write time: 233468 20:33:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288788480; Read time: 16; Write time: 191060 20:33:31 INFO - Running post-run listener: _upload_blobber_files 20:33:31 INFO - Blob upload gear active. 20:33:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:33:31 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 20:33:31 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'] 20:33:31 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 20:33:31 INFO - (blobuploader) - INFO - Open directory for files ... 20:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:33:32 INFO - (blobuploader) - INFO - Done attempting. 20:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:33:33 INFO - (blobuploader) - INFO - Done attempting. 20:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:33:36 INFO - (blobuploader) - INFO - Done attempting. 20:33:36 INFO - (blobuploader) - INFO - Iteration through files over. 20:33:36 INFO - Return code: 0 20:33:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:33:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:33:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb798c92f7a7df6e2d24e2048da39bc85497188d306319e2a30239df8a043555c0c0121ee6d05d2b9c37b118cc352b45461d1d7919f4563dd836e92576fb10b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd5846f23b00e18ec12cd0586f941f73c13761ef68da2075ca6edaf520367a263d26bf6a843ac936af05255ea9bd838dbbf8c1b3eb77ac6070153f53d9d8a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f9158fd17ce05b142693d1a20543a48c00dfb8ac0cd504f9abb1b4f9c0684d551702fd58b23acf3a7f89208765e850d85f274e9593555dd29a3f8afe6a2e726"} 20:33:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:33:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:33:36 INFO - Contents: 20:33:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb798c92f7a7df6e2d24e2048da39bc85497188d306319e2a30239df8a043555c0c0121ee6d05d2b9c37b118cc352b45461d1d7919f4563dd836e92576fb10b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd5846f23b00e18ec12cd0586f941f73c13761ef68da2075ca6edaf520367a263d26bf6a843ac936af05255ea9bd838dbbf8c1b3eb77ac6070153f53d9d8a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f9158fd17ce05b142693d1a20543a48c00dfb8ac0cd504f9abb1b4f9c0684d551702fd58b23acf3a7f89208765e850d85f274e9593555dd29a3f8afe6a2e726"} 20:33:36 INFO - Running post-run listener: copy_logs_to_upload_dir 20:33:36 INFO - Copying logs to upload dir... 20:33:36 INFO - mkdir: /builds/slave/test/build/upload/logs 20:33:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.218171 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-06-25 20:33:36.664778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 20:33:36.668697) ========= 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=00204705a9daa57ed339a427000001b9-1466910234.356435-315723272 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/eb798c92f7a7df6e2d24e2048da39bc85497188d306319e2a30239df8a043555c0c0121ee6d05d2b9c37b118cc352b45461d1d7919f4563dd836e92576fb10b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd5846f23b00e18ec12cd0586f941f73c13761ef68da2075ca6edaf520367a263d26bf6a843ac936af05255ea9bd838dbbf8c1b3eb77ac6070153f53d9d8a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f9158fd17ce05b142693d1a20543a48c00dfb8ac0cd504f9abb1b4f9c0684d551702fd58b23acf3a7f89208765e850d85f274e9593555dd29a3f8afe6a2e726"} build_url:https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/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/eb798c92f7a7df6e2d24e2048da39bc85497188d306319e2a30239df8a043555c0c0121ee6d05d2b9c37b118cc352b45461d1d7919f4563dd836e92576fb10b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd5846f23b00e18ec12cd0586f941f73c13761ef68da2075ca6edaf520367a263d26bf6a843ac936af05255ea9bd838dbbf8c1b3eb77ac6070153f53d9d8a5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f9158fd17ce05b142693d1a20543a48c00dfb8ac0cd504f9abb1b4f9c0684d551702fd58b23acf3a7f89208765e850d85f274e9593555dd29a3f8afe6a2e726"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 20:33:36.698047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:33:36.698404) ========= 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=00204705a9daa57ed339a427000001b9-1466910234.356435-315723272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:33:36.781459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 20:33:36.782214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 20:33:36.782908) ========= ========= Total master_lag: 0.21 =========