builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1465474215.01 results: success (0) buildid: 20160609042428 builduid: 0bfa6b74456c4e57b04adc8caddf9fee revision: c03e4314339f812e3a2aca39607f483e59b875ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.008359) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.008799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.009090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.024304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.024670) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 05:10:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-06-09 05:10:15 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086543 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.418800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.419122) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.471014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 05:10:15.471923) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c03e4314339f812e3a2aca39607f483e59b875ef --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 c03e4314339f812e3a2aca39607f483e59b875ef --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=2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 05:10:15,894 truncating revision to first 12 chars 2016-06-09 05:10:15,894 Setting DEBUG logging. 2016-06-09 05:10:15,894 attempt 1/10 2016-06-09 05:10:15,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c03e4314339f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 05:10:17,111 unpacking tar archive at: fx-team-c03e4314339f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.574291 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 05:10:17.075095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.075394) ========= script_repo_revision: c03e4314339f812e3a2aca39607f483e59b875ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.075865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.076159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.085590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-09 05:10:17.086188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:17 INFO - MultiFileLogger online at 20160609 05:10:17 in /builds/slave/test 05:10:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:10:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:17 INFO - {'append_to_log': False, 05:10:17 INFO - 'base_work_dir': '/builds/slave/test', 05:10:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:10:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:17 INFO - 'branch': 'Fx-Team-Non-PGO', 05:10:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:17 INFO - 'config_files': ('talos/linux_config.py',), 05:10:17 INFO - 'default_actions': ('clobber', 05:10:17 INFO - 'read-buildbot-config', 05:10:17 INFO - 'download-and-extract', 05:10:17 INFO - 'populate-webroot', 05:10:17 INFO - 'create-virtualenv', 05:10:17 INFO - 'install', 05:10:17 INFO - 'run-tests'), 05:10:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:17 INFO - 'download_minidump_stackwalk': True, 05:10:17 INFO - 'download_symbols': 'ondemand', 05:10:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:17 INFO - 'installer_path': 'installer.exe', 05:10:17 INFO - 'log_level': 'info', 05:10:17 INFO - 'log_name': 'talos', 05:10:17 INFO - 'log_to_console': True, 05:10:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:17 INFO - 'opt_config_files': (), 05:10:17 INFO - 'pip_index': False, 05:10:17 INFO - 'sps_profile': False, 05:10:17 INFO - 'sps_profile_interval': 0, 05:10:17 INFO - 'suite': 'dromaeojs', 05:10:17 INFO - 'system_bits': '32', 05:10:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:17 INFO - 'title': 'talos-linux64-ix-012', 05:10:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:17 INFO - 'use_talos_json': True, 05:10:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:17 INFO - 'work_dir': 'build'} 05:10:17 INFO - ##### 05:10:17 INFO - ##### Running clobber step. 05:10:17 INFO - ##### 05:10:17 INFO - Running pre-action listener: _resource_record_pre_action 05:10:17 INFO - Running main action method: clobber 05:10:17 INFO - rmtree: /builds/slave/test/build 05:10:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:18 INFO - Running post-action listener: _resource_record_post_action 05:10:18 INFO - ##### 05:10:18 INFO - ##### Finished clobber step (success) 05:10:18 INFO - ##### 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running read-buildbot-config step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: read_buildbot_config 05:10:18 INFO - Using buildbot properties: 05:10:18 INFO - { 05:10:18 INFO - "project": "", 05:10:18 INFO - "product": "firefox", 05:10:18 INFO - "script_repo_revision": "production", 05:10:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:10:18 INFO - "repository": "", 05:10:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:10:18 INFO - "buildid": "20160609042428", 05:10:18 INFO - "pgo_build": "False", 05:10:18 INFO - "basedir": "/builds/slave/test", 05:10:18 INFO - "buildnumber": 3074, 05:10:18 INFO - "slavename": "talos-linux64-ix-012", 05:10:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:10:18 INFO - "platform": "ubuntu64_hw", 05:10:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:10:18 INFO - "branch": "fx-team", 05:10:18 INFO - "repo_path": "integration/fx-team", 05:10:18 INFO - "revision": "c03e4314339f812e3a2aca39607f483e59b875ef", 05:10:18 INFO - "stage_platform": "linux64", 05:10:18 INFO - "builduid": "0bfa6b74456c4e57b04adc8caddf9fee", 05:10:18 INFO - "slavebuilddir": "test" 05:10:18 INFO - } 05:10:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:10:18 INFO - Running post-action listener: _resource_record_post_action 05:10:18 INFO - ##### 05:10:18 INFO - ##### Finished read-buildbot-config step (success) 05:10:18 INFO - ##### 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running download-and-extract step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: download_and_extract 05:10:18 INFO - mkdir: /builds/slave/test/build/tests 05:10:18 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')]} 05:10:18 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:23 INFO - Downloaded 1361 bytes. 05:10:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:23 INFO - Using the following test package requirements: 05:10:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'jsshell-linux-x86_64.zip'], 05:10:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:23 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')]} 05:10:23 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:24 INFO - Downloaded 22879579 bytes. 05:10:24 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'] 05:10:24 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 05:10:25 INFO - Return code: 0 05:10:25 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 05:10: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')]} 05:10:25 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:31 INFO - Downloaded 22879579 bytes. 05:10:31 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'] 05:10:31 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 05:10:32 INFO - Return code: 0 05:10: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')]} 05:10:32 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:34 INFO - Downloaded 10833377 bytes. 05:10:34 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'] 05:10:34 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 05:10:34 INFO - Return code: 0 05:10:34 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')]} 05:10:34 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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 05:10:36 INFO - Downloaded 55433612 bytes. 05:10:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:36 INFO - mkdir: /builds/slave/test/properties 05:10:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:36 INFO - Contents: 05:10:36 INFO - build_url:https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:36 INFO - Running post-action listener: _resource_record_post_action 05:10:36 INFO - Running post-action listener: set_extra_try_arguments 05:10:36 INFO - ##### 05:10:36 INFO - ##### Finished download-and-extract step (success) 05:10:36 INFO - ##### 05:10:36 INFO - ##### 05:10:36 INFO - ##### Running populate-webroot step. 05:10:36 INFO - ##### 05:10:36 INFO - Running pre-action listener: _resource_record_pre_action 05:10:36 INFO - Running main action method: populate_webroot 05:10:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:36 INFO - '--tppagecycles', 05:10:36 INFO - '7'], 05:10:36 INFO - 'tests': ['tsvgm']}}, 05:10:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['damp', 'tps']}, 05:10:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'tests': ['damp', 'tps']}, 05:10:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['dromaeo_dom']}, 05:10:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore', 05:10:36 INFO - 'tabpaint']}, 05:10:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore', 05:10:36 INFO - 'tabpaint']}, 05:10:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore', 05:10:36 INFO - 'tabpaint']}, 05:10:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore', 05:10:36 INFO - 'tabpaint']}, 05:10:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore', 05:10:36 INFO - 'tabpaint']}, 05:10:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore', 05:10:36 INFO - 'tabpaint']}, 05:10:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['tsvgx', 05:10:36 INFO - 'tsvgr_opacity', 05:10:36 INFO - 'tart', 05:10:36 INFO - 'tscrollx', 05:10:36 INFO - 'cart']}, 05:10:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:36 INFO - 'tsvgr_opacity', 05:10:36 INFO - 'tart', 05:10:36 INFO - 'tscrollx', 05:10:36 INFO - 'cart']}, 05:10:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--disable-e10s'], 05:10:36 INFO - 'tests': ['tp5o']}, 05:10:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'tests': ['tp5o']}, 05:10:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--disable-e10s', 05:10:36 INFO - '--xperf_path', 05:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:36 INFO - 'tests': ['tp5n']}, 05:10:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--xperf_path', 05:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:36 INFO - 'tests': ['tp5n']}}, 05:10:36 INFO - 'talos.zip': {'path': '', 05:10:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:36 INFO - Running post-action listener: _resource_record_post_action 05:10:36 INFO - ##### 05:10:36 INFO - ##### Finished populate-webroot step (success) 05:10:36 INFO - ##### 05:10:36 INFO - ##### 05:10:36 INFO - ##### Running create-virtualenv step. 05:10:36 INFO - ##### 05:10:36 INFO - Running pre-action listener: _resource_record_pre_action 05:10:36 INFO - Running main action method: create_virtualenv 05:10:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:36 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 05:10:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:36 INFO - Using real prefix '/usr' 05:10:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:39 INFO - Installing pip.................done. 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:39 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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:39 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 05:10:39 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 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 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 05:10:39 INFO - Cleaning up... 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:39 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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:39 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 05:10:39 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 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 INFO - Downloading/unpacking psutil>=3.1.1 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:41 INFO - Installing collected packages: psutil 05:10:41 INFO - Running setup.py install for psutil 05:10:41 INFO - building 'psutil._psutil_linux' extension 05:10:41 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 05:10:42 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 05:10:42 INFO - building 'psutil._psutil_posix' extension 05:10:42 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 05:10:42 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 05:10:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:42 INFO - Successfully installed psutil 05:10:42 INFO - Cleaning up... 05:10:42 INFO - Return code: 0 05:10:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:42 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 05:10:42 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 05:10:42 INFO - Using env: {'DISPLAY': ':0', 05:10:42 INFO - 'HOME': '/home/cltbld', 05:10:42 INFO - 'LANG': 'en_US.UTF-8', 05:10:42 INFO - 'LANGUAGE': 'en_US:en', 05:10:42 INFO - 'LOGNAME': 'cltbld', 05:10:42 INFO - 'MAIL': '/var/mail/cltbld', 05:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:42 INFO - 'MOZ_NO_REMOTE': '1', 05:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:42 INFO - 'NO_EM_RESTART': '1', 05:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:42 INFO - 'PWD': '/builds/slave/test', 05:10:42 INFO - 'SHELL': '/bin/bash', 05:10:42 INFO - 'SHLVL': '1', 05:10:42 INFO - 'TERM': 'linux', 05:10:42 INFO - 'TMOUT': '86400', 05:10:42 INFO - 'USER': 'cltbld', 05:10:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:42 INFO - '_': '/tools/buildbot/bin/python'} 05:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:44 INFO - Installing collected packages: mozsystemmonitor 05:10:44 INFO - Running setup.py install for mozsystemmonitor 05:10:44 INFO - Successfully installed mozsystemmonitor 05:10:44 INFO - Cleaning up... 05:10:44 INFO - Return code: 0 05:10:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:44 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')]} 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 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')]} 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:44 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 05:10:44 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 05:10:44 INFO - Using env: {'DISPLAY': ':0', 05:10:44 INFO - 'HOME': '/home/cltbld', 05:10:44 INFO - 'LANG': 'en_US.UTF-8', 05:10:44 INFO - 'LANGUAGE': 'en_US:en', 05:10:44 INFO - 'LOGNAME': 'cltbld', 05:10:44 INFO - 'MAIL': '/var/mail/cltbld', 05:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:44 INFO - 'MOZ_NO_REMOTE': '1', 05:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:44 INFO - 'NO_EM_RESTART': '1', 05:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:44 INFO - 'PWD': '/builds/slave/test', 05:10:44 INFO - 'SHELL': '/bin/bash', 05:10:44 INFO - 'SHLVL': '1', 05:10:44 INFO - 'TERM': 'linux', 05:10:44 INFO - 'TMOUT': '86400', 05:10:44 INFO - 'USER': 'cltbld', 05:10:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:44 INFO - '_': '/tools/buildbot/bin/python'} 05:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:44 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 05:10:44 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 05:10:44 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 05:10:44 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 05:10:44 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 05:10:44 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 05:10:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:47 INFO - warning: no files found matching '*.txt' 05:10:47 INFO - no previously-included directories found matching 'build' 05:10:47 INFO - no previously-included directories found matching 'dist' 05:10:47 INFO - no previously-included directories found matching '.git*' 05:10:47 INFO - Installing collected packages: jsonschema, functools32 05:10:47 INFO - Running setup.py install for functools32 05:10:47 INFO - warning: no files found matching '*.txt' 05:10:47 INFO - no previously-included directories found matching 'build' 05:10:47 INFO - no previously-included directories found matching 'dist' 05:10:47 INFO - no previously-included directories found matching '.git*' 05:10:47 INFO - Successfully installed jsonschema functools32 05:10:47 INFO - Cleaning up... 05:10:47 INFO - Return code: 0 05:10:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:47 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')]} 05:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:47 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')]} 05:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:47 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:47 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 05:10:47 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 05:10:47 INFO - Using env: {'DISPLAY': ':0', 05:10:47 INFO - 'HOME': '/home/cltbld', 05:10:47 INFO - 'LANG': 'en_US.UTF-8', 05:10:47 INFO - 'LANGUAGE': 'en_US:en', 05:10:47 INFO - 'LOGNAME': 'cltbld', 05:10:47 INFO - 'MAIL': '/var/mail/cltbld', 05:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:47 INFO - 'MOZ_NO_REMOTE': '1', 05:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:47 INFO - 'NO_EM_RESTART': '1', 05:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:47 INFO - 'PWD': '/builds/slave/test', 05:10:47 INFO - 'SHELL': '/bin/bash', 05:10:47 INFO - 'SHLVL': '1', 05:10:47 INFO - 'TERM': 'linux', 05:10:47 INFO - 'TMOUT': '86400', 05:10:47 INFO - 'USER': 'cltbld', 05:10:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:47 INFO - '_': '/tools/buildbot/bin/python'} 05:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:50 INFO - Downloading docopt-0.6.1.tar.gz 05:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:50 INFO - Running setup.py install for blobuploader 05:10:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:50 INFO - Running setup.py install for requests 05:10:50 INFO - Running setup.py install for docopt 05:10:50 INFO - Successfully installed blobuploader requests docopt 05:10:50 INFO - Cleaning up... 05:10:50 INFO - Return code: 0 05:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:50 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')]} 05:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:50 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')]} 05:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:50 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:50 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 05:10:50 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 05:10:50 INFO - Using env: {'DISPLAY': ':0', 05:10:50 INFO - 'HOME': '/home/cltbld', 05:10:50 INFO - 'LANG': 'en_US.UTF-8', 05:10:50 INFO - 'LANGUAGE': 'en_US:en', 05:10:50 INFO - 'LOGNAME': 'cltbld', 05:10:50 INFO - 'MAIL': '/var/mail/cltbld', 05:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:50 INFO - 'MOZ_NO_REMOTE': '1', 05:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:50 INFO - 'NO_EM_RESTART': '1', 05:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:50 INFO - 'PWD': '/builds/slave/test', 05:10:50 INFO - 'SHELL': '/bin/bash', 05:10:50 INFO - 'SHLVL': '1', 05:10:50 INFO - 'TERM': 'linux', 05:10:50 INFO - 'TMOUT': '86400', 05:10:50 INFO - 'USER': 'cltbld', 05:10:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:50 INFO - '_': '/tools/buildbot/bin/python'} 05:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:50 INFO - Running setup.py (path:/tmp/pip-Out4IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:51 INFO - Running setup.py (path:/tmp/pip-NAegQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:51 INFO - Running setup.py (path:/tmp/pip-5rRvKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:51 INFO - Running setup.py (path:/tmp/pip-Vtb1Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:51 INFO - Running setup.py (path:/tmp/pip-bQZ2NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:51 INFO - Running setup.py (path:/tmp/pip-ttPm3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:51 INFO - Running setup.py (path:/tmp/pip-VBTQ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:51 INFO - Running setup.py (path:/tmp/pip-2pUff6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:51 INFO - Running setup.py (path:/tmp/pip-HCYx_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:51 INFO - Running setup.py (path:/tmp/pip-fDsnCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:51 INFO - Running setup.py (path:/tmp/pip-w1x8_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:51 INFO - Running setup.py (path:/tmp/pip-pi3Z_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:51 INFO - Running setup.py (path:/tmp/pip-puRmuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:51 INFO - Running setup.py (path:/tmp/pip-GGXM5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:51 INFO - Running setup.py (path:/tmp/pip-z5pL2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:51 INFO - Running setup.py (path:/tmp/pip-k1ftAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:52 INFO - Running setup.py (path:/tmp/pip-vWt_uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:52 INFO - Running setup.py install for manifestparser 05:10:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozcrash 05:10:52 INFO - Running setup.py install for mozdebug 05:10:52 INFO - Running setup.py install for mozdevice 05:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozfile 05:10:52 INFO - Running setup.py install for mozhttpd 05:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozinfo 05:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozInstall 05:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozleak 05:10:53 INFO - Running setup.py install for mozlog 05:10:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Running setup.py install for moznetwork 05:10:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Running setup.py install for mozprocess 05:10:53 INFO - Running setup.py install for mozprofile 05:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Running setup.py install for mozrunner 05:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Running setup.py install for mozscreenshot 05:10:53 INFO - Running setup.py install for moztest 05:10:53 INFO - Running setup.py install for mozversion 05:10:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:53 INFO - Cleaning up... 05:10:53 INFO - Return code: 0 05:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:53 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')]} 05:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:53 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')]} 05:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:53 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:53 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 05:10:53 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 05:10:53 INFO - Using env: {'DISPLAY': ':0', 05:10:53 INFO - 'HOME': '/home/cltbld', 05:10:53 INFO - 'LANG': 'en_US.UTF-8', 05:10:53 INFO - 'LANGUAGE': 'en_US:en', 05:10:53 INFO - 'LOGNAME': 'cltbld', 05:10:53 INFO - 'MAIL': '/var/mail/cltbld', 05:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:53 INFO - 'MOZ_NO_REMOTE': '1', 05:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:53 INFO - 'NO_EM_RESTART': '1', 05:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:53 INFO - 'PWD': '/builds/slave/test', 05:10:53 INFO - 'SHELL': '/bin/bash', 05:10:53 INFO - 'SHLVL': '1', 05:10:53 INFO - 'TERM': 'linux', 05:10:53 INFO - 'TMOUT': '86400', 05:10:53 INFO - 'USER': 'cltbld', 05:10:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:53 INFO - '_': '/tools/buildbot/bin/python'} 05:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:54 INFO - Running setup.py (path:/tmp/pip-OdrEdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:54 INFO - Running setup.py (path:/tmp/pip-5yH_c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:54 INFO - Running setup.py (path:/tmp/pip-lyLoMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:54 INFO - Running setup.py (path:/tmp/pip-oTOaCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:54 INFO - Running setup.py (path:/tmp/pip-xat90p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:54 INFO - Running setup.py (path:/tmp/pip-igL0tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:54 INFO - Running setup.py (path:/tmp/pip-LSs0TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:54 INFO - Running setup.py (path:/tmp/pip-IRIQ_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:54 INFO - Running setup.py (path:/tmp/pip-VpIkld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:54 INFO - Running setup.py (path:/tmp/pip-17_e6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:54 INFO - Running setup.py (path:/tmp/pip-CUrIOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:54 INFO - Running setup.py (path:/tmp/pip-IaKbxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:55 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)) 05:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:55 INFO - Running setup.py (path:/tmp/pip-SDI73k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:55 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)) 05:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:55 INFO - Running setup.py (path:/tmp/pip-HMDAjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:55 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)) 05:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:55 INFO - Running setup.py (path:/tmp/pip-wLQidy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:55 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)) 05:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:55 INFO - Running setup.py (path:/tmp/pip-lM8voG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:55 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)) 05:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:55 INFO - Running setup.py (path:/tmp/pip-awp7_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:55 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 05:10:55 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 05:10:55 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 05:10:55 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 05:10:55 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 05:10:55 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 05:10:57 INFO - Downloading blessings-1.6.tar.gz 05:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:57 INFO - Installing collected packages: blessings 05:10:57 INFO - Running setup.py install for blessings 05:10:57 INFO - Successfully installed blessings 05:10:57 INFO - Cleaning up... 05:10:57 INFO - Return code: 0 05:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:57 INFO - Reading from file tmpfile_stdout 05:10:57 INFO - Current package versions: 05:10:57 INFO - argparse == 1.2.1 05:10:57 INFO - blessings == 1.6 05:10:57 INFO - blobuploader == 1.2.4 05:10:57 INFO - docopt == 0.6.1 05:10:57 INFO - functools32 == 3.2.3-2 05:10:57 INFO - jsonschema == 2.5.1 05:10:57 INFO - manifestparser == 1.1 05:10:57 INFO - mozInstall == 1.12 05:10:57 INFO - mozcrash == 0.17 05:10:57 INFO - mozdebug == 0.1 05:10:57 INFO - mozdevice == 0.48 05:10:57 INFO - mozfile == 1.2 05:10:57 INFO - mozhttpd == 0.7 05:10:57 INFO - mozinfo == 0.9 05:10:57 INFO - mozleak == 0.1 05:10:57 INFO - mozlog == 3.2 05:10:57 INFO - moznetwork == 0.27 05:10:57 INFO - mozprocess == 0.22 05:10:57 INFO - mozprofile == 0.28 05:10:57 INFO - mozrunner == 6.11 05:10:57 INFO - mozscreenshot == 0.1 05:10:57 INFO - mozsystemmonitor == 0.3 05:10:57 INFO - moztest == 0.7 05:10:57 INFO - mozversion == 1.4 05:10:57 INFO - psutil == 3.1.1 05:10:57 INFO - requests == 1.2.3 05:10:57 INFO - wsgiref == 0.1.2 05:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:57 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:57 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 05:10:57 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 05:10:57 INFO - Using env: {'DISPLAY': ':0', 05:10:57 INFO - 'HOME': '/home/cltbld', 05:10:57 INFO - 'LANG': 'en_US.UTF-8', 05:10:57 INFO - 'LANGUAGE': 'en_US:en', 05:10:57 INFO - 'LOGNAME': 'cltbld', 05:10:57 INFO - 'MAIL': '/var/mail/cltbld', 05:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:57 INFO - 'MOZ_NO_REMOTE': '1', 05:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:57 INFO - 'NO_EM_RESTART': '1', 05:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:57 INFO - 'PWD': '/builds/slave/test', 05:10:57 INFO - 'SHELL': '/bin/bash', 05:10:57 INFO - 'SHLVL': '1', 05:10:57 INFO - 'TERM': 'linux', 05:10:57 INFO - 'TMOUT': '86400', 05:10:57 INFO - 'USER': 'cltbld', 05:10:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:57 INFO - '_': '/tools/buildbot/bin/python'} 05:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 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)) 05:10:57 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:58 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')]} 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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')]} 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:58 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 05:10:58 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 05:10:58 INFO - Using env: {'DISPLAY': ':0', 05:10:58 INFO - 'HOME': '/home/cltbld', 05:10:58 INFO - 'LANG': 'en_US.UTF-8', 05:10:58 INFO - 'LANGUAGE': 'en_US:en', 05:10:58 INFO - 'LOGNAME': 'cltbld', 05:10:58 INFO - 'MAIL': '/var/mail/cltbld', 05:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:58 INFO - 'MOZ_NO_REMOTE': '1', 05:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:58 INFO - 'NO_EM_RESTART': '1', 05:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:58 INFO - 'PWD': '/builds/slave/test', 05:10:58 INFO - 'SHELL': '/bin/bash', 05:10:58 INFO - 'SHLVL': '1', 05:10:58 INFO - 'TERM': 'linux', 05:10:58 INFO - 'TMOUT': '86400', 05:10:58 INFO - 'USER': 'cltbld', 05:10:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:58 INFO - '_': '/tools/buildbot/bin/python'} 05:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:58 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:10:58 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')]} 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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')]} 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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 0x7fc98b05df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2586350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', '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 05:10:58 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 05:10:58 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 05:10:58 INFO - Using env: {'DISPLAY': ':0', 05:10:58 INFO - 'HOME': '/home/cltbld', 05:10:58 INFO - 'LANG': 'en_US.UTF-8', 05:10:58 INFO - 'LANGUAGE': 'en_US:en', 05:10:58 INFO - 'LOGNAME': 'cltbld', 05:10:58 INFO - 'MAIL': '/var/mail/cltbld', 05:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:58 INFO - 'MOZ_NO_REMOTE': '1', 05:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:58 INFO - 'NO_EM_RESTART': '1', 05:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:58 INFO - 'PWD': '/builds/slave/test', 05:10:58 INFO - 'SHELL': '/bin/bash', 05:10:58 INFO - 'SHLVL': '1', 05:10:58 INFO - 'TERM': 'linux', 05:10:58 INFO - 'TMOUT': '86400', 05:10:58 INFO - 'USER': 'cltbld', 05:10:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:58 INFO - '_': '/tools/buildbot/bin/python'} 05:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:58 INFO - Downloading/unpacking flake8 05:10:58 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 05:10:58 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 05:10:58 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 05:10:58 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 05:10:58 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 05:10:58 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 05:11:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:01 INFO - no previously-included directories found matching 'docs/_build' 05:11:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:01 INFO - Running setup.py install for pep8 05:11:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:01 INFO - no previously-included directories found matching 'docs/_build' 05:11:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:01 INFO - Cleaning up... 05:11:01 INFO - Return code: 0 05:11:01 INFO - Running post-action listener: _resource_record_post_action 05:11:01 INFO - Running post-action listener: _start_resource_monitoring 05:11:01 INFO - Starting resource monitoring. 05:11:01 INFO - ##### 05:11:01 INFO - ##### Finished create-virtualenv step (success) 05:11:01 INFO - ##### 05:11:01 INFO - ##### 05:11:01 INFO - ##### Running install step. 05:11:01 INFO - ##### 05:11:01 INFO - Running pre-action listener: _resource_record_pre_action 05:11:01 INFO - Running main action method: install 05:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:01 INFO - Reading from file tmpfile_stdout 05:11:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:01 INFO - Reading from file tmpfile_stdout 05:11:01 INFO - Output received: 05:11:01 INFO - Usage: mozinstall [options] installer 05:11:01 INFO - Options: 05:11:01 INFO - -h, --help show this help message and exit 05:11:01 INFO - -d DEST, --destination=DEST 05:11:01 INFO - Directory to install application into. [default: 05:11:01 INFO - "/builds/slave/test"] 05:11:01 INFO - --app=APP Application being installed. [default: firefox] 05:11:01 INFO - mkdir: /builds/slave/test/build/application 05:11:01 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'] 05:11:01 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 05:11:17 INFO - Reading from file tmpfile_stdout 05:11:17 INFO - Output received: 05:11:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:17 INFO - Running post-action listener: _resource_record_post_action 05:11:17 INFO - ##### 05:11:17 INFO - ##### Finished install step (success) 05:11:17 INFO - ##### 05:11:17 INFO - ##### 05:11:17 INFO - ##### Running run-tests step. 05:11:17 INFO - ##### 05:11:17 INFO - Running pre-action listener: _resource_record_pre_action 05:11:17 INFO - Running main action method: run_tests 05:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:17 INFO - Python 2.7.3 05:11:17 INFO - Return code: 0 05:11:17 INFO - grabbing minidump binary from tooltool 05:11: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')]} 05:11:17 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 0x26151c0>, '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 0x26160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2616550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:17 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 05:11:17 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 05:11:17 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 05:11:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:17 INFO - Return code: 0 05:11:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:18 INFO - Return code: 0 05:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:11:18 INFO - Using env: {'DISPLAY': ':0', 05:11:18 INFO - 'HOME': '/home/cltbld', 05:11:18 INFO - 'LANG': 'en_US.UTF-8', 05:11:18 INFO - 'LANGUAGE': 'en_US:en', 05:11:18 INFO - 'LOGNAME': 'cltbld', 05:11:18 INFO - 'MAIL': '/var/mail/cltbld', 05:11:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:18 INFO - 'MOZ_NO_REMOTE': '1', 05:11:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:18 INFO - 'NO_EM_RESTART': '1', 05:11:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:18 INFO - 'PWD': '/builds/slave/test', 05:11:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:18 INFO - 'SHELL': '/bin/bash', 05:11:18 INFO - 'SHLVL': '1', 05:11:18 INFO - 'TERM': 'linux', 05:11:18 INFO - 'TMOUT': '86400', 05:11:18 INFO - 'USER': 'cltbld', 05:11:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401', 05:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:18 INFO - '_': '/tools/buildbot/bin/python'} 05:11:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:11:18 INFO - mozversion application_buildid: 20160609042428 05:11:18 INFO - mozversion application_changeset: c03e4314339f812e3a2aca39607f483e59b875ef 05:11:18 INFO - mozversion application_display_name: Nightly 05:11:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:18 INFO - mozversion application_name: Firefox 05:11:18 INFO - mozversion application_remotingname: firefox 05:11:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:18 INFO - mozversion application_vendor: Mozilla 05:11:18 INFO - mozversion application_version: 50.0a1 05:11:18 INFO - mozversion platform_buildid: 20160609042428 05:11:18 INFO - mozversion platform_changeset: c03e4314339f812e3a2aca39607f483e59b875ef 05:11:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:18 INFO - mozversion platform_version: 50.0a1 05:11:18 INFO - using testdate: 1465474278 05:11:18 INFO - actual date: 1465474278 05:11:18 INFO - starting webserver on 'localhost:50569' 05:11:18 INFO - SUITE-START | Running 2 tests 05:11:18 INFO - TEST-START | dromaeo_css 05:11:18 INFO - operating with platform_type : linux_ 05:11:18 INFO - Initialising browser for dromaeo_css test... 05:11:18 INFO - TEST-INFO | started process 24204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxQu_mV/profile http://localhost:50569/getInfo.html) 05:11:22 INFO - PROCESS | 24204 | __metrics Screen width/height:1600/1200 05:11:22 INFO - PROCESS | 24204 | colorDepth:24 05:11:22 INFO - PROCESS | 24204 | Browser inner width/height: 1024/697 05:11:22 INFO - PROCESS | 24204 | __metrics 05:11:23 ERROR - PROCESS | 24204 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:11:23 INFO - PROCESS | 24204 | console.error: PushService: 05:11:23 INFO - PROCESS | 24204 | stateChangeProcessEnqueue: Error transitioning state 05:11:23 INFO - PROCESS | 24204 | UnknownError 05:11:24 INFO - TEST-INFO | 24204: exit 0 05:11:24 INFO - Browser initialized. 05:11:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:24 INFO - TEST-INFO | started process 24284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxQu_mV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:36 INFO - PROCESS | 24284 | RSS: Main: 174944256 05:11:36 INFO - PROCESS | 24284 | 05:12:28 INFO - PROCESS | 24284 | 1465474348361 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] 05:14:39 INFO - PROCESS | 24284 | Cycle 1(1): loaded http://localhost:50569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50569/tests/dromaeo/cssquery-ext.html) 05:14:40 INFO - PROCESS | 24284 | RSS: Main: 295227392 05:14:40 INFO - PROCESS | 24284 | 05:17:43 INFO - PROCESS | 24284 | Cycle 1(1): loaded http://localhost:50569/tests/dromaeo/cssquery-ext.html (next: http://localhost:50569/tests/dromaeo/cssquery-jquery.html) 05:17:44 INFO - PROCESS | 24284 | RSS: Main: 257396736 05:17:44 INFO - PROCESS | 24284 | 05:20:46 INFO - PROCESS | 24284 | Cycle 1(1): loaded http://localhost:50569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50569/tests/dromaeo/cssquery-mootools.html) 05:20:47 INFO - PROCESS | 24284 | RSS: Main: 259391488 05:20:47 INFO - PROCESS | 24284 | 05:23:49 INFO - PROCESS | 24284 | Cycle 1(1): loaded http://localhost:50569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50569/tests/dromaeo/cssquery-prototype.html) 05:23:50 INFO - PROCESS | 24284 | RSS: Main: 256307200 05:23:50 INFO - PROCESS | 24284 | 05:26:53 INFO - PROCESS | 24284 | Cycle 1(1): loaded http://localhost:50569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50569/tests/dromaeo/cssquery-yui.html) 05:26:53 INFO - PROCESS | 24284 | RSS: Main: 231473152 05:26:53 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | Cycle 1(1): loaded http://localhost:50569/tests/dromaeo/cssquery-yui.html (next: http://localhost:50569/tests/dromaeo/cssquery-dojo.html) 05:29:56 INFO - PROCESS | 24284 | RSS: Main: 287227904 05:29:56 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | __start_tp_report 05:29:56 INFO - PROCESS | 24284 | _x_x_mozilla_page_load 05:29:56 INFO - PROCESS | 24284 | _x_x_mozilla_page_load_details 05:29:56 INFO - PROCESS | 24284 | |i|pagename|runs| 05:29:56 INFO - PROCESS | 24284 | |0;dojo.html;2587.8964841406346;2598.6881574211097;2628.369191394065;2641.1548304542544;2647.933801654958;4642.883927901804;4711.575958163765;4740.90518189636;4781.976090119549;4819.759012049397;4638.768061596915;4672.813087476497;4679.321498382733;4718.882027949295;4740.431148262205;4293.076988447491;4360.803763830635;4395.714278571899;4422.5577442255835;4490.5509449055;4370.934435983463;4399.780010999453;4415.20526305265;4433.733975961437;4445.488768791582;4186.39297301891;4219.51475580306;4269.210196113729;4280.935785963213;4307.82768689252;4272.6154646081695;4272.6795490338345;4275.551067137968;4371.344298355272;4379.321205213197;4285.935710964338;4304.978475107636;4309.288967320388;4352.455943007124;4356.43366362374;4581.541845815425;4620.052889157748;4640.837570685044;4715.127701375257;4722.031983443386;5048.974755126201;5054.519820617035;5056.84829455117;5066.493350664904;5103.106956282672;5072.2391641253735;5081.8475445736685;5086.643934924557;5102.464241254689;5122.743862806845;4603.49361570227;4727.905441891212;4758.214894542396;4776.307435421844;4781.904361912742;5240.895182096413;5243.397009343898;5310.522053015247;5312.04383211018;5312.335958005249;5035.82374616894;5047.646664733506;5097.8725531861255;5099.923501147486;5105.668131571436;4879.121758083579;4996.150654388763;5034.270030845581;5040.193569029011;5060.746962651852;4977.104121258136;5018.272350509229;5020.146575082244;5022.121128802445;5065.949340506621;4817.0365926814075;4978.726170060609;4983.252512123138;4983.950160498421;5039.992001599695;4243.893902652459;4309.741415515079;4345.130973805189;4348.934765978513;4380.496242932039;3738.457923601117;3760.793156376371;3761;3798.1264309209037;3802.239552089593;4376.059147283349;4383.123375324948;4383.561643835655;4425.35832304314;4433.091216300651;4937.777799998937;5027;5064.949350506447;5069.417017043013;5086.593072554261;4352.782360882006;4356.259435895905;4366.345048242789;4370.431843860341;4409.33859921008;4495.235809912323;4597.977010114995;4602.769861506911;4606.677532572755;4642.582167604932;4649.883752906137;4651.488336283006;4692.296155576554;4700.623950084054;4701.7178969260585;4971.801127954841;5003.799848006039;5006.1739812930455;5007.7496125192865;5053.31780209667;4602.723836569817;4685.4143232095985;4699.647526435463;4741.312509686008;4741.668083234141;4967.801287948441;5013;5025.321581586439;5033.446320904771;5077.263796749525;5064.215046667772;5092.694438333712;5106.055379754757;5110.66780659256;5156.04613146569;4809.278608208797;4831.903361932671;4857.975710121426;4955.306257124078;4961.627877909099;4856.63575231852;4885.755712214304;4886.438059623047;4909.410870695539;4936.506349365179;4809.0862736080035;4817.614590832655;4820.4456487502985;4898.191798353232;4899.730514821576;4777.498362672009;4820.9517904820505;4878;4921.138800709933;5002.074616196015;4754.45323787755;4771.260454629538;4798.352222449925;4800.783964721526;4832.106060378701 05:29:56 INFO - PROCESS | 24284 | |1;ext.html;529.5140849843;571.2488078177197;571.8370264474623;575.0827430248752;588.9411058894111;27310.5903411449;40347.79826100869;41424.378634320434;41552.792236038855;41562.79218603903;40164.59835401645;40800.79599602005;40809.18381632365;40921.386179207264;40976.38535421971;7606.885896711554;7866.999999999985;8023.117457079717;10272.691819245434;10600;9881.505924703772;10344.586216551328;10345.534450949688;10353.068223859851;10365.481725913713;10333.070023697866;10408.947955260213;10411.687649370531;10414.427206503638;10415.843762343571;10215.131713804336;10334.741631459236;10338.276320657556;10338.379697218115;10340.638077667321;7637.15991240963;10257.128144107684;10309.948450257776;10325.9483702581;10330.483475826253;29058.564121538195;31059.22351941197;31060.844695776377;31095.68904310973;39672.60327396747;3085.8765649374;3102.6431960324626;3132.530120481923;3234.4016356974034;3313.3207692422993;29666.406671866658;29752.55371169434;29946.850265748533;30490.695093049006;30595.082147535388;3384.983075084609;3388.102152929476;3419.7264218862433;3447.9827600861836;3476.878309259164;276964;281814;282463.58768206235;282479;284284;57387.426125739046;57647;57693.71153144207;57739.711301443225;57793.711031444574;60925.69537152286;61228.38771612316;61346.693266534276;61437.156885293516;61443.69278153581;15490.30293636789;15923.840761592235;16008.839911600735;16045.117518536592;16050.277737501607;11285.943570282261;11392.601258955896;11396.316221026766;11417.60038398652;11429.771404572028;17642.73535896937;18130.728039079426;18216.271349145885;18248.087595620167;18253.087345632666;7227.819304517429;7257.8548429031125;7397.112346518452;7431.145418276859;7501.812454688677;786.8229648329194;810.1776696652902;890.5235698901187;924.0805398628273;948.3503799897093;26870.193894183205;27583.86208068947;27887;28144.577831332546;28268.43463130767;814.4787336104897;931.3992474853682;983.9163671088038;1018.8115198688266;1091.0834898685143;14802.703945921021;15253.923730381277;15261.23693815327;15300.682950224953;15417.152056636993;423319;424486;426066;427035.5944660833;429124;49889;51175.74412127915;51180.23229651558;51277.74361128245;51364.74317628388;1073.4847273308856;1116.6538373104202;1158.5134243617533;1178.7642471505562;1202.2606097250127;27071.1878643641;28465.857670711513;28651.57022644704;29069;29305.56041659334;43219.56780432155;43405.78297108494;43854.12291754211;43972.780136099114;44002.33996490119;336115;339841;340081;340576;341285;22944.082236710343;23542.411439714146;25772.8711356442;26382.20853374402;26399.604005939542;41273;41328.58671413247;41359.586404135574;41444.37833432441;42272.5772742281;36006.27987440289;36333.0916727084;36638.084047899014;36815.81592092022;36907.26185476329;35372.46941295934;35667.821660892565;35741.285174296885;36109.27781444409;36292.637073628925;35855.46216806802;36044.63955360413;36537.26925461423;36687.63312366842;36776.44835327526;31109.8444507776;31921.20196995001;32415.189620259684;32501.67498325081;32579.511307330882;24861.87569062143;24991.625125623494;25092.37269068215;25154.612394968128;25300.493990120463 05:29:56 INFO - PROCESS | 24284 | |2;jquery.html;360.50070652146775;362.3984186250824;363.0651073485773;373.246042993154;383.6036825953528;15680.52958411248;16603.58491037723;17433.128343582834;17445.651086978254;17485.21316540757;16112.597185070379;16307.429239976604;16517.91741041296;16629.91685041576;16694.248758805854;5014.2227954667;5218.6346955712925;5241.947580524184;5247.501487358695;5262.421133675292;3730.6269373062746;3930.0567863712645;5117.078925793356;5671.829845104633;5974.3428222895445;5977.940220597782;5988.341282458926;6010.098485227229;6014.969925150368;6024;5918.4673379395845;5948.97025514874;5974.581779275452;5994.370591087938;6105.755769769204;3379.4423920053164;4968.975155124237;5217.5043370880085;5234.502722241381;5268.209768534713;20114.69827952582;20293.18827246923;20330.898345508176;20482.89758551198;20487.48781280465;1967.45894878908;1994.4415563642203;2074.0459388681074;2228.1755750372304;2421.164698179143;11790.764184716258;12994;13135.211887286794;13142.802857957138;13403.597892063253;1705.8379453951854;1756.2711474737969;1767.54043948573;1785.5893843863332;1810.4930619426582;42707.359389609184;62293.688531557505;65143.34856651467;66111.0083348755;66658;9649.276304277208;9745.269104817167;9854;9922.305438619373;9925.85852626957;13483.393247303698;13787.448502060006;13792.724145517033;13798.586042418543;13810.516631917835;7175.174854891754;7189.460790440738;7299.489035767551;7416.147143078507;7471.8505629887095;6895.965520172367;6905.136857892763;6955.65221738911;7078.265824872939;7119.82200444993;4223.788810559459;4279.529251782364;4289.2922667760095;4320.3519472078815;4384.254676704968;1621.1164915121287;1758.5955230297104;3122.3443076954095;3135.4356215880903;3220.903372898817;804.412778671573;862.6851199312206;880.9559522023873;944.8960614332418;951.2390087929629;15831.208439577975;16587.336506539843;16755.66488670244;16867.662646746998;17017.31930722782;826.9669213231524;866.4974314897345;877.5261358866269;888.4314039015036;940.3840484482674;9439.811203775886;9497.715068547956;9537.618495260112;9831.901680983241;10192.898071019343;405614;409580;416865;418443;419331;80006;83152;83292.58353708313;83500.58249708713;84316.57841710874;922.0917396364575;922.4603606890045;936.9718908432621;942.6182396129578;952.038441174405;15729.606759830638;15787.921060394625;15852.365905364117;16159.75760363572;16344.182790860646;35092.473612896334;35220.823895880356;35447.10081891042;36419.27161456703;36593.45109823408;47429.52570474389;49813.501864980884;51503.2274515875;51629.741851290506;51845;7096.254893236136;7241.203467618452;7282.526635768658;7286.927130728837;7342.118945726547;9058.818823623622;10591.735206619587;10645.574177032831;10789;11074.833877492005;5498;9219.308551858503;9464.526773661428;9547.474888881177;9557.092076252746;9239.39943903671;9343.53282335867;9801.11789938909;9831;9946.602135914482;9411.43531388119;9862.605495780088;9892.109710126124;9901.405915645084;9976.20190384782;7150;7228.530145540523;7289.562626242442;7320.890186647098;7561.584112873625;8606.44058136219;9767.85348219763;10104.545295461576;10197.796044078928;10870.130389568658 05:29:56 INFO - PROCESS | 24284 | |3;mootools.html;1244.2907542700664;1361.088070992435;1384.7368999890023;1452.5424491285244;1661.0864024786365;6267.843303917399;7099.929000709992;7300.817479563014;7314.122305323355;7500.362469190111;7328.78013659591;7348.706051757937;7402.555846649205;7407.6296185190795;7417.332440080391;2153.1172219390055;2161.1031421959947;2179.5640871825617;2182.8690278583335;2182.967255491169;2096.0986775686447;2126.170793390579;2160.9351719448364;2162.9242976495825;2167.934961951144;2130.9786902131013;2153.138744502196;2159.416957421495;2161.146347192858;2162.91348346066;2129.4995676016124;2136.1455417832835;2137.326742076241;2138.123369418539;2144.9785502145014;2029.736134302546;2102.9158833646634;2111.546017606222;2113.5350222950924;2113.746350437942;7361.815954601124;7428.9257107428775;7476.327130558221;7478.925210747877;7491.175970643225;4338.1540599583095;4521.050579378301;4522.909541809178;4531.796069176895;4538.3873177120995;2679.9598006029923;2811.2971757060736;2841.176058942904;2872.727090926359;2873.5115030444877;862.9180227878342;873.9082396348356;891.9163216691751;899.9640014399416;904.2856143646511;10019.198464122852;10085.49572521371;10124.088832005082;10125.139363154141;10132.999999999925;3857.7299589029058;3931.1351502669368;3977.423273625308;3980.6218409251073;4002;7992.16082311349;8027.959860200778;8047.718329858427;8048.718294859769;8052.154523775036;4249.107687385622;4291.935620965688;4292.012837047497;4296.398504209413;4300.80646370914;3525.9118522036642;3953.723239373274;3971.8808435746973;4028.073543085107;4118.464599602093;3292.8024318540965;3315.55240042596;3383.4755612880044;3417.53863228461;3457.6888080072413;1002.5438425516372;1006.059334522224;1009.5255230041869;1016.4663551635302;1017.7913527726946;777.2771322669971;799.9400793948042;801.2788490358723;801.3388954112763;806.8830019647119;4706.811727530929;4914.115459217375;4926.359573255526;4948.282499037691;4982.750862456863;790.6284046498137;798.9880151797728;811.7134342067889;817.7424111404888;845.3026253340895;3219.323941972212;3232.272738633789;3249.870005199813;3322.1362445763793;3373.3590617782543;8723.694670686495;8999.64001439935;9002.324825638103;9010.59452324647;9030.954845225864;8733.126687331216;8996.82006359869;9002.954985225031;9006.63973441068;9008.684696035607;6809.863802724017;6914.861702765917;6921.342472465108;6936.618485983319;6938.687759050855;4725.905481890274;4742.288656701522;4854.441739199896;4917.926231106465;4952.5542701157065;8207.58962051907;8386.916130838614;8460.069392366711;8495.065542790411;8496.53269070207;8455.619497122767;8601.096884827253;8651.870221946801;8666.869996949925;8736.432131911406;5514.035043867388;5854.209681692917;6260.467860231931;6367.808965731036;6374.745010199726;7048.894266586108;7196.640167991684;7275.272472752894;7275.672594733144;7281.089863767029;6149.169862068742;6389.297177310399;6464.676766161767;6493.415592596689;6571.868562628625;6222.160008398808;6372.681365931592;6377.649229292433;6500.772472963424;6587.934120658732;5860.619059761272;5870.5010074142465;5930.318013428338;5935.495482884004;5938;4058;4074.164796216709;4156.771377574141;4192.119654872511;4235.661147108285;3979.243943650697;4041.373587094005;4228.1966426378885;4241.066965267636;4331.740095594275 05:29:56 INFO - PROCESS | 24284 | |4;prototype.html;287.6002356724153;294.67732832548353;295.553713892023;296.08804880966625;300.6662604508993;4682.9697466557345;4826.3484429601995;4849.903001939959;4884.63365247607;4899.804007839686;4770.427548694153;4808.735519546432;4828.155072862252;4828.28595848474;4851.781669824857;3521.1901262709594;3643.7995910224927;3644.6355364463607;3739.4203898395726;3780.5085338905906;3477.9130521737034;3656.579493358258;3668.449732540127;3672.614375490575;3722.7952462614544;3693.759905606127;3701.518802555664;3712.3688972874543;3715.8327875245677;3728.738988270822;3690.132818787596;3696.20531585709;3699.130704284518;3700.6299370063048;3730.421784623388;3070.6949546442675;3163.6519982801874;3246.577944867152;3280.1799550112473;3288.720458761008;4683.508231635663;4708.976455117737;4727.267273572567;4738.739369334685;4777.116233496779;4272.273713468718;4291.678124140702;4292.1630282095;4301.505326887417;4311.1593239318345;4894.143524883131;5000.949990500121;5066.949330506722;5103.260027296058;5139.306193663845;3545.2554963457706;3564.1446052947367;3565.340412023758;3567.090391950062;3584.121890136933;5022.192010876081;5148.9742551287;5301.54936830366;5320.494553017457;5343.664083979005;3613.0786649404236;3634.509341238952;3635.163912300133;3638.21778317663;3672.540932383452;3632.72754543405;3637.5089362936196;3648.7993160376436;3694.556653201633;3698.613020117456;4172.520160181557;4275.337322714984;4275.764832934156;4281.437275394521;4284.207421626947;5050.671706339076;5084.262781896604;5098.209777484496;5113.105206588906;5115.1559992600805;1262.141743614351;1269.6444995401303;1282.4549566434227;1289.1878116786365;1290.2581015915887;788.9605519724106;805.923437273458;819.9385046121446;821.6179476543316;831.9584020798936;4019.799010049486;4050.5544390117066;4051.777152256654;4065.5121385433936;4080.489938757655;4591.403117594691;4627.768611569475;4632.559906808848;4662.251655629139;4664.696794708333;4021.557628660845;4046.615571520701;4050.3519436889956;4074.5314288856566;4098.52866920302;2487.4278915849454;2579.8452092874486;2800.3559181388396;2842.161562339115;2842.5167721487396;4956.727379994135;4964.925526117111;4968.478309777493;4993.226049962262;5018.84943451697;5290;5416.187571864173;5419.674819510842;5431.321084864392;5461.918071228934;4935;4937.160682683881;4957.942453881671;4981.676191047571;5002.549770520598;5203.219517072469;5263.184206448007;5264.552513036435;5320.866978325573;5328.626996110235;4971.144278606966;5056.84829455117;5140.228965655182;5160.174372100446;5201.817936372209;4730.834420795256;4830.420349558076;4943.555080042814;4960.751962401938;4961.784362831129;3604.6395360463744;3623.9456408153374;3638.4178531434845;3664.5602527696847;3672.540932383452;5285.735713214401;5302.337207849019;5306.204069389622;5321.600879934098;5337.706426146599;4984;5072.594192464668;5109.693418394908;5117.692938423557;5137.563307118788;5060.291559181644;5092.363454568179;5106.825430151161;5112.36095488064;5120.436751957356;5026.271190677405;5030.8239211627415;5047.596192304681;5048.469910659328;5062.265971434195;4956.702597844141;5075.619328550448;5142.305788718625;5150.40770311419;5184.429712731672;4992.975035124801;5005.721252579566;5006.899862002667;5015.297858299914;5022.623303252198 05:29:56 INFO - PROCESS | 24284 | |5;yui.html;610.8595023144677;652.3443938841464;655.6426747422654;657.5397221944637;720.8666396716608;12218.205816621914;12986;13046.739065218702;13052.934735326322;13063;12332.876671233285;12382.442790074445;12383.876161238384;12397.628071157857;12409.069319801007;610.5085406247969;624.6595605395071;763.2672634271106;771.6604693934679;783.75703531905;781.070526073973;783.0251337085308;790.699534177012;790.7351037402449;791.2245998921032;834.9791255218607;836.1262480707645;838.367032890167;838.8699751538521;839.9664013439456;655.151578705575;800.3917023062456;822.8066404395022;823.9711610093618;827.6523859978794;603.9909401358983;606.1059936593533;606.429955841512;606.4481321997006;608.1394826320751;12457.813132803016;12505.874941250562;12518.81221781674;12524.998000159965;12537.435815388239;12490.50037998488;13052.477900883954;13083;13119.540816071487;13188.802167967488;8992.23565996891;10862.728431789268;11178.44107794607;11356.602518911799;11678.532858685727;4200.390943313233;4254.87235382939;4312.072904325553;4346;4378.978105109486;55086.449135508534;55201.72399137979;55502.72248638771;55730;56385;10426.791464170674;10485.842712359321;10554.577816887391;10586.57653693859;10597.9470102649;17644.735328970077;17662.558436038944;17664.55838604045;18324.54188645268;19028.90485547591;7115.288471152947;7118.275404853871;7155.248698886542;7172.282771722786;7309.269073092648;3462.6710462506526;3612.476190952297;3665.1694243510365;3666.0285024468535;3673.0817991537933;2749.230215539652;2863.3414314707734;2868.5697145428353;2876.8130071545283;2877.49643812332;423.5468049187402;515.047162748919;515.8632962265003;523.5392854288202;525.1230445156598;551.5229326632514;565.7425871228581;565.9179418984224;572.5857132881775;611.9143319935213;8094.878576821352;8494.235518803338;8728.389012769172;8896.199342059246;8902.643894244287;507.6649411388466;545.5826292885945;606.2506532873398;614.5268143529457;629.2103410220144;3616.2044350242904;3682.429223470366;3694.519712437366;3792.658660720493;3827;87743;87750.56124719464;89470.55264723634;91573.54213228892;96592;77595.2240477588;78562;79790;79847.60076199698;81180.59409702914;46741.027012704304;67925.32074679388;68482.65758671274;69084;71025.64487177634;7751.37988960893;7831.725889594065;7847.447381436336;7880.724174653859;7996.56018918965;42368.57631423646;42473.150536989706;42482.36276455918;42920;43261.78369108134;58067.70966145311;58917;59302.40697592969;59306;59899.40100599112;9967.25245606597;10419.583216671248;10571.312864663772;10611.681649550526;10626.096781773636;10971.341719496855;11117.83323250168;11139.610113645984;11377.772444551229;11766.411679416165;10047.598096076075;10294.948525257325;10367;10510.474476276002;10920;11812.291262524275;12097.395130243629;12163.57427490069;12271.815922760987;12809.359532023547;11088.501017454395;11427.085833133164;11557.30656160633;11927.76144477123;11988.220765650205;9697.903020969983;9795.167410770164;10013.699589012342;10181.134603558781;10313.751168381936;9217;10087.798244034931;10189.133923616575;10246.129079028366;10302 05:29:56 INFO - PROCESS | 24284 | __end_tp_report 05:29:56 INFO - PROCESS | 24284 | __start_cc_report 05:29:56 INFO - PROCESS | 24284 | _x_x_mozilla_cycle_collect,1119 05:29:56 INFO - PROCESS | 24284 | __end_cc_report 05:29:56 INFO - PROCESS | 24284 | __startTimestamp1465475396986__endTimestamp 05:29:56 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | ------- Summary: start ------- 05:29:56 INFO - PROCESS | 24284 | Number of tests: 6 05:29:56 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | [#0] dojo.html Cycles:165 Average:4664.82 Median:4771.26 stddev:490.10 (10.3%) stddev-sans-first:463.73 05:29:56 INFO - PROCESS | 24284 | Values: 2587.9 2598.7 2628.4 2641.2 2647.9 4642.9 4711.6 4740.9 4782.0 4819.8 4638.8 4672.8 4679.3 4718.9 4740.4 4293.1 4360.8 4395.7 4422.6 4490.6 4370.9 4399.8 4415.2 4433.7 4445.5 4186.4 4219.5 4269.2 4280.9 4307.8 4272.6 4272.7 4275.6 4371.3 4379.3 4285.9 4305.0 4309.3 4352.5 4356.4 4581.5 4620.1 4640.8 4715.1 4722.0 5049.0 5054.5 5056.8 5066.5 5103.1 5072.2 5081.8 5086.6 5102.5 5122.7 4603.5 4727.9 4758.2 4776.3 4781.9 5240.9 5243.4 5310.5 5312.0 5312.3 5035.8 5047.6 5097.9 5099.9 5105.7 4879.1 4996.2 5034.3 5040.2 5060.7 4977.1 5018.3 5020.1 5022.1 5065.9 4817.0 4978.7 4983.3 4984.0 5040.0 4243.9 4309.7 4345.1 4348.9 4380.5 3738.5 3760.8 3761.0 3798.1 3802.2 4376.1 4383.1 4383.6 4425.4 4433.1 4937.8 5027.0 5064.9 5069.4 5086.6 4352.8 4356.3 4366.3 4370.4 4409.3 4495.2 4598.0 4602.8 4606.7 4642.6 4649.9 4651.5 4692.3 4700.6 4701.7 4971.8 5003.8 5006.2 5007.7 5053.3 4602.7 4685.4 4699.6 4741.3 4741.7 4967.8 5013.0 5025.3 5033.4 5077.3 5064.2 5092.7 5106.1 5110.7 5156.0 4809.3 4831.9 4858.0 4955.3 4961.6 4856.6 4885.8 4886.4 4909.4 4936.5 4809.1 4817.6 4820.4 4898.2 4899.7 4777.5 4821.0 4878.0 4921.1 5002.1 4754.5 4771.3 4798.4 4800.8 4832.1 05:29:56 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | [#1] ext.html Cycles:180 Average:50525.25 Median:17946.42 stddev:93352.87 (520.2%) stddev-sans-first:93539.28 05:29:56 INFO - PROCESS | 24284 | Values: 529.5 571.2 571.8 575.1 588.9 27310.6 40347.8 41424.4 41552.8 41562.8 40164.6 40800.8 40809.2 40921.4 40976.4 7606.9 7867.0 8023.1 10272.7 10600.0 9881.5 10344.6 10345.5 10353.1 10365.5 10333.1 10408.9 10411.7 10414.4 10415.8 10215.1 10334.7 10338.3 10338.4 10340.6 7637.2 10257.1 10309.9 10325.9 10330.5 29058.6 31059.2 31060.8 31095.7 39672.6 3085.9 3102.6 3132.5 3234.4 3313.3 29666.4 29752.6 29946.9 30490.7 30595.1 3385.0 3388.1 3419.7 3448.0 3476.9 276964.0 281814.0 282463.6 282479.0 284284.0 57387.4 57647.0 57693.7 57739.7 57793.7 60925.7 61228.4 61346.7 61437.2 61443.7 15490.3 15923.8 16008.8 16045.1 16050.3 11285.9 11392.6 11396.3 11417.6 11429.8 17642.7 18130.7 18216.3 18248.1 18253.1 7227.8 7257.9 7397.1 7431.1 7501.8 786.8 810.2 890.5 924.1 948.4 26870.2 27583.9 27887.0 28144.6 28268.4 814.5 931.4 983.9 1018.8 1091.1 14802.7 15253.9 15261.2 15300.7 15417.2 423319.0 424486.0 426066.0 427035.6 429124.0 49889.0 51175.7 51180.2 51277.7 51364.7 1073.5 1116.7 1158.5 1178.8 1202.3 27071.2 28465.9 28651.6 29069.0 29305.6 43219.6 43405.8 43854.1 43972.8 44002.3 336115.0 339841.0 340081.0 340576.0 341285.0 22944.1 23542.4 25772.9 26382.2 26399.6 41273.0 41328.6 41359.6 41444.4 42272.6 36006.3 36333.1 36638.1 36815.8 36907.3 35372.5 35667.8 35741.3 36109.3 36292.6 35855.5 36044.6 36537.3 36687.6 36776.4 31109.8 31921.2 32415.2 32501.7 32579.5 24861.9 24991.6 25092.4 25154.6 25300.5 05:29:56 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | [#2] jquery.html Cycles:180 Average:24835.92 Median:5218.07 stddev:68207.81 (1307.1%) stddev-sans-first:68374.39 05:29:56 INFO - PROCESS | 24284 | Values: 360.5 362.4 363.1 373.2 383.6 15680.5 16603.6 17433.1 17445.7 17485.2 16112.6 16307.4 16517.9 16629.9 16694.2 5014.2 5218.6 5241.9 5247.5 5262.4 3730.6 3930.1 5117.1 5671.8 5974.3 5977.9 5988.3 6010.1 6015.0 6024.0 5918.5 5949.0 5974.6 5994.4 6105.8 3379.4 4969.0 5217.5 5234.5 5268.2 20114.7 20293.2 20330.9 20482.9 20487.5 1967.5 1994.4 2074.0 2228.2 2421.2 11790.8 12994.0 13135.2 13142.8 13403.6 1705.8 1756.3 1767.5 1785.6 1810.5 42707.4 62293.7 65143.3 66111.0 66658.0 9649.3 9745.3 9854.0 9922.3 9925.9 13483.4 13787.4 13792.7 13798.6 13810.5 7175.2 7189.5 7299.5 7416.1 7471.9 6896.0 6905.1 6955.7 7078.3 7119.8 4223.8 4279.5 4289.3 4320.4 4384.3 1621.1 1758.6 3122.3 3135.4 3220.9 804.4 862.7 881.0 944.9 951.2 15831.2 16587.3 16755.7 16867.7 17017.3 827.0 866.5 877.5 888.4 940.4 9439.8 9497.7 9537.6 9831.9 10192.9 405614.0 409580.0 416865.0 418443.0 419331.0 80006.0 83152.0 83292.6 83500.6 84316.6 922.1 922.5 937.0 942.6 952.0 15729.6 15787.9 15852.4 16159.8 16344.2 35092.5 35220.8 35447.1 36419.3 36593.5 47429.5 49813.5 51503.2 51629.7 51845.0 7096.3 7241.2 7282.5 7286.9 7342.1 9058.8 10591.7 10645.6 10789.0 11074.8 5498.0 9219.3 9464.5 9547.5 9557.1 9239.4 9343.5 9801.1 9831.0 9946.6 9411.4 9862.6 9892.1 9901.4 9976.2 7150.0 7228.5 7289.6 7320.9 7561.6 8606.4 9767.9 10104.5 10197.8 10870.1 05:29:56 INFO - PROCESS | 24284 | 05:29:56 INFO - PROCESS | 24284 | [#3] mootools.html Cycles:180 Average:4825.06 Median:4922.14 stddev:2683.36 (54.5%) stddev-sans-first:2677.40 05:29:56 INFO - PROCESS | 24284 | Values: 1244.3 1361.1 1384.7 1452.5 1661.1 6267.8 7099.9 7300.8 7314.1 7500.4 7328.8 7348.7 7402.6 7407.6 7417.3 2153.1 2161.1 2179.6 2182.9 2183.0 2096.1 2126.2 2160.9 2162.9 2167.9 2131.0 2153.1 2159.4 2161.1 2162.9 2129.5 2136.1 2137.3 2138.1 2145.0 2029.7 2102.9 2111.5 2113.5 2113.7 7361.8 7428.9 7476.3 7478.9 7491.2 4338.2 4521.1 4522.9 4531.8 4538.4 2680.0 2811.3 2841.2 2872.7 2873.5 862.9 873.9 891.9 900.0 904.3 10019.2 10085.5 10124.1 10125.1 10133.0 3857.7 3931.1 3977.4 3980.6 4002.0 7992.2 8028.0 8047.7 8048.7 8052.2 4249.1 4291.9 4292.0 4296.4 4300.8 3525.9 3953.7 3971.9 4028.1 4118.5 3292.8 3315.6 3383.5 3417.5 3457.7 1002.5 1006.1 1009.5 1016.5 1017.8 777.3 799.9 801.3 801.3 806.9 4706.8 4914.1 4926.4 4948.3 4982.8 790.6 799.0 811.7 817.7 845.3 3219.3 3232.3 3249.9 3322.1 3373.4 8723.7 8999.6 9002.3 9010.6 9031.0 8733.1 8996.8 9003.0 9006.6 9008.7 6809.9 6914.9 6921.3 6936.6 6938.7 4725.9 4742.3 4854.4 4917.9 4952.6 8207.6 8386.9 8460.1 8495.1 8496.5 8455.6 8601.1 8651.9 8666.9 8736.4 5514.0 5854.2 6260.5 6367.8 6374.7 7048.9 7196.6 7275.3 7275.7 7281.1 6149.2 6389.3 6464.7 6493.4 6571.9 6222.2 6372.7 6377.6 6500.8 6587.9 5860.6 5870.5 5930.3 5935.5 5938.0 4058.0 4074.2 4156.8 4192.1 4235.7 3979.2 4041.4 4228.2 4241.1 4331.7 05:29:56 INFO - PROCESS | 24284 | 05:29:57 INFO - PROCESS | 24284 | [#4] prototype.html Cycles:180 Average:4161.93 Median:4754.58 stddev:1237.94 (26.0%) stddev-sans-first:1206.77 05:29:57 INFO - PROCESS | 24284 | Values: 287.6 294.7 295.6 296.1 300.7 4683.0 4826.3 4849.9 4884.6 4899.8 4770.4 4808.7 4828.2 4828.3 4851.8 3521.2 3643.8 3644.6 3739.4 3780.5 3477.9 3656.6 3668.4 3672.6 3722.8 3693.8 3701.5 3712.4 3715.8 3728.7 3690.1 3696.2 3699.1 3700.6 3730.4 3070.7 3163.7 3246.6 3280.2 3288.7 4683.5 4709.0 4727.3 4738.7 4777.1 4272.3 4291.7 4292.2 4301.5 4311.2 4894.1 5000.9 5066.9 5103.3 5139.3 3545.3 3564.1 3565.3 3567.1 3584.1 5022.2 5149.0 5301.5 5320.5 5343.7 3613.1 3634.5 3635.2 3638.2 3672.5 3632.7 3637.5 3648.8 3694.6 3698.6 4172.5 4275.3 4275.8 4281.4 4284.2 5050.7 5084.3 5098.2 5113.1 5115.2 1262.1 1269.6 1282.5 1289.2 1290.3 789.0 805.9 819.9 821.6 832.0 4019.8 4050.6 4051.8 4065.5 4080.5 4591.4 4627.8 4632.6 4662.3 4664.7 4021.6 4046.6 4050.4 4074.5 4098.5 2487.4 2579.8 2800.4 2842.2 2842.5 4956.7 4964.9 4968.5 4993.2 5018.8 5290.0 5416.2 5419.7 5431.3 5461.9 4935.0 4937.2 4957.9 4981.7 5002.5 5203.2 5263.2 5264.6 5320.9 5328.6 4971.1 5056.8 5140.2 5160.2 5201.8 4730.8 4830.4 4943.6 4960.8 4961.8 3604.6 3623.9 3638.4 3664.6 3672.5 5285.7 5302.3 5306.2 5321.6 5337.7 4984.0 5072.6 5109.7 5117.7 5137.6 5060.3 5092.4 5106.8 5112.4 5120.4 5026.3 5030.8 5047.6 5048.5 5062.3 4956.7 5075.6 5142.3 5150.4 5184.4 4993.0 5005.7 5006.9 5015.3 5022.6 05:29:57 INFO - PROCESS | 24284 | 05:29:57 INFO - PROCESS | 24284 | [#5] yui.html Cycles:180 Average:16732.71 Median:25560.00 stddev:23273.72 (91.1%) stddev-sans-first:23307.53 05:29:57 INFO - PROCESS | 24284 | Values: 610.9 652.3 655.6 657.5 720.9 12218.2 12986.0 13046.7 13052.9 13063.0 12332.9 12382.4 12383.9 12397.6 12409.1 610.5 624.7 763.3 771.7 783.8 781.1 783.0 790.7 790.7 791.2 835.0 836.1 838.4 838.9 840.0 655.2 800.4 822.8 824.0 827.7 604.0 606.1 606.4 606.4 608.1 12457.8 12505.9 12518.8 12525.0 12537.4 12490.5 13052.5 13083.0 13119.5 13188.8 8992.2 10862.7 11178.4 11356.6 11678.5 4200.4 4254.9 4312.1 4346.0 4379.0 55086.4 55201.7 55502.7 55730.0 56385.0 10426.8 10485.8 10554.6 10586.6 10597.9 17644.7 17662.6 17664.6 18324.5 19028.9 7115.3 7118.3 7155.2 7172.3 7309.3 3462.7 3612.5 3665.2 3666.0 3673.1 2749.2 2863.3 2868.6 2876.8 2877.5 423.5 515.0 515.9 523.5 525.1 551.5 565.7 565.9 572.6 611.9 8094.9 8494.2 8728.4 8896.2 8902.6 507.7 545.6 606.3 614.5 629.2 3616.2 3682.4 3694.5 3792.7 3827.0 87743.0 87750.6 89470.6 91573.5 96592.0 77595.2 78562.0 79790.0 79847.6 81180.6 46741.0 67925.3 68482.7 69084.0 71025.6 7751.4 7831.7 7847.4 7880.7 7996.6 42368.6 42473.2 42482.4 42920.0 43261.8 58067.7 58917.0 59302.4 59306.0 59899.4 9967.3 10419.6 10571.3 10611.7 10626.1 10971.3 11117.8 11139.6 11377.8 11766.4 10047.6 10294.9 10367.0 10510.5 10920.0 11812.3 12097.4 12163.6 12271.8 12809.4 11088.5 11427.1 11557.3 11927.8 11988.2 9697.9 9795.2 10013.7 10181.1 10313.8 9217.0 10087.8 10189.1 10246.1 10302.0 05:29:57 INFO - PROCESS | 24284 | -------- Summary: end -------- 05:29:57 INFO - PROCESS | 24284 | 05:29:57 INFO - TEST-INFO | 24284: exit 0 05:29:57 INFO - TEST-OK | dromaeo_css | took 1118951ms 05:29:57 INFO - TEST-START | kraken 05:29:57 INFO - operating with platform_type : linux_ 05:29:57 INFO - Initialising browser for kraken test... 05:29:57 INFO - TEST-INFO | started process 24468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevnK4l/profile http://localhost:50569/getInfo.html) 05:30:01 INFO - PROCESS | 24468 | __metrics Screen width/height:1600/1200 05:30:01 INFO - PROCESS | 24468 | colorDepth:24 05:30:01 INFO - PROCESS | 24468 | Browser inner width/height: 1024/697 05:30:01 INFO - PROCESS | 24468 | __metrics 05:30:02 ERROR - PROCESS | 24468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:30:02 INFO - PROCESS | 24468 | console.error: PushService: 05:30:02 INFO - PROCESS | 24468 | stateChangeProcessEnqueue: Error transitioning state 05:30:02 INFO - PROCESS | 24468 | UnknownError 05:30:03 INFO - TEST-INFO | 24468: exit 0 05:30:03 INFO - Browser initialized. 05:30:03 INFO - Running cycle 1/1 for kraken test... 05:30:03 INFO - TEST-INFO | started process 24550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevnK4l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:15 INFO - PROCESS | 24550 | RSS: Main: 174874624 05:30:15 INFO - PROCESS | 24550 | 05:30:18 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50569/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:19 INFO - PROCESS | 24550 | RSS: Main: 232456192 05:30:19 INFO - PROCESS | 24550 | 05:30:21 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50569/tests/kraken/driver.html?testName=audio-dft) 05:30:22 INFO - PROCESS | 24550 | RSS: Main: 221257728 05:30:22 INFO - PROCESS | 24550 | 05:30:25 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50569/tests/kraken/driver.html?testName=audio-fft) 05:30:26 INFO - PROCESS | 24550 | RSS: Main: 287739904 05:30:26 INFO - PROCESS | 24550 | 05:30:28 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50569/tests/kraken/driver.html?testName=audio-oscillator) 05:30:29 INFO - PROCESS | 24550 | RSS: Main: 197640192 05:30:29 INFO - PROCESS | 24550 | 05:30:31 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:32 INFO - PROCESS | 24550 | RSS: Main: 201457664 05:30:32 INFO - PROCESS | 24550 | 05:30:35 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50569/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:35 INFO - PROCESS | 24550 | RSS: Main: 237723648 05:30:35 INFO - PROCESS | 24550 | 05:30:39 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50569/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:39 INFO - PROCESS | 24550 | RSS: Main: 238305280 05:30:39 INFO - PROCESS | 24550 | 05:30:42 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50569/tests/kraken/driver.html?testName=json-parse-financial) 05:30:43 INFO - PROCESS | 24550 | RSS: Main: 237707264 05:30:43 INFO - PROCESS | 24550 | 05:30:45 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:45 INFO - PROCESS | 24550 | RSS: Main: 220561408 05:30:45 INFO - PROCESS | 24550 | 05:30:47 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:48 INFO - PROCESS | 24550 | RSS: Main: 226926592 05:30:48 INFO - PROCESS | 24550 | 05:30:50 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:51 INFO - PROCESS | 24550 | RSS: Main: 234700800 05:30:51 INFO - PROCESS | 24550 | 05:30:53 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:54 INFO - PROCESS | 24550 | RSS: Main: 239804416 05:30:54 INFO - PROCESS | 24550 | 05:30:57 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:58 INFO - PROCESS | 24550 | RSS: Main: 238567424 05:30:58 INFO - PROCESS | 24550 | 05:30:59 INFO - PROCESS | 24550 | Cycle 1(1): loaded http://localhost:50569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50569/tests/kraken/driver.html?testName=ai-astar) 05:31:00 INFO - PROCESS | 24550 | RSS: Main: 281247744 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | __start_tp_report 05:31:00 INFO - PROCESS | 24550 | _x_x_mozilla_page_load 05:31:00 INFO - PROCESS | 24550 | _x_x_mozilla_page_load_details 05:31:00 INFO - PROCESS | 24550 | |i|pagename|runs| 05:31:00 INFO - PROCESS | 24550 | |0;ai-astar;115;107;113;114;114;112;112;112;111;112 05:31:00 INFO - PROCESS | 24550 | |1;audio-beat-detection;166;129;130;187;130;139;156;131;207;131 05:31:00 INFO - PROCESS | 24550 | |2;audio-dft;163;160;161;161;160;161;161;161;162;161 05:31:00 INFO - PROCESS | 24550 | |3;audio-fft;75;77;77;109;76;75;76;77;102;76 05:31:00 INFO - PROCESS | 24550 | |4;audio-oscillator;86;86;111;86;86;86;123;85;87;129 05:31:00 INFO - PROCESS | 24550 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;117;116 05:31:00 INFO - PROCESS | 24550 | |6;imaging-darkroom;145;146;145;145;146;146;147;145;146;146 05:31:00 INFO - PROCESS | 24550 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 05:31:00 INFO - PROCESS | 24550 | |8;json-parse-financial;63;62;64;64;63;64;63;64;63;63 05:31:00 INFO - PROCESS | 24550 | |9;json-stringify-tinderbox;64;64;65;64;64;64;64;65;65;65 05:31:00 INFO - PROCESS | 24550 | |10;stanford-crypto-aes;91;84;84;85;85;84;85;86;134;85 05:31:00 INFO - PROCESS | 24550 | |11;stanford-crypto-ccm;150;133;133;143;130;131;131;140;136;143 05:31:00 INFO - PROCESS | 24550 | |12;stanford-crypto-pbkdf2;178;173;169;166;171;167;166;171;168;170 05:31:00 INFO - PROCESS | 24550 | |13;stanford-crypto-sha256-iterative;67;69;67;66;66;66;66;66;67;66 05:31:00 INFO - PROCESS | 24550 | __end_tp_report 05:31:00 INFO - PROCESS | 24550 | __start_cc_report 05:31:00 INFO - PROCESS | 24550 | _x_x_mozilla_cycle_collect,1933 05:31:00 INFO - PROCESS | 24550 | __end_cc_report 05:31:00 INFO - PROCESS | 24550 | __startTimestamp1465475460017__endTimestamp 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | ------- Summary: start ------- 05:31:00 INFO - PROCESS | 24550 | Number of tests: 14 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:2.20 (2.0%) stddev-sans-first:2.09 05:31:00 INFO - PROCESS | 24550 | Values: 115.0 107.0 113.0 114.0 114.0 112.0 112.0 112.0 111.0 112.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:147.50 stddev:27.87 (18.9%) stddev-sans-first:29.00 05:31:00 INFO - PROCESS | 24550 | Values: 166.0 129.0 130.0 187.0 130.0 139.0 156.0 131.0 207.0 131.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.60 05:31:00 INFO - PROCESS | 24550 | Values: 163.0 160.0 161.0 161.0 160.0 161.0 161.0 161.0 162.0 161.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.52 (16.5%) stddev-sans-first:13.02 05:31:00 INFO - PROCESS | 24550 | Values: 75.0 77.0 77.0 109.0 76.0 75.0 76.0 77.0 102.0 76.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:86.00 stddev:17.46 (20.3%) stddev-sans-first:18.10 05:31:00 INFO - PROCESS | 24550 | Values: 86.0 86.0 111.0 86.0 86.0 86.0 123.0 85.0 87.0 129.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:31:00 INFO - PROCESS | 24550 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 116.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:31:00 INFO - PROCESS | 24550 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 147.0 145.0 146.0 146.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:31:00 INFO - PROCESS | 24550 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 05:31:00 INFO - PROCESS | 24550 | Values: 63.0 62.0 64.0 64.0 63.0 64.0 63.0 64.0 63.0 63.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:31:00 INFO - PROCESS | 24550 | Values: 64.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 65.0 65.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:85.00 stddev:15.49 (18.2%) stddev-sans-first:16.43 05:31:00 INFO - PROCESS | 24550 | Values: 91.0 84.0 84.0 85.0 85.0 84.0 85.0 86.0 134.0 85.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:138.00 stddev:6.70 (4.9%) stddev-sans-first:5.20 05:31:00 INFO - PROCESS | 24550 | Values: 150.0 133.0 133.0 143.0 130.0 131.0 131.0 140.0 136.0 143.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:3.67 (2.1%) stddev-sans-first:2.45 05:31:00 INFO - PROCESS | 24550 | Values: 178.0 173.0 169.0 166.0 171.0 167.0 166.0 171.0 168.0 170.0 05:31:00 INFO - PROCESS | 24550 | 05:31:00 INFO - PROCESS | 24550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:31:00 INFO - PROCESS | 24550 | Values: 67.0 69.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 05:31:00 INFO - PROCESS | 24550 | -------- Summary: end -------- 05:31:00 INFO - PROCESS | 24550 | 05:31:01 INFO - TEST-INFO | 24550: exit 0 05:31:01 INFO - TEST-OK | kraken | took 63267ms 05:31:01 INFO - SUITE-END | took 1182s 05:31:01 INFO - Completed test suite (00:19:42) 05:31:01 INFO - javascript benchmark 05:31:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.8964841406346, 2598.6881574211097, 2628.369191394065, 2641.1548304542544, 2647.933801654958, 4642.883927901804, 4711.575958163765, 4740.90518189636, 4781.976090119549, 4819.759012049397, 4638.768061596915, 4672.813087476497, 4679.321498382733, 4718.882027949295, 4740.431148262205, 4293.076988447491, 4360.803763830635, 4395.714278571899, 4422.5577442255835, 4490.5509449055, 4370.934435983463, 4399.780010999453, 4415.20526305265, 4433.733975961437, 4445.488768791582, 4186.39297301891, 4219.51475580306, 4269.210196113729, 4280.935785963213, 4307.82768689252, 4272.6154646081695, 4272.6795490338345, 4275.551067137968, 4371.344298355272, 4379.321205213197, 4285.935710964338, 4304.978475107636, 4309.288967320388, 4352.455943007124, 4356.43366362374, 4581.541845815425, 4620.052889157748, 4640.837570685044, 4715.127701375257, 4722.031983443386, 5048.974755126201, 5054.519820617035, 5056.84829455117, 5066.493350664904, 5103.106956282672, 5072.2391641253735, 5081.8475445736685, 5086.643934924557, 5102.464241254689, 5122.743862806845, 4603.49361570227, 4727.905441891212, 4758.214894542396, 4776.307435421844, 4781.904361912742, 5240.895182096413, 5243.397009343898, 5310.522053015247, 5312.04383211018, 5312.335958005249, 5035.82374616894, 5047.646664733506, 5097.8725531861255, 5099.923501147486, 5105.668131571436, 4879.121758083579, 4996.150654388763, 5034.270030845581, 5040.193569029011, 5060.746962651852, 4977.104121258136, 5018.272350509229, 5020.146575082244, 5022.121128802445, 5065.949340506621, 4817.0365926814075, 4978.726170060609, 4983.252512123138, 4983.950160498421, 5039.992001599695, 4243.893902652459, 4309.741415515079, 4345.130973805189, 4348.934765978513, 4380.496242932039, 3738.457923601117, 3760.793156376371, 3761.0, 3798.1264309209037, 3802.239552089593, 4376.059147283349, 4383.123375324948, 4383.561643835655, 4425.35832304314, 4433.091216300651, 4937.777799998937, 5027.0, 5064.949350506447, 5069.417017043013, 5086.593072554261, 4352.782360882006, 4356.259435895905, 4366.345048242789, 4370.431843860341, 4409.33859921008, 4495.235809912323, 4597.977010114995, 4602.769861506911, 4606.677532572755, 4642.582167604932, 4649.883752906137, 4651.488336283006, 4692.296155576554, 4700.623950084054, 4701.7178969260585, 4971.801127954841, 5003.799848006039, 5006.1739812930455, 5007.7496125192865, 5053.31780209667, 4602.723836569817, 4685.4143232095985, 4699.647526435463, 4741.312509686008, 4741.668083234141, 4967.801287948441, 5013.0, 5025.321581586439, 5033.446320904771, 5077.263796749525, 5064.215046667772, 5092.694438333712, 5106.055379754757, 5110.66780659256, 5156.04613146569, 4809.278608208797, 4831.903361932671, 4857.975710121426, 4955.306257124078, 4961.627877909099, 4856.63575231852, 4885.755712214304, 4886.438059623047, 4909.410870695539, 4936.506349365179, 4809.0862736080035, 4817.614590832655, 4820.4456487502985, 4898.191798353232, 4899.730514821576, 4777.498362672009, 4820.9517904820505, 4878.0, 4921.138800709933, 5002.074616196015, 4754.45323787755, 4771.260454629538, 4798.352222449925, 4800.783964721526, 4832.106060378701], "value": 4633.398295698282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.5140849843, 571.2488078177197, 571.8370264474623, 575.0827430248752, 588.9411058894111, 27310.5903411449, 40347.79826100869, 41424.378634320434, 41552.792236038855, 41562.79218603903, 40164.59835401645, 40800.79599602005, 40809.18381632365, 40921.386179207264, 40976.38535421971, 7606.885896711554, 7866.999999999985, 8023.117457079717, 10272.691819245434, 10600.0, 9881.505924703772, 10344.586216551328, 10345.534450949688, 10353.068223859851, 10365.481725913713, 10333.070023697866, 10408.947955260213, 10411.687649370531, 10414.427206503638, 10415.843762343571, 10215.131713804336, 10334.741631459236, 10338.276320657556, 10338.379697218115, 10340.638077667321, 7637.15991240963, 10257.128144107684, 10309.948450257776, 10325.9483702581, 10330.483475826253, 29058.564121538195, 31059.22351941197, 31060.844695776377, 31095.68904310973, 39672.60327396747, 3085.8765649374, 3102.6431960324626, 3132.530120481923, 3234.4016356974034, 3313.3207692422993, 29666.406671866658, 29752.55371169434, 29946.850265748533, 30490.695093049006, 30595.082147535388, 3384.983075084609, 3388.102152929476, 3419.7264218862433, 3447.9827600861836, 3476.878309259164, 276964.0, 281814.0, 282463.58768206235, 282479.0, 284284.0, 57387.426125739046, 57647.0, 57693.71153144207, 57739.711301443225, 57793.711031444574, 60925.69537152286, 61228.38771612316, 61346.693266534276, 61437.156885293516, 61443.69278153581, 15490.30293636789, 15923.840761592235, 16008.839911600735, 16045.117518536592, 16050.277737501607, 11285.943570282261, 11392.601258955896, 11396.316221026766, 11417.60038398652, 11429.771404572028, 17642.73535896937, 18130.728039079426, 18216.271349145885, 18248.087595620167, 18253.087345632666, 7227.819304517429, 7257.8548429031125, 7397.112346518452, 7431.145418276859, 7501.812454688677, 786.8229648329194, 810.1776696652902, 890.5235698901187, 924.0805398628273, 948.3503799897093, 26870.193894183205, 27583.86208068947, 27887.0, 28144.577831332546, 28268.43463130767, 814.4787336104897, 931.3992474853682, 983.9163671088038, 1018.8115198688266, 1091.0834898685143, 14802.703945921021, 15253.923730381277, 15261.23693815327, 15300.682950224953, 15417.152056636993, 423319.0, 424486.0, 426066.0, 427035.5944660833, 429124.0, 49889.0, 51175.74412127915, 51180.23229651558, 51277.74361128245, 51364.74317628388, 1073.4847273308856, 1116.6538373104202, 1158.5134243617533, 1178.7642471505562, 1202.2606097250127, 27071.1878643641, 28465.857670711513, 28651.57022644704, 29069.0, 29305.56041659334, 43219.56780432155, 43405.78297108494, 43854.12291754211, 43972.780136099114, 44002.33996490119, 336115.0, 339841.0, 340081.0, 340576.0, 341285.0, 22944.082236710343, 23542.411439714146, 25772.8711356442, 26382.20853374402, 26399.604005939542, 41273.0, 41328.58671413247, 41359.586404135574, 41444.37833432441, 42272.5772742281, 36006.27987440289, 36333.0916727084, 36638.084047899014, 36815.81592092022, 36907.26185476329, 35372.46941295934, 35667.821660892565, 35741.285174296885, 36109.27781444409, 36292.637073628925, 35855.46216806802, 36044.63955360413, 36537.26925461423, 36687.63312366842, 36776.44835327526, 31109.8444507776, 31921.20196995001, 32415.189620259684, 32501.67498325081, 32579.511307330882, 24861.87569062143, 24991.625125623494, 25092.37269068215, 25154.612394968128, 25300.493990120463], "value": 18372.047112356227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.50070652146775, 362.3984186250824, 363.0651073485773, 373.246042993154, 383.6036825953528, 15680.52958411248, 16603.58491037723, 17433.128343582834, 17445.651086978254, 17485.21316540757, 16112.597185070379, 16307.429239976604, 16517.91741041296, 16629.91685041576, 16694.248758805854, 5014.2227954667, 5218.6346955712925, 5241.947580524184, 5247.501487358695, 5262.421133675292, 3730.6269373062746, 3930.0567863712645, 5117.078925793356, 5671.829845104633, 5974.3428222895445, 5977.940220597782, 5988.341282458926, 6010.098485227229, 6014.969925150368, 6024.0, 5918.4673379395845, 5948.97025514874, 5974.581779275452, 5994.370591087938, 6105.755769769204, 3379.4423920053164, 4968.975155124237, 5217.5043370880085, 5234.502722241381, 5268.209768534713, 20114.69827952582, 20293.18827246923, 20330.898345508176, 20482.89758551198, 20487.48781280465, 1967.45894878908, 1994.4415563642203, 2074.0459388681074, 2228.1755750372304, 2421.164698179143, 11790.764184716258, 12994.0, 13135.211887286794, 13142.802857957138, 13403.597892063253, 1705.8379453951854, 1756.2711474737969, 1767.54043948573, 1785.5893843863332, 1810.4930619426582, 42707.359389609184, 62293.688531557505, 65143.34856651467, 66111.0083348755, 66658.0, 9649.276304277208, 9745.269104817167, 9854.0, 9922.305438619373, 9925.85852626957, 13483.393247303698, 13787.448502060006, 13792.724145517033, 13798.586042418543, 13810.516631917835, 7175.174854891754, 7189.460790440738, 7299.489035767551, 7416.147143078507, 7471.8505629887095, 6895.965520172367, 6905.136857892763, 6955.65221738911, 7078.265824872939, 7119.82200444993, 4223.788810559459, 4279.529251782364, 4289.2922667760095, 4320.3519472078815, 4384.254676704968, 1621.1164915121287, 1758.5955230297104, 3122.3443076954095, 3135.4356215880903, 3220.903372898817, 804.412778671573, 862.6851199312206, 880.9559522023873, 944.8960614332418, 951.2390087929629, 15831.208439577975, 16587.336506539843, 16755.66488670244, 16867.662646746998, 17017.31930722782, 826.9669213231524, 866.4974314897345, 877.5261358866269, 888.4314039015036, 940.3840484482674, 9439.811203775886, 9497.715068547956, 9537.618495260112, 9831.901680983241, 10192.898071019343, 405614.0, 409580.0, 416865.0, 418443.0, 419331.0, 80006.0, 83152.0, 83292.58353708313, 83500.58249708713, 84316.57841710874, 922.0917396364575, 922.4603606890045, 936.9718908432621, 942.6182396129578, 952.038441174405, 15729.606759830638, 15787.921060394625, 15852.365905364117, 16159.75760363572, 16344.182790860646, 35092.473612896334, 35220.823895880356, 35447.10081891042, 36419.27161456703, 36593.45109823408, 47429.52570474389, 49813.501864980884, 51503.2274515875, 51629.741851290506, 51845.0, 7096.254893236136, 7241.203467618452, 7282.526635768658, 7286.927130728837, 7342.118945726547, 9058.818823623622, 10591.735206619587, 10645.574177032831, 10789.0, 11074.833877492005, 5498.0, 9219.308551858503, 9464.526773661428, 9547.474888881177, 9557.092076252746, 9239.39943903671, 9343.53282335867, 9801.11789938909, 9831.0, 9946.602135914482, 9411.43531388119, 9862.605495780088, 9892.109710126124, 9901.405915645084, 9976.20190384782, 7150.0, 7228.530145540523, 7289.562626242442, 7320.890186647098, 7561.584112873625, 8606.44058136219, 9767.85348219763, 10104.545295461576, 10197.796044078928, 10870.130389568658], "value": 8272.082336640602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.2907542700664, 1361.088070992435, 1384.7368999890023, 1452.5424491285244, 1661.0864024786365, 6267.843303917399, 7099.929000709992, 7300.817479563014, 7314.122305323355, 7500.362469190111, 7328.78013659591, 7348.706051757937, 7402.555846649205, 7407.6296185190795, 7417.332440080391, 2153.1172219390055, 2161.1031421959947, 2179.5640871825617, 2182.8690278583335, 2182.967255491169, 2096.0986775686447, 2126.170793390579, 2160.9351719448364, 2162.9242976495825, 2167.934961951144, 2130.9786902131013, 2153.138744502196, 2159.416957421495, 2161.146347192858, 2162.91348346066, 2129.4995676016124, 2136.1455417832835, 2137.326742076241, 2138.123369418539, 2144.9785502145014, 2029.736134302546, 2102.9158833646634, 2111.546017606222, 2113.5350222950924, 2113.746350437942, 7361.815954601124, 7428.9257107428775, 7476.327130558221, 7478.925210747877, 7491.175970643225, 4338.1540599583095, 4521.050579378301, 4522.909541809178, 4531.796069176895, 4538.3873177120995, 2679.9598006029923, 2811.2971757060736, 2841.176058942904, 2872.727090926359, 2873.5115030444877, 862.9180227878342, 873.9082396348356, 891.9163216691751, 899.9640014399416, 904.2856143646511, 10019.198464122852, 10085.49572521371, 10124.088832005082, 10125.139363154141, 10132.999999999925, 3857.7299589029058, 3931.1351502669368, 3977.423273625308, 3980.6218409251073, 4002.0, 7992.16082311349, 8027.959860200778, 8047.718329858427, 8048.718294859769, 8052.154523775036, 4249.107687385622, 4291.935620965688, 4292.012837047497, 4296.398504209413, 4300.80646370914, 3525.9118522036642, 3953.723239373274, 3971.8808435746973, 4028.073543085107, 4118.464599602093, 3292.8024318540965, 3315.55240042596, 3383.4755612880044, 3417.53863228461, 3457.6888080072413, 1002.5438425516372, 1006.059334522224, 1009.5255230041869, 1016.4663551635302, 1017.7913527726946, 777.2771322669971, 799.9400793948042, 801.2788490358723, 801.3388954112763, 806.8830019647119, 4706.811727530929, 4914.115459217375, 4926.359573255526, 4948.282499037691, 4982.750862456863, 790.6284046498137, 798.9880151797728, 811.7134342067889, 817.7424111404888, 845.3026253340895, 3219.323941972212, 3232.272738633789, 3249.870005199813, 3322.1362445763793, 3373.3590617782543, 8723.694670686495, 8999.64001439935, 9002.324825638103, 9010.59452324647, 9030.954845225864, 8733.126687331216, 8996.82006359869, 9002.954985225031, 9006.63973441068, 9008.684696035607, 6809.863802724017, 6914.861702765917, 6921.342472465108, 6936.618485983319, 6938.687759050855, 4725.905481890274, 4742.288656701522, 4854.441739199896, 4917.926231106465, 4952.5542701157065, 8207.58962051907, 8386.916130838614, 8460.069392366711, 8495.065542790411, 8496.53269070207, 8455.619497122767, 8601.096884827253, 8651.870221946801, 8666.869996949925, 8736.432131911406, 5514.035043867388, 5854.209681692917, 6260.467860231931, 6367.808965731036, 6374.745010199726, 7048.894266586108, 7196.640167991684, 7275.272472752894, 7275.672594733144, 7281.089863767029, 6149.169862068742, 6389.297177310399, 6464.676766161767, 6493.415592596689, 6571.868562628625, 6222.160008398808, 6372.681365931592, 6377.649229292433, 6500.772472963424, 6587.934120658732, 5860.619059761272, 5870.5010074142465, 5930.318013428338, 5935.495482884004, 5938.0, 4058.0, 4074.164796216709, 4156.771377574141, 4192.119654872511, 4235.661147108285, 3979.243943650697, 4041.373587094005, 4228.1966426378885, 4241.066965267636, 4331.740095594275], "value": 3900.318238852076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.6002356724153, 294.67732832548353, 295.553713892023, 296.08804880966625, 300.6662604508993, 4682.9697466557345, 4826.3484429601995, 4849.903001939959, 4884.63365247607, 4899.804007839686, 4770.427548694153, 4808.735519546432, 4828.155072862252, 4828.28595848474, 4851.781669824857, 3521.1901262709594, 3643.7995910224927, 3644.6355364463607, 3739.4203898395726, 3780.5085338905906, 3477.9130521737034, 3656.579493358258, 3668.449732540127, 3672.614375490575, 3722.7952462614544, 3693.759905606127, 3701.518802555664, 3712.3688972874543, 3715.8327875245677, 3728.738988270822, 3690.132818787596, 3696.20531585709, 3699.130704284518, 3700.6299370063048, 3730.421784623388, 3070.6949546442675, 3163.6519982801874, 3246.577944867152, 3280.1799550112473, 3288.720458761008, 4683.508231635663, 4708.976455117737, 4727.267273572567, 4738.739369334685, 4777.116233496779, 4272.273713468718, 4291.678124140702, 4292.1630282095, 4301.505326887417, 4311.1593239318345, 4894.143524883131, 5000.949990500121, 5066.949330506722, 5103.260027296058, 5139.306193663845, 3545.2554963457706, 3564.1446052947367, 3565.340412023758, 3567.090391950062, 3584.121890136933, 5022.192010876081, 5148.9742551287, 5301.54936830366, 5320.494553017457, 5343.664083979005, 3613.0786649404236, 3634.509341238952, 3635.163912300133, 3638.21778317663, 3672.540932383452, 3632.72754543405, 3637.5089362936196, 3648.7993160376436, 3694.556653201633, 3698.613020117456, 4172.520160181557, 4275.337322714984, 4275.764832934156, 4281.437275394521, 4284.207421626947, 5050.671706339076, 5084.262781896604, 5098.209777484496, 5113.105206588906, 5115.1559992600805, 1262.141743614351, 1269.6444995401303, 1282.4549566434227, 1289.1878116786365, 1290.2581015915887, 788.9605519724106, 805.923437273458, 819.9385046121446, 821.6179476543316, 831.9584020798936, 4019.799010049486, 4050.5544390117066, 4051.777152256654, 4065.5121385433936, 4080.489938757655, 4591.403117594691, 4627.768611569475, 4632.559906808848, 4662.251655629139, 4664.696794708333, 4021.557628660845, 4046.615571520701, 4050.3519436889956, 4074.5314288856566, 4098.52866920302, 2487.4278915849454, 2579.8452092874486, 2800.3559181388396, 2842.161562339115, 2842.5167721487396, 4956.727379994135, 4964.925526117111, 4968.478309777493, 4993.226049962262, 5018.84943451697, 5290.0, 5416.187571864173, 5419.674819510842, 5431.321084864392, 5461.918071228934, 4935.0, 4937.160682683881, 4957.942453881671, 4981.676191047571, 5002.549770520598, 5203.219517072469, 5263.184206448007, 5264.552513036435, 5320.866978325573, 5328.626996110235, 4971.144278606966, 5056.84829455117, 5140.228965655182, 5160.174372100446, 5201.817936372209, 4730.834420795256, 4830.420349558076, 4943.555080042814, 4960.751962401938, 4961.784362831129, 3604.6395360463744, 3623.9456408153374, 3638.4178531434845, 3664.5602527696847, 3672.540932383452, 5285.735713214401, 5302.337207849019, 5306.204069389622, 5321.600879934098, 5337.706426146599, 4984.0, 5072.594192464668, 5109.693418394908, 5117.692938423557, 5137.563307118788, 5060.291559181644, 5092.363454568179, 5106.825430151161, 5112.36095488064, 5120.436751957356, 5026.271190677405, 5030.8239211627415, 5047.596192304681, 5048.469910659328, 5062.265971434195, 4956.702597844141, 5075.619328550448, 5142.305788718625, 5150.40770311419, 5184.429712731672, 4992.975035124801, 5005.721252579566, 5006.899862002667, 5015.297858299914, 5022.623303252198], "value": 3767.160486332744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8595023144677, 652.3443938841464, 655.6426747422654, 657.5397221944637, 720.8666396716608, 12218.205816621914, 12986.0, 13046.739065218702, 13052.934735326322, 13063.0, 12332.876671233285, 12382.442790074445, 12383.876161238384, 12397.628071157857, 12409.069319801007, 610.5085406247969, 624.6595605395071, 763.2672634271106, 771.6604693934679, 783.75703531905, 781.070526073973, 783.0251337085308, 790.699534177012, 790.7351037402449, 791.2245998921032, 834.9791255218607, 836.1262480707645, 838.367032890167, 838.8699751538521, 839.9664013439456, 655.151578705575, 800.3917023062456, 822.8066404395022, 823.9711610093618, 827.6523859978794, 603.9909401358983, 606.1059936593533, 606.429955841512, 606.4481321997006, 608.1394826320751, 12457.813132803016, 12505.874941250562, 12518.81221781674, 12524.998000159965, 12537.435815388239, 12490.50037998488, 13052.477900883954, 13083.0, 13119.540816071487, 13188.802167967488, 8992.23565996891, 10862.728431789268, 11178.44107794607, 11356.602518911799, 11678.532858685727, 4200.390943313233, 4254.87235382939, 4312.072904325553, 4346.0, 4378.978105109486, 55086.449135508534, 55201.72399137979, 55502.72248638771, 55730.0, 56385.0, 10426.791464170674, 10485.842712359321, 10554.577816887391, 10586.57653693859, 10597.9470102649, 17644.735328970077, 17662.558436038944, 17664.55838604045, 18324.54188645268, 19028.90485547591, 7115.288471152947, 7118.275404853871, 7155.248698886542, 7172.282771722786, 7309.269073092648, 3462.6710462506526, 3612.476190952297, 3665.1694243510365, 3666.0285024468535, 3673.0817991537933, 2749.230215539652, 2863.3414314707734, 2868.5697145428353, 2876.8130071545283, 2877.49643812332, 423.5468049187402, 515.047162748919, 515.8632962265003, 523.5392854288202, 525.1230445156598, 551.5229326632514, 565.7425871228581, 565.9179418984224, 572.5857132881775, 611.9143319935213, 8094.878576821352, 8494.235518803338, 8728.389012769172, 8896.199342059246, 8902.643894244287, 507.6649411388466, 545.5826292885945, 606.2506532873398, 614.5268143529457, 629.2103410220144, 3616.2044350242904, 3682.429223470366, 3694.519712437366, 3792.658660720493, 3827.0, 87743.0, 87750.56124719464, 89470.55264723634, 91573.54213228892, 96592.0, 77595.2240477588, 78562.0, 79790.0, 79847.60076199698, 81180.59409702914, 46741.027012704304, 67925.32074679388, 68482.65758671274, 69084.0, 71025.64487177634, 7751.37988960893, 7831.725889594065, 7847.447381436336, 7880.724174653859, 7996.56018918965, 42368.57631423646, 42473.150536989706, 42482.36276455918, 42920.0, 43261.78369108134, 58067.70966145311, 58917.0, 59302.40697592969, 59306.0, 59899.40100599112, 9967.25245606597, 10419.583216671248, 10571.312864663772, 10611.681649550526, 10626.096781773636, 10971.341719496855, 11117.83323250168, 11139.610113645984, 11377.772444551229, 11766.411679416165, 10047.598096076075, 10294.948525257325, 10367.0, 10510.474476276002, 10920.0, 11812.291262524275, 12097.395130243629, 12163.57427490069, 12271.815922760987, 12809.359532023547, 11088.501017454395, 11427.085833133164, 11557.30656160633, 11927.76144477123, 11988.220765650205, 9697.903020969983, 9795.167410770164, 10013.699589012342, 10181.134603558781, 10313.751168381936, 9217.0, 10087.798244034931, 10189.133923616575, 10246.129079028366, 10302.0], "value": 6423.942053132462, "unit": "score"}], "name": "dromaeo_css", "value": 6364.638610138247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 113.0, 114.0, 114.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 129.0, 130.0, 187.0, 130.0, 139.0, 156.0, 131.0, 207.0, 131.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 109.0, 76.0, 75.0, 76.0, 77.0, 102.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 111.0, 86.0, 86.0, 86.0, 123.0, 85.0, 87.0, 129.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 86.0, 134.0, 85.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 133.0, 143.0, 130.0, 131.0, 131.0, 140.0, 136.0, 143.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 169.0, 166.0, 171.0, 167.0, 166.0, 171.0, 168.0, 170.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1551.6, "alertThreshold": 2.0}]} 05:31:01 INFO - Return code: 0 05:31:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:01 ERROR - # TBPL SUCCESS # 05:31:01 INFO - Running post-action listener: _resource_record_post_action 05:31:01 INFO - ##### 05:31:01 INFO - ##### Finished run-tests step (success) 05:31:01 INFO - ##### 05:31:01 INFO - Running post-run listener: _resource_record_post_run 05:31:01 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525373440; Read time: 12; Write time: 446148 05:31:01 INFO - TinderboxPrint: CPU usage
13.2% 05:31:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:31:01 INFO - TinderboxPrint: I/O write bytes / time
525,373,440 / 446,148 05:31:01 INFO - TinderboxPrint: CPU idle
8,305.9 (86.8%) 05:31:01 INFO - TinderboxPrint: CPU user
1,218.2 (12.7%) 05:31:01 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237973504; Read time: 0; Write time: 275704 05:31:01 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287399936; Read time: 12; Write time: 170444 05:31:01 INFO - Running post-run listener: _upload_blobber_files 05:31:01 INFO - Blob upload gear active. 05:31:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:01 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 05:31:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:03 INFO - (blobuploader) - INFO - Done attempting. 05:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:06 INFO - (blobuploader) - INFO - Done attempting. 05:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:07 INFO - (blobuploader) - INFO - Done attempting. 05:31:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:07 INFO - Return code: 0 05:31:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cc1c42d18f73c49f3255517894793b0c83f94a1f7cc8361a1f153718fe212a33d36e6a8c19483c7531894b3a7503b856dfb6813a0067b59a4df345934a489c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1634376310eeaa68e6968d407903e7d48f74253444082ced3e72c9794b1c1a6968e75ec107a31c073b384f8e76da828bc295d3bcccac64c0bea92c2171c852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e3e12ef06e7d67adee6385089d970b2103c7903c538cff0fd1a8e959aebe68c9abbf82973c9c8b26193cb1272223d17ff5308f38739ab5035cc6ab2d0217647"} 05:31:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:07 INFO - Contents: 05:31:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cc1c42d18f73c49f3255517894793b0c83f94a1f7cc8361a1f153718fe212a33d36e6a8c19483c7531894b3a7503b856dfb6813a0067b59a4df345934a489c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1634376310eeaa68e6968d407903e7d48f74253444082ced3e72c9794b1c1a6968e75ec107a31c073b384f8e76da828bc295d3bcccac64c0bea92c2171c852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e3e12ef06e7d67adee6385089d970b2103c7903c538cff0fd1a8e959aebe68c9abbf82973c9c8b26193cb1272223d17ff5308f38739ab5035cc6ab2d0217647"} 05:31:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:07 INFO - Copying logs to upload dir... 05:31:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.159715 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-09 05:31:07.265558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:07.268984) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cc1c42d18f73c49f3255517894793b0c83f94a1f7cc8361a1f153718fe212a33d36e6a8c19483c7531894b3a7503b856dfb6813a0067b59a4df345934a489c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1634376310eeaa68e6968d407903e7d48f74253444082ced3e72c9794b1c1a6968e75ec107a31c073b384f8e76da828bc295d3bcccac64c0bea92c2171c852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e3e12ef06e7d67adee6385089d970b2103c7903c538cff0fd1a8e959aebe68c9abbf82973c9c8b26193cb1272223d17ff5308f38739ab5035cc6ab2d0217647"} build_url:https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011505 build_url: 'https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96cc1c42d18f73c49f3255517894793b0c83f94a1f7cc8361a1f153718fe212a33d36e6a8c19483c7531894b3a7503b856dfb6813a0067b59a4df345934a489c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1634376310eeaa68e6968d407903e7d48f74253444082ced3e72c9794b1c1a6968e75ec107a31c073b384f8e76da828bc295d3bcccac64c0bea92c2171c852", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e3e12ef06e7d67adee6385089d970b2103c7903c538cff0fd1a8e959aebe68c9abbf82973c9c8b26193cb1272223d17ff5308f38739ab5035cc6ab2d0217647"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:07.294371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:07.294711) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465473873.628375-1794709401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004740 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:07.376358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 05:31:07.376732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 05:31:07.377036) ========= ========= Total master_lag: 0.48 =========