builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1465171385.41 results: success (0) buildid: 20160605143012 builduid: 2e2378f7909542089380c6200e867538 revision: 87207eee5e4785e29d405e7f3586d7bde08b91ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.409104) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.409561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.409845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.447256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.447570) ========= 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=62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 17:03:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-06-05 17:03:05 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137050 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.818252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.818606) ========= 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=62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016480 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:05.881774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 17:03:05.882139) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87207eee5e4785e29d405e7f3586d7bde08b91ce --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 87207eee5e4785e29d405e7f3586d7bde08b91ce --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=62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 17:03:05,948 truncating revision to first 12 chars 2016-06-05 17:03:05,948 Setting DEBUG logging. 2016-06-05 17:03:05,948 attempt 1/10 2016-06-05 17:03:05,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/87207eee5e47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 17:03:07,245 unpacking tar archive at: fx-team-87207eee5e47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 17:03:07.528393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:07.528788) ========= script_repo_revision: 87207eee5e4785e29d405e7f3586d7bde08b91ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:07.529208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:07.529518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 17:03:07.537982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-05 17:03:07.538284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:07 INFO - MultiFileLogger online at 20160605 17:03:07 in /builds/slave/test 17:03:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:03:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:03:07 INFO - {'append_to_log': False, 17:03:07 INFO - 'base_work_dir': '/builds/slave/test', 17:03:07 INFO - 'blob_upload_branch': 'Fx-Team', 17:03:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:03:07 INFO - 'branch': 'Fx-Team', 17:03:07 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:07 INFO - 'config_files': ('talos/linux_config.py',), 17:03:07 INFO - 'default_actions': ('clobber', 17:03:07 INFO - 'read-buildbot-config', 17:03:07 INFO - 'download-and-extract', 17:03:07 INFO - 'populate-webroot', 17:03:07 INFO - 'create-virtualenv', 17:03:07 INFO - 'install', 17:03:07 INFO - 'run-tests'), 17:03:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:07 INFO - 'download_minidump_stackwalk': True, 17:03:07 INFO - 'download_symbols': 'ondemand', 17:03:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:07 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:07 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:07 INFO - 'installer_path': 'installer.exe', 17:03:07 INFO - 'log_level': 'info', 17:03:07 INFO - 'log_name': 'talos', 17:03:07 INFO - 'log_to_console': True, 17:03:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:07 INFO - 'opt_config_files': (), 17:03:07 INFO - 'pip_index': False, 17:03:07 INFO - 'sps_profile': False, 17:03:07 INFO - 'sps_profile_interval': 0, 17:03:07 INFO - 'suite': 'dromaeojs', 17:03:07 INFO - 'system_bits': '32', 17:03:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:07 INFO - 'title': 'talos-linux64-ix-018', 17:03:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:07 INFO - 'use_talos_json': True, 17:03:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:03:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:07 INFO - 'work_dir': 'build'} 17:03:07 INFO - ##### 17:03:07 INFO - ##### Running clobber step. 17:03:07 INFO - ##### 17:03:07 INFO - Running pre-action listener: _resource_record_pre_action 17:03:07 INFO - Running main action method: clobber 17:03:07 INFO - rmtree: /builds/slave/test/build 17:03:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:03:08 INFO - Running post-action listener: _resource_record_post_action 17:03:08 INFO - ##### 17:03:08 INFO - ##### Finished clobber step (success) 17:03:08 INFO - ##### 17:03:08 INFO - ##### 17:03:08 INFO - ##### Running read-buildbot-config step. 17:03:08 INFO - ##### 17:03:08 INFO - Running pre-action listener: _resource_record_pre_action 17:03:08 INFO - Running main action method: read_buildbot_config 17:03:08 INFO - Using buildbot properties: 17:03:08 INFO - { 17:03:08 INFO - "project": "", 17:03:08 INFO - "product": "firefox", 17:03:08 INFO - "script_repo_revision": "production", 17:03:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:03:08 INFO - "repository": "", 17:03:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:03:08 INFO - "buildid": "20160605143012", 17:03:08 INFO - "pgo_build": "True", 17:03:08 INFO - "basedir": "/builds/slave/test", 17:03:08 INFO - "buildnumber": 769, 17:03:08 INFO - "slavename": "talos-linux64-ix-018", 17:03:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:03:08 INFO - "platform": "ubuntu64_hw", 17:03:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:03:08 INFO - "branch": "fx-team", 17:03:08 INFO - "repo_path": "integration/fx-team", 17:03:08 INFO - "revision": "87207eee5e4785e29d405e7f3586d7bde08b91ce", 17:03:08 INFO - "stage_platform": "linux64-pgo", 17:03:08 INFO - "builduid": "2e2378f7909542089380c6200e867538", 17:03:08 INFO - "slavebuilddir": "test" 17:03:08 INFO - } 17:03:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:03:08 INFO - Running post-action listener: _resource_record_post_action 17:03:08 INFO - ##### 17:03:08 INFO - ##### Finished read-buildbot-config step (success) 17:03:08 INFO - ##### 17:03:08 INFO - ##### 17:03:08 INFO - ##### Running download-and-extract step. 17:03:08 INFO - ##### 17:03:08 INFO - Running pre-action listener: _resource_record_pre_action 17:03:08 INFO - Running main action method: download_and_extract 17:03:08 INFO - mkdir: /builds/slave/test/build/tests 17:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:08 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:03:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:03:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:03:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:03:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:03:11 INFO - Downloaded 1361 bytes. 17:03:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:03:11 INFO - Using the following test package requirements: 17:03:11 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:03:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'jsshell-linux-x86_64.zip'], 17:03:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:11 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:11 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:03:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:03:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:03:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:32 INFO - Downloaded 24440968 bytes. 17:03:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:03:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:03:33 INFO - Return code: 0 17:03:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:03:33 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')]} 17:03:33 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:03:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:03:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:36 INFO - Downloaded 24440968 bytes. 17:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:03:37 INFO - Return code: 0 17:03:37 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')]} 17:03:37 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:03:38 INFO - Downloaded 10833369 bytes. 17:03:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:03:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:03:39 INFO - Return code: 0 17:03: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')]} 17:03:39 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:03:42 INFO - Downloaded 59154984 bytes. 17:03:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:03:42 INFO - mkdir: /builds/slave/test/properties 17:03:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:03:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:03:42 INFO - Contents: 17:03:42 INFO - build_url:https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:03:43 INFO - Running post-action listener: _resource_record_post_action 17:03:43 INFO - Running post-action listener: set_extra_try_arguments 17:03:43 INFO - ##### 17:03:43 INFO - ##### Finished download-and-extract step (success) 17:03:43 INFO - ##### 17:03:43 INFO - ##### 17:03:43 INFO - ##### Running populate-webroot step. 17:03:43 INFO - ##### 17:03:43 INFO - Running pre-action listener: _resource_record_pre_action 17:03:43 INFO - Running main action method: populate_webroot 17:03:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:03:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:03:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:03:43 INFO - '--tppagecycles', 17:03:43 INFO - '7'], 17:03:43 INFO - 'tests': ['tsvgm']}}, 17:03:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:03:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:03:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:03:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:03:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['damp', 'tps']}, 17:03:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'tests': ['damp', 'tps']}, 17:03:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['dromaeo_dom']}, 17:03:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:03:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['a11yr', 17:03:43 INFO - 'ts_paint', 17:03:43 INFO - 'tpaint', 17:03:43 INFO - 'sessionrestore', 17:03:43 INFO - 'sessionrestore_no_auto_restore', 17:03:43 INFO - 'tabpaint']}, 17:03:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:03:43 INFO - 'ts_paint', 17:03:43 INFO - 'tpaint', 17:03:43 INFO - 'sessionrestore', 17:03:43 INFO - 'sessionrestore_no_auto_restore', 17:03:43 INFO - 'tabpaint']}, 17:03:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:03:43 INFO - 'ts_paint', 17:03:43 INFO - 'tpaint', 17:03:43 INFO - 'sessionrestore', 17:03:43 INFO - 'sessionrestore_no_auto_restore', 17:03:43 INFO - 'tabpaint']}, 17:03:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:03:43 INFO - 'ts_paint', 17:03:43 INFO - 'tpaint', 17:03:43 INFO - 'sessionrestore', 17:03:43 INFO - 'sessionrestore_no_auto_restore', 17:03:43 INFO - 'tabpaint']}, 17:03:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['a11yr', 17:03:43 INFO - 'ts_paint', 17:03:43 INFO - 'tpaint', 17:03:43 INFO - 'sessionrestore', 17:03:43 INFO - 'sessionrestore_no_auto_restore', 17:03:43 INFO - 'tabpaint']}, 17:03:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['a11yr', 17:03:43 INFO - 'ts_paint', 17:03:43 INFO - 'tpaint', 17:03:43 INFO - 'sessionrestore', 17:03:43 INFO - 'sessionrestore_no_auto_restore', 17:03:43 INFO - 'tabpaint']}, 17:03:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['tsvgx', 17:03:43 INFO - 'tsvgr_opacity', 17:03:43 INFO - 'tart', 17:03:43 INFO - 'tscrollx', 17:03:43 INFO - 'cart']}, 17:03:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:03:43 INFO - 'tsvgr_opacity', 17:03:43 INFO - 'tart', 17:03:43 INFO - 'tscrollx', 17:03:43 INFO - 'cart']}, 17:03:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'talos_options': ['--disable-e10s'], 17:03:43 INFO - 'tests': ['tp5o']}, 17:03:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'tests': ['tp5o']}, 17:03:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'talos_options': ['--disable-e10s', 17:03:43 INFO - '--xperf_path', 17:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:43 INFO - 'tests': ['tp5n']}, 17:03:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:03:43 INFO - 'talos_options': ['--xperf_path', 17:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:43 INFO - 'tests': ['tp5n']}}, 17:03:43 INFO - 'talos.zip': {'path': '', 17:03:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:03:43 INFO - Running post-action listener: _resource_record_post_action 17:03:43 INFO - ##### 17:03:43 INFO - ##### Finished populate-webroot step (success) 17:03:43 INFO - ##### 17:03:43 INFO - ##### 17:03:43 INFO - ##### Running create-virtualenv step. 17:03:43 INFO - ##### 17:03:43 INFO - Running pre-action listener: _resource_record_pre_action 17:03:43 INFO - Running main action method: create_virtualenv 17:03:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:03:43 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 17:03:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:03:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:03:43 INFO - Using real prefix '/usr' 17:03:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:03:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:46 INFO - Installing pip.................done. 17:03:46 INFO - Return code: 0 17:03:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03:46 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')]} 17:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:46 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')]} 17:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:46 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:03:46 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 17:03:46 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 17:03:46 INFO - Using env: {'DISPLAY': ':0', 17:03:46 INFO - 'HOME': '/home/cltbld', 17:03:46 INFO - 'LANG': 'en_US.UTF-8', 17:03:46 INFO - 'LANGUAGE': 'en_US:en', 17:03:46 INFO - 'LOGNAME': 'cltbld', 17:03:46 INFO - 'MAIL': '/var/mail/cltbld', 17:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:46 INFO - 'MOZ_NO_REMOTE': '1', 17:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:46 INFO - 'NO_EM_RESTART': '1', 17:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:46 INFO - 'PWD': '/builds/slave/test', 17:03:46 INFO - 'SHELL': '/bin/bash', 17:03:46 INFO - 'SHLVL': '1', 17:03:46 INFO - 'TERM': 'linux', 17:03:46 INFO - 'TMOUT': '86400', 17:03:46 INFO - 'USER': 'cltbld', 17:03:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:46 INFO - '_': '/tools/buildbot/bin/python'} 17:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:46 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 17:03:46 INFO - Cleaning up... 17:03:46 INFO - Return code: 0 17:03:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:03:46 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')]} 17:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:46 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')]} 17:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:46 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:03:46 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 17:03:46 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 17:03:46 INFO - Using env: {'DISPLAY': ':0', 17:03:46 INFO - 'HOME': '/home/cltbld', 17:03:46 INFO - 'LANG': 'en_US.UTF-8', 17:03:46 INFO - 'LANGUAGE': 'en_US:en', 17:03:46 INFO - 'LOGNAME': 'cltbld', 17:03:46 INFO - 'MAIL': '/var/mail/cltbld', 17:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:46 INFO - 'MOZ_NO_REMOTE': '1', 17:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:46 INFO - 'NO_EM_RESTART': '1', 17:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:46 INFO - 'PWD': '/builds/slave/test', 17:03:46 INFO - 'SHELL': '/bin/bash', 17:03:46 INFO - 'SHLVL': '1', 17:03:46 INFO - 'TERM': 'linux', 17:03:46 INFO - 'TMOUT': '86400', 17:03:46 INFO - 'USER': 'cltbld', 17:03:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:46 INFO - '_': '/tools/buildbot/bin/python'} 17:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:46 INFO - Downloading/unpacking psutil>=3.1.1 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:48 INFO - Installing collected packages: psutil 17:03:48 INFO - Running setup.py install for psutil 17:03:48 INFO - building 'psutil._psutil_linux' extension 17:03:48 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 17:03:49 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 17:03:49 INFO - building 'psutil._psutil_posix' extension 17:03:49 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 17:03:49 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 17:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:49 INFO - Successfully installed psutil 17:03:49 INFO - Cleaning up... 17:03:49 INFO - Return code: 0 17:03:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:03:49 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')]} 17:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:49 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')]} 17:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:49 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:03:49 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 17:03:49 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 17:03:49 INFO - Using env: {'DISPLAY': ':0', 17:03:49 INFO - 'HOME': '/home/cltbld', 17:03:49 INFO - 'LANG': 'en_US.UTF-8', 17:03:49 INFO - 'LANGUAGE': 'en_US:en', 17:03:49 INFO - 'LOGNAME': 'cltbld', 17:03:49 INFO - 'MAIL': '/var/mail/cltbld', 17:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:49 INFO - 'MOZ_NO_REMOTE': '1', 17:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:49 INFO - 'NO_EM_RESTART': '1', 17:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:49 INFO - 'PWD': '/builds/slave/test', 17:03:49 INFO - 'SHELL': '/bin/bash', 17:03:49 INFO - 'SHLVL': '1', 17:03:49 INFO - 'TERM': 'linux', 17:03:49 INFO - 'TMOUT': '86400', 17:03:49 INFO - 'USER': 'cltbld', 17:03:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:49 INFO - '_': '/tools/buildbot/bin/python'} 17:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:51 INFO - Installing collected packages: mozsystemmonitor 17:03:51 INFO - Running setup.py install for mozsystemmonitor 17:03:51 INFO - Successfully installed mozsystemmonitor 17:03:52 INFO - Cleaning up... 17:03:52 INFO - Return code: 0 17:03:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:52 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')]} 17:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:52 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')]} 17:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:52 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:03:52 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 17:03:52 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 17:03:52 INFO - Using env: {'DISPLAY': ':0', 17:03:52 INFO - 'HOME': '/home/cltbld', 17:03:52 INFO - 'LANG': 'en_US.UTF-8', 17:03:52 INFO - 'LANGUAGE': 'en_US:en', 17:03:52 INFO - 'LOGNAME': 'cltbld', 17:03:52 INFO - 'MAIL': '/var/mail/cltbld', 17:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:52 INFO - 'MOZ_NO_REMOTE': '1', 17:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:52 INFO - 'NO_EM_RESTART': '1', 17:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:52 INFO - 'PWD': '/builds/slave/test', 17:03:52 INFO - 'SHELL': '/bin/bash', 17:03:52 INFO - 'SHLVL': '1', 17:03:52 INFO - 'TERM': 'linux', 17:03:52 INFO - 'TMOUT': '86400', 17:03:52 INFO - 'USER': 'cltbld', 17:03:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:52 INFO - '_': '/tools/buildbot/bin/python'} 17:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:53 INFO - Downloading/unpacking jsonschema==2.5.1 17:03:53 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 17:03:53 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 17:03:53 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 17:03:53 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 17:03:53 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 17:03:53 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 17:03:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:03:54 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 17:03:54 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 17:03:54 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 17:03:54 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 17:03:54 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 17:03:54 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 17:03:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:55 INFO - warning: no files found matching '*.txt' 17:03:55 INFO - no previously-included directories found matching 'build' 17:03:55 INFO - no previously-included directories found matching 'dist' 17:03:55 INFO - no previously-included directories found matching '.git*' 17:03:55 INFO - Installing collected packages: jsonschema, functools32 17:03:55 INFO - Running setup.py install for functools32 17:03:55 INFO - warning: no files found matching '*.txt' 17:03:55 INFO - no previously-included directories found matching 'build' 17:03:55 INFO - no previously-included directories found matching 'dist' 17:03:55 INFO - no previously-included directories found matching '.git*' 17:03:55 INFO - Successfully installed jsonschema functools32 17:03:55 INFO - Cleaning up... 17:03:55 INFO - Return code: 0 17:03:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:55 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')]} 17:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 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')]} 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:03:55 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 17:03:55 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 17:03:55 INFO - Using env: {'DISPLAY': ':0', 17:03:55 INFO - 'HOME': '/home/cltbld', 17:03:55 INFO - 'LANG': 'en_US.UTF-8', 17:03:55 INFO - 'LANGUAGE': 'en_US:en', 17:03:55 INFO - 'LOGNAME': 'cltbld', 17:03:55 INFO - 'MAIL': '/var/mail/cltbld', 17:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:55 INFO - 'MOZ_NO_REMOTE': '1', 17:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:55 INFO - 'NO_EM_RESTART': '1', 17:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:55 INFO - 'PWD': '/builds/slave/test', 17:03:55 INFO - 'SHELL': '/bin/bash', 17:03:55 INFO - 'SHLVL': '1', 17:03:55 INFO - 'TERM': 'linux', 17:03:55 INFO - 'TMOUT': '86400', 17:03:55 INFO - 'USER': 'cltbld', 17:03:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:55 INFO - '_': '/tools/buildbot/bin/python'} 17:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 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 17:03:57 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 17:03:58 INFO - Downloading docopt-0.6.1.tar.gz 17:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:58 INFO - Running setup.py install for blobuploader 17:03:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:58 INFO - Running setup.py install for requests 17:03:58 INFO - Running setup.py install for docopt 17:03:58 INFO - Successfully installed blobuploader requests docopt 17:03:58 INFO - Cleaning up... 17:03:58 INFO - Return code: 0 17:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:03:58 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 17:03:58 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 17:03:58 INFO - Using env: {'DISPLAY': ':0', 17:03:58 INFO - 'HOME': '/home/cltbld', 17:03:58 INFO - 'LANG': 'en_US.UTF-8', 17:03:58 INFO - 'LANGUAGE': 'en_US:en', 17:03:58 INFO - 'LOGNAME': 'cltbld', 17:03:58 INFO - 'MAIL': '/var/mail/cltbld', 17:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:58 INFO - 'MOZ_NO_REMOTE': '1', 17:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:58 INFO - 'NO_EM_RESTART': '1', 17:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:58 INFO - 'PWD': '/builds/slave/test', 17:03:58 INFO - 'SHELL': '/bin/bash', 17:03:58 INFO - 'SHLVL': '1', 17:03:58 INFO - 'TERM': 'linux', 17:03:58 INFO - 'TMOUT': '86400', 17:03:58 INFO - 'USER': 'cltbld', 17:03:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:58 INFO - '_': '/tools/buildbot/bin/python'} 17:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:59 INFO - Running setup.py (path:/tmp/pip-wEl9YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:59 INFO - Running setup.py (path:/tmp/pip-MHmIab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:59 INFO - Running setup.py (path:/tmp/pip-Z1kyzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:59 INFO - Running setup.py (path:/tmp/pip-W5i9CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:59 INFO - Running setup.py (path:/tmp/pip-vDi8hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:59 INFO - Running setup.py (path:/tmp/pip-xqMjz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:59 INFO - Running setup.py (path:/tmp/pip-o0k_xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:59 INFO - Running setup.py (path:/tmp/pip-9fSx46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:59 INFO - Running setup.py (path:/tmp/pip-wOPZi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:59 INFO - Running setup.py (path:/tmp/pip-ILNcyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:59 INFO - Running setup.py (path:/tmp/pip-8pFYPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:59 INFO - Running setup.py (path:/tmp/pip-pWtjwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:59 INFO - Running setup.py (path:/tmp/pip-0uLcPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:00 INFO - Running setup.py (path:/tmp/pip-y6RG9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:00 INFO - Running setup.py (path:/tmp/pip-8MKuqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:00 INFO - Running setup.py (path:/tmp/pip-EgQJKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:00 INFO - Running setup.py (path:/tmp/pip-w92i7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:00 INFO - Running setup.py install for manifestparser 17:04:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:00 INFO - Running setup.py install for mozcrash 17:04:00 INFO - Running setup.py install for mozdebug 17:04:00 INFO - Running setup.py install for mozdevice 17:04:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:04:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:00 INFO - Running setup.py install for mozfile 17:04:00 INFO - Running setup.py install for mozhttpd 17:04:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:00 INFO - Running setup.py install for mozinfo 17:04:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:00 INFO - Running setup.py install for mozInstall 17:04:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Running setup.py install for mozleak 17:04:01 INFO - Running setup.py install for mozlog 17:04:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Running setup.py install for moznetwork 17:04:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Running setup.py install for mozprocess 17:04:01 INFO - Running setup.py install for mozprofile 17:04:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Running setup.py install for mozrunner 17:04:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:01 INFO - Running setup.py install for mozscreenshot 17:04:01 INFO - Running setup.py install for moztest 17:04:01 INFO - Running setup.py install for mozversion 17:04:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:02 INFO - Cleaning up... 17:04:02 INFO - Return code: 0 17:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:02 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:04:02 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 17:04:02 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 17:04:02 INFO - Using env: {'DISPLAY': ':0', 17:04:02 INFO - 'HOME': '/home/cltbld', 17:04:02 INFO - 'LANG': 'en_US.UTF-8', 17:04:02 INFO - 'LANGUAGE': 'en_US:en', 17:04:02 INFO - 'LOGNAME': 'cltbld', 17:04:02 INFO - 'MAIL': '/var/mail/cltbld', 17:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:02 INFO - 'MOZ_NO_REMOTE': '1', 17:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:02 INFO - 'NO_EM_RESTART': '1', 17:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:02 INFO - 'PWD': '/builds/slave/test', 17:04:02 INFO - 'SHELL': '/bin/bash', 17:04:02 INFO - 'SHLVL': '1', 17:04:02 INFO - 'TERM': 'linux', 17:04:02 INFO - 'TMOUT': '86400', 17:04:02 INFO - 'USER': 'cltbld', 17:04:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:02 INFO - '_': '/tools/buildbot/bin/python'} 17:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:02 INFO - Running setup.py (path:/tmp/pip-pbOi3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:02 INFO - Running setup.py (path:/tmp/pip-luFJnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:02 INFO - Running setup.py (path:/tmp/pip-NN5lmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:02 INFO - Running setup.py (path:/tmp/pip-GXoWaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:02 INFO - Running setup.py (path:/tmp/pip-YMPwCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:02 INFO - Running setup.py (path:/tmp/pip-4WLt8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:02 INFO - Running setup.py (path:/tmp/pip-ZTY8aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:02 INFO - Running setup.py (path:/tmp/pip-4wcd6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:02 INFO - Running setup.py (path:/tmp/pip-D8qV6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:02 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)) 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:02 INFO - Running setup.py (path:/tmp/pip-NWU26J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:03 INFO - Running setup.py (path:/tmp/pip-ozxcrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:03 INFO - Running setup.py (path:/tmp/pip-OA5eFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:03 INFO - Running setup.py (path:/tmp/pip-TEpoDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:03 INFO - Running setup.py (path:/tmp/pip-jRo7me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:03 INFO - Running setup.py (path:/tmp/pip-G22ffu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:03 INFO - Running setup.py (path:/tmp/pip-ZythDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:03 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)) 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:03 INFO - Running setup.py (path:/tmp/pip-xwuBrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:03 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)) 17:04:03 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)) 17:04:03 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)) 17:04:03 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)) 17:04:03 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)) 17:04:03 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)) 17:04:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:05 INFO - Downloading blessings-1.6.tar.gz 17:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:05 INFO - Installing collected packages: blessings 17:04:05 INFO - Running setup.py install for blessings 17:04:05 INFO - Successfully installed blessings 17:04:05 INFO - Cleaning up... 17:04:05 INFO - Return code: 0 17:04:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:05 INFO - Reading from file tmpfile_stdout 17:04:05 INFO - Current package versions: 17:04:05 INFO - argparse == 1.2.1 17:04:05 INFO - blessings == 1.6 17:04:05 INFO - blobuploader == 1.2.4 17:04:05 INFO - docopt == 0.6.1 17:04:05 INFO - functools32 == 3.2.3-2 17:04:05 INFO - jsonschema == 2.5.1 17:04:05 INFO - manifestparser == 1.1 17:04:05 INFO - mozInstall == 1.12 17:04:05 INFO - mozcrash == 0.17 17:04:05 INFO - mozdebug == 0.1 17:04:05 INFO - mozdevice == 0.48 17:04:05 INFO - mozfile == 1.2 17:04:05 INFO - mozhttpd == 0.7 17:04:05 INFO - mozinfo == 0.9 17:04:05 INFO - mozleak == 0.1 17:04:05 INFO - mozlog == 3.2 17:04:05 INFO - moznetwork == 0.27 17:04:05 INFO - mozprocess == 0.22 17:04:05 INFO - mozprofile == 0.28 17:04:05 INFO - mozrunner == 6.11 17:04:05 INFO - mozscreenshot == 0.1 17:04:05 INFO - mozsystemmonitor == 0.3 17:04:05 INFO - moztest == 0.7 17:04:05 INFO - mozversion == 1.4 17:04:05 INFO - psutil == 3.1.1 17:04:05 INFO - requests == 1.2.3 17:04:05 INFO - wsgiref == 0.1.2 17:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:05 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:04:05 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 17:04:05 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 17:04:05 INFO - Using env: {'DISPLAY': ':0', 17:04:05 INFO - 'HOME': '/home/cltbld', 17:04:05 INFO - 'LANG': 'en_US.UTF-8', 17:04:05 INFO - 'LANGUAGE': 'en_US:en', 17:04:05 INFO - 'LOGNAME': 'cltbld', 17:04:05 INFO - 'MAIL': '/var/mail/cltbld', 17:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:05 INFO - 'MOZ_NO_REMOTE': '1', 17:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:05 INFO - 'NO_EM_RESTART': '1', 17:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:05 INFO - 'PWD': '/builds/slave/test', 17:04:05 INFO - 'SHELL': '/bin/bash', 17:04:05 INFO - 'SHLVL': '1', 17:04:05 INFO - 'TERM': 'linux', 17:04:05 INFO - 'TMOUT': '86400', 17:04:05 INFO - 'USER': 'cltbld', 17:04:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:05 INFO - '_': '/tools/buildbot/bin/python'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 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)) 17:04:06 INFO - Cleaning up... 17:04:06 INFO - Return code: 0 17:04:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:06 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')]} 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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')]} 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:04:06 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 17:04:06 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 17:04:06 INFO - Using env: {'DISPLAY': ':0', 17:04:06 INFO - 'HOME': '/home/cltbld', 17:04:06 INFO - 'LANG': 'en_US.UTF-8', 17:04:06 INFO - 'LANGUAGE': 'en_US:en', 17:04:06 INFO - 'LOGNAME': 'cltbld', 17:04:06 INFO - 'MAIL': '/var/mail/cltbld', 17:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:06 INFO - 'MOZ_NO_REMOTE': '1', 17:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:06 INFO - 'NO_EM_RESTART': '1', 17:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:06 INFO - 'PWD': '/builds/slave/test', 17:04:06 INFO - 'SHELL': '/bin/bash', 17:04:06 INFO - 'SHLVL': '1', 17:04:06 INFO - 'TERM': 'linux', 17:04:06 INFO - 'TMOUT': '86400', 17:04:06 INFO - 'USER': 'cltbld', 17:04:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:06 INFO - '_': '/tools/buildbot/bin/python'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:04:06 INFO - Cleaning up... 17:04:06 INFO - Return code: 0 17:04:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:04:06 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')]} 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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')]} 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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 0x7f5eaa7a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', '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 17:04:06 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 17:04:06 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 17:04:06 INFO - Using env: {'DISPLAY': ':0', 17:04:06 INFO - 'HOME': '/home/cltbld', 17:04:06 INFO - 'LANG': 'en_US.UTF-8', 17:04:06 INFO - 'LANGUAGE': 'en_US:en', 17:04:06 INFO - 'LOGNAME': 'cltbld', 17:04:06 INFO - 'MAIL': '/var/mail/cltbld', 17:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:06 INFO - 'MOZ_NO_REMOTE': '1', 17:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:06 INFO - 'NO_EM_RESTART': '1', 17:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:06 INFO - 'PWD': '/builds/slave/test', 17:04:06 INFO - 'SHELL': '/bin/bash', 17:04:06 INFO - 'SHLVL': '1', 17:04:06 INFO - 'TERM': 'linux', 17:04:06 INFO - 'TMOUT': '86400', 17:04:06 INFO - 'USER': 'cltbld', 17:04:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:06 INFO - '_': '/tools/buildbot/bin/python'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 INFO - Downloading/unpacking flake8 17:04:06 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 17:04:06 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 17:04:06 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 17:04:06 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 17:04:06 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 17:04:06 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 17:04:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:09 INFO - no previously-included directories found matching 'docs/_build' 17:04:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:09 INFO - Running setup.py install for pep8 17:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:09 INFO - no previously-included directories found matching 'docs/_build' 17:04:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:04:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:09 INFO - Cleaning up... 17:04:09 INFO - Return code: 0 17:04:09 INFO - Running post-action listener: _resource_record_post_action 17:04:09 INFO - Running post-action listener: _start_resource_monitoring 17:04:09 INFO - Starting resource monitoring. 17:04:09 INFO - ##### 17:04:09 INFO - ##### Finished create-virtualenv step (success) 17:04:09 INFO - ##### 17:04:09 INFO - ##### 17:04:09 INFO - ##### Running install step. 17:04:09 INFO - ##### 17:04:09 INFO - Running pre-action listener: _resource_record_pre_action 17:04:09 INFO - Running main action method: install 17:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:09 INFO - Reading from file tmpfile_stdout 17:04:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:09 INFO - Reading from file tmpfile_stdout 17:04:09 INFO - Output received: 17:04:09 INFO - Usage: mozinstall [options] installer 17:04:09 INFO - Options: 17:04:09 INFO - -h, --help show this help message and exit 17:04:09 INFO - -d DEST, --destination=DEST 17:04:09 INFO - Directory to install application into. [default: 17:04:09 INFO - "/builds/slave/test"] 17:04:09 INFO - --app=APP Application being installed. [default: firefox] 17:04:09 INFO - mkdir: /builds/slave/test/build/application 17:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:04:26 INFO - Reading from file tmpfile_stdout 17:04:26 INFO - Output received: 17:04:26 INFO - /builds/slave/test/build/application/firefox/firefox 17:04:26 INFO - Running post-action listener: _resource_record_post_action 17:04:26 INFO - ##### 17:04:26 INFO - ##### Finished install step (success) 17:04:26 INFO - ##### 17:04:26 INFO - ##### 17:04:26 INFO - ##### Running run-tests step. 17:04:26 INFO - ##### 17:04:26 INFO - Running pre-action listener: _resource_record_pre_action 17:04:26 INFO - Running main action method: run_tests 17:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:26 INFO - Python 2.7.3 17:04:26 INFO - Return code: 0 17:04:26 INFO - grabbing minidump binary from tooltool 17:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:26 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 0x1e10110>, '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 0x1d7c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:26 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 17:04:26 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 17:04:26 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 17:04:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:26 INFO - Return code: 0 17:04:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:04:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:04:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:04:27 INFO - Return code: 0 17:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 17:04:27 INFO - Using env: {'DISPLAY': ':0', 17:04:27 INFO - 'HOME': '/home/cltbld', 17:04:27 INFO - 'LANG': 'en_US.UTF-8', 17:04:27 INFO - 'LANGUAGE': 'en_US:en', 17:04:27 INFO - 'LOGNAME': 'cltbld', 17:04:27 INFO - 'MAIL': '/var/mail/cltbld', 17:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:27 INFO - 'MOZ_NO_REMOTE': '1', 17:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:27 INFO - 'NO_EM_RESTART': '1', 17:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:27 INFO - 'PWD': '/builds/slave/test', 17:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:27 INFO - 'SHELL': '/bin/bash', 17:04:27 INFO - 'SHLVL': '1', 17:04:27 INFO - 'TERM': 'linux', 17:04:27 INFO - 'TMOUT': '86400', 17:04:27 INFO - 'USER': 'cltbld', 17:04:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309', 17:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:27 INFO - '_': '/tools/buildbot/bin/python'} 17:04:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:04:27 INFO - mozversion application_buildid: 20160605143012 17:04:27 INFO - mozversion application_changeset: 87207eee5e4785e29d405e7f3586d7bde08b91ce 17:04:27 INFO - mozversion application_display_name: Nightly 17:04:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:27 INFO - mozversion application_name: Firefox 17:04:27 INFO - mozversion application_remotingname: firefox 17:04:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:04:27 INFO - mozversion application_vendor: Mozilla 17:04:27 INFO - mozversion application_version: 49.0a1 17:04:27 INFO - mozversion platform_buildid: 20160605143012 17:04:27 INFO - mozversion platform_changeset: 87207eee5e4785e29d405e7f3586d7bde08b91ce 17:04:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:04:27 INFO - mozversion platform_version: 49.0a1 17:04:27 INFO - using testdate: 1465171467 17:04:27 INFO - actual date: 1465171467 17:04:27 INFO - starting webserver on 'localhost:33015' 17:04:27 INFO - SUITE-START | Running 2 tests 17:04:27 INFO - TEST-START | dromaeo_css 17:04:27 INFO - operating with platform_type : linux_ 17:04:27 INFO - Initialising browser for dromaeo_css test... 17:04:27 INFO - TEST-INFO | started process 4327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR2cC_S/profile http://localhost:33015/getInfo.html) 17:04:31 INFO - PROCESS | 4327 | __metrics Screen width/height:1600/1200 17:04:31 INFO - PROCESS | 4327 | colorDepth:24 17:04:31 INFO - PROCESS | 4327 | Browser inner width/height: 1024/697 17:04:31 INFO - PROCESS | 4327 | __metrics 17:04:32 ERROR - PROCESS | 4327 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:04:33 INFO - TEST-INFO | 4327: exit 0 17:04:33 INFO - Browser initialized. 17:04:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:33 INFO - TEST-INFO | started process 4411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR2cC_S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:45 INFO - PROCESS | 4411 | RSS: Main: 157020160 17:04:45 INFO - PROCESS | 4411 | 17:05:36 INFO - PROCESS | 4411 | 1465171536249 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] 17:07:44 INFO - PROCESS | 4411 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33015/tests/dromaeo/cssquery-ext.html) 17:07:45 INFO - PROCESS | 4411 | RSS: Main: 258236416 17:07:45 INFO - PROCESS | 4411 | 17:10:47 INFO - PROCESS | 4411 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-ext.html (next: http://localhost:33015/tests/dromaeo/cssquery-jquery.html) 17:10:48 INFO - PROCESS | 4411 | RSS: Main: 248942592 17:10:48 INFO - PROCESS | 4411 | 17:13:50 INFO - PROCESS | 4411 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33015/tests/dromaeo/cssquery-mootools.html) 17:13:51 INFO - PROCESS | 4411 | RSS: Main: 240504832 17:13:51 INFO - PROCESS | 4411 | 17:16:52 INFO - PROCESS | 4411 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33015/tests/dromaeo/cssquery-prototype.html) 17:16:53 INFO - PROCESS | 4411 | RSS: Main: 237555712 17:16:53 INFO - PROCESS | 4411 | 17:19:56 INFO - PROCESS | 4411 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33015/tests/dromaeo/cssquery-yui.html) 17:19:56 INFO - PROCESS | 4411 | RSS: Main: 213446656 17:19:56 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-yui.html (next: http://localhost:33015/tests/dromaeo/cssquery-dojo.html) 17:22:59 INFO - PROCESS | 4411 | RSS: Main: 284180480 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | __start_tp_report 17:22:59 INFO - PROCESS | 4411 | _x_x_mozilla_page_load 17:22:59 INFO - PROCESS | 4411 | _x_x_mozilla_page_load_details 17:22:59 INFO - PROCESS | 4411 | |i|pagename|runs| 17:22:59 INFO - PROCESS | 4411 | |0;dojo.html;3085.5834462347584;3092.6598074211834;3112.5642410062587;3125.0468607074863;3147.166001009733;5261.500157485042;5288.947110528903;5346.171343441768;5416.729163541822;5448.101063324557;5388.7305634718205;5403.405625381215;5414.810481633143;5423.83728488145;5470.070088085025;4824.565789078983;4893.437254715717;4905.803767849282;4921.8277360292395;5011.323471331379;4888.169011268093;4944.456109827916;4978.327925730016;4991.650584459089;5001;4759.547842954931;4817.22924332107;4849.684770489906;4854.344663470421;4914.385701787294;4843.58829499493;4848.345473361086;4910.361652985125;4934.136526107953;4963.40439147301;4734.810607575727;4849.175640141185;4860.05228980349;4880.926786098212;4905.2642103684375;5329.067413202674;5406.945930540684;5407.324084489439;5487.725613719338;5502.779888804443;5837.532997360201;5872.618279811799;5873.588848780587;5892.322382925976;5897.380775018647;5690.260266165372;5799.710014499258;5891.793787217427;5958.285005799332;5960.7019649017375;5491.862703432406;5571.359293681197;5572.024895643246;5578.3584887738425;5592.049351610236;6016.819495415145;6027.969860150672;6031.24609423822;6031.276246850318;6033.487153591994;5502.697351645698;5606;5659.971700141473;5819.82540523785;5833.270841144857;5764.596478246566;5813.244278243886;5826.184334193216;5829.387914268941;5830.300363956352;5710.428957104256;5742.655440673573;5754.539636829044;5757.165211044375;5761.53907687384;5592.468715472024;5707.6575405475805;5763.625364351304;5766.308043034779;5783.913241301299;4416.867493975186;4418.955810441855;4419.535948725402;4420.403245561873;4458.353538736865;3932.3708206686792;3940.192260586573;3949.7235193536753;3984.900377490586;4004.2992476316526;5280.313559237351;5376.274202982626;5436.184572314105;5467.425920278393;5477.315335583052;5813.273340832396;5816.127580862904;5827.708614569255;5863.2670916135485;5867.442592953663;5487.6981766002455;5499.477549632778;5500.42245564218;5512.145617429305;5516.586256030814;4895.412550493964;4922.237053256751;4950.430700469492;4953.23224900141;4959;5930.140129681172;5932.911006334908;5933.762649494059;5937;5942.1383899335215;5681.943180568307;5778.306603207642;5787.479126878601;5803.042497987784;5804.303483581997;5890.793822216202;5938.524918006463;5954.255718035246;5992.340842507234;6003.6998150093195;5639.238702775073;5669.31968163823;5671.943280567141;5674.687892165805;5681.119426488901;5649.887002259849;5727.942720572741;5775.855603609775;5777.277840269966;5788.334341550607;5719.914201286901;5752.395998420273;5757.568182386254;5760.481556659921;5798.884022319615;5626.184203290418;5657.801976930952;5675.517581005661;5682.715864206856;5682.77268909239;5394.217838413329;5520.447955204448;5580.218769372373;5584.050711379156;5585.245991791056;5737.254156959569;5737.713114344349;5764.855878603068;5772.509336706427;5780.075187969905;5569.749361278671;5609.859753506195;5612.494875461228;5615.831525054255;5674.148877668383 17:22:59 INFO - PROCESS | 4411 | |1;ext.html;585.3122580967362;611.4069352727853;617.8486270863639;625.334019269478;626.9686515674216;33466.33067338655;35977.46033809492;36077.63922360776;36106;44342.66971990837;41897.7905110474;46561.534384656145;46575.767121164434;46619.83450413741;46655.30017049747;8722.956385218082;8919.866202006975;8929.062448442917;8931.821363572724;8938.553072346356;8734.956325218365;8900.554972251393;8904.910950890506;8908.331875109392;8909.55452227386;8929.41958772681;9020.368574199809;9021.95489022554;9022.413543119676;9028.187463128317;8914;8971.641134354619;8975.237104846095;8980.506072165996;8982.461052336881;8705.521196334199;8777.824443511157;8790.692325768567;8795.032546419889;8805.559722013937;43879;44340.55659443429;44391;44429.77785111086;44450.33324500135;3428.8114153721535;3933.724639275252;4070.206309769596;4098.52866920305;4148.191102734938;32613.51079733806;32867.01398958035;33231.667683323096;33489.497657534914;33555.6644433555;4322.848700295506;4456.955430445686;4497.64018878489;4518.774061296955;4533.705309154894;348499;349856;350102;350966.2451687751;351102;58129.70935145297;58931;58974.10258974068;59016;59019.114713279334;36202;36831.263374732356;36874.8156259217;38662.22675546473;38687;16322.102284374236;16488.34046638121;16490.670186596442;16494.42269520561;16503.422380216634;11814.645560633195;11815.350155741517;11905.40472976365;11913.404329783649;11918.046556275478;19600.70598941017;19771.802281976998;19844.305449309206;20032;20103.597928041356;6960.686769095301;6962.443004559623;7036.472264580075;7083.858322833515;7161.89257161143;975.8487434447673;1012.2559918460073;1034.343192073039;1055.0082922053246;1085.5277954089995;32220.83889580537;32282.515762263585;32478.350432991207;32912.3417531648;32974;1062.574970011986;1132.2810015640127;1145.2949707695598;1149.545929357899;1185.9288442693467;16968.151592420578;17247.223874925658;17311.65376692459;17380;17590;533264;536224;536535;538971;539971;59326;59865.401345985985;59930;59964.40035599675;60117;1248.9875101249054;1324.543032653733;1332.3072002558615;1354.8983826212877;1358.103651589946;31059;34483.65516344804;34509.30981380409;34610.48084278788;35230;52834;53772.73113634407;53835.73082134564;53945.73027134996;53977;459928;466076;466506;467014;467239;34568;39606;39614.40578391269;45053.36832895888;45963;50192.498075020245;50205.497945020084;50315;51138.23292650688;51235.487645123074;42135.7893210532;42493.362599560416;42941.78529107334;43538.129237415706;43738.34392484179;41641;41873.37189942093;42250.577494224664;42585.36121958235;42718;41137;41544;42644.78677606592;42697;42782.57217427911;35513.82243088768;37656.24687506289;37662.246755064196;38548.6145138545;38549.80725096357;28184.577231341136;28737.42525149527;28755.5686664696;28990;29142.56286155752 17:22:59 INFO - PROCESS | 4411 | |2;jquery.html;390.9081365879016;394.6566487156174;396.5320921312853;401.2096170544028;420.3358693264642;13098.329880261075;18119.275228990842;19494.220231190735;19704;19842.107105180283;18851.15169817358;18987.33544325949;19747.70378444321;19969.900150499263;20001.299954501595;5517.69652669104;5657.9717101414435;5681.829545113653;5682.573806964494;5713.400092990218;5616.269884914956;5664.660120392769;5667.489925906668;5668.659880407189;5680.602357834953;4118.444010058649;5951.85120371992;6255.781047663333;6261.154744109533;6358.268799088095;6148.6618235997;6227.813165605039;6264.279607845087;6307.306196318425;6325.304216536178;5573.749181286811;5580.832575022756;5598.524125449342;5599.216109744639;5615.382307946123;22055.889720551455;22653.320400388016;23545.88227058871;23560.29319120429;23649.527009459885;2357.5284943011466;2370.099362242354;2463.8152138589676;2542.427953710419;2575.35616095976;14249.145051296955;14651.560453186421;14786.18675972821;15065;15066.171360575165;1829.6798060339388;1899.1074195128267;1903.5336342596152;1933.3136736458637;1980.633582787189;79529;79529.60235198787;80125.19874801235;80325.19674803235;81311;9833.360831545926;10032.448215348226;10890.440746424583;10939.23425360233;11145.554177832959;15260.160691162093;15385.153816540198;15406.845931540765;15410.460633877761;15435.922820385826;7572.432067594952;8416.452930559493;8416.957915210385;8527.445716028438;8531.573421328909;7995.120536740954;8073.152319006537;8103.513789172668;8269.255766981001;8297.087320394752;6739.393454589111;6785.93214067853;6860.211075726255;6863.897041544381;7007.964960175268;1884.2557189910183;1885.5568941298784;1933.4682962185511;1957.082059581618;1967.2917749610128;960.3325688646463;1049.4123290957089;1054.3884546962743;1065.8166695719272;1100.664297389304;18963.62072758537;19723.211071556976;19829.60340793205;19934.70097948532;20026.299079532146;982.1455333859445;998.1914649134225;1031.1338475680313;1060.81966065769;1067.7170549804307;10848.349099054081;11511.079113670887;11528.59649912249;11548.826767598493;11554.653360399201;406729;408462;413199;515071;518258;63341;101269.49365253127;106683.46658266659;107254.46372768086;107801.4609926961;997.4414327976211;1012.8176928152856;1035.7255327338262;1041.0214398465419;1042.7705904700954;17577.472675819747;17661.55846103806;17911.373101941368;18137.27450901949;18381.26474941041;42575.7871210642;43163.56836431721;43550.782246088565;44108.33837492504;44136.558634413246;61369.386306136366;61917;62025.37974620196;62053;63368;8686.261667758312;8733.650653974024;8749.47503149813;8778.780530486789;8893.28853691716;9871.062249086326;13355.465781369025;13543.796843047165;13601.387937542637;13783.173009619455;11574.6527604172;11737.647870563897;11875.52497900109;11903.285802851857;12062.396880156133;11519.952323011663;11636.36000020007;11744.177907546731;11909.285442873455;12006.339651318913;10674;11202.15983801202;11974.64076077719;12157;12188.634340969786;8535.189157030072;8635.913640863511;8802;8858.955705221433;9048.591342881553;8014.639341229776;11035.062019728413;11066;11361.261518001304;11975.64073077809 17:22:59 INFO - PROCESS | 4411 | |3;mootools.html;1318.5582829752032;1486.591187423458;1517.0215211188784;1636.6399392133726;1780.9910950445246;8421.452605580633;8769.824603507934;8782.033976262614;8997.685081022166;9006.32452566057;8633.87049194261;8817.426867253624;8830.735077947671;8834.381593288472;8835.293176545876;2376.9881150594224;2398.304491697406;2399.7120345558556;2409.2410890569413;2409.662647229389;2338.8128949683983;2362.728286247078;2373.2524254859663;2374.4182675244588;2394.5570069537193;2353.5881220786378;2360.173939121311;2368.834181607288;2382.737898831127;2386.081358676913;2334.556434277482;2350.27141586108;2363.5863723848256;2363.869987150706;2369.5497855407502;2222.288867562381;2286.622707253301;2288.931332060041;2290.4846409557717;2295.8737269450176;7663.961680191619;7914.643841027168;8822.86765698515;8860.822783544358;8891.06643802398;4519.457665080178;4622.838200662961;5093.668911520739;5300.602454815904;5309.601779866487;3397.0997685613333;3400.1669590950128;3460.584729832411;3478.5477887874413;3482.4776283557417;1163.110220681171;1173.847399838024;1191.773563023023;1243.0676992255808;1243.8507379114474;12538.185017973803;12716.554920577828;12775.29735864527;12836.294003829786;12856.999999999907;4534.070515544306;4680.3915490985955;4720.716756994591;4790.640701947368;4804.327394164819;10660.62687805923;10667.679969600924;10684.305520141166;10699.946500267604;10702.46487675613;5335.33308336458;5355.732213389315;5371.301730774974;5371.6508426952905;5382.138857782736;4791.520847915181;4843.104025755247;4843.15244832153;4917.704937703749;5032.974835125874;3840.462335273064;3861.1505468796818;3865.613438656112;3933.783641899723;3946.664533514626;1231.956881509143;1243.5088140184575;1247.114548670436;1260.294235228275;1262.0534599050711;955.1212884146602;955.603424578792;985.935914165577;987.1411871671692;1015.8577799108131;5921.911171332434;5969.403059693996;6012.7294271757;6056.3035250946705;6095.2685677718955;442.0253341382244;442.37404073236655;445.89744358797657;1015.5024038221219;1049.480507148951;4021.1153546219784;4054.2094291613444;4081.285774989365;4098.815553300109;4109.773962432095;10742.194335424874;11418.486168122454;11427.428628568538;11430.085593152528;11444;11087.611933582286;11269.605563805228;11327.2070955034;11333.943330283295;11388.715282118013;8490.745277641681;8575.828483430421;8600.698975535826;8624.956875215585;8643.870341944876;6042.456178943916;6047.697615119315;6071.666058366833;6162;6163.96918015407;10184.694459166238;10279.229057820843;10575.788484230427;10591.152707783513;10629.574817007233;10589.735256618646;10637.414942177946;10798.460076995962;10812.297200681931;10857.457127143769;7575.6969721210535;7600.239976002355;7689.307962283421;7689.730859419893;7691.077070751322;8386.790330241793;8579.571021449028;8595.699150529701;8664.176903194186;8692.434991725771;7582.203868593939;7808.7657370278985;7830.92169078302;7860.6069696513805;8125.959370203112;7774.455788094779;7778.338841198562;7780.961095194488;7971.3224375926375;8001.279884810162;7072.858542829217;7298.927010729824;7302.160251570925;7307.634618269171;7312.122545294599;5286.577073834161;5296.390915044819;5327.094393953114;5335.226392173191;5433.8369848904595;5338.1458966566715;5368.114261146867;5394.136938090044;5478.698671573102;5536.169574563848 17:22:59 INFO - PROCESS | 4411 | |4;prototype.html;333.65370729108037;338.42805658437237;342.6025810060329;344.77761843610887;348.1817728338405;5346.572274218068;5380.865478363038;5400.810971615994;5405.756740946657;5416.593755468336;5269.314989051418;5325.573954083674;5344;5366.275552800371;5378.435264297251;4001.859470051036;4203.348480985437;4204.56418478505;4230.646193218156;4233.809478573472;3996.2407142642805;4063.2076745034583;4079.3065178919505;4200.747955122687;4220.894477638053;4139.81370838313;4155.127423241123;4156.937645935313;4173.64524015459;4177.289860723669;4005.439238506611;4173.582641735818;4174.853880114197;4196.265653510654;4213.262679031188;3492.755507114503;3645.2527231917393;3657.762245454037;3672.3022625701033;3699.112213068871;5109.846704598868;5117.411497677777;5117.923231151536;5182.274481572583;5224.294720212799;4719.4100737407825;4811.350467686852;4815;4815.627546149331;4838.225883858601;5586.748596313176;5596.636218645775;5597.384287728347;5603.319004298694;5627.352854421753;4064.9837540614844;4067.7559346439307;4072.4705788247634;4077.734947228421;4081.979420186997;5523.861903452405;5788.450097240798;5802.970985145047;5818.5345172386105;5849.795257166022;4098.467199264077;4109.815058322382;4109.856155034559;4119.258533464005;4121.196366708463;4138.441310423054;4139.937900931488;4142.730722503027;4163.647539140376;4176.7076304658385;4720.858374248778;4746.359241502422;4757.738324392122;4763.571278584944;4765.8570242892765;5461.617686761889;5619.269494965628;5640.32316122068;5658.009848276535;5658.1426379678;1409.3587417724912;1429.1925062339744;1432.5630682641686;1445.7325394801994;1448.3192899337294;894.2511734025577;922.2760133295465;924.7688077980505;926.6849271247808;931.897491275959;4869.659123861366;4869.9269510957365;5249.42256351801;5331.4935081168005;5441.727913604304;5808.970955145197;5823.883522329615;5836.832633473237;5839.678817665069;5849.561282903799;5448.42791506894;5473.917891231635;5477.616566840363;5489.478499542537;5519.006578815852;2951.8081324713826;3142.4186525492855;3145.7640676949322;3145.937081258362;3147.5593416921647;5943.31651860033;5983.491403230687;6029.246344206974;6043.425874541911;6076.422739839796;5640.266765320482;5928.7332070056955;5942.61373010753;5950.285965684146;5976.701164941735;5916.290045194604;5920.342304154844;5937.179839576167;5952.166696662384;5966.284045914518;5633.324001119892;5889.793857215148;5890.823275301748;5895.263092113486;5919.437653422918;5764.740586673526;5775.9133612996675;5784.248047753765;5784.855378615568;5795.971020144872;5951.49412299942;6021.126936594082;6024.216851809237;6024.740722229164;6040.305364882919;4059.5331536873637;4258.1483703258855;4272.530021697673;4273.87178384649;4287.828486860615;5719.199312096393;5752.303070594101;5759.1649210865025;5776.162456443876;5826.41735826414;5622.2128901954575;5668.886622267614;5673.4469488731065;5717.485426311486;5737.8565535861935;5449.6730196188355;5580.693061881636;5608.270924779753;5633.676086119676;5638.971805140948;5451.318585176853;5514;5528.695921724183;5557.055300598827;5558.499735023867;5429.457054294539;5528.502434780728;5654.236678048411;5677.432256774289;5698.287714035746;5535.280413546213;5536.390996990247;5545.778168873361;5566.721663916869;5580.581456390868 17:22:59 INFO - PROCESS | 4411 | |5;yui.html;679.1001922452748;736.0357931110246;772.9149793522715;791.5171745235406;849.689863199932;15199.164045977466;15447.227638618053;15497;15651.530454086367;15859.999999999985;14689.485867994623;14880.553583392488;14909.105453672788;14910.776338354934;14950.40198392063;693.19935474527;802.4864086984335;811.5982588618642;830.5722552885269;834;823.81875987283;828.8218033122878;829.0258945738763;829.0300348592132;831.0733532111682;869.882565853608;873.5064688451037;874.1477059866611;874.1564390363299;874.9475031498131;716.6846587501509;824.3364091906013;851.0553285852699;870.0125357718971;870.2037635563452;626.5081910700125;627.1282916745727;627.2159800249688;627.2191122053073;627.2347735762363;15048.021878577858;15075.246237688181;15128.848711512854;15136;15142.54572362831;14101.858981410158;14395.78406323906;14432.92783536086;14524.782128268085;14622.488212912604;13045.282509461977;13095.083344165912;13159.802602960868;13205.603831885059;13306;4408.20652282589;4468.620167285784;4505.36924830524;4525.524819893897;4599.400599400599;68179.3182068178;69250;69352.30647693509;69546.65226673834;69640.6517967412;10939.453027348602;10985.395803230898;10988.780224395467;11093.168012399103;11225.831612525819;20964.580708385747;20980.895095524425;21038.263660772107;21076;21124.155033798783;8153.062397824207;8153.510789352657;8236.382271329674;8470.280026197843;8615.61229744663;4796.2805579163405;4835.95164048362;4864.440589332272;4876.707397556158;4922.803087876517;3367.5958884933475;3502.649735026477;3504.8773292934625;3506.4214404622953;3508.8771892983623;602.099860708244;616.3928530397554;618.1809102938535;620.5842085802523;628.720219502317;649.4057936987698;670.1890712238246;675.7263308360122;685.5525772990476;689.899964505154;9243.39917905334;9630;9781.559829807533;9790.363626364264;9795.265355098254;614.665007570875;651.7067319706151;682.737146198717;693.6531734132933;701.7684164225793;4377.124575084996;4510.255807791743;5088.586630435289;5304.549113325334;5373.328333958255;74209;75751.62124189344;120873;122322;126314.36842815726;102811;105828;106239;106952.46523767331;108842;92816;95117.52441237749;95764;96711;98562;10055.19558435338;10263.23025773085;10407.375557466576;10538.473076346305;10577.576896924036;48464.7576762114;49615.25577116274;50135.47425989051;51228;51518;73203;73289;76113.6194319047;79374;80259.19740802517;13116.83445329877;13196;13405.932970335087;13623.046386753229;13872.583822485341;14333.396624261977;14395.640108997359;15159.545213643609;15222.847771522143;15273.694526109193;14026.789598155832;14195.64510887236;14224.217668028357;14224.79089277423;14340.282985850874;13994;14086.788698169741;14235;14239.216843073731;14430.567082987527;13750.710985600606;13848.09987350819;13863;13866;14052.508162214273;10494.212934029825;10921.83617245726;11029.22795404314;11056.502457389275;11206.43967801623;10691.839622405825;10898.50956706966;11078.169137314573;11458.4270786462;11571.826422603835 17:22:59 INFO - PROCESS | 4411 | __end_tp_report 17:22:59 INFO - PROCESS | 4411 | __start_cc_report 17:22:59 INFO - PROCESS | 4411 | _x_x_mozilla_cycle_collect,924 17:22:59 INFO - PROCESS | 4411 | __end_cc_report 17:22:59 INFO - PROCESS | 4411 | __startTimestamp1465172579821__endTimestamp 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | ------- Summary: start ------- 17:22:59 INFO - PROCESS | 4411 | Number of tests: 6 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | [#0] dojo.html Cycles:165 Average:5379.87 Median:5592.47 stddev:621.84 (11.1%) stddev-sans-first:597.14 17:22:59 INFO - PROCESS | 4411 | Values: 3085.6 3092.7 3112.6 3125.0 3147.2 5261.5 5288.9 5346.2 5416.7 5448.1 5388.7 5403.4 5414.8 5423.8 5470.1 4824.6 4893.4 4905.8 4921.8 5011.3 4888.2 4944.5 4978.3 4991.7 5001.0 4759.5 4817.2 4849.7 4854.3 4914.4 4843.6 4848.3 4910.4 4934.1 4963.4 4734.8 4849.2 4860.1 4880.9 4905.3 5329.1 5406.9 5407.3 5487.7 5502.8 5837.5 5872.6 5873.6 5892.3 5897.4 5690.3 5799.7 5891.8 5958.3 5960.7 5491.9 5571.4 5572.0 5578.4 5592.0 6016.8 6028.0 6031.2 6031.3 6033.5 5502.7 5606.0 5660.0 5819.8 5833.3 5764.6 5813.2 5826.2 5829.4 5830.3 5710.4 5742.7 5754.5 5757.2 5761.5 5592.5 5707.7 5763.6 5766.3 5783.9 4416.9 4419.0 4419.5 4420.4 4458.4 3932.4 3940.2 3949.7 3984.9 4004.3 5280.3 5376.3 5436.2 5467.4 5477.3 5813.3 5816.1 5827.7 5863.3 5867.4 5487.7 5499.5 5500.4 5512.1 5516.6 4895.4 4922.2 4950.4 4953.2 4959.0 5930.1 5932.9 5933.8 5937.0 5942.1 5681.9 5778.3 5787.5 5803.0 5804.3 5890.8 5938.5 5954.3 5992.3 6003.7 5639.2 5669.3 5671.9 5674.7 5681.1 5649.9 5727.9 5775.9 5777.3 5788.3 5719.9 5752.4 5757.6 5760.5 5798.9 5626.2 5657.8 5675.5 5682.7 5682.8 5394.2 5520.4 5580.2 5584.1 5585.2 5737.3 5737.7 5764.9 5772.5 5780.1 5569.7 5609.9 5612.5 5615.8 5674.1 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | [#1] ext.html Cycles:180 Average:61219.81 Median:42670.89 stddev:121232.75 (284.1%) stddev-sans-first:121487.37 17:22:59 INFO - PROCESS | 4411 | Values: 585.3 611.4 617.8 625.3 627.0 33466.3 35977.5 36077.6 36106.0 44342.7 41897.8 46561.5 46575.8 46619.8 46655.3 8723.0 8919.9 8929.1 8931.8 8938.6 8735.0 8900.6 8904.9 8908.3 8909.6 8929.4 9020.4 9022.0 9022.4 9028.2 8914.0 8971.6 8975.2 8980.5 8982.5 8705.5 8777.8 8790.7 8795.0 8805.6 43879.0 44340.6 44391.0 44429.8 44450.3 3428.8 3933.7 4070.2 4098.5 4148.2 32613.5 32867.0 33231.7 33489.5 33555.7 4322.8 4457.0 4497.6 4518.8 4533.7 348499.0 349856.0 350102.0 350966.2 351102.0 58129.7 58931.0 58974.1 59016.0 59019.1 36202.0 36831.3 36874.8 38662.2 38687.0 16322.1 16488.3 16490.7 16494.4 16503.4 11814.6 11815.4 11905.4 11913.4 11918.0 19600.7 19771.8 19844.3 20032.0 20103.6 6960.7 6962.4 7036.5 7083.9 7161.9 975.8 1012.3 1034.3 1055.0 1085.5 32220.8 32282.5 32478.4 32912.3 32974.0 1062.6 1132.3 1145.3 1149.5 1185.9 16968.2 17247.2 17311.7 17380.0 17590.0 533264.0 536224.0 536535.0 538971.0 539971.0 59326.0 59865.4 59930.0 59964.4 60117.0 1249.0 1324.5 1332.3 1354.9 1358.1 31059.0 34483.7 34509.3 34610.5 35230.0 52834.0 53772.7 53835.7 53945.7 53977.0 459928.0 466076.0 466506.0 467014.0 467239.0 34568.0 39606.0 39614.4 45053.4 45963.0 50192.5 50205.5 50315.0 51138.2 51235.5 42135.8 42493.4 42941.8 43538.1 43738.3 41641.0 41873.4 42250.6 42585.4 42718.0 41137.0 41544.0 42644.8 42697.0 42782.6 35513.8 37656.2 37662.2 38548.6 38549.8 28184.6 28737.4 28755.6 28990.0 29142.6 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | [#2] jquery.html Cycles:180 Average:28448.96 Median:12958.91 stddev:75496.79 (582.6%) stddev-sans-first:75679.18 17:22:59 INFO - PROCESS | 4411 | Values: 390.9 394.7 396.5 401.2 420.3 13098.3 18119.3 19494.2 19704.0 19842.1 18851.2 18987.3 19747.7 19969.9 20001.3 5517.7 5658.0 5681.8 5682.6 5713.4 5616.3 5664.7 5667.5 5668.7 5680.6 4118.4 5951.9 6255.8 6261.2 6358.3 6148.7 6227.8 6264.3 6307.3 6325.3 5573.7 5580.8 5598.5 5599.2 5615.4 22055.9 22653.3 23545.9 23560.3 23649.5 2357.5 2370.1 2463.8 2542.4 2575.4 14249.1 14651.6 14786.2 15065.0 15066.2 1829.7 1899.1 1903.5 1933.3 1980.6 79529.0 79529.6 80125.2 80325.2 81311.0 9833.4 10032.4 10890.4 10939.2 11145.6 15260.2 15385.2 15406.8 15410.5 15435.9 7572.4 8416.5 8417.0 8527.4 8531.6 7995.1 8073.2 8103.5 8269.3 8297.1 6739.4 6785.9 6860.2 6863.9 7008.0 1884.3 1885.6 1933.5 1957.1 1967.3 960.3 1049.4 1054.4 1065.8 1100.7 18963.6 19723.2 19829.6 19934.7 20026.3 982.1 998.2 1031.1 1060.8 1067.7 10848.3 11511.1 11528.6 11548.8 11554.7 406729.0 408462.0 413199.0 515071.0 518258.0 63341.0 101269.5 106683.5 107254.5 107801.5 997.4 1012.8 1035.7 1041.0 1042.8 17577.5 17661.6 17911.4 18137.3 18381.3 42575.8 43163.6 43550.8 44108.3 44136.6 61369.4 61917.0 62025.4 62053.0 63368.0 8686.3 8733.7 8749.5 8778.8 8893.3 9871.1 13355.5 13543.8 13601.4 13783.2 11574.7 11737.6 11875.5 11903.3 12062.4 11520.0 11636.4 11744.2 11909.3 12006.3 10674.0 11202.2 11974.6 12157.0 12188.6 8535.2 8635.9 8802.0 8859.0 9048.6 8014.6 11035.1 11066.0 11361.3 11975.6 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | [#3] mootools.html Cycles:180 Average:5906.09 Median:2482.68 stddev:3414.48 (137.5%) stddev-sans-first:3406.65 17:22:59 INFO - PROCESS | 4411 | Values: 1318.6 1486.6 1517.0 1636.6 1781.0 8421.5 8769.8 8782.0 8997.7 9006.3 8633.9 8817.4 8830.7 8834.4 8835.3 2377.0 2398.3 2399.7 2409.2 2409.7 2338.8 2362.7 2373.3 2374.4 2394.6 2353.6 2360.2 2368.8 2382.7 2386.1 2334.6 2350.3 2363.6 2363.9 2369.5 2222.3 2286.6 2288.9 2290.5 2295.9 7664.0 7914.6 8822.9 8860.8 8891.1 4519.5 4622.8 5093.7 5300.6 5309.6 3397.1 3400.2 3460.6 3478.5 3482.5 1163.1 1173.8 1191.8 1243.1 1243.9 12538.2 12716.6 12775.3 12836.3 12857.0 4534.1 4680.4 4720.7 4790.6 4804.3 10660.6 10667.7 10684.3 10699.9 10702.5 5335.3 5355.7 5371.3 5371.7 5382.1 4791.5 4843.1 4843.2 4917.7 5033.0 3840.5 3861.2 3865.6 3933.8 3946.7 1232.0 1243.5 1247.1 1260.3 1262.1 955.1 955.6 985.9 987.1 1015.9 5921.9 5969.4 6012.7 6056.3 6095.3 442.0 442.4 445.9 1015.5 1049.5 4021.1 4054.2 4081.3 4098.8 4109.8 10742.2 11418.5 11427.4 11430.1 11444.0 11087.6 11269.6 11327.2 11333.9 11388.7 8490.7 8575.8 8600.7 8625.0 8643.9 6042.5 6047.7 6071.7 6162.0 6164.0 10184.7 10279.2 10575.8 10591.2 10629.6 10589.7 10637.4 10798.5 10812.3 10857.5 7575.7 7600.2 7689.3 7689.7 7691.1 8386.8 8579.6 8595.7 8664.2 8692.4 7582.2 7808.8 7830.9 7860.6 8126.0 7774.5 7778.3 7781.0 7971.3 8001.3 7072.9 7298.9 7302.2 7307.6 7312.1 5286.6 5296.4 5327.1 5335.2 5433.8 5338.1 5368.1 5394.1 5478.7 5536.2 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | [#4] prototype.html Cycles:180 Average:4740.24 Median:5445.08 stddev:1399.73 (25.7%) stddev-sans-first:1364.02 17:22:59 INFO - PROCESS | 4411 | Values: 333.7 338.4 342.6 344.8 348.2 5346.6 5380.9 5400.8 5405.8 5416.6 5269.3 5325.6 5344.0 5366.3 5378.4 4001.9 4203.3 4204.6 4230.6 4233.8 3996.2 4063.2 4079.3 4200.7 4220.9 4139.8 4155.1 4156.9 4173.6 4177.3 4005.4 4173.6 4174.9 4196.3 4213.3 3492.8 3645.3 3657.8 3672.3 3699.1 5109.8 5117.4 5117.9 5182.3 5224.3 4719.4 4811.4 4815.0 4815.6 4838.2 5586.7 5596.6 5597.4 5603.3 5627.4 4065.0 4067.8 4072.5 4077.7 4082.0 5523.9 5788.5 5803.0 5818.5 5849.8 4098.5 4109.8 4109.9 4119.3 4121.2 4138.4 4139.9 4142.7 4163.6 4176.7 4720.9 4746.4 4757.7 4763.6 4765.9 5461.6 5619.3 5640.3 5658.0 5658.1 1409.4 1429.2 1432.6 1445.7 1448.3 894.3 922.3 924.8 926.7 931.9 4869.7 4869.9 5249.4 5331.5 5441.7 5809.0 5823.9 5836.8 5839.7 5849.6 5448.4 5473.9 5477.6 5489.5 5519.0 2951.8 3142.4 3145.8 3145.9 3147.6 5943.3 5983.5 6029.2 6043.4 6076.4 5640.3 5928.7 5942.6 5950.3 5976.7 5916.3 5920.3 5937.2 5952.2 5966.3 5633.3 5889.8 5890.8 5895.3 5919.4 5764.7 5775.9 5784.2 5784.9 5796.0 5951.5 6021.1 6024.2 6024.7 6040.3 4059.5 4258.1 4272.5 4273.9 4287.8 5719.2 5752.3 5759.2 5776.2 5826.4 5622.2 5668.9 5673.4 5717.5 5737.9 5449.7 5580.7 5608.3 5633.7 5639.0 5451.3 5514.0 5528.7 5557.1 5558.5 5429.5 5528.5 5654.2 5677.4 5698.3 5535.3 5536.4 5545.8 5566.7 5580.6 17:22:59 INFO - PROCESS | 4411 | 17:22:59 INFO - PROCESS | 4411 | [#5] yui.html Cycles:180 Average:20896.86 Median:4486.99 stddev:30119.92 (671.3%) stddev-sans-first:30166.16 17:22:59 INFO - PROCESS | 4411 | Values: 679.1 736.0 772.9 791.5 849.7 15199.2 15447.2 15497.0 15651.5 15860.0 14689.5 14880.6 14909.1 14910.8 14950.4 693.2 802.5 811.6 830.6 834.0 823.8 828.8 829.0 829.0 831.1 869.9 873.5 874.1 874.2 874.9 716.7 824.3 851.1 870.0 870.2 626.5 627.1 627.2 627.2 627.2 15048.0 15075.2 15128.8 15136.0 15142.5 14101.9 14395.8 14432.9 14524.8 14622.5 13045.3 13095.1 13159.8 13205.6 13306.0 4408.2 4468.6 4505.4 4525.5 4599.4 68179.3 69250.0 69352.3 69546.7 69640.7 10939.5 10985.4 10988.8 11093.2 11225.8 20964.6 20980.9 21038.3 21076.0 21124.2 8153.1 8153.5 8236.4 8470.3 8615.6 4796.3 4836.0 4864.4 4876.7 4922.8 3367.6 3502.6 3504.9 3506.4 3508.9 602.1 616.4 618.2 620.6 628.7 649.4 670.2 675.7 685.6 689.9 9243.4 9630.0 9781.6 9790.4 9795.3 614.7 651.7 682.7 693.7 701.8 4377.1 4510.3 5088.6 5304.5 5373.3 74209.0 75751.6 120873.0 122322.0 126314.4 102811.0 105828.0 106239.0 106952.5 108842.0 92816.0 95117.5 95764.0 96711.0 98562.0 10055.2 10263.2 10407.4 10538.5 10577.6 48464.8 49615.3 50135.5 51228.0 51518.0 73203.0 73289.0 76113.6 79374.0 80259.2 13116.8 13196.0 13405.9 13623.0 13872.6 14333.4 14395.6 15159.5 15222.8 15273.7 14026.8 14195.6 14224.2 14224.8 14340.3 13994.0 14086.8 14235.0 14239.2 14430.6 13750.7 13848.1 13863.0 13866.0 14052.5 10494.2 10921.8 11029.2 11056.5 11206.4 10691.8 10898.5 11078.2 11458.4 11571.8 17:22:59 INFO - PROCESS | 4411 | -------- Summary: end -------- 17:22:59 INFO - PROCESS | 4411 | 17:23:00 INFO - TEST-INFO | 4411: exit 0 17:23:00 INFO - TEST-OK | dromaeo_css | took 1112982ms 17:23:00 INFO - TEST-START | kraken 17:23:00 INFO - operating with platform_type : linux_ 17:23:00 INFO - Initialising browser for kraken test... 17:23:00 INFO - TEST-INFO | started process 4591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSUXkIb/profile http://localhost:33015/getInfo.html) 17:23:04 INFO - PROCESS | 4591 | __metrics Screen width/height:1600/1200 17:23:04 INFO - PROCESS | 4591 | colorDepth:24 17:23:04 INFO - PROCESS | 4591 | Browser inner width/height: 1024/697 17:23:04 INFO - PROCESS | 4591 | __metrics 17:23:05 ERROR - PROCESS | 4591 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:23:06 INFO - TEST-INFO | 4591: exit 0 17:23:06 INFO - Browser initialized. 17:23:06 INFO - Running cycle 1/1 for kraken test... 17:23:06 INFO - TEST-INFO | started process 4673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSUXkIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:18 INFO - PROCESS | 4673 | RSS: Main: 156573696 17:23:18 INFO - PROCESS | 4673 | 17:23:20 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:21 INFO - PROCESS | 4673 | RSS: Main: 214548480 17:23:21 INFO - PROCESS | 4673 | 17:23:24 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-dft) 17:23:24 INFO - PROCESS | 4673 | RSS: Main: 201056256 17:23:24 INFO - PROCESS | 4673 | 17:23:28 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-fft) 17:23:28 INFO - PROCESS | 4673 | RSS: Main: 268365824 17:23:28 INFO - PROCESS | 4673 | 17:23:30 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-oscillator) 17:23:31 INFO - PROCESS | 4673 | RSS: Main: 179675136 17:23:31 INFO - PROCESS | 4673 | 17:23:33 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:34 INFO - PROCESS | 4673 | RSS: Main: 183455744 17:23:34 INFO - PROCESS | 4673 | 17:23:37 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33015/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:37 INFO - PROCESS | 4673 | RSS: Main: 218152960 17:23:37 INFO - PROCESS | 4673 | 17:23:41 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33015/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:41 INFO - PROCESS | 4673 | RSS: Main: 220356608 17:23:41 INFO - PROCESS | 4673 | 17:23:44 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33015/tests/kraken/driver.html?testName=json-parse-financial) 17:23:45 INFO - PROCESS | 4673 | RSS: Main: 220594176 17:23:45 INFO - PROCESS | 4673 | 17:23:46 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:23:47 INFO - PROCESS | 4673 | RSS: Main: 205676544 17:23:47 INFO - PROCESS | 4673 | 17:23:48 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:49 INFO - PROCESS | 4673 | RSS: Main: 210427904 17:23:49 INFO - PROCESS | 4673 | 17:23:51 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:23:52 INFO - PROCESS | 4673 | RSS: Main: 216469504 17:23:52 INFO - PROCESS | 4673 | 17:23:54 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:23:55 INFO - PROCESS | 4673 | RSS: Main: 222449664 17:23:55 INFO - PROCESS | 4673 | 17:23:58 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:58 INFO - PROCESS | 4673 | RSS: Main: 220934144 17:23:58 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33015/tests/kraken/driver.html?testName=ai-astar) 17:24:00 INFO - PROCESS | 4673 | RSS: Main: 263811072 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | __start_tp_report 17:24:00 INFO - PROCESS | 4673 | _x_x_mozilla_page_load 17:24:00 INFO - PROCESS | 4673 | _x_x_mozilla_page_load_details 17:24:00 INFO - PROCESS | 4673 | |i|pagename|runs| 17:24:00 INFO - PROCESS | 4673 | |0;ai-astar;112;109;111;111;111;111;110;110;111;110 17:24:00 INFO - PROCESS | 4673 | |1;audio-beat-detection;154;136;127;196;129;135;158;129;161;127 17:24:00 INFO - PROCESS | 4673 | |2;audio-dft;162;159;160;161;161;161;162;161;163;162 17:24:00 INFO - PROCESS | 4673 | |3;audio-fft;74;74;74;124;73;75;74;76;108;74 17:24:00 INFO - PROCESS | 4673 | |4;audio-oscillator;85;85;115;84;84;85;119;85;85;122 17:24:00 INFO - PROCESS | 4673 | |5;imaging-gaussian-blur;117;117;116;116;116;116;117;117;117;116 17:24:00 INFO - PROCESS | 4673 | |6;imaging-darkroom;146;146;146;147;145;146;145;146;146;145 17:24:00 INFO - PROCESS | 4673 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 17:24:00 INFO - PROCESS | 4673 | |8;json-parse-financial;55;52;53;53;52;54;52;53;54;53 17:24:00 INFO - PROCESS | 4673 | |9;json-stringify-tinderbox;62;63;62;62;71;61;62;62;62;61 17:24:00 INFO - PROCESS | 4673 | |10;stanford-crypto-aes;80;79;78;79;80;86;81;80;112;85 17:24:00 INFO - PROCESS | 4673 | |11;stanford-crypto-ccm;124;130;120;120;135;125;122;128;127;122 17:24:00 INFO - PROCESS | 4673 | |12;stanford-crypto-pbkdf2;161;162;160;161;157;162;160;164;157;155 17:24:00 INFO - PROCESS | 4673 | |13;stanford-crypto-sha256-iterative;62;64;64;62;64;62;62;62;63;60 17:24:00 INFO - PROCESS | 4673 | __end_tp_report 17:24:00 INFO - PROCESS | 4673 | __start_cc_report 17:24:00 INFO - PROCESS | 4673 | _x_x_mozilla_cycle_collect,1637 17:24:00 INFO - PROCESS | 4673 | __end_cc_report 17:24:00 INFO - PROCESS | 4673 | __startTimestamp1465172640646__endTimestamp 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | ------- Summary: start ------- 17:24:00 INFO - PROCESS | 4673 | Number of tests: 14 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:0.84 (0.8%) stddev-sans-first:0.73 17:24:00 INFO - PROCESS | 4673 | Values: 112.0 109.0 111.0 111.0 111.0 111.0 110.0 110.0 111.0 110.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:145.00 stddev:22.23 (15.3%) stddev-sans-first:23.35 17:24:00 INFO - PROCESS | 4673 | Values: 154.0 136.0 127.0 196.0 129.0 135.0 158.0 129.0 161.0 127.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 17:24:00 INFO - PROCESS | 4673 | Values: 162.0 159.0 160.0 161.0 161.0 161.0 162.0 161.0 163.0 162.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:18.02 (24.4%) stddev-sans-first:18.84 17:24:00 INFO - PROCESS | 4673 | Values: 74.0 74.0 74.0 124.0 73.0 75.0 74.0 76.0 108.0 74.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:85.00 stddev:16.49 (19.4%) stddev-sans-first:17.10 17:24:00 INFO - PROCESS | 4673 | Values: 85.0 85.0 115.0 84.0 84.0 85.0 119.0 85.0 85.0 122.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:24:00 INFO - PROCESS | 4673 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:24:00 INFO - PROCESS | 4673 | Values: 146.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 145.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:24:00 INFO - PROCESS | 4673 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.78 17:24:00 INFO - PROCESS | 4673 | Values: 55.0 52.0 53.0 53.0 52.0 54.0 52.0 53.0 54.0 53.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:62.00 stddev:2.94 (4.7%) stddev-sans-first:3.10 17:24:00 INFO - PROCESS | 4673 | Values: 62.0 63.0 62.0 62.0 71.0 61.0 62.0 62.0 62.0 61.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:80.00 stddev:10.18 (12.7%) stddev-sans-first:10.69 17:24:00 INFO - PROCESS | 4673 | Values: 80.0 79.0 78.0 79.0 80.0 86.0 81.0 80.0 112.0 85.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.00 stddev:4.79 (3.8%) stddev-sans-first:5.05 17:24:00 INFO - PROCESS | 4673 | Values: 124.0 130.0 120.0 120.0 135.0 125.0 122.0 128.0 127.0 122.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:161.00 stddev:2.77 (1.7%) stddev-sans-first:2.91 17:24:00 INFO - PROCESS | 4673 | Values: 161.0 162.0 160.0 161.0 157.0 162.0 160.0 164.0 157.0 155.0 17:24:00 INFO - PROCESS | 4673 | 17:24:00 INFO - PROCESS | 4673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.27 (2.0%) stddev-sans-first:1.33 17:24:00 INFO - PROCESS | 4673 | Values: 62.0 64.0 64.0 62.0 64.0 62.0 62.0 62.0 63.0 60.0 17:24:00 INFO - PROCESS | 4673 | -------- Summary: end -------- 17:24:00 INFO - PROCESS | 4673 | 17:24:01 INFO - TEST-INFO | 4673: exit 0 17:24:01 INFO - TEST-OK | kraken | took 61021ms 17:24:01 INFO - SUITE-END | took 1174s 17:24:01 INFO - Completed test suite (00:19:34) 17:24:01 INFO - javascript benchmark 17:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.5834462347584, 3092.6598074211834, 3112.5642410062587, 3125.0468607074863, 3147.166001009733, 5261.500157485042, 5288.947110528903, 5346.171343441768, 5416.729163541822, 5448.101063324557, 5388.7305634718205, 5403.405625381215, 5414.810481633143, 5423.83728488145, 5470.070088085025, 4824.565789078983, 4893.437254715717, 4905.803767849282, 4921.8277360292395, 5011.323471331379, 4888.169011268093, 4944.456109827916, 4978.327925730016, 4991.650584459089, 5001.0, 4759.547842954931, 4817.22924332107, 4849.684770489906, 4854.344663470421, 4914.385701787294, 4843.58829499493, 4848.345473361086, 4910.361652985125, 4934.136526107953, 4963.40439147301, 4734.810607575727, 4849.175640141185, 4860.05228980349, 4880.926786098212, 4905.2642103684375, 5329.067413202674, 5406.945930540684, 5407.324084489439, 5487.725613719338, 5502.779888804443, 5837.532997360201, 5872.618279811799, 5873.588848780587, 5892.322382925976, 5897.380775018647, 5690.260266165372, 5799.710014499258, 5891.793787217427, 5958.285005799332, 5960.7019649017375, 5491.862703432406, 5571.359293681197, 5572.024895643246, 5578.3584887738425, 5592.049351610236, 6016.819495415145, 6027.969860150672, 6031.24609423822, 6031.276246850318, 6033.487153591994, 5502.697351645698, 5606.0, 5659.971700141473, 5819.82540523785, 5833.270841144857, 5764.596478246566, 5813.244278243886, 5826.184334193216, 5829.387914268941, 5830.300363956352, 5710.428957104256, 5742.655440673573, 5754.539636829044, 5757.165211044375, 5761.53907687384, 5592.468715472024, 5707.6575405475805, 5763.625364351304, 5766.308043034779, 5783.913241301299, 4416.867493975186, 4418.955810441855, 4419.535948725402, 4420.403245561873, 4458.353538736865, 3932.3708206686792, 3940.192260586573, 3949.7235193536753, 3984.900377490586, 4004.2992476316526, 5280.313559237351, 5376.274202982626, 5436.184572314105, 5467.425920278393, 5477.315335583052, 5813.273340832396, 5816.127580862904, 5827.708614569255, 5863.2670916135485, 5867.442592953663, 5487.6981766002455, 5499.477549632778, 5500.42245564218, 5512.145617429305, 5516.586256030814, 4895.412550493964, 4922.237053256751, 4950.430700469492, 4953.23224900141, 4959.0, 5930.140129681172, 5932.911006334908, 5933.762649494059, 5937.0, 5942.1383899335215, 5681.943180568307, 5778.306603207642, 5787.479126878601, 5803.042497987784, 5804.303483581997, 5890.793822216202, 5938.524918006463, 5954.255718035246, 5992.340842507234, 6003.6998150093195, 5639.238702775073, 5669.31968163823, 5671.943280567141, 5674.687892165805, 5681.119426488901, 5649.887002259849, 5727.942720572741, 5775.855603609775, 5777.277840269966, 5788.334341550607, 5719.914201286901, 5752.395998420273, 5757.568182386254, 5760.481556659921, 5798.884022319615, 5626.184203290418, 5657.801976930952, 5675.517581005661, 5682.715864206856, 5682.77268909239, 5394.217838413329, 5520.447955204448, 5580.218769372373, 5584.050711379156, 5585.245991791056, 5737.254156959569, 5737.713114344349, 5764.855878603068, 5772.509336706427, 5780.075187969905, 5569.749361278671, 5609.859753506195, 5612.494875461228, 5615.831525054255, 5674.148877668383], "value": 5337.150666973964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.3122580967362, 611.4069352727853, 617.8486270863639, 625.334019269478, 626.9686515674216, 33466.33067338655, 35977.46033809492, 36077.63922360776, 36106.0, 44342.66971990837, 41897.7905110474, 46561.534384656145, 46575.767121164434, 46619.83450413741, 46655.30017049747, 8722.956385218082, 8919.866202006975, 8929.062448442917, 8931.821363572724, 8938.553072346356, 8734.956325218365, 8900.554972251393, 8904.910950890506, 8908.331875109392, 8909.55452227386, 8929.41958772681, 9020.368574199809, 9021.95489022554, 9022.413543119676, 9028.187463128317, 8914.0, 8971.641134354619, 8975.237104846095, 8980.506072165996, 8982.461052336881, 8705.521196334199, 8777.824443511157, 8790.692325768567, 8795.032546419889, 8805.559722013937, 43879.0, 44340.55659443429, 44391.0, 44429.77785111086, 44450.33324500135, 3428.8114153721535, 3933.724639275252, 4070.206309769596, 4098.52866920305, 4148.191102734938, 32613.51079733806, 32867.01398958035, 33231.667683323096, 33489.497657534914, 33555.6644433555, 4322.848700295506, 4456.955430445686, 4497.64018878489, 4518.774061296955, 4533.705309154894, 348499.0, 349856.0, 350102.0, 350966.2451687751, 351102.0, 58129.70935145297, 58931.0, 58974.10258974068, 59016.0, 59019.114713279334, 36202.0, 36831.263374732356, 36874.8156259217, 38662.22675546473, 38687.0, 16322.102284374236, 16488.34046638121, 16490.670186596442, 16494.42269520561, 16503.422380216634, 11814.645560633195, 11815.350155741517, 11905.40472976365, 11913.404329783649, 11918.046556275478, 19600.70598941017, 19771.802281976998, 19844.305449309206, 20032.0, 20103.597928041356, 6960.686769095301, 6962.443004559623, 7036.472264580075, 7083.858322833515, 7161.89257161143, 975.8487434447673, 1012.2559918460073, 1034.343192073039, 1055.0082922053246, 1085.5277954089995, 32220.83889580537, 32282.515762263585, 32478.350432991207, 32912.3417531648, 32974.0, 1062.574970011986, 1132.2810015640127, 1145.2949707695598, 1149.545929357899, 1185.9288442693467, 16968.151592420578, 17247.223874925658, 17311.65376692459, 17380.0, 17590.0, 533264.0, 536224.0, 536535.0, 538971.0, 539971.0, 59326.0, 59865.401345985985, 59930.0, 59964.40035599675, 60117.0, 1248.9875101249054, 1324.543032653733, 1332.3072002558615, 1354.8983826212877, 1358.103651589946, 31059.0, 34483.65516344804, 34509.30981380409, 34610.48084278788, 35230.0, 52834.0, 53772.73113634407, 53835.73082134564, 53945.73027134996, 53977.0, 459928.0, 466076.0, 466506.0, 467014.0, 467239.0, 34568.0, 39606.0, 39614.40578391269, 45053.36832895888, 45963.0, 50192.498075020245, 50205.497945020084, 50315.0, 51138.23292650688, 51235.487645123074, 42135.7893210532, 42493.362599560416, 42941.78529107334, 43538.129237415706, 43738.34392484179, 41641.0, 41873.37189942093, 42250.577494224664, 42585.36121958235, 42718.0, 41137.0, 41544.0, 42644.78677606592, 42697.0, 42782.57217427911, 35513.82243088768, 37656.24687506289, 37662.246755064196, 38548.6145138545, 38549.80725096357, 28184.577231341136, 28737.42525149527, 28755.5686664696, 28990.0, 29142.56286155752], "value": 20357.365427510715, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9081365879016, 394.6566487156174, 396.5320921312853, 401.2096170544028, 420.3358693264642, 13098.329880261075, 18119.275228990842, 19494.220231190735, 19704.0, 19842.107105180283, 18851.15169817358, 18987.33544325949, 19747.70378444321, 19969.900150499263, 20001.299954501595, 5517.69652669104, 5657.9717101414435, 5681.829545113653, 5682.573806964494, 5713.400092990218, 5616.269884914956, 5664.660120392769, 5667.489925906668, 5668.659880407189, 5680.602357834953, 4118.444010058649, 5951.85120371992, 6255.781047663333, 6261.154744109533, 6358.268799088095, 6148.6618235997, 6227.813165605039, 6264.279607845087, 6307.306196318425, 6325.304216536178, 5573.749181286811, 5580.832575022756, 5598.524125449342, 5599.216109744639, 5615.382307946123, 22055.889720551455, 22653.320400388016, 23545.88227058871, 23560.29319120429, 23649.527009459885, 2357.5284943011466, 2370.099362242354, 2463.8152138589676, 2542.427953710419, 2575.35616095976, 14249.145051296955, 14651.560453186421, 14786.18675972821, 15065.0, 15066.171360575165, 1829.6798060339388, 1899.1074195128267, 1903.5336342596152, 1933.3136736458637, 1980.633582787189, 79529.0, 79529.60235198787, 80125.19874801235, 80325.19674803235, 81311.0, 9833.360831545926, 10032.448215348226, 10890.440746424583, 10939.23425360233, 11145.554177832959, 15260.160691162093, 15385.153816540198, 15406.845931540765, 15410.460633877761, 15435.922820385826, 7572.432067594952, 8416.452930559493, 8416.957915210385, 8527.445716028438, 8531.573421328909, 7995.120536740954, 8073.152319006537, 8103.513789172668, 8269.255766981001, 8297.087320394752, 6739.393454589111, 6785.93214067853, 6860.211075726255, 6863.897041544381, 7007.964960175268, 1884.2557189910183, 1885.5568941298784, 1933.4682962185511, 1957.082059581618, 1967.2917749610128, 960.3325688646463, 1049.4123290957089, 1054.3884546962743, 1065.8166695719272, 1100.664297389304, 18963.62072758537, 19723.211071556976, 19829.60340793205, 19934.70097948532, 20026.299079532146, 982.1455333859445, 998.1914649134225, 1031.1338475680313, 1060.81966065769, 1067.7170549804307, 10848.349099054081, 11511.079113670887, 11528.59649912249, 11548.826767598493, 11554.653360399201, 406729.0, 408462.0, 413199.0, 515071.0, 518258.0, 63341.0, 101269.49365253127, 106683.46658266659, 107254.46372768086, 107801.4609926961, 997.4414327976211, 1012.8176928152856, 1035.7255327338262, 1041.0214398465419, 1042.7705904700954, 17577.472675819747, 17661.55846103806, 17911.373101941368, 18137.27450901949, 18381.26474941041, 42575.7871210642, 43163.56836431721, 43550.782246088565, 44108.33837492504, 44136.558634413246, 61369.386306136366, 61917.0, 62025.37974620196, 62053.0, 63368.0, 8686.261667758312, 8733.650653974024, 8749.47503149813, 8778.780530486789, 8893.28853691716, 9871.062249086326, 13355.465781369025, 13543.796843047165, 13601.387937542637, 13783.173009619455, 11574.6527604172, 11737.647870563897, 11875.52497900109, 11903.285802851857, 12062.396880156133, 11519.952323011663, 11636.36000020007, 11744.177907546731, 11909.285442873455, 12006.339651318913, 10674.0, 11202.15983801202, 11974.64076077719, 12157.0, 12188.634340969786, 8535.189157030072, 8635.913640863511, 8802.0, 8858.955705221433, 9048.591342881553, 8014.639341229776, 11035.062019728413, 11066.0, 11361.261518001304, 11975.64073077809], "value": 9494.63683334217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.5582829752032, 1486.591187423458, 1517.0215211188784, 1636.6399392133726, 1780.9910950445246, 8421.452605580633, 8769.824603507934, 8782.033976262614, 8997.685081022166, 9006.32452566057, 8633.87049194261, 8817.426867253624, 8830.735077947671, 8834.381593288472, 8835.293176545876, 2376.9881150594224, 2398.304491697406, 2399.7120345558556, 2409.2410890569413, 2409.662647229389, 2338.8128949683983, 2362.728286247078, 2373.2524254859663, 2374.4182675244588, 2394.5570069537193, 2353.5881220786378, 2360.173939121311, 2368.834181607288, 2382.737898831127, 2386.081358676913, 2334.556434277482, 2350.27141586108, 2363.5863723848256, 2363.869987150706, 2369.5497855407502, 2222.288867562381, 2286.622707253301, 2288.931332060041, 2290.4846409557717, 2295.8737269450176, 7663.961680191619, 7914.643841027168, 8822.86765698515, 8860.822783544358, 8891.06643802398, 4519.457665080178, 4622.838200662961, 5093.668911520739, 5300.602454815904, 5309.601779866487, 3397.0997685613333, 3400.1669590950128, 3460.584729832411, 3478.5477887874413, 3482.4776283557417, 1163.110220681171, 1173.847399838024, 1191.773563023023, 1243.0676992255808, 1243.8507379114474, 12538.185017973803, 12716.554920577828, 12775.29735864527, 12836.294003829786, 12856.999999999907, 4534.070515544306, 4680.3915490985955, 4720.716756994591, 4790.640701947368, 4804.327394164819, 10660.62687805923, 10667.679969600924, 10684.305520141166, 10699.946500267604, 10702.46487675613, 5335.33308336458, 5355.732213389315, 5371.301730774974, 5371.6508426952905, 5382.138857782736, 4791.520847915181, 4843.104025755247, 4843.15244832153, 4917.704937703749, 5032.974835125874, 3840.462335273064, 3861.1505468796818, 3865.613438656112, 3933.783641899723, 3946.664533514626, 1231.956881509143, 1243.5088140184575, 1247.114548670436, 1260.294235228275, 1262.0534599050711, 955.1212884146602, 955.603424578792, 985.935914165577, 987.1411871671692, 1015.8577799108131, 5921.911171332434, 5969.403059693996, 6012.7294271757, 6056.3035250946705, 6095.2685677718955, 442.0253341382244, 442.37404073236655, 445.89744358797657, 1015.5024038221219, 1049.480507148951, 4021.1153546219784, 4054.2094291613444, 4081.285774989365, 4098.815553300109, 4109.773962432095, 10742.194335424874, 11418.486168122454, 11427.428628568538, 11430.085593152528, 11444.0, 11087.611933582286, 11269.605563805228, 11327.2070955034, 11333.943330283295, 11388.715282118013, 8490.745277641681, 8575.828483430421, 8600.698975535826, 8624.956875215585, 8643.870341944876, 6042.456178943916, 6047.697615119315, 6071.666058366833, 6162.0, 6163.96918015407, 10184.694459166238, 10279.229057820843, 10575.788484230427, 10591.152707783513, 10629.574817007233, 10589.735256618646, 10637.414942177946, 10798.460076995962, 10812.297200681931, 10857.457127143769, 7575.6969721210535, 7600.239976002355, 7689.307962283421, 7689.730859419893, 7691.077070751322, 8386.790330241793, 8579.571021449028, 8595.699150529701, 8664.176903194186, 8692.434991725771, 7582.203868593939, 7808.7657370278985, 7830.92169078302, 7860.6069696513805, 8125.959370203112, 7774.455788094779, 7778.338841198562, 7780.961095194488, 7971.3224375926375, 8001.279884810162, 7072.858542829217, 7298.927010729824, 7302.160251570925, 7307.634618269171, 7312.122545294599, 5286.577073834161, 5296.390915044819, 5327.094393953114, 5335.226392173191, 5433.8369848904595, 5338.1458966566715, 5368.114261146867, 5394.136938090044, 5478.698671573102, 5536.169574563848], "value": 4672.884172856045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.65370729108037, 338.42805658437237, 342.6025810060329, 344.77761843610887, 348.1817728338405, 5346.572274218068, 5380.865478363038, 5400.810971615994, 5405.756740946657, 5416.593755468336, 5269.314989051418, 5325.573954083674, 5344.0, 5366.275552800371, 5378.435264297251, 4001.859470051036, 4203.348480985437, 4204.56418478505, 4230.646193218156, 4233.809478573472, 3996.2407142642805, 4063.2076745034583, 4079.3065178919505, 4200.747955122687, 4220.894477638053, 4139.81370838313, 4155.127423241123, 4156.937645935313, 4173.64524015459, 4177.289860723669, 4005.439238506611, 4173.582641735818, 4174.853880114197, 4196.265653510654, 4213.262679031188, 3492.755507114503, 3645.2527231917393, 3657.762245454037, 3672.3022625701033, 3699.112213068871, 5109.846704598868, 5117.411497677777, 5117.923231151536, 5182.274481572583, 5224.294720212799, 4719.4100737407825, 4811.350467686852, 4815.0, 4815.627546149331, 4838.225883858601, 5586.748596313176, 5596.636218645775, 5597.384287728347, 5603.319004298694, 5627.352854421753, 4064.9837540614844, 4067.7559346439307, 4072.4705788247634, 4077.734947228421, 4081.979420186997, 5523.861903452405, 5788.450097240798, 5802.970985145047, 5818.5345172386105, 5849.795257166022, 4098.467199264077, 4109.815058322382, 4109.856155034559, 4119.258533464005, 4121.196366708463, 4138.441310423054, 4139.937900931488, 4142.730722503027, 4163.647539140376, 4176.7076304658385, 4720.858374248778, 4746.359241502422, 4757.738324392122, 4763.571278584944, 4765.8570242892765, 5461.617686761889, 5619.269494965628, 5640.32316122068, 5658.009848276535, 5658.1426379678, 1409.3587417724912, 1429.1925062339744, 1432.5630682641686, 1445.7325394801994, 1448.3192899337294, 894.2511734025577, 922.2760133295465, 924.7688077980505, 926.6849271247808, 931.897491275959, 4869.659123861366, 4869.9269510957365, 5249.42256351801, 5331.4935081168005, 5441.727913604304, 5808.970955145197, 5823.883522329615, 5836.832633473237, 5839.678817665069, 5849.561282903799, 5448.42791506894, 5473.917891231635, 5477.616566840363, 5489.478499542537, 5519.006578815852, 2951.8081324713826, 3142.4186525492855, 3145.7640676949322, 3145.937081258362, 3147.5593416921647, 5943.31651860033, 5983.491403230687, 6029.246344206974, 6043.425874541911, 6076.422739839796, 5640.266765320482, 5928.7332070056955, 5942.61373010753, 5950.285965684146, 5976.701164941735, 5916.290045194604, 5920.342304154844, 5937.179839576167, 5952.166696662384, 5966.284045914518, 5633.324001119892, 5889.793857215148, 5890.823275301748, 5895.263092113486, 5919.437653422918, 5764.740586673526, 5775.9133612996675, 5784.248047753765, 5784.855378615568, 5795.971020144872, 5951.49412299942, 6021.126936594082, 6024.216851809237, 6024.740722229164, 6040.305364882919, 4059.5331536873637, 4258.1483703258855, 4272.530021697673, 4273.87178384649, 4287.828486860615, 5719.199312096393, 5752.303070594101, 5759.1649210865025, 5776.162456443876, 5826.41735826414, 5622.2128901954575, 5668.886622267614, 5673.4469488731065, 5717.485426311486, 5737.8565535861935, 5449.6730196188355, 5580.693061881636, 5608.270924779753, 5633.676086119676, 5638.971805140948, 5451.318585176853, 5514.0, 5528.695921724183, 5557.055300598827, 5558.499735023867, 5429.457054294539, 5528.502434780728, 5654.236678048411, 5677.432256774289, 5698.287714035746, 5535.280413546213, 5536.390996990247, 5545.778168873361, 5566.721663916869, 5580.581456390868], "value": 4292.806333243091, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1001922452748, 736.0357931110246, 772.9149793522715, 791.5171745235406, 849.689863199932, 15199.164045977466, 15447.227638618053, 15497.0, 15651.530454086367, 15859.999999999985, 14689.485867994623, 14880.553583392488, 14909.105453672788, 14910.776338354934, 14950.40198392063, 693.19935474527, 802.4864086984335, 811.5982588618642, 830.5722552885269, 834.0, 823.81875987283, 828.8218033122878, 829.0258945738763, 829.0300348592132, 831.0733532111682, 869.882565853608, 873.5064688451037, 874.1477059866611, 874.1564390363299, 874.9475031498131, 716.6846587501509, 824.3364091906013, 851.0553285852699, 870.0125357718971, 870.2037635563452, 626.5081910700125, 627.1282916745727, 627.2159800249688, 627.2191122053073, 627.2347735762363, 15048.021878577858, 15075.246237688181, 15128.848711512854, 15136.0, 15142.54572362831, 14101.858981410158, 14395.78406323906, 14432.92783536086, 14524.782128268085, 14622.488212912604, 13045.282509461977, 13095.083344165912, 13159.802602960868, 13205.603831885059, 13306.0, 4408.20652282589, 4468.620167285784, 4505.36924830524, 4525.524819893897, 4599.400599400599, 68179.3182068178, 69250.0, 69352.30647693509, 69546.65226673834, 69640.6517967412, 10939.453027348602, 10985.395803230898, 10988.780224395467, 11093.168012399103, 11225.831612525819, 20964.580708385747, 20980.895095524425, 21038.263660772107, 21076.0, 21124.155033798783, 8153.062397824207, 8153.510789352657, 8236.382271329674, 8470.280026197843, 8615.61229744663, 4796.2805579163405, 4835.95164048362, 4864.440589332272, 4876.707397556158, 4922.803087876517, 3367.5958884933475, 3502.649735026477, 3504.8773292934625, 3506.4214404622953, 3508.8771892983623, 602.099860708244, 616.3928530397554, 618.1809102938535, 620.5842085802523, 628.720219502317, 649.4057936987698, 670.1890712238246, 675.7263308360122, 685.5525772990476, 689.899964505154, 9243.39917905334, 9630.0, 9781.559829807533, 9790.363626364264, 9795.265355098254, 614.665007570875, 651.7067319706151, 682.737146198717, 693.6531734132933, 701.7684164225793, 4377.124575084996, 4510.255807791743, 5088.586630435289, 5304.549113325334, 5373.328333958255, 74209.0, 75751.62124189344, 120873.0, 122322.0, 126314.36842815726, 102811.0, 105828.0, 106239.0, 106952.46523767331, 108842.0, 92816.0, 95117.52441237749, 95764.0, 96711.0, 98562.0, 10055.19558435338, 10263.23025773085, 10407.375557466576, 10538.473076346305, 10577.576896924036, 48464.7576762114, 49615.25577116274, 50135.47425989051, 51228.0, 51518.0, 73203.0, 73289.0, 76113.6194319047, 79374.0, 80259.19740802517, 13116.83445329877, 13196.0, 13405.932970335087, 13623.046386753229, 13872.583822485341, 14333.396624261977, 14395.640108997359, 15159.545213643609, 15222.847771522143, 15273.694526109193, 14026.789598155832, 14195.64510887236, 14224.217668028357, 14224.79089277423, 14340.282985850874, 13994.0, 14086.788698169741, 14235.0, 14239.216843073731, 14430.567082987527, 13750.710985600606, 13848.09987350819, 13863.0, 13866.0, 14052.508162214273, 10494.212934029825, 10921.83617245726, 11029.22795404314, 11056.502457389275, 11206.43967801623, 10691.839622405825, 10898.50956706966, 11078.169137314573, 11458.4270786462, 11571.826422603835], "value": 7629.727928702793, "unit": "score"}], "name": "dromaeo_css", "value": 7351.878100063478, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 136.0, 127.0, 196.0, 129.0, 135.0, 158.0, 129.0, 161.0, 127.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 124.0, 73.0, 75.0, 74.0, 76.0, 108.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 84.0, 84.0, 85.0, 119.0, 85.0, 85.0, 122.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.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": [55.0, 52.0, 53.0, 53.0, 52.0, 54.0, 52.0, 53.0, 54.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 71.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 80.0, 86.0, 81.0, 80.0, 112.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 120.0, 120.0, 135.0, 125.0, 122.0, 128.0, 127.0, 122.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 157.0, 162.0, 160.0, 164.0, 157.0, 155.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 62.0, 64.0, 62.0, 62.0, 62.0, 63.0, 60.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1499.5, "alertThreshold": 2.0}]} 17:24:01 INFO - Return code: 0 17:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:24:01 ERROR - # TBPL SUCCESS # 17:24:01 INFO - Running post-action listener: _resource_record_post_action 17:24:01 INFO - ##### 17:24:01 INFO - ##### Finished run-tests step (success) 17:24:01 INFO - ##### 17:24:01 INFO - Running post-run listener: _resource_record_post_run 17:24:02 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300253184; Read time: 12; Write time: 346336 17:24:02 INFO - TinderboxPrint: CPU usage
13.1% 17:24:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:24:02 INFO - TinderboxPrint: I/O write bytes / time
300,253,184 / 346,336 17:24:02 INFO - TinderboxPrint: CPU idle
8,263.6 (86.9%) 17:24:02 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 17:24:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:24:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 11403264; Read time: 0; Write time: 7840 17:24:02 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288067584; Read time: 12; Write time: 338252 17:24:02 INFO - Running post-run listener: _upload_blobber_files 17:24:02 INFO - Blob upload gear active. 17:24:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:24:02 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 17:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:03 INFO - (blobuploader) - INFO - Done attempting. 17:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:04 INFO - (blobuploader) - INFO - Done attempting. 17:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:07 INFO - (blobuploader) - INFO - Done attempting. 17:24:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:07 INFO - Return code: 0 17:24:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:24:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb720fdfbb1cdc25011c1b5128044fed3d9cf5326ebdb41a8dcc39e68082b8f3f20e42c2e95d53e45e2253c4d39cda5400c5c9c3264e7802f9a7ac0bd885c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a06825acdc58fbaff0133da691f332f88b3c5b25f616dd07fec1ca832c7e8b74cf1b75a30597d1513222e423173c8a6f2261a23e338a8540947b7d055ec167f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4ba1952423b841ec8d99797d4fa3dee90add1a9615317bb82d33f243ed7a873b47ba46def6ebc7764041e8dd09a5eb114d16ba9f0344bcdfe2d818a6938ef7"} 17:24:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:24:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:24:07 INFO - Contents: 17:24:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb720fdfbb1cdc25011c1b5128044fed3d9cf5326ebdb41a8dcc39e68082b8f3f20e42c2e95d53e45e2253c4d39cda5400c5c9c3264e7802f9a7ac0bd885c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a06825acdc58fbaff0133da691f332f88b3c5b25f616dd07fec1ca832c7e8b74cf1b75a30597d1513222e423173c8a6f2261a23e338a8540947b7d055ec167f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4ba1952423b841ec8d99797d4fa3dee90add1a9615317bb82d33f243ed7a873b47ba46def6ebc7764041e8dd09a5eb114d16ba9f0344bcdfe2d818a6938ef7"} 17:24:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:24:07 INFO - Copying logs to upload dir... 17:24:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:24:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.358188 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-05 17:24:07.934985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 17:24:07.940134) ========= 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=62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb720fdfbb1cdc25011c1b5128044fed3d9cf5326ebdb41a8dcc39e68082b8f3f20e42c2e95d53e45e2253c4d39cda5400c5c9c3264e7802f9a7ac0bd885c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a06825acdc58fbaff0133da691f332f88b3c5b25f616dd07fec1ca832c7e8b74cf1b75a30597d1513222e423173c8a6f2261a23e338a8540947b7d055ec167f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4ba1952423b841ec8d99797d4fa3dee90add1a9615317bb82d33f243ed7a873b47ba46def6ebc7764041e8dd09a5eb114d16ba9f0344bcdfe2d818a6938ef7"} build_url:https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb720fdfbb1cdc25011c1b5128044fed3d9cf5326ebdb41a8dcc39e68082b8f3f20e42c2e95d53e45e2253c4d39cda5400c5c9c3264e7802f9a7ac0bd885c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a06825acdc58fbaff0133da691f332f88b3c5b25f616dd07fec1ca832c7e8b74cf1b75a30597d1513222e423173c8a6f2261a23e338a8540947b7d055ec167f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4ba1952423b841ec8d99797d4fa3dee90add1a9615317bb82d33f243ed7a873b47ba46def6ebc7764041e8dd09a5eb114d16ba9f0344bcdfe2d818a6938ef7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 17:24:07.973557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:24:07.973923) ========= 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=62c568580acbfdaac3eec7be000001dc-1465170228.92948-1642147309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:24:08.058365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 17:24:08.058885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 17:24:08.059286) ========= ========= Total master_lag: 0.44 =========