builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1465549222.99 results: success (0) buildid: 20160609233020 builduid: c9743ed94240451ebe26dc53e13c6d72 revision: ff9fd611d818116cfd47ee7d067c2642368cf3f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:22.990956) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:22.991343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:22.991643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.051255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.051547) ========= 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=ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 02:00:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.6M=0.001s 2016-06-10 02:00:23 (19.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.176990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.177273) ========= 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=ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015207 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.226247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.226626) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff9fd611d818116cfd47ee7d067c2642368cf3f9 --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 ff9fd611d818116cfd47ee7d067c2642368cf3f9 --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=ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 02:00:23,539 truncating revision to first 12 chars 2016-06-10 02:00:23,539 Setting DEBUG logging. 2016-06-10 02:00:23,539 attempt 1/10 2016-06-10 02:00:23,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff9fd611d818?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 02:00:23,909 unpacking tar archive at: fx-team-ff9fd611d818/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716151 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.957872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.958318) ========= script_repo_revision: ff9fd611d818116cfd47ee7d067c2642368cf3f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.958835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.959236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 02:00:23.969938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-10 02:00:23.970208) ========= /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=ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:00:24 INFO - MultiFileLogger online at 20160610 02:00:24 in /builds/slave/test 02:00:24 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 02:00:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:00:24 INFO - {'append_to_log': False, 02:00:24 INFO - 'base_work_dir': '/builds/slave/test', 02:00:24 INFO - 'blob_upload_branch': 'Fx-Team', 02:00:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:00:24 INFO - 'branch': 'Fx-Team', 02:00:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:00:24 INFO - 'config_files': ('talos/linux_config.py',), 02:00:24 INFO - 'default_actions': ('clobber', 02:00:24 INFO - 'read-buildbot-config', 02:00:24 INFO - 'download-and-extract', 02:00:24 INFO - 'populate-webroot', 02:00:24 INFO - 'create-virtualenv', 02:00:24 INFO - 'install', 02:00:24 INFO - 'run-tests'), 02:00:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:00:24 INFO - 'download_minidump_stackwalk': True, 02:00:24 INFO - 'download_symbols': 'ondemand', 02:00:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:00:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:00:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:00:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:00:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:00:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:00:24 INFO - 'installer_path': 'installer.exe', 02:00:24 INFO - 'log_level': 'info', 02:00:24 INFO - 'log_name': 'talos', 02:00:24 INFO - 'log_to_console': True, 02:00:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:00:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:00:24 INFO - 'opt_config_files': (), 02:00:24 INFO - 'pip_index': False, 02:00:24 INFO - 'sps_profile': False, 02:00:24 INFO - 'sps_profile_interval': 0, 02:00:24 INFO - 'suite': 'dromaeojs', 02:00:24 INFO - 'system_bits': '32', 02:00:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:00:24 INFO - 'title': 'talos-linux64-ix-035', 02:00:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:00:24 INFO - 'use_talos_json': True, 02:00:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:00:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:00:24 INFO - 'work_dir': 'build'} 02:00:24 INFO - ##### 02:00:24 INFO - ##### Running clobber step. 02:00:24 INFO - ##### 02:00:24 INFO - Running pre-action listener: _resource_record_pre_action 02:00:24 INFO - Running main action method: clobber 02:00:24 INFO - rmtree: /builds/slave/test/build 02:00:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:00:24 INFO - Running post-action listener: _resource_record_post_action 02:00:24 INFO - ##### 02:00:24 INFO - ##### Finished clobber step (success) 02:00:24 INFO - ##### 02:00:24 INFO - ##### 02:00:24 INFO - ##### Running read-buildbot-config step. 02:00:24 INFO - ##### 02:00:24 INFO - Running pre-action listener: _resource_record_pre_action 02:00:24 INFO - Running main action method: read_buildbot_config 02:00:24 INFO - Using buildbot properties: 02:00:24 INFO - { 02:00:24 INFO - "project": "", 02:00:24 INFO - "product": "firefox", 02:00:24 INFO - "script_repo_revision": "production", 02:00:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:00:24 INFO - "repository": "", 02:00:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:00:24 INFO - "buildid": "20160609233020", 02:00:24 INFO - "pgo_build": "True", 02:00:24 INFO - "basedir": "/builds/slave/test", 02:00:24 INFO - "buildnumber": 176, 02:00:24 INFO - "slavename": "talos-linux64-ix-035", 02:00:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:00:24 INFO - "platform": "ubuntu64_hw", 02:00:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:00:24 INFO - "branch": "fx-team", 02:00:24 INFO - "repo_path": "integration/fx-team", 02:00:24 INFO - "revision": "ff9fd611d818116cfd47ee7d067c2642368cf3f9", 02:00:24 INFO - "stage_platform": "linux64-pgo", 02:00:24 INFO - "builduid": "c9743ed94240451ebe26dc53e13c6d72", 02:00:24 INFO - "slavebuilddir": "test" 02:00:24 INFO - } 02:00:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:00:24 INFO - Running post-action listener: _resource_record_post_action 02:00:24 INFO - ##### 02:00:24 INFO - ##### Finished read-buildbot-config step (success) 02:00:24 INFO - ##### 02:00:24 INFO - ##### 02:00:24 INFO - ##### Running download-and-extract step. 02:00:24 INFO - ##### 02:00:24 INFO - Running pre-action listener: _resource_record_pre_action 02:00:24 INFO - Running main action method: download_and_extract 02:00:24 INFO - mkdir: /builds/slave/test/build/tests 02:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:24 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:00:27 INFO - Downloaded 1361 bytes. 02:00:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:00:27 INFO - Using the following test package requirements: 02:00:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:00:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:00:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:00:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'jsshell-linux-x86_64.zip'], 02:00:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:00:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:00:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:00:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:00:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:00:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:00:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:27 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:00:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:00:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:00:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:00:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:00:28 INFO - Downloaded 24452446 bytes. 02:00:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:00:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:00:29 INFO - Return code: 0 02:00:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:29 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:00:37 INFO - Downloaded 24452446 bytes. 02:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:00:39 INFO - Return code: 0 02:00: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')]} 02:00:39 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:00:40 INFO - Downloaded 10833377 bytes. 02:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:00:40 INFO - Return code: 0 02:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:40 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:00:42 INFO - Downloaded 59304052 bytes. 02:00:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:00:42 INFO - mkdir: /builds/slave/test/properties 02:00:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:00:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:00:42 INFO - Contents: 02:00:42 INFO - build_url:https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:00:42 INFO - Running post-action listener: _resource_record_post_action 02:00:42 INFO - Running post-action listener: set_extra_try_arguments 02:00:42 INFO - ##### 02:00:42 INFO - ##### Finished download-and-extract step (success) 02:00:42 INFO - ##### 02:00:42 INFO - ##### 02:00:42 INFO - ##### Running populate-webroot step. 02:00:42 INFO - ##### 02:00:42 INFO - Running pre-action listener: _resource_record_pre_action 02:00:42 INFO - Running main action method: populate_webroot 02:00:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:42 INFO - '--tppagecycles', 02:00:42 INFO - '7'], 02:00:42 INFO - 'tests': ['tsvgm']}}, 02:00:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['damp', 'tps']}, 02:00:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'tests': ['damp', 'tps']}, 02:00:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['dromaeo_dom']}, 02:00:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['a11yr', 02:00:42 INFO - 'ts_paint', 02:00:42 INFO - 'tpaint', 02:00:42 INFO - 'sessionrestore', 02:00:42 INFO - 'sessionrestore_no_auto_restore', 02:00:42 INFO - 'tabpaint']}, 02:00:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:42 INFO - 'ts_paint', 02:00:42 INFO - 'tpaint', 02:00:42 INFO - 'sessionrestore', 02:00:42 INFO - 'sessionrestore_no_auto_restore', 02:00:42 INFO - 'tabpaint']}, 02:00:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:42 INFO - 'ts_paint', 02:00:42 INFO - 'tpaint', 02:00:42 INFO - 'sessionrestore', 02:00:42 INFO - 'sessionrestore_no_auto_restore', 02:00:42 INFO - 'tabpaint']}, 02:00:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:42 INFO - 'ts_paint', 02:00:42 INFO - 'tpaint', 02:00:42 INFO - 'sessionrestore', 02:00:42 INFO - 'sessionrestore_no_auto_restore', 02:00:42 INFO - 'tabpaint']}, 02:00:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['a11yr', 02:00:42 INFO - 'ts_paint', 02:00:42 INFO - 'tpaint', 02:00:42 INFO - 'sessionrestore', 02:00:42 INFO - 'sessionrestore_no_auto_restore', 02:00:42 INFO - 'tabpaint']}, 02:00:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['a11yr', 02:00:42 INFO - 'ts_paint', 02:00:42 INFO - 'tpaint', 02:00:42 INFO - 'sessionrestore', 02:00:42 INFO - 'sessionrestore_no_auto_restore', 02:00:42 INFO - 'tabpaint']}, 02:00:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['tsvgx', 02:00:42 INFO - 'tsvgr_opacity', 02:00:42 INFO - 'tart', 02:00:42 INFO - 'tscrollx', 02:00:42 INFO - 'cart']}, 02:00:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:42 INFO - 'tsvgr_opacity', 02:00:42 INFO - 'tart', 02:00:42 INFO - 'tscrollx', 02:00:42 INFO - 'cart']}, 02:00:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'talos_options': ['--disable-e10s'], 02:00:42 INFO - 'tests': ['tp5o']}, 02:00:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'tests': ['tp5o']}, 02:00:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'talos_options': ['--disable-e10s', 02:00:42 INFO - '--xperf_path', 02:00:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:42 INFO - 'tests': ['tp5n']}, 02:00:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:42 INFO - 'talos_options': ['--xperf_path', 02:00:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:42 INFO - 'tests': ['tp5n']}}, 02:00:42 INFO - 'talos.zip': {'path': '', 02:00:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:42 INFO - Running post-action listener: _resource_record_post_action 02:00:42 INFO - ##### 02:00:42 INFO - ##### Finished populate-webroot step (success) 02:00:42 INFO - ##### 02:00:42 INFO - ##### 02:00:42 INFO - ##### Running create-virtualenv step. 02:00:42 INFO - ##### 02:00:42 INFO - Running pre-action listener: _resource_record_pre_action 02:00:42 INFO - Running main action method: create_virtualenv 02:00:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:42 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 02:00:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:42 INFO - Using real prefix '/usr' 02:00:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:45 INFO - Installing pip.................done. 02:00:45 INFO - Return code: 0 02:00:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00:45 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')]} 02:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:45 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')]} 02:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:45 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:00:45 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 02:00:45 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 02:00:45 INFO - Using env: {'DISPLAY': ':0', 02:00:45 INFO - 'HOME': '/home/cltbld', 02:00:45 INFO - 'LANG': 'en_US.UTF-8', 02:00:45 INFO - 'LANGUAGE': 'en_US:en', 02:00:45 INFO - 'LOGNAME': 'cltbld', 02:00:45 INFO - 'MAIL': '/var/mail/cltbld', 02:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:45 INFO - 'MOZ_NO_REMOTE': '1', 02:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:45 INFO - 'NO_EM_RESTART': '1', 02:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:45 INFO - 'PWD': '/builds/slave/test', 02:00:45 INFO - 'SHELL': '/bin/bash', 02:00:45 INFO - 'SHLVL': '1', 02:00:45 INFO - 'TERM': 'linux', 02:00:45 INFO - 'TMOUT': '86400', 02:00:45 INFO - 'USER': 'cltbld', 02:00:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:45 INFO - '_': '/tools/buildbot/bin/python'} 02:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:45 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 02:00:45 INFO - Cleaning up... 02:00:45 INFO - Return code: 0 02:00:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:00:45 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')]} 02:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:45 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')]} 02:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:45 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:00:45 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 02:00:45 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 02:00:45 INFO - Using env: {'DISPLAY': ':0', 02:00:45 INFO - 'HOME': '/home/cltbld', 02:00:45 INFO - 'LANG': 'en_US.UTF-8', 02:00:45 INFO - 'LANGUAGE': 'en_US:en', 02:00:45 INFO - 'LOGNAME': 'cltbld', 02:00:45 INFO - 'MAIL': '/var/mail/cltbld', 02:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:45 INFO - 'MOZ_NO_REMOTE': '1', 02:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:45 INFO - 'NO_EM_RESTART': '1', 02:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:45 INFO - 'PWD': '/builds/slave/test', 02:00:45 INFO - 'SHELL': '/bin/bash', 02:00:45 INFO - 'SHLVL': '1', 02:00:45 INFO - 'TERM': 'linux', 02:00:45 INFO - 'TMOUT': '86400', 02:00:45 INFO - 'USER': 'cltbld', 02:00:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:45 INFO - '_': '/tools/buildbot/bin/python'} 02:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:45 INFO - Downloading/unpacking psutil>=3.1.1 02:00:45 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 02:00:45 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 02:00:45 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 02:00:45 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 02:00:45 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 02:00:45 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 02:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:47 INFO - Installing collected packages: psutil 02:00:47 INFO - Running setup.py install for psutil 02:00:47 INFO - building 'psutil._psutil_linux' extension 02:00:47 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 02:00:48 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 02:00:48 INFO - building 'psutil._psutil_posix' extension 02:00:48 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 02:00:48 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 02:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:48 INFO - Successfully installed psutil 02:00:48 INFO - Cleaning up... 02:00:48 INFO - Return code: 0 02:00:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:00:48 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')]} 02:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:48 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')]} 02:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:48 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:00:48 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 02:00:48 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 02:00:48 INFO - Using env: {'DISPLAY': ':0', 02:00:48 INFO - 'HOME': '/home/cltbld', 02:00:48 INFO - 'LANG': 'en_US.UTF-8', 02:00:48 INFO - 'LANGUAGE': 'en_US:en', 02:00:48 INFO - 'LOGNAME': 'cltbld', 02:00:48 INFO - 'MAIL': '/var/mail/cltbld', 02:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:48 INFO - 'MOZ_NO_REMOTE': '1', 02:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:48 INFO - 'NO_EM_RESTART': '1', 02:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:48 INFO - 'PWD': '/builds/slave/test', 02:00:48 INFO - 'SHELL': '/bin/bash', 02:00:48 INFO - 'SHLVL': '1', 02:00:48 INFO - 'TERM': 'linux', 02:00:48 INFO - 'TMOUT': '86400', 02:00:48 INFO - 'USER': 'cltbld', 02:00:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:48 INFO - '_': '/tools/buildbot/bin/python'} 02:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:00:48 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 02:00:48 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 02:00:48 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 02:00:48 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 02:00:48 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 02:00:48 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 02:00:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:00:50 INFO - Installing collected packages: mozsystemmonitor 02:00:50 INFO - Running setup.py install for mozsystemmonitor 02:00:50 INFO - Successfully installed mozsystemmonitor 02:00:50 INFO - Cleaning up... 02:00:50 INFO - Return code: 0 02:00:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:00:50 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 02:00:50 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 02:00:50 INFO - Using env: {'DISPLAY': ':0', 02:00:50 INFO - 'HOME': '/home/cltbld', 02:00:50 INFO - 'LANG': 'en_US.UTF-8', 02:00:50 INFO - 'LANGUAGE': 'en_US:en', 02:00:50 INFO - 'LOGNAME': 'cltbld', 02:00:50 INFO - 'MAIL': '/var/mail/cltbld', 02:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:50 INFO - 'MOZ_NO_REMOTE': '1', 02:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:50 INFO - 'NO_EM_RESTART': '1', 02:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:50 INFO - 'PWD': '/builds/slave/test', 02:00:50 INFO - 'SHELL': '/bin/bash', 02:00:50 INFO - 'SHLVL': '1', 02:00:50 INFO - 'TERM': 'linux', 02:00:50 INFO - 'TMOUT': '86400', 02:00:50 INFO - 'USER': 'cltbld', 02:00:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:50 INFO - '_': '/tools/buildbot/bin/python'} 02:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:50 INFO - Downloading/unpacking jsonschema==2.5.1 02:00:50 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 02:00:50 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 02:00:50 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 02:00:50 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 02:00:50 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 02:00:50 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 02:00:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 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 02:00:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:53 INFO - warning: no files found matching '*.txt' 02:00:53 INFO - no previously-included directories found matching 'build' 02:00:53 INFO - no previously-included directories found matching 'dist' 02:00:53 INFO - no previously-included directories found matching '.git*' 02:00:53 INFO - Installing collected packages: jsonschema, functools32 02:00:53 INFO - Running setup.py install for functools32 02:00:53 INFO - warning: no files found matching '*.txt' 02:00:53 INFO - no previously-included directories found matching 'build' 02:00:53 INFO - no previously-included directories found matching 'dist' 02:00:53 INFO - no previously-included directories found matching '.git*' 02:00:53 INFO - Successfully installed jsonschema functools32 02:00:53 INFO - Cleaning up... 02:00:53 INFO - Return code: 0 02:00:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:53 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:00:53 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 02:00:53 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 02:00:53 INFO - Using env: {'DISPLAY': ':0', 02:00:53 INFO - 'HOME': '/home/cltbld', 02:00:53 INFO - 'LANG': 'en_US.UTF-8', 02:00:53 INFO - 'LANGUAGE': 'en_US:en', 02:00:53 INFO - 'LOGNAME': 'cltbld', 02:00:53 INFO - 'MAIL': '/var/mail/cltbld', 02:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:53 INFO - 'MOZ_NO_REMOTE': '1', 02:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:53 INFO - 'NO_EM_RESTART': '1', 02:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:53 INFO - 'PWD': '/builds/slave/test', 02:00:53 INFO - 'SHELL': '/bin/bash', 02:00:53 INFO - 'SHLVL': '1', 02:00:53 INFO - 'TERM': 'linux', 02:00:53 INFO - 'TMOUT': '86400', 02:00:53 INFO - 'USER': 'cltbld', 02:00:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:53 INFO - '_': '/tools/buildbot/bin/python'} 02:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:00:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:56 INFO - Downloading docopt-0.6.1.tar.gz 02:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:56 INFO - Running setup.py install for blobuploader 02:00:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:00:56 INFO - Running setup.py install for requests 02:00:56 INFO - Running setup.py install for docopt 02:00:56 INFO - Successfully installed blobuploader requests docopt 02:00:56 INFO - Cleaning up... 02:00:56 INFO - Return code: 0 02:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:56 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:00:56 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 02:00:56 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 02:00:56 INFO - Using env: {'DISPLAY': ':0', 02:00:56 INFO - 'HOME': '/home/cltbld', 02:00:56 INFO - 'LANG': 'en_US.UTF-8', 02:00:56 INFO - 'LANGUAGE': 'en_US:en', 02:00:56 INFO - 'LOGNAME': 'cltbld', 02:00:56 INFO - 'MAIL': '/var/mail/cltbld', 02:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:56 INFO - 'MOZ_NO_REMOTE': '1', 02:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:56 INFO - 'NO_EM_RESTART': '1', 02:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:56 INFO - 'PWD': '/builds/slave/test', 02:00:56 INFO - 'SHELL': '/bin/bash', 02:00:56 INFO - 'SHLVL': '1', 02:00:56 INFO - 'TERM': 'linux', 02:00:56 INFO - 'TMOUT': '86400', 02:00:56 INFO - 'USER': 'cltbld', 02:00:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:56 INFO - '_': '/tools/buildbot/bin/python'} 02:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:57 INFO - Running setup.py (path:/tmp/pip-XXm0_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:57 INFO - Running setup.py (path:/tmp/pip-GkzpP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:57 INFO - Running setup.py (path:/tmp/pip-oNp9Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:57 INFO - Running setup.py (path:/tmp/pip-mX5HgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:57 INFO - Running setup.py (path:/tmp/pip-tBYEgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:57 INFO - Running setup.py (path:/tmp/pip-3h5irf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:57 INFO - Running setup.py (path:/tmp/pip-M_VSxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:57 INFO - Running setup.py (path:/tmp/pip-RTK40G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:57 INFO - Running setup.py (path:/tmp/pip-SGLQ1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:57 INFO - Running setup.py (path:/tmp/pip-DeuTKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:57 INFO - Running setup.py (path:/tmp/pip-PesNoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:57 INFO - Running setup.py (path:/tmp/pip-RdPrNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:57 INFO - Running setup.py (path:/tmp/pip-3BzzB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:57 INFO - Running setup.py (path:/tmp/pip-fMCU5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:58 INFO - Running setup.py (path:/tmp/pip-HoxjSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:58 INFO - Running setup.py (path:/tmp/pip-mG5l1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:58 INFO - Running setup.py (path:/tmp/pip-2f29yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:58 INFO - Running setup.py install for manifestparser 02:00:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:00:58 INFO - Running setup.py install for mozcrash 02:00:58 INFO - Running setup.py install for mozdebug 02:00:58 INFO - Running setup.py install for mozdevice 02:00:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:00:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:00:58 INFO - Running setup.py install for mozfile 02:00:58 INFO - Running setup.py install for mozhttpd 02:00:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:00:58 INFO - Running setup.py install for mozinfo 02:00:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:00:58 INFO - Running setup.py install for mozInstall 02:00:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Running setup.py install for mozleak 02:00:59 INFO - Running setup.py install for mozlog 02:00:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Running setup.py install for moznetwork 02:00:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Running setup.py install for mozprocess 02:00:59 INFO - Running setup.py install for mozprofile 02:00:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Running setup.py install for mozrunner 02:00:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Running setup.py install for mozscreenshot 02:00:59 INFO - Running setup.py install for moztest 02:00:59 INFO - Running setup.py install for mozversion 02:00:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:59 INFO - Cleaning up... 02:01:00 INFO - Return code: 0 02:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:00 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:01:00 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 02:01:00 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 02:01:00 INFO - Using env: {'DISPLAY': ':0', 02:01:00 INFO - 'HOME': '/home/cltbld', 02:01:00 INFO - 'LANG': 'en_US.UTF-8', 02:01:00 INFO - 'LANGUAGE': 'en_US:en', 02:01:00 INFO - 'LOGNAME': 'cltbld', 02:01:00 INFO - 'MAIL': '/var/mail/cltbld', 02:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:00 INFO - 'MOZ_NO_REMOTE': '1', 02:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:00 INFO - 'NO_EM_RESTART': '1', 02:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:00 INFO - 'PWD': '/builds/slave/test', 02:01:00 INFO - 'SHELL': '/bin/bash', 02:01:00 INFO - 'SHLVL': '1', 02:01:00 INFO - 'TERM': 'linux', 02:01:00 INFO - 'TMOUT': '86400', 02:01:00 INFO - 'USER': 'cltbld', 02:01:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:00 INFO - '_': '/tools/buildbot/bin/python'} 02:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:00 INFO - Running setup.py (path:/tmp/pip-uw1jKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:00 INFO - Running setup.py (path:/tmp/pip-hnJzN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:00 INFO - Running setup.py (path:/tmp/pip-pTGUkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:00 INFO - Running setup.py (path:/tmp/pip-91UDOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:00 INFO - Running setup.py (path:/tmp/pip-hAvMJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:00 INFO - Running setup.py (path:/tmp/pip-9qiKKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:00 INFO - Running setup.py (path:/tmp/pip-m1cHlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:00 INFO - Running setup.py (path:/tmp/pip-7shQUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:00 INFO - Running setup.py (path:/tmp/pip-fqQisI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:00 INFO - Running setup.py (path:/tmp/pip-omYhmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:00 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)) 02:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:00 INFO - Running setup.py (path:/tmp/pip-zRhXb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:01 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)) 02:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:01 INFO - Running setup.py (path:/tmp/pip-plYRmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:01 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)) 02:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:01 INFO - Running setup.py (path:/tmp/pip-nHjOL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:01 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)) 02:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:01 INFO - Running setup.py (path:/tmp/pip-zUs6cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:01 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)) 02:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:01 INFO - Running setup.py (path:/tmp/pip-5y2IZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:01 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)) 02:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:01 INFO - Running setup.py (path:/tmp/pip-R6XsH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:01 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)) 02:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:01 INFO - Running setup.py (path:/tmp/pip-1a7rz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:01 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)) 02:01:01 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)) 02:01:01 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)) 02:01:01 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)) 02:01:01 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)) 02:01:01 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)) 02:01:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:01:01 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 02:01:01 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 02:01:01 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 02:01:01 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 02:01:01 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 02:01:01 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 02:01:03 INFO - Downloading blessings-1.6.tar.gz 02:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:01:03 INFO - Installing collected packages: blessings 02:01:03 INFO - Running setup.py install for blessings 02:01:03 INFO - Successfully installed blessings 02:01:03 INFO - Cleaning up... 02:01:03 INFO - Return code: 0 02:01:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:03 INFO - Reading from file tmpfile_stdout 02:01:03 INFO - Current package versions: 02:01:03 INFO - argparse == 1.2.1 02:01:03 INFO - blessings == 1.6 02:01:03 INFO - blobuploader == 1.2.4 02:01:03 INFO - docopt == 0.6.1 02:01:03 INFO - functools32 == 3.2.3-2 02:01:03 INFO - jsonschema == 2.5.1 02:01:03 INFO - manifestparser == 1.1 02:01:03 INFO - mozInstall == 1.12 02:01:03 INFO - mozcrash == 0.17 02:01:03 INFO - mozdebug == 0.1 02:01:03 INFO - mozdevice == 0.48 02:01:03 INFO - mozfile == 1.2 02:01:03 INFO - mozhttpd == 0.7 02:01:03 INFO - mozinfo == 0.9 02:01:03 INFO - mozleak == 0.1 02:01:03 INFO - mozlog == 3.2 02:01:03 INFO - moznetwork == 0.27 02:01:03 INFO - mozprocess == 0.22 02:01:03 INFO - mozprofile == 0.28 02:01:03 INFO - mozrunner == 6.11 02:01:03 INFO - mozscreenshot == 0.1 02:01:03 INFO - mozsystemmonitor == 0.3 02:01:03 INFO - moztest == 0.7 02:01:03 INFO - mozversion == 1.4 02:01:03 INFO - psutil == 3.1.1 02:01:03 INFO - requests == 1.2.3 02:01:03 INFO - wsgiref == 0.1.2 02:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:03 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')]} 02:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:03 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')]} 02:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:03 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:01:03 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 02:01:03 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 02:01:03 INFO - Using env: {'DISPLAY': ':0', 02:01:03 INFO - 'HOME': '/home/cltbld', 02:01:03 INFO - 'LANG': 'en_US.UTF-8', 02:01:03 INFO - 'LANGUAGE': 'en_US:en', 02:01:03 INFO - 'LOGNAME': 'cltbld', 02:01:03 INFO - 'MAIL': '/var/mail/cltbld', 02:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:03 INFO - 'MOZ_NO_REMOTE': '1', 02:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:03 INFO - 'NO_EM_RESTART': '1', 02:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:03 INFO - 'PWD': '/builds/slave/test', 02:01:03 INFO - 'SHELL': '/bin/bash', 02:01:03 INFO - 'SHLVL': '1', 02:01:03 INFO - 'TERM': 'linux', 02:01:03 INFO - 'TMOUT': '86400', 02:01:03 INFO - 'USER': 'cltbld', 02:01:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:03 INFO - '_': '/tools/buildbot/bin/python'} 02:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 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)) 02:01:04 INFO - Cleaning up... 02:01:04 INFO - Return code: 0 02:01:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:01:04 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')]} 02:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:04 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')]} 02:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:04 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:01:04 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 02:01:04 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 02:01:04 INFO - Using env: {'DISPLAY': ':0', 02:01:04 INFO - 'HOME': '/home/cltbld', 02:01:04 INFO - 'LANG': 'en_US.UTF-8', 02:01:04 INFO - 'LANGUAGE': 'en_US:en', 02:01:04 INFO - 'LOGNAME': 'cltbld', 02:01:04 INFO - 'MAIL': '/var/mail/cltbld', 02:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:04 INFO - 'MOZ_NO_REMOTE': '1', 02:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:04 INFO - 'NO_EM_RESTART': '1', 02:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:04 INFO - 'PWD': '/builds/slave/test', 02:01:04 INFO - 'SHELL': '/bin/bash', 02:01:04 INFO - 'SHLVL': '1', 02:01:04 INFO - 'TERM': 'linux', 02:01:04 INFO - 'TMOUT': '86400', 02:01:04 INFO - 'USER': 'cltbld', 02:01:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:04 INFO - '_': '/tools/buildbot/bin/python'} 02:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:01:04 INFO - Cleaning up... 02:01:04 INFO - Return code: 0 02:01:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:01:04 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')]} 02:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:04 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')]} 02:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:04 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 0x7ff6cf533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', '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 02:01:04 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 02:01:04 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 02:01:04 INFO - Using env: {'DISPLAY': ':0', 02:01:04 INFO - 'HOME': '/home/cltbld', 02:01:04 INFO - 'LANG': 'en_US.UTF-8', 02:01:04 INFO - 'LANGUAGE': 'en_US:en', 02:01:04 INFO - 'LOGNAME': 'cltbld', 02:01:04 INFO - 'MAIL': '/var/mail/cltbld', 02:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:04 INFO - 'MOZ_NO_REMOTE': '1', 02:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:04 INFO - 'NO_EM_RESTART': '1', 02:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:04 INFO - 'PWD': '/builds/slave/test', 02:01:04 INFO - 'SHELL': '/bin/bash', 02:01:04 INFO - 'SHLVL': '1', 02:01:04 INFO - 'TERM': 'linux', 02:01:04 INFO - 'TMOUT': '86400', 02:01:04 INFO - 'USER': 'cltbld', 02:01:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:04 INFO - '_': '/tools/buildbot/bin/python'} 02:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:04 INFO - Downloading/unpacking flake8 02:01:04 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 02:01:04 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 02:01:04 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 02:01:04 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 02:01:04 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 02:01:04 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 02:01:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:01:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:01:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:01:07 INFO - no previously-included directories found matching 'docs/_build' 02:01:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:01:07 INFO - Running setup.py install for pep8 02:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:01:07 INFO - no previously-included directories found matching 'docs/_build' 02:01:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:01:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:01:07 INFO - Cleaning up... 02:01:07 INFO - Return code: 0 02:01:07 INFO - Running post-action listener: _resource_record_post_action 02:01:07 INFO - Running post-action listener: _start_resource_monitoring 02:01:07 INFO - Starting resource monitoring. 02:01:07 INFO - ##### 02:01:07 INFO - ##### Finished create-virtualenv step (success) 02:01:07 INFO - ##### 02:01:07 INFO - ##### 02:01:07 INFO - ##### Running install step. 02:01:07 INFO - ##### 02:01:07 INFO - Running pre-action listener: _resource_record_pre_action 02:01:07 INFO - Running main action method: install 02:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:07 INFO - Reading from file tmpfile_stdout 02:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:01:07 INFO - Reading from file tmpfile_stdout 02:01:07 INFO - Output received: 02:01:07 INFO - Usage: mozinstall [options] installer 02:01:07 INFO - Options: 02:01:07 INFO - -h, --help show this help message and exit 02:01:07 INFO - -d DEST, --destination=DEST 02:01:07 INFO - Directory to install application into. [default: 02:01:07 INFO - "/builds/slave/test"] 02:01:07 INFO - --app=APP Application being installed. [default: firefox] 02:01:07 INFO - mkdir: /builds/slave/test/build/application 02:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:01:24 INFO - Reading from file tmpfile_stdout 02:01:24 INFO - Output received: 02:01:24 INFO - /builds/slave/test/build/application/firefox/firefox 02:01:24 INFO - Running post-action listener: _resource_record_post_action 02:01:24 INFO - ##### 02:01:24 INFO - ##### Finished install step (success) 02:01:24 INFO - ##### 02:01:24 INFO - ##### 02:01:24 INFO - ##### Running run-tests step. 02:01:24 INFO - ##### 02:01:24 INFO - Running pre-action listener: _resource_record_pre_action 02:01:24 INFO - Running main action method: run_tests 02:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:01:24 INFO - Python 2.7.3 02:01:24 INFO - Return code: 0 02:01:24 INFO - grabbing minidump binary from tooltool 02:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:24 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 0x122e110>, '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 0x119a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:01:24 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 02:01:24 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 02:01:24 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 02:01:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:01:24 INFO - Return code: 0 02:01:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:01:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:01:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:01:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:01:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:01:25 INFO - Return code: 0 02:01:25 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/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:01:25 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/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 02:01:25 INFO - Using env: {'DISPLAY': ':0', 02:01:25 INFO - 'HOME': '/home/cltbld', 02:01:25 INFO - 'LANG': 'en_US.UTF-8', 02:01:25 INFO - 'LANGUAGE': 'en_US:en', 02:01:25 INFO - 'LOGNAME': 'cltbld', 02:01:25 INFO - 'MAIL': '/var/mail/cltbld', 02:01:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:01:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:25 INFO - 'MOZ_NO_REMOTE': '1', 02:01:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:25 INFO - 'NO_EM_RESTART': '1', 02:01:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:25 INFO - 'PWD': '/builds/slave/test', 02:01:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:01:25 INFO - 'SHELL': '/bin/bash', 02:01:25 INFO - 'SHLVL': '1', 02:01:25 INFO - 'TERM': 'linux', 02:01:25 INFO - 'TMOUT': '86400', 02:01:25 INFO - 'USER': 'cltbld', 02:01:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159', 02:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:25 INFO - '_': '/tools/buildbot/bin/python'} 02:01:25 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/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:01:25 INFO - mozversion application_buildid: 20160609233020 02:01:25 INFO - mozversion application_changeset: ff9fd611d818116cfd47ee7d067c2642368cf3f9 02:01:25 INFO - mozversion application_display_name: Nightly 02:01:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:01:25 INFO - mozversion application_name: Firefox 02:01:25 INFO - mozversion application_remotingname: firefox 02:01:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:01:25 INFO - mozversion application_vendor: Mozilla 02:01:25 INFO - mozversion application_version: 50.0a1 02:01:25 INFO - mozversion platform_buildid: 20160609233020 02:01:25 INFO - mozversion platform_changeset: ff9fd611d818116cfd47ee7d067c2642368cf3f9 02:01:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:01:25 INFO - mozversion platform_version: 50.0a1 02:01:25 INFO - using testdate: 1465549285 02:01:25 INFO - actual date: 1465549285 02:01:25 INFO - starting webserver on 'localhost:40168' 02:01:25 INFO - SUITE-START | Running 2 tests 02:01:25 INFO - TEST-START | dromaeo_css 02:01:25 INFO - operating with platform_type : linux_ 02:01:25 INFO - Initialising browser for dromaeo_css test... 02:01:25 INFO - TEST-INFO | started process 15495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxVP3yM/profile http://localhost:40168/getInfo.html) 02:01:29 INFO - PROCESS | 15495 | __metrics Screen width/height:1600/1200 02:01:29 INFO - PROCESS | 15495 | colorDepth:24 02:01:29 INFO - PROCESS | 15495 | Browser inner width/height: 1024/697 02:01:29 INFO - PROCESS | 15495 | __metrics 02:01:31 ERROR - PROCESS | 15495 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:01:31 INFO - PROCESS | 15495 | console.error: PushService: 02:01:31 INFO - PROCESS | 15495 | stateChangeProcessEnqueue: Error transitioning state 02:01:31 INFO - PROCESS | 15495 | UnknownError 02:01:31 INFO - TEST-INFO | 15495: exit 0 02:01:31 INFO - Browser initialized. 02:01:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:31 INFO - TEST-INFO | started process 15578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxVP3yM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:43 INFO - PROCESS | 15578 | RSS: Main: 173641728 02:01:43 INFO - PROCESS | 15578 | 02:02:35 INFO - PROCESS | 15578 | 1465549355223 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] 02:04:43 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40168/tests/dromaeo/cssquery-ext.html) 02:04:44 INFO - PROCESS | 15578 | RSS: Main: 285872128 02:04:44 INFO - PROCESS | 15578 | 02:07:47 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-ext.html (next: http://localhost:40168/tests/dromaeo/cssquery-jquery.html) 02:07:47 INFO - PROCESS | 15578 | RSS: Main: 257683456 02:07:47 INFO - PROCESS | 15578 | 02:10:49 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40168/tests/dromaeo/cssquery-mootools.html) 02:10:50 INFO - PROCESS | 15578 | RSS: Main: 258801664 02:10:50 INFO - PROCESS | 15578 | 02:13:52 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40168/tests/dromaeo/cssquery-prototype.html) 02:13:52 INFO - PROCESS | 15578 | RSS: Main: 253288448 02:13:52 INFO - PROCESS | 15578 | 02:16:55 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40168/tests/dromaeo/cssquery-yui.html) 02:16:56 INFO - PROCESS | 15578 | RSS: Main: 218574848 02:16:56 INFO - PROCESS | 15578 | 02:19:58 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-yui.html (next: http://localhost:40168/tests/dromaeo/cssquery-dojo.html) 02:19:59 INFO - PROCESS | 15578 | RSS: Main: 281247744 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | __start_tp_report 02:19:59 INFO - PROCESS | 15578 | _x_x_mozilla_page_load 02:19:59 INFO - PROCESS | 15578 | _x_x_mozilla_page_load_details 02:19:59 INFO - PROCESS | 15578 | |i|pagename|runs| 02:19:59 INFO - PROCESS | 15578 | |0;dojo.html;3036.787424880258;3048.6189226346705;3062.111987523618;3084.121025507731;3113.501839705646;5206.50538198871;5217.530422261995;5263.894722105556;5279.788808447663;5317.202419637057;5248.134057880455;5254;5268.236105764662;5316.0962636351815;5338.172583249593;4754.595859351951;4808.567228949394;4931.408231012266;4982;5024.346834911456;4937.111319962405;4961.131801934647;4966.329545511346;4966.776495057731;4982.501749825006;4748.738819364934;4797.328374027639;4833.589144922651;4849.9757501212625;4896.902061958759;4881;4890.608751299887;4892.559669629751;4930.80276788928;4961.82633607822;4822.807087716487;4868.464468908417;4887.462379138292;4896.387951506062;4914.754262286907;5151.278820965068;5182.015417070782;5184.092783762826;5273;5394.811181608664;5600.859978500529;5608.719564021782;5641.182028605829;5655.858603534944;5658.264425624684;5727.770889164429;5774.335951365605;5779.046457334534;5782.277215348082;5849.03490923997;5447.509724124848;5462.399136095027;5462.6995515246645;5463.399026107125;5464.562834973192;5644.068728659725;5730.856728581735;5783.8554036149435;5886.411358864079;5889.764409423661;5625.859353516113;5654.349749778746;5663.716814159276;5671.688057156896;5682.516986056149;5682.147677848356;5720.427957204246;5757.366689664133;5765.221695071112;5766.596338256281;5509.421510741315;5537.833864984057;5591.944080559142;5593.580481463907;5691.686957217393;5642.351129620064;5642.4075472075665;5644.858878527987;5686.715664216773;5694.715264236772;4354;4361.716488428242;4361.869143925687;4364.890877728082;4402.933955990663;3831.7700937943814;3893.805309734502;3903.882883513499;3905.3556163233316;3918.1967696622123;5394.62237643369;5405.324334458192;5409.0263752524925;5413.918791218135;5445.37378201504;5726.141078838207;5767.36558978512;5770.019096753478;5770.105633626795;5814.680192589448;5194.3766747990485;5288.894222115536;5333.120035194227;5344.706041167773;5391.272178255886;4948.529889660476;4980.377452818398;4990.3762029746285;4990.925136122888;5043.394792624908;5744.4542768438605;5798.478136967608;5800.4199580042505;5811.302643682785;5827.562932780059;5560.471755183251;5573.916391254215;5610.635308704921;5631.7184140793615;5655.886882262414;5741.1388291756575;5748.45389687979;5751.252337196138;5753.338366087786;5757.193992841089;5477.04151773446;5588.329400471969;5590.720463976866;5592.720363981866;5596.692181930033;5640.85897852557;5656.1798539212405;5716.714164291686;5753.482186603226;5757.222774925332;5585.860353491195;5593.412691667317;5596.104623260258;5600.523955463831;5601.831945041656;5397.028534863763;5421.295231619864;5593.720313984203;5600.131979543177;5603.299587551556;5362.115250983544;5427.457254274699;5427.48438898304;5430.212619170277;5474.151506516497;5527.281453411191;5580.748866300945;5615.354234263112;5623.044082505902;5624.465675760796;5367.731613419392;5408.323959505062;5449.754761035842;5456.699881506555;5463.754131064032 02:19:59 INFO - PROCESS | 15578 | |1;ext.html;590.610197269802;627.6830200748622;631.9873602527947;648.7242921758252;649.7920665387076;31242;31950.20124496886;43400.565994340046;44415;44472.77763611177;42627.36058959118;46953;47035;47035.52964470354;47079.52920470803;9001.099890010995;9168.174864262215;9179.357444978854;9180.8622870657;9184.954075229614;8776.297896168291;8877.156670116328;8881.1118888111;8881.77795555113;8884.422512536697;8945.0607686193;8945.686900958468;8977;8977.506237156953;8979.730608081769;8883.022867484571;8940.061293564147;8943.64225430982;8947;8947.1052894711;8918.55407229636;8948.8657670135;8960.103989601053;9033.909660903373;9035.141661542142;43322.35016474756;43691.34462983058;43821.12357752859;43844.78077609592;43857.78071109624;3387.983060084684;3457.567804024497;3477.826108694555;3502.7548071634997;3631.364511210554;32853;33008.504872426936;33346.1663458413;34280.828595857114;34827.651723482944;4252.489701235841;4287.764172970486;4292.506361768405;4333.349997500401;4471.910561788746;367303;367657;367731;368279;369927;56243.718781405834;56268;56270;60248.39751602516;61334.0799888002;35454.468182977274;65046;65363;65425.67287163534;65461.67269163624;15240.085594864344;16089.356425743073;16133;16135.112568808594;16139.435119770751;13558.254296013814;13747;13755.724885502234;13791.448342066406;13840.653983650489;19292.967280932437;19308.71036934447;19363.128659210368;19377.224911003683;19486.512837179183;6922.688479018456;6985.1617805863625;7091.971664108779;7145.499815013003;7329.413646908234;943.8772959515356;964.4020707161604;1059.9311044782064;1087.4345340423095;1103.093349025308;32357.352852942808;32372.676273237437;32451.350972980406;32957.34085318328;33282;1098.6099934523288;1159.2349049627373;1171.701216189866;1183.798754211786;1234.975300493985;16719.83280167207;17075.40236091731;17080.48758537246;17339.21973511195;17383.043932583576;537992;539618;543853;545959;546946.3263418446;61724;61947.38052619416;62253.37746622566;62269.688651556455;62366;1206.4390058622782;1311.2198242045968;1320.9273489958146;1347.7843545032747;1360.3538319298452;32669.836650816593;33939.830300848334;34034.489482658275;34242.03389153534;34465;51082;51634.74182629063;51930.480695192564;52023.73988130035;52104;405966;408204;410547;410957;411732;24882.875585621958;27146.72853271442;27970.783359913872;28043.43913121767;28231.57652635171;48638.02723945572;48832.267515988;48934.26598600952;49777.25334120064;50012.24981625351;40745.18509629732;41208.38187427131;42000.36999445072;42043.7897810509;42491;40678.593214068664;40944.18111637691;41210;41548;41676.1664766709;41427.58572414358;41820.372694409;43004;43037.78481107575;43141.56858431501;36138.45792313065;36456.81771591125;37149;37377;37435;28228.71771282261;28290.575641364983;28617;28641.570376444786;28659 02:19:59 INFO - PROCESS | 15578 | |2;jquery.html;388.2022443877832;388.89694231028767;390.75773020727144;391.21561269654336;408.80173116038736;14121.646958826035;15430.3827846886;17681.557961050963;19202.615947681057;19214.519637009063;14454.638634034129;18170.5457363566;18183.27266909322;18271.817281827178;18698.25206991722;5576.832695019156;5631.859203519924;5651.378348381675;5725.770969161229;5823.941760582404;4064.126212864234;5636.605437619368;5672.489475947164;5732.971335143318;6001.549883758714;6287.811365659015;6398.424141827235;6433.195850518685;6434.163558737358;6437.742490300382;6177.969110154443;6379;6387.1377364055725;6393.520485963571;6393.552451328409;5608.046632072557;5613.326400831886;5616.185653080322;5616.438356164392;5629.634073785191;22195.778042219696;23325;23398.766012339827;23974.760252397427;25268.494630107478;2500.4874000829786;2522.823402361835;2565.6921169459597;2623.829451085673;2631.4210873607967;14504.70990580193;14736.336864841109;15314.463993760277;15747.763783543256;16011.839881601152;1959.6178745144703;2070.8136267735977;2095.1409921931936;2135.5942370949624;2183.879886606236;64729.676351618415;67426;87356.56321718414;91383;91838;15800.604984875241;16909;17226.224819883137;17235.310587576358;17418.65162696739;29535.556966645516;29855.701442985293;29979.250518737204;30017.699823001927;30125.548116778267;8294.460860044199;9315;9526.142647161789;9903.851442228372;10054.899451005542;8128.715494957766;8158.918410815934;8370.16298370158;8492.193241642035;8520.531370774543;8405.663773448994;8566.443181193203;8669.523176225242;8753.693620723245;8821.250193733476;3184.7770656053854;3377.6622337766025;3381.323735252959;3421.2473255883665;3472.541532556332;901.715959472764;921.861720741894;942.7501712046313;991.4299277915228;1008.9243306752023;18084.728729069073;18511.81488185101;18815.435536933914;18875.52811179704;19107.713384299248;963.1764841060932;1014.7108074198966;1027.773889744255;1053.378506681062;1077.0737166037202;9800.35390444576;10485.528151233213;10541.947290263653;10556.261061725605;10611.787764244671;443256;451532;460029;461314;465039;83961.58019209864;88459.11540884638;88644;88962;89956;988.5205675247499;999.4602914426129;1009.2329829329763;1031.2059714020163;1032.2413026425572;15512.767308490156;16539.173041348124;16611.41860034893;16613.50159495217;16773.496795096165;35924;38465.80767096147;39345.21309573735;40993.975150621474;41736.79131604323;48882.75558622184;51721.7413912928;53901.73049134729;54908.72545637406;59247;7377.8155546111775;7434.628268586657;8170.42807003504;8453.112423195476;8651.394402391772;12099.516019359478;12404.131710780159;12513.624591262276;12616.747665046463;13066.281354525592;10947.397893115955;11031.503582338975;11334.846379187928;11508.769824603629;11531.077513799044;10164.186865050926;10767.300125491818;11060.778784424427;11273.71815704614;11533.423328833693;11211.887881121085;11498.712532186762;11532.481038353462;11549.6535103947;11636.36000020007;7424.777256682308;7544.886826697494;7565.470417070972;7713.614319283901;7729;11412.08703303717;11467.885321147016;11573.669028061544;11586.420678966186;11631.88368116342 02:19:59 INFO - PROCESS | 15578 | |3;mootools.html;1297.0920355750977;1458.8468210837862;1477.6379786952198;1557.3614817924654;1748.283203886406;8424.1997010284;8933.330000249984;8935.731928042162;9087.591058402371;9177.403468774524;8891.955540222307;9077.546122693871;9088.72733817985;9089.68186113486;9096.77258068547;1992.80071992801;2276.829237807163;2319.7796209360126;2345.6716059751648;2363.775441333079;2325.7092863392077;2334.9883250583725;2336.380859072347;2337.1002164166835;2338;2312.4334538038206;2322.9883850580723;2365.775251351119;2368.0646144772804;2368.2895131460577;1974.1511150205406;2175.5322605639863;2240.484688521633;2242.473018840571;2248.9100435982623;2299.977000229993;2319.1998760427628;2344.4138965258685;2344.4959333743327;2345.8475199112004;9133.908660913372;9198.908010919871;9200.585973631203;9206.263498920138;9210.81578368429;5250.842474725764;5375.059364611217;5378.381486129106;5381.838544843661;5385.272988146589;3183.649798522161;3297.505374193866;3342.5487559179687;3352.614449338333;3391.253924136711;1056.4348073780568;1072.9538699767743;1093.0872721277742;1093.1145771924687;1106.9280496767685;12769.680757981125;12794.232346059172;12807.935960320232;12819.230846149261;12825.102242843004;4535.591796738309;4605.0559635274685;4707.2468405055715;4709.67032307742;4715.717056976592;10239.897601024044;10264.43545604984;10270.486475676336;10284.177265818716;10289.3311934724;5322.2548843161985;5372.301600791872;5377.7311134443125;5380.757865896044;5383.542398896059;4396.846110386121;4669.696469729524;4783.043391321749;4798.712077275374;4833.347498087784;3854.6338097880657;3960.6237407446247;3965.167314863911;4040.6969477288735;4090;1214.7388311513066;1221.8373478942221;1232.9815052774215;1271.1927925767204;1272.5291642092484;858.2018722588053;962.1629182611173;966.8791401074866;983.2723784399493;1021.7292417509366;6047.879042419127;6052.303985041688;6116.235470566179;6139.539534534928;6153.046277826944;451.905099929012;458.3560098062228;461.5937974582346;867.4058270085012;1026.071405378134;4266.381374700713;4291.120320334324;4312.611864932172;4326.178026175016;4376.912461750747;11185.272957257752;11526.769464610661;11658.53365865356;11668.474918628683;11673.241239319417;11424.885751142549;11455.083593312682;11506.94246528762;11523.308601483937;11538.59614913474;7632.542047477169;8083.110857805755;8095.190480951857;8361.205685459872;8568.742937711879;5400.325898971331;5555.2778138841695;5578.832635020955;5585.050541407889;6179.250233645985;10237.74405639865;10304.484775761332;10473.26687131924;10551.050405463546;10600.098991585493;9990.500474976367;10387.584496620051;10390.480475976323;10917.454127293762;10920.56317747313;7739.380849532136;7803.453758236869;7866.449348545547;7914.287714105528;7931.801704957422;8281.21328473794;8283.213094755989;8336;8336.791580210544;8371.121032291521;6900.861982760216;7079;7093.6453177341955;7171.784846454615;7219.639018049182;7446.813829654302;7509.3617042552;7543.698252069856;7569.814209932432;7670.654820532978;6961.408280296029;7000.579965202104;7038.331358520933;7039.401650859734;7043.929560704328;4904.6566740327835;5023.874403139951;5083.72039537829;5130.281760553451;5178.275041494269;5023.799048038038;5106.157484015244;5150.459201783909;5177.611679124156;5302.496262855023 02:19:59 INFO - PROCESS | 15578 | |4;prototype.html;331.4481388488167;331.87554666999876;335.9479280711491;336.7289332087668;343.6958291911659;5317.627766056377;5340.359156901172;5360.5443537299325;5374;5435.320584926884;5282.072043704049;5286.127788914834;5306.893862122755;5322.680639161653;5324.174752913295;3913.7847418391975;4155.958440415602;4170.7914604269745;4193.370994350857;4210.726302790325;4070.5318888327924;4112.465379500661;4117.258893399187;4127;4134.131832315217;4112.8971775705695;4113.239050775601;4113.979430102845;4128.442660240859;4136.869512201219;3892.824822882977;3923.215356928597;4065.9796701016307;4105.3020986432075;4151.23202207591;3562.928741425157;3574.160072382988;3583.8387272572795;3588.1926566522584;3611.638836116367;5155.149400348938;5155.381354237516;5161.27742116104;5189.610779191538;5215.217717342429;4275.4228179195725;4492.495014170224;4579.519150489184;4617.676762626617;4630;5476.58925580583;5521.095222148392;5525.309336332958;5526.972365138189;5543.334799824007;3930.567637559866;3969.4244334571326;3969.960300397017;3971.7418367806;3984.6812255019527;5566.803137325494;5767.68277744728;5772.278465191851;5784.971075144639;5786.3056433228285;4036.414719865662;4055.2497787909333;4062.512498500199;4071.2875246831686;4074.7758873262255;4100.138970816102;4101.405296232029;4108.77401742907;4129.2773764591075;4150.398192262105;4479.7984090716;4657.347971284023;4681.6020638245445;4689.742064186435;4747.121782470254;5503.174523821459;5507.0637991541535;5530.529904958124;5539.362973258047;5547.55619550435;1406.7116241170536;1408.1621435246013;1410.4569740649924;1416.0937000319805;1423.3381477612959;854.4616891358404;873.5413907698382;880.212210071982;886.7384121684119;890.2788741119714;4664.55686709762;4732.858014259577;4741.857744267678;4741.976290118528;4767.998720268783;4969.279454479152;4991.450940396553;5001.274815151783;5052.686301561621;5071.290019397287;4753.239481682914;4768.9031522749965;4775.116603428377;4782.95217047832;4946.579540739078;2884.1924261206896;2967.109867039879;3029.424409362214;3059.2504836315247;3068.938621227563;5717.742701578439;5751.913721294184;5766.250387449605;5798.391168927286;5802.593818432669;5603.299587551556;5815.389384114607;5838.562107841929;5849.736761845727;5856.560757943172;5694.772209111672;5756.510696590837;5761.193432919478;5761.9135712964335;5780.682062486603;5649.180868774087;5662.235598194356;5720.141978703228;5720.570957178145;5725.368270043018;5380.488853558905;5694.288213973254;5712.343080545625;5718.142278658068;5727.627704199213;5710.314762228559;5744.281964754406;5753.5616095976;5778.624389414675;5802.82591522255;4097.426360309619;4160.854370097032;4167.166566686614;4184.142250838631;4207.684423668176;5615.691136987505;5632.352279487747;5649.54803615718;5650.29371328584;5671.461211184931;5482.506574408163;5499.175123731472;5505.779768809202;5505.834824955257;5527.861803454945;5239.685618862881;5498.340199176125;5520.392756796829;5536.307961504812;5600.131979543177;5391.16436952273;5490.529261832271;5494.5054945055135;5507.972460137674;5510.504054635102;5597.244372009726;5629.54963602919;5634.267545219259;5634.971825140848;5637.689927053887;5222.947770522398;5497.752601133038;5527.530159936289;5535.114381698909;5539.14143307788 02:19:59 INFO - PROCESS | 15578 | |5;yui.html;721.3615949884351;726.3535453446434;729.6534146280518;780.855541724781;850.4472093139459;14884.181370024658;15194.468193613226;15229.847701522995;15233.086014839117;15390.38438462463;14646.121232726044;14727.410903563872;14783.852161478382;14790.630234244123;14828.332725027372;655.678717428459;760.3878877503607;784.262792974602;786.4259090863673;791.8099656082527;786.7954331873725;790.5928446849877;791.7505985614513;791.877259024852;793.9126696063429;849.583703985049;850.1795767084762;850.8298340331927;850.8766228896807;851.3529717414779;689.472553496573;710.7547895975906;809.401043228007;835.6490274084899;849.3799526345771;614.2659521871366;614.8124821929309;615.7383112177307;616.6824085595922;616.7255571270787;14436;14449.205293708841;14460.204688742115;14475.78286325706;14488;13768.24274664893;14270.714585708332;14493.347799349054;14542.27288635564;14642.41430342785;11545.365004924726;11671.533138674442;12351.683034673042;12572.119951603392;13240.404181811842;4449.7330160190495;4488.7531185784765;4488.8877778055485;4684.297355396718;4693.718376897397;69758;70087;70573.2942670577;71857.28142718558;72774.27225727728;11414.828777568344;11514.136439767051;11554.306741595532;11589.420528973518;11653.53385864573;19322.130504127348;19594.70607940882;19658.803411965982;19670.213191472467;19707.704384434244;7922;8126.634301456449;8163.428560000743;8176.01887773471;8244.54654993981;4682.297655351725;4701.764911754399;4714.834980775725;4751.548602882721;4890.804367825318;3266.5263536787033;3375.628680845105;3387.4749413840896;3394.0666316762595;3394.490826376014;573.0744847071949;577.4023885278716;577.6534079552235;585.5783835638333;597.3399393670019;585.6983653418492;592.386879579633;671.9092922455503;679.0120374854673;692.9307069293131;8839.69061082859;9203.309751768644;9342.159205671522;9379.24966002718;9476.50285190963;542.9348478182643;558.7988324203284;564.4271064869079;582.7843697831829;598.7305712429425;3822.1782316802023;4047.0489434982755;4206.747595144301;4756.357891684578;4801.207800712913;117643;125254;129686;129819.35090324488;129939;86104;109842;110391.44804276088;111205.44397277961;112575.4371228155;92245.53877230705;94081;96246.9999999986;96951.51524242334;99255;9338.338573506519;9538.618455261712;9576.952115239379;9599.456483729347;9713;54925.17612235899;55128.173077404674;55379.16931246115;55760.44239557715;55885.72057139851;74969.62515187389;81404.59297703474;82153.58923205346;82254.58872705598;82981;12619.87380126187;12690.712854393618;12701.87298127007;12908.354582271037;12976.545820896223;13781.448742050206;13795.310234488436;13940.79088813689;14255.287235638383;14432.350544225324;12978.415971281127;13105.737885242432;13234.376014503834;13320.467181313026;14022.579322620337;12475;12874.227546347249;12916.160449570747;12972.221666700028;13144.737105257651;12966.416511256828;13213.669658258621;13254.403551840383;13257.933710331386;13318.267495287851;8950.373473856767;9242.768930776785;9297.442153470813;9449.338546301968;9851.359661621971;9217.446953182562;9305.627774889199;9758.530733585738;9806.705798826046;9919.2560557957 02:19:59 INFO - PROCESS | 15578 | __end_tp_report 02:19:59 INFO - PROCESS | 15578 | __start_cc_report 02:19:59 INFO - PROCESS | 15578 | _x_x_mozilla_cycle_collect,917 02:19:59 INFO - PROCESS | 15578 | __end_cc_report 02:19:59 INFO - PROCESS | 15578 | __startTimestamp1465550399027__endTimestamp 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | ------- Summary: start ------- 02:19:59 INFO - PROCESS | 15578 | Number of tests: 6 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | [#0] dojo.html Cycles:165 Average:5283.97 Median:5462.70 stddev:585.16 (10.7%) stddev-sans-first:559.77 02:19:59 INFO - PROCESS | 15578 | Values: 3036.8 3048.6 3062.1 3084.1 3113.5 5206.5 5217.5 5263.9 5279.8 5317.2 5248.1 5254.0 5268.2 5316.1 5338.2 4754.6 4808.6 4931.4 4982.0 5024.3 4937.1 4961.1 4966.3 4966.8 4982.5 4748.7 4797.3 4833.6 4850.0 4896.9 4881.0 4890.6 4892.6 4930.8 4961.8 4822.8 4868.5 4887.5 4896.4 4914.8 5151.3 5182.0 5184.1 5273.0 5394.8 5600.9 5608.7 5641.2 5655.9 5658.3 5727.8 5774.3 5779.0 5782.3 5849.0 5447.5 5462.4 5462.7 5463.4 5464.6 5644.1 5730.9 5783.9 5886.4 5889.8 5625.9 5654.3 5663.7 5671.7 5682.5 5682.1 5720.4 5757.4 5765.2 5766.6 5509.4 5537.8 5591.9 5593.6 5691.7 5642.4 5642.4 5644.9 5686.7 5694.7 4354.0 4361.7 4361.9 4364.9 4402.9 3831.8 3893.8 3903.9 3905.4 3918.2 5394.6 5405.3 5409.0 5413.9 5445.4 5726.1 5767.4 5770.0 5770.1 5814.7 5194.4 5288.9 5333.1 5344.7 5391.3 4948.5 4980.4 4990.4 4990.9 5043.4 5744.5 5798.5 5800.4 5811.3 5827.6 5560.5 5573.9 5610.6 5631.7 5655.9 5741.1 5748.5 5751.3 5753.3 5757.2 5477.0 5588.3 5590.7 5592.7 5596.7 5640.9 5656.2 5716.7 5753.5 5757.2 5585.9 5593.4 5596.1 5600.5 5601.8 5397.0 5421.3 5593.7 5600.1 5603.3 5362.1 5427.5 5427.5 5430.2 5474.2 5527.3 5580.7 5615.4 5623.0 5624.5 5367.7 5408.3 5449.8 5456.7 5463.8 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | [#1] ext.html Cycles:180 Average:60510.69 Median:42022.08 stddev:118282.62 (281.5%) stddev-sans-first:118528.87 02:19:59 INFO - PROCESS | 15578 | Values: 590.6 627.7 632.0 648.7 649.8 31242.0 31950.2 43400.6 44415.0 44472.8 42627.4 46953.0 47035.0 47035.5 47079.5 9001.1 9168.2 9179.4 9180.9 9185.0 8776.3 8877.2 8881.1 8881.8 8884.4 8945.1 8945.7 8977.0 8977.5 8979.7 8883.0 8940.1 8943.6 8947.0 8947.1 8918.6 8948.9 8960.1 9033.9 9035.1 43322.4 43691.3 43821.1 43844.8 43857.8 3388.0 3457.6 3477.8 3502.8 3631.4 32853.0 33008.5 33346.2 34280.8 34827.7 4252.5 4287.8 4292.5 4333.3 4471.9 367303.0 367657.0 367731.0 368279.0 369927.0 56243.7 56268.0 56270.0 60248.4 61334.1 35454.5 65046.0 65363.0 65425.7 65461.7 15240.1 16089.4 16133.0 16135.1 16139.4 13558.3 13747.0 13755.7 13791.4 13840.7 19293.0 19308.7 19363.1 19377.2 19486.5 6922.7 6985.2 7092.0 7145.5 7329.4 943.9 964.4 1059.9 1087.4 1103.1 32357.4 32372.7 32451.4 32957.3 33282.0 1098.6 1159.2 1171.7 1183.8 1235.0 16719.8 17075.4 17080.5 17339.2 17383.0 537992.0 539618.0 543853.0 545959.0 546946.3 61724.0 61947.4 62253.4 62269.7 62366.0 1206.4 1311.2 1320.9 1347.8 1360.4 32669.8 33939.8 34034.5 34242.0 34465.0 51082.0 51634.7 51930.5 52023.7 52104.0 405966.0 408204.0 410547.0 410957.0 411732.0 24882.9 27146.7 27970.8 28043.4 28231.6 48638.0 48832.3 48934.3 49777.3 50012.2 40745.2 41208.4 42000.4 42043.8 42491.0 40678.6 40944.2 41210.0 41548.0 41676.2 41427.6 41820.4 43004.0 43037.8 43141.6 36138.5 36456.8 37149.0 37377.0 37435.0 28228.7 28290.6 28617.0 28641.6 28659.0 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | [#2] jquery.html Cycles:180 Average:28454.71 Median:3401.29 stddev:75194.85 (2210.8%) stddev-sans-first:75376.26 02:19:59 INFO - PROCESS | 15578 | Values: 388.2 388.9 390.8 391.2 408.8 14121.6 15430.4 17681.6 19202.6 19214.5 14454.6 18170.5 18183.3 18271.8 18698.3 5576.8 5631.9 5651.4 5725.8 5823.9 4064.1 5636.6 5672.5 5733.0 6001.5 6287.8 6398.4 6433.2 6434.2 6437.7 6178.0 6379.0 6387.1 6393.5 6393.6 5608.0 5613.3 5616.2 5616.4 5629.6 22195.8 23325.0 23398.8 23974.8 25268.5 2500.5 2522.8 2565.7 2623.8 2631.4 14504.7 14736.3 15314.5 15747.8 16011.8 1959.6 2070.8 2095.1 2135.6 2183.9 64729.7 67426.0 87356.6 91383.0 91838.0 15800.6 16909.0 17226.2 17235.3 17418.7 29535.6 29855.7 29979.3 30017.7 30125.5 8294.5 9315.0 9526.1 9903.9 10054.9 8128.7 8158.9 8370.2 8492.2 8520.5 8405.7 8566.4 8669.5 8753.7 8821.3 3184.8 3377.7 3381.3 3421.2 3472.5 901.7 921.9 942.8 991.4 1008.9 18084.7 18511.8 18815.4 18875.5 19107.7 963.2 1014.7 1027.8 1053.4 1077.1 9800.4 10485.5 10541.9 10556.3 10611.8 443256.0 451532.0 460029.0 461314.0 465039.0 83961.6 88459.1 88644.0 88962.0 89956.0 988.5 999.5 1009.2 1031.2 1032.2 15512.8 16539.2 16611.4 16613.5 16773.5 35924.0 38465.8 39345.2 40994.0 41736.8 48882.8 51721.7 53901.7 54908.7 59247.0 7377.8 7434.6 8170.4 8453.1 8651.4 12099.5 12404.1 12513.6 12616.7 13066.3 10947.4 11031.5 11334.8 11508.8 11531.1 10164.2 10767.3 11060.8 11273.7 11533.4 11211.9 11498.7 11532.5 11549.7 11636.4 7424.8 7544.9 7565.5 7713.6 7729.0 11412.1 11467.9 11573.7 11586.4 11631.9 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | [#3] mootools.html Cycles:180 Average:5854.03 Median:2533.32 stddev:3430.68 (135.4%) stddev-sans-first:3423.21 02:19:59 INFO - PROCESS | 15578 | Values: 1297.1 1458.8 1477.6 1557.4 1748.3 8424.2 8933.3 8935.7 9087.6 9177.4 8892.0 9077.5 9088.7 9089.7 9096.8 1992.8 2276.8 2319.8 2345.7 2363.8 2325.7 2335.0 2336.4 2337.1 2338.0 2312.4 2323.0 2365.8 2368.1 2368.3 1974.2 2175.5 2240.5 2242.5 2248.9 2300.0 2319.2 2344.4 2344.5 2345.8 9133.9 9198.9 9200.6 9206.3 9210.8 5250.8 5375.1 5378.4 5381.8 5385.3 3183.6 3297.5 3342.5 3352.6 3391.3 1056.4 1073.0 1093.1 1093.1 1106.9 12769.7 12794.2 12807.9 12819.2 12825.1 4535.6 4605.1 4707.2 4709.7 4715.7 10239.9 10264.4 10270.5 10284.2 10289.3 5322.3 5372.3 5377.7 5380.8 5383.5 4396.8 4669.7 4783.0 4798.7 4833.3 3854.6 3960.6 3965.2 4040.7 4090.0 1214.7 1221.8 1233.0 1271.2 1272.5 858.2 962.2 966.9 983.3 1021.7 6047.9 6052.3 6116.2 6139.5 6153.0 451.9 458.4 461.6 867.4 1026.1 4266.4 4291.1 4312.6 4326.2 4376.9 11185.3 11526.8 11658.5 11668.5 11673.2 11424.9 11455.1 11506.9 11523.3 11538.6 7632.5 8083.1 8095.2 8361.2 8568.7 5400.3 5555.3 5578.8 5585.1 6179.3 10237.7 10304.5 10473.3 10551.1 10600.1 9990.5 10387.6 10390.5 10917.5 10920.6 7739.4 7803.5 7866.4 7914.3 7931.8 8281.2 8283.2 8336.0 8336.8 8371.1 6900.9 7079.0 7093.6 7171.8 7219.6 7446.8 7509.4 7543.7 7569.8 7670.7 6961.4 7000.6 7038.3 7039.4 7043.9 4904.7 5023.9 5083.7 5130.3 5178.3 5023.8 5106.2 5150.5 5177.6 5302.5 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | [#4] prototype.html Cycles:180 Average:4607.35 Median:5231.32 stddev:1354.71 (25.9%) stddev-sans-first:1319.95 02:19:59 INFO - PROCESS | 15578 | Values: 331.4 331.9 335.9 336.7 343.7 5317.6 5340.4 5360.5 5374.0 5435.3 5282.1 5286.1 5306.9 5322.7 5324.2 3913.8 4156.0 4170.8 4193.4 4210.7 4070.5 4112.5 4117.3 4127.0 4134.1 4112.9 4113.2 4114.0 4128.4 4136.9 3892.8 3923.2 4066.0 4105.3 4151.2 3562.9 3574.2 3583.8 3588.2 3611.6 5155.1 5155.4 5161.3 5189.6 5215.2 4275.4 4492.5 4579.5 4617.7 4630.0 5476.6 5521.1 5525.3 5527.0 5543.3 3930.6 3969.4 3970.0 3971.7 3984.7 5566.8 5767.7 5772.3 5785.0 5786.3 4036.4 4055.2 4062.5 4071.3 4074.8 4100.1 4101.4 4108.8 4129.3 4150.4 4479.8 4657.3 4681.6 4689.7 4747.1 5503.2 5507.1 5530.5 5539.4 5547.6 1406.7 1408.2 1410.5 1416.1 1423.3 854.5 873.5 880.2 886.7 890.3 4664.6 4732.9 4741.9 4742.0 4768.0 4969.3 4991.5 5001.3 5052.7 5071.3 4753.2 4768.9 4775.1 4783.0 4946.6 2884.2 2967.1 3029.4 3059.3 3068.9 5717.7 5751.9 5766.3 5798.4 5802.6 5603.3 5815.4 5838.6 5849.7 5856.6 5694.8 5756.5 5761.2 5761.9 5780.7 5649.2 5662.2 5720.1 5720.6 5725.4 5380.5 5694.3 5712.3 5718.1 5727.6 5710.3 5744.3 5753.6 5778.6 5802.8 4097.4 4160.9 4167.2 4184.1 4207.7 5615.7 5632.4 5649.5 5650.3 5671.5 5482.5 5499.2 5505.8 5505.8 5527.9 5239.7 5498.3 5520.4 5536.3 5600.1 5391.2 5490.5 5494.5 5508.0 5510.5 5597.2 5629.5 5634.3 5635.0 5637.7 5222.9 5497.8 5527.5 5535.1 5539.1 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - PROCESS | 15578 | [#5] yui.html Cycles:180 Average:21473.72 Median:55026.67 stddev:32359.73 (58.8%) stddev-sans-first:32412.99 02:19:59 INFO - PROCESS | 15578 | Values: 721.4 726.4 729.7 780.9 850.4 14884.2 15194.5 15229.8 15233.1 15390.4 14646.1 14727.4 14783.9 14790.6 14828.3 655.7 760.4 784.3 786.4 791.8 786.8 790.6 791.8 791.9 793.9 849.6 850.2 850.8 850.9 851.4 689.5 710.8 809.4 835.6 849.4 614.3 614.8 615.7 616.7 616.7 14436.0 14449.2 14460.2 14475.8 14488.0 13768.2 14270.7 14493.3 14542.3 14642.4 11545.4 11671.5 12351.7 12572.1 13240.4 4449.7 4488.8 4488.9 4684.3 4693.7 69758.0 70087.0 70573.3 71857.3 72774.3 11414.8 11514.1 11554.3 11589.4 11653.5 19322.1 19594.7 19658.8 19670.2 19707.7 7922.0 8126.6 8163.4 8176.0 8244.5 4682.3 4701.8 4714.8 4751.5 4890.8 3266.5 3375.6 3387.5 3394.1 3394.5 573.1 577.4 577.7 585.6 597.3 585.7 592.4 671.9 679.0 692.9 8839.7 9203.3 9342.2 9379.2 9476.5 542.9 558.8 564.4 582.8 598.7 3822.2 4047.0 4206.7 4756.4 4801.2 117643.0 125254.0 129686.0 129819.4 129939.0 86104.0 109842.0 110391.4 111205.4 112575.4 92245.5 94081.0 96247.0 96951.5 99255.0 9338.3 9538.6 9577.0 9599.5 9713.0 54925.2 55128.2 55379.2 55760.4 55885.7 74969.6 81404.6 82153.6 82254.6 82981.0 12619.9 12690.7 12701.9 12908.4 12976.5 13781.4 13795.3 13940.8 14255.3 14432.4 12978.4 13105.7 13234.4 13320.5 14022.6 12475.0 12874.2 12916.2 12972.2 13144.7 12966.4 13213.7 13254.4 13257.9 13318.3 8950.4 9242.8 9297.4 9449.3 9851.4 9217.4 9305.6 9758.5 9806.7 9919.3 02:19:59 INFO - PROCESS | 15578 | -------- Summary: end -------- 02:19:59 INFO - PROCESS | 15578 | 02:19:59 INFO - TEST-INFO | 15578: exit 0 02:19:59 INFO - TEST-OK | dromaeo_css | took 1114030ms 02:19:59 INFO - TEST-START | kraken 02:19:59 INFO - operating with platform_type : linux_ 02:19:59 INFO - Initialising browser for kraken test... 02:19:59 INFO - TEST-INFO | started process 15770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbZURPE/profile http://localhost:40168/getInfo.html) 02:20:03 INFO - PROCESS | 15770 | __metrics Screen width/height:1600/1200 02:20:03 INFO - PROCESS | 15770 | colorDepth:24 02:20:03 INFO - PROCESS | 15770 | Browser inner width/height: 1024/697 02:20:03 INFO - PROCESS | 15770 | __metrics 02:20:04 ERROR - PROCESS | 15770 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:20:04 INFO - PROCESS | 15770 | console.error: PushService: 02:20:04 INFO - PROCESS | 15770 | stateChangeProcessEnqueue: Error transitioning state 02:20:04 INFO - PROCESS | 15770 | UnknownError 02:20:05 INFO - TEST-INFO | 15770: exit 0 02:20:05 INFO - Browser initialized. 02:20:05 INFO - Running cycle 1/1 for kraken test... 02:20:05 INFO - TEST-INFO | started process 15852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbZURPE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:17 INFO - PROCESS | 15852 | RSS: Main: 173780992 02:20:17 INFO - PROCESS | 15852 | 02:20:19 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:20 INFO - PROCESS | 15852 | RSS: Main: 232321024 02:20:20 INFO - PROCESS | 15852 | 02:20:23 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-dft) 02:20:23 INFO - PROCESS | 15852 | RSS: Main: 220528640 02:20:23 INFO - PROCESS | 15852 | 02:20:27 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-fft) 02:20:27 INFO - PROCESS | 15852 | RSS: Main: 285347840 02:20:27 INFO - PROCESS | 15852 | 02:20:29 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-oscillator) 02:20:30 INFO - PROCESS | 15852 | RSS: Main: 196571136 02:20:30 INFO - PROCESS | 15852 | 02:20:32 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40168/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:33 INFO - PROCESS | 15852 | RSS: Main: 200302592 02:20:33 INFO - PROCESS | 15852 | 02:20:36 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40168/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:36 INFO - PROCESS | 15852 | RSS: Main: 236564480 02:20:36 INFO - PROCESS | 15852 | 02:20:40 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40168/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:40 INFO - PROCESS | 15852 | RSS: Main: 236953600 02:20:40 INFO - PROCESS | 15852 | 02:20:43 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40168/tests/kraken/driver.html?testName=json-parse-financial) 02:20:44 INFO - PROCESS | 15852 | RSS: Main: 237056000 02:20:44 INFO - PROCESS | 15852 | 02:20:45 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40168/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:46 INFO - PROCESS | 15852 | RSS: Main: 221540352 02:20:46 INFO - PROCESS | 15852 | 02:20:48 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:48 INFO - PROCESS | 15852 | RSS: Main: 226664448 02:20:48 INFO - PROCESS | 15852 | 02:20:50 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:51 INFO - PROCESS | 15852 | RSS: Main: 233283584 02:20:51 INFO - PROCESS | 15852 | 02:20:53 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:20:54 INFO - PROCESS | 15852 | RSS: Main: 239935488 02:20:54 INFO - PROCESS | 15852 | 02:20:57 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:20:57 INFO - PROCESS | 15852 | RSS: Main: 239923200 02:20:57 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40168/tests/kraken/driver.html?testName=ai-astar) 02:20:59 INFO - PROCESS | 15852 | RSS: Main: 282136576 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | __start_tp_report 02:20:59 INFO - PROCESS | 15852 | _x_x_mozilla_page_load 02:20:59 INFO - PROCESS | 15852 | _x_x_mozilla_page_load_details 02:20:59 INFO - PROCESS | 15852 | |i|pagename|runs| 02:20:59 INFO - PROCESS | 15852 | |0;ai-astar;111;105;110;110;112;110;111;109;110;110 02:20:59 INFO - PROCESS | 15852 | |1;audio-beat-detection;152;127;143;155;127;160;158;126;190;126 02:20:59 INFO - PROCESS | 15852 | |2;audio-dft;160;160;162;162;161;161;162;161;160;161 02:20:59 INFO - PROCESS | 15852 | |3;audio-fft;75;74;76;130;75;75;74;74;98;75 02:20:59 INFO - PROCESS | 15852 | |4;audio-oscillator;86;86;114;85;84;86;125;85;85;127 02:20:59 INFO - PROCESS | 15852 | |5;imaging-gaussian-blur;116;118;117;117;116;117;117;116;116;117 02:20:59 INFO - PROCESS | 15852 | |6;imaging-darkroom;144;146;145;146;145;146;145;145;145;145 02:20:59 INFO - PROCESS | 15852 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;95;96 02:20:59 INFO - PROCESS | 15852 | |8;json-parse-financial;53;52;53;54;53;53;52;54;66;52 02:20:59 INFO - PROCESS | 15852 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;60;61;61 02:20:59 INFO - PROCESS | 15852 | |10;stanford-crypto-aes;80;81;81;79;85;80;80;82;114;81 02:20:59 INFO - PROCESS | 15852 | |11;stanford-crypto-ccm;123;126;121;129;121;121;122;126;126;140 02:20:59 INFO - PROCESS | 15852 | |12;stanford-crypto-pbkdf2;160;165;162;161;159;159;162;168;159;160 02:20:59 INFO - PROCESS | 15852 | |13;stanford-crypto-sha256-iterative;68;64;64;70;65;69;63;63;64;62 02:20:59 INFO - PROCESS | 15852 | __end_tp_report 02:20:59 INFO - PROCESS | 15852 | __start_cc_report 02:20:59 INFO - PROCESS | 15852 | _x_x_mozilla_cycle_collect,1627 02:20:59 INFO - PROCESS | 15852 | __end_cc_report 02:20:59 INFO - PROCESS | 15852 | __startTimestamp1465550459813__endTimestamp 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | ------- Summary: start ------- 02:20:59 INFO - PROCESS | 15852 | Number of tests: 14 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.87 (1.7%) stddev-sans-first:1.94 02:20:59 INFO - PROCESS | 15852 | Values: 111.0 105.0 110.0 110.0 112.0 110.0 111.0 109.0 110.0 110.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:153.50 stddev:20.88 (13.6%) stddev-sans-first:22.04 02:20:59 INFO - PROCESS | 15852 | Values: 152.0 127.0 143.0 155.0 127.0 160.0 158.0 126.0 190.0 126.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 02:20:59 INFO - PROCESS | 15852 | Values: 160.0 160.0 162.0 162.0 161.0 161.0 162.0 161.0 160.0 161.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:18.20 (24.3%) stddev-sans-first:19.09 02:20:59 INFO - PROCESS | 15852 | Values: 75.0 74.0 76.0 130.0 75.0 75.0 74.0 74.0 98.0 75.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.05 (21.2%) stddev-sans-first:18.76 02:20:59 INFO - PROCESS | 15852 | Values: 86.0 86.0 114.0 85.0 84.0 86.0 125.0 85.0 85.0 127.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 02:20:59 INFO - PROCESS | 15852 | Values: 116.0 118.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 02:20:59 INFO - PROCESS | 15852 | Values: 144.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:20:59 INFO - PROCESS | 15852 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 96.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.00 stddev:4.21 (7.9%) stddev-sans-first:4.44 02:20:59 INFO - PROCESS | 15852 | Values: 53.0 52.0 53.0 54.0 53.0 53.0 52.0 54.0 66.0 52.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 02:20:59 INFO - PROCESS | 15852 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:10.56 (13.0%) stddev-sans-first:11.09 02:20:59 INFO - PROCESS | 15852 | Values: 80.0 81.0 81.0 79.0 85.0 80.0 80.0 82.0 114.0 81.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:5.80 (4.6%) stddev-sans-first:6.08 02:20:59 INFO - PROCESS | 15852 | Values: 123.0 126.0 121.0 129.0 121.0 121.0 122.0 126.0 126.0 140.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.50 stddev:2.95 (1.8%) stddev-sans-first:3.08 02:20:59 INFO - PROCESS | 15852 | Values: 160.0 165.0 162.0 161.0 159.0 159.0 162.0 168.0 159.0 160.0 02:20:59 INFO - PROCESS | 15852 | 02:20:59 INFO - PROCESS | 15852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:2.78 (4.3%) stddev-sans-first:2.76 02:20:59 INFO - PROCESS | 15852 | Values: 68.0 64.0 64.0 70.0 65.0 69.0 63.0 63.0 64.0 62.0 02:20:59 INFO - PROCESS | 15852 | -------- Summary: end -------- 02:20:59 INFO - PROCESS | 15852 | 02:21:00 INFO - TEST-INFO | 15852: exit 0 02:21:00 INFO - TEST-OK | kraken | took 61103ms 02:21:00 INFO - SUITE-END | took 1175s 02:21:00 INFO - Completed test suite (00:19:35) 02:21:00 INFO - javascript benchmark 02:21:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.787424880258, 3048.6189226346705, 3062.111987523618, 3084.121025507731, 3113.501839705646, 5206.50538198871, 5217.530422261995, 5263.894722105556, 5279.788808447663, 5317.202419637057, 5248.134057880455, 5254.0, 5268.236105764662, 5316.0962636351815, 5338.172583249593, 4754.595859351951, 4808.567228949394, 4931.408231012266, 4982.0, 5024.346834911456, 4937.111319962405, 4961.131801934647, 4966.329545511346, 4966.776495057731, 4982.501749825006, 4748.738819364934, 4797.328374027639, 4833.589144922651, 4849.9757501212625, 4896.902061958759, 4881.0, 4890.608751299887, 4892.559669629751, 4930.80276788928, 4961.82633607822, 4822.807087716487, 4868.464468908417, 4887.462379138292, 4896.387951506062, 4914.754262286907, 5151.278820965068, 5182.015417070782, 5184.092783762826, 5273.0, 5394.811181608664, 5600.859978500529, 5608.719564021782, 5641.182028605829, 5655.858603534944, 5658.264425624684, 5727.770889164429, 5774.335951365605, 5779.046457334534, 5782.277215348082, 5849.03490923997, 5447.509724124848, 5462.399136095027, 5462.6995515246645, 5463.399026107125, 5464.562834973192, 5644.068728659725, 5730.856728581735, 5783.8554036149435, 5886.411358864079, 5889.764409423661, 5625.859353516113, 5654.349749778746, 5663.716814159276, 5671.688057156896, 5682.516986056149, 5682.147677848356, 5720.427957204246, 5757.366689664133, 5765.221695071112, 5766.596338256281, 5509.421510741315, 5537.833864984057, 5591.944080559142, 5593.580481463907, 5691.686957217393, 5642.351129620064, 5642.4075472075665, 5644.858878527987, 5686.715664216773, 5694.715264236772, 4354.0, 4361.716488428242, 4361.869143925687, 4364.890877728082, 4402.933955990663, 3831.7700937943814, 3893.805309734502, 3903.882883513499, 3905.3556163233316, 3918.1967696622123, 5394.62237643369, 5405.324334458192, 5409.0263752524925, 5413.918791218135, 5445.37378201504, 5726.141078838207, 5767.36558978512, 5770.019096753478, 5770.105633626795, 5814.680192589448, 5194.3766747990485, 5288.894222115536, 5333.120035194227, 5344.706041167773, 5391.272178255886, 4948.529889660476, 4980.377452818398, 4990.3762029746285, 4990.925136122888, 5043.394792624908, 5744.4542768438605, 5798.478136967608, 5800.4199580042505, 5811.302643682785, 5827.562932780059, 5560.471755183251, 5573.916391254215, 5610.635308704921, 5631.7184140793615, 5655.886882262414, 5741.1388291756575, 5748.45389687979, 5751.252337196138, 5753.338366087786, 5757.193992841089, 5477.04151773446, 5588.329400471969, 5590.720463976866, 5592.720363981866, 5596.692181930033, 5640.85897852557, 5656.1798539212405, 5716.714164291686, 5753.482186603226, 5757.222774925332, 5585.860353491195, 5593.412691667317, 5596.104623260258, 5600.523955463831, 5601.831945041656, 5397.028534863763, 5421.295231619864, 5593.720313984203, 5600.131979543177, 5603.299587551556, 5362.115250983544, 5427.457254274699, 5427.48438898304, 5430.212619170277, 5474.151506516497, 5527.281453411191, 5580.748866300945, 5615.354234263112, 5623.044082505902, 5624.465675760796, 5367.731613419392, 5408.323959505062, 5449.754761035842, 5456.699881506555, 5463.754131064032], "value": 5245.013756393917, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.610197269802, 627.6830200748622, 631.9873602527947, 648.7242921758252, 649.7920665387076, 31242.0, 31950.20124496886, 43400.565994340046, 44415.0, 44472.77763611177, 42627.36058959118, 46953.0, 47035.0, 47035.52964470354, 47079.52920470803, 9001.099890010995, 9168.174864262215, 9179.357444978854, 9180.8622870657, 9184.954075229614, 8776.297896168291, 8877.156670116328, 8881.1118888111, 8881.77795555113, 8884.422512536697, 8945.0607686193, 8945.686900958468, 8977.0, 8977.506237156953, 8979.730608081769, 8883.022867484571, 8940.061293564147, 8943.64225430982, 8947.0, 8947.1052894711, 8918.55407229636, 8948.8657670135, 8960.103989601053, 9033.909660903373, 9035.141661542142, 43322.35016474756, 43691.34462983058, 43821.12357752859, 43844.78077609592, 43857.78071109624, 3387.983060084684, 3457.567804024497, 3477.826108694555, 3502.7548071634997, 3631.364511210554, 32853.0, 33008.504872426936, 33346.1663458413, 34280.828595857114, 34827.651723482944, 4252.489701235841, 4287.764172970486, 4292.506361768405, 4333.349997500401, 4471.910561788746, 367303.0, 367657.0, 367731.0, 368279.0, 369927.0, 56243.718781405834, 56268.0, 56270.0, 60248.39751602516, 61334.0799888002, 35454.468182977274, 65046.0, 65363.0, 65425.67287163534, 65461.67269163624, 15240.085594864344, 16089.356425743073, 16133.0, 16135.112568808594, 16139.435119770751, 13558.254296013814, 13747.0, 13755.724885502234, 13791.448342066406, 13840.653983650489, 19292.967280932437, 19308.71036934447, 19363.128659210368, 19377.224911003683, 19486.512837179183, 6922.688479018456, 6985.1617805863625, 7091.971664108779, 7145.499815013003, 7329.413646908234, 943.8772959515356, 964.4020707161604, 1059.9311044782064, 1087.4345340423095, 1103.093349025308, 32357.352852942808, 32372.676273237437, 32451.350972980406, 32957.34085318328, 33282.0, 1098.6099934523288, 1159.2349049627373, 1171.701216189866, 1183.798754211786, 1234.975300493985, 16719.83280167207, 17075.40236091731, 17080.48758537246, 17339.21973511195, 17383.043932583576, 537992.0, 539618.0, 543853.0, 545959.0, 546946.3263418446, 61724.0, 61947.38052619416, 62253.37746622566, 62269.688651556455, 62366.0, 1206.4390058622782, 1311.2198242045968, 1320.9273489958146, 1347.7843545032747, 1360.3538319298452, 32669.836650816593, 33939.830300848334, 34034.489482658275, 34242.03389153534, 34465.0, 51082.0, 51634.74182629063, 51930.480695192564, 52023.73988130035, 52104.0, 405966.0, 408204.0, 410547.0, 410957.0, 411732.0, 24882.875585621958, 27146.72853271442, 27970.783359913872, 28043.43913121767, 28231.57652635171, 48638.02723945572, 48832.267515988, 48934.26598600952, 49777.25334120064, 50012.24981625351, 40745.18509629732, 41208.38187427131, 42000.36999445072, 42043.7897810509, 42491.0, 40678.593214068664, 40944.18111637691, 41210.0, 41548.0, 41676.1664766709, 41427.58572414358, 41820.372694409, 43004.0, 43037.78481107575, 43141.56858431501, 36138.45792313065, 36456.81771591125, 37149.0, 37377.0, 37435.0, 28228.71771282261, 28290.575641364983, 28617.0, 28641.570376444786, 28659.0], "value": 20332.62700417521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2022443877832, 388.89694231028767, 390.75773020727144, 391.21561269654336, 408.80173116038736, 14121.646958826035, 15430.3827846886, 17681.557961050963, 19202.615947681057, 19214.519637009063, 14454.638634034129, 18170.5457363566, 18183.27266909322, 18271.817281827178, 18698.25206991722, 5576.832695019156, 5631.859203519924, 5651.378348381675, 5725.770969161229, 5823.941760582404, 4064.126212864234, 5636.605437619368, 5672.489475947164, 5732.971335143318, 6001.549883758714, 6287.811365659015, 6398.424141827235, 6433.195850518685, 6434.163558737358, 6437.742490300382, 6177.969110154443, 6379.0, 6387.1377364055725, 6393.520485963571, 6393.552451328409, 5608.046632072557, 5613.326400831886, 5616.185653080322, 5616.438356164392, 5629.634073785191, 22195.778042219696, 23325.0, 23398.766012339827, 23974.760252397427, 25268.494630107478, 2500.4874000829786, 2522.823402361835, 2565.6921169459597, 2623.829451085673, 2631.4210873607967, 14504.70990580193, 14736.336864841109, 15314.463993760277, 15747.763783543256, 16011.839881601152, 1959.6178745144703, 2070.8136267735977, 2095.1409921931936, 2135.5942370949624, 2183.879886606236, 64729.676351618415, 67426.0, 87356.56321718414, 91383.0, 91838.0, 15800.604984875241, 16909.0, 17226.224819883137, 17235.310587576358, 17418.65162696739, 29535.556966645516, 29855.701442985293, 29979.250518737204, 30017.699823001927, 30125.548116778267, 8294.460860044199, 9315.0, 9526.142647161789, 9903.851442228372, 10054.899451005542, 8128.715494957766, 8158.918410815934, 8370.16298370158, 8492.193241642035, 8520.531370774543, 8405.663773448994, 8566.443181193203, 8669.523176225242, 8753.693620723245, 8821.250193733476, 3184.7770656053854, 3377.6622337766025, 3381.323735252959, 3421.2473255883665, 3472.541532556332, 901.715959472764, 921.861720741894, 942.7501712046313, 991.4299277915228, 1008.9243306752023, 18084.728729069073, 18511.81488185101, 18815.435536933914, 18875.52811179704, 19107.713384299248, 963.1764841060932, 1014.7108074198966, 1027.773889744255, 1053.378506681062, 1077.0737166037202, 9800.35390444576, 10485.528151233213, 10541.947290263653, 10556.261061725605, 10611.787764244671, 443256.0, 451532.0, 460029.0, 461314.0, 465039.0, 83961.58019209864, 88459.11540884638, 88644.0, 88962.0, 89956.0, 988.5205675247499, 999.4602914426129, 1009.2329829329763, 1031.2059714020163, 1032.2413026425572, 15512.767308490156, 16539.173041348124, 16611.41860034893, 16613.50159495217, 16773.496795096165, 35924.0, 38465.80767096147, 39345.21309573735, 40993.975150621474, 41736.79131604323, 48882.75558622184, 51721.7413912928, 53901.73049134729, 54908.72545637406, 59247.0, 7377.8155546111775, 7434.628268586657, 8170.42807003504, 8453.112423195476, 8651.394402391772, 12099.516019359478, 12404.131710780159, 12513.624591262276, 12616.747665046463, 13066.281354525592, 10947.397893115955, 11031.503582338975, 11334.846379187928, 11508.769824603629, 11531.077513799044, 10164.186865050926, 10767.300125491818, 11060.778784424427, 11273.71815704614, 11533.423328833693, 11211.887881121085, 11498.712532186762, 11532.481038353462, 11549.6535103947, 11636.36000020007, 7424.777256682308, 7544.886826697494, 7565.470417070972, 7713.614319283901, 7729.0, 11412.08703303717, 11467.885321147016, 11573.669028061544, 11586.420678966186, 11631.88368116342], "value": 9811.64223128923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.0920355750977, 1458.8468210837862, 1477.6379786952198, 1557.3614817924654, 1748.283203886406, 8424.1997010284, 8933.330000249984, 8935.731928042162, 9087.591058402371, 9177.403468774524, 8891.955540222307, 9077.546122693871, 9088.72733817985, 9089.68186113486, 9096.77258068547, 1992.80071992801, 2276.829237807163, 2319.7796209360126, 2345.6716059751648, 2363.775441333079, 2325.7092863392077, 2334.9883250583725, 2336.380859072347, 2337.1002164166835, 2338.0, 2312.4334538038206, 2322.9883850580723, 2365.775251351119, 2368.0646144772804, 2368.2895131460577, 1974.1511150205406, 2175.5322605639863, 2240.484688521633, 2242.473018840571, 2248.9100435982623, 2299.977000229993, 2319.1998760427628, 2344.4138965258685, 2344.4959333743327, 2345.8475199112004, 9133.908660913372, 9198.908010919871, 9200.585973631203, 9206.263498920138, 9210.81578368429, 5250.842474725764, 5375.059364611217, 5378.381486129106, 5381.838544843661, 5385.272988146589, 3183.649798522161, 3297.505374193866, 3342.5487559179687, 3352.614449338333, 3391.253924136711, 1056.4348073780568, 1072.9538699767743, 1093.0872721277742, 1093.1145771924687, 1106.9280496767685, 12769.680757981125, 12794.232346059172, 12807.935960320232, 12819.230846149261, 12825.102242843004, 4535.591796738309, 4605.0559635274685, 4707.2468405055715, 4709.67032307742, 4715.717056976592, 10239.897601024044, 10264.43545604984, 10270.486475676336, 10284.177265818716, 10289.3311934724, 5322.2548843161985, 5372.301600791872, 5377.7311134443125, 5380.757865896044, 5383.542398896059, 4396.846110386121, 4669.696469729524, 4783.043391321749, 4798.712077275374, 4833.347498087784, 3854.6338097880657, 3960.6237407446247, 3965.167314863911, 4040.6969477288735, 4090.0, 1214.7388311513066, 1221.8373478942221, 1232.9815052774215, 1271.1927925767204, 1272.5291642092484, 858.2018722588053, 962.1629182611173, 966.8791401074866, 983.2723784399493, 1021.7292417509366, 6047.879042419127, 6052.303985041688, 6116.235470566179, 6139.539534534928, 6153.046277826944, 451.905099929012, 458.3560098062228, 461.5937974582346, 867.4058270085012, 1026.071405378134, 4266.381374700713, 4291.120320334324, 4312.611864932172, 4326.178026175016, 4376.912461750747, 11185.272957257752, 11526.769464610661, 11658.53365865356, 11668.474918628683, 11673.241239319417, 11424.885751142549, 11455.083593312682, 11506.94246528762, 11523.308601483937, 11538.59614913474, 7632.542047477169, 8083.110857805755, 8095.190480951857, 8361.205685459872, 8568.742937711879, 5400.325898971331, 5555.2778138841695, 5578.832635020955, 5585.050541407889, 6179.250233645985, 10237.74405639865, 10304.484775761332, 10473.26687131924, 10551.050405463546, 10600.098991585493, 9990.500474976367, 10387.584496620051, 10390.480475976323, 10917.454127293762, 10920.56317747313, 7739.380849532136, 7803.453758236869, 7866.449348545547, 7914.287714105528, 7931.801704957422, 8281.21328473794, 8283.213094755989, 8336.0, 8336.791580210544, 8371.121032291521, 6900.861982760216, 7079.0, 7093.6453177341955, 7171.784846454615, 7219.639018049182, 7446.813829654302, 7509.3617042552, 7543.698252069856, 7569.814209932432, 7670.654820532978, 6961.408280296029, 7000.579965202104, 7038.331358520933, 7039.401650859734, 7043.929560704328, 4904.6566740327835, 5023.874403139951, 5083.72039537829, 5130.281760553451, 5178.275041494269, 5023.799048038038, 5106.157484015244, 5150.459201783909, 5177.611679124156, 5302.496262855023], "value": 4601.6941732146215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.4481388488167, 331.87554666999876, 335.9479280711491, 336.7289332087668, 343.6958291911659, 5317.627766056377, 5340.359156901172, 5360.5443537299325, 5374.0, 5435.320584926884, 5282.072043704049, 5286.127788914834, 5306.893862122755, 5322.680639161653, 5324.174752913295, 3913.7847418391975, 4155.958440415602, 4170.7914604269745, 4193.370994350857, 4210.726302790325, 4070.5318888327924, 4112.465379500661, 4117.258893399187, 4127.0, 4134.131832315217, 4112.8971775705695, 4113.239050775601, 4113.979430102845, 4128.442660240859, 4136.869512201219, 3892.824822882977, 3923.215356928597, 4065.9796701016307, 4105.3020986432075, 4151.23202207591, 3562.928741425157, 3574.160072382988, 3583.8387272572795, 3588.1926566522584, 3611.638836116367, 5155.149400348938, 5155.381354237516, 5161.27742116104, 5189.610779191538, 5215.217717342429, 4275.4228179195725, 4492.495014170224, 4579.519150489184, 4617.676762626617, 4630.0, 5476.58925580583, 5521.095222148392, 5525.309336332958, 5526.972365138189, 5543.334799824007, 3930.567637559866, 3969.4244334571326, 3969.960300397017, 3971.7418367806, 3984.6812255019527, 5566.803137325494, 5767.68277744728, 5772.278465191851, 5784.971075144639, 5786.3056433228285, 4036.414719865662, 4055.2497787909333, 4062.512498500199, 4071.2875246831686, 4074.7758873262255, 4100.138970816102, 4101.405296232029, 4108.77401742907, 4129.2773764591075, 4150.398192262105, 4479.7984090716, 4657.347971284023, 4681.6020638245445, 4689.742064186435, 4747.121782470254, 5503.174523821459, 5507.0637991541535, 5530.529904958124, 5539.362973258047, 5547.55619550435, 1406.7116241170536, 1408.1621435246013, 1410.4569740649924, 1416.0937000319805, 1423.3381477612959, 854.4616891358404, 873.5413907698382, 880.212210071982, 886.7384121684119, 890.2788741119714, 4664.55686709762, 4732.858014259577, 4741.857744267678, 4741.976290118528, 4767.998720268783, 4969.279454479152, 4991.450940396553, 5001.274815151783, 5052.686301561621, 5071.290019397287, 4753.239481682914, 4768.9031522749965, 4775.116603428377, 4782.95217047832, 4946.579540739078, 2884.1924261206896, 2967.109867039879, 3029.424409362214, 3059.2504836315247, 3068.938621227563, 5717.742701578439, 5751.913721294184, 5766.250387449605, 5798.391168927286, 5802.593818432669, 5603.299587551556, 5815.389384114607, 5838.562107841929, 5849.736761845727, 5856.560757943172, 5694.772209111672, 5756.510696590837, 5761.193432919478, 5761.9135712964335, 5780.682062486603, 5649.180868774087, 5662.235598194356, 5720.141978703228, 5720.570957178145, 5725.368270043018, 5380.488853558905, 5694.288213973254, 5712.343080545625, 5718.142278658068, 5727.627704199213, 5710.314762228559, 5744.281964754406, 5753.5616095976, 5778.624389414675, 5802.82591522255, 4097.426360309619, 4160.854370097032, 4167.166566686614, 4184.142250838631, 4207.684423668176, 5615.691136987505, 5632.352279487747, 5649.54803615718, 5650.29371328584, 5671.461211184931, 5482.506574408163, 5499.175123731472, 5505.779768809202, 5505.834824955257, 5527.861803454945, 5239.685618862881, 5498.340199176125, 5520.392756796829, 5536.307961504812, 5600.131979543177, 5391.16436952273, 5490.529261832271, 5494.5054945055135, 5507.972460137674, 5510.504054635102, 5597.244372009726, 5629.54963602919, 5634.267545219259, 5634.971825140848, 5637.689927053887, 5222.947770522398, 5497.752601133038, 5527.530159936289, 5535.114381698909, 5539.14143307788], "value": 4174.754932231077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.3615949884351, 726.3535453446434, 729.6534146280518, 780.855541724781, 850.4472093139459, 14884.181370024658, 15194.468193613226, 15229.847701522995, 15233.086014839117, 15390.38438462463, 14646.121232726044, 14727.410903563872, 14783.852161478382, 14790.630234244123, 14828.332725027372, 655.678717428459, 760.3878877503607, 784.262792974602, 786.4259090863673, 791.8099656082527, 786.7954331873725, 790.5928446849877, 791.7505985614513, 791.877259024852, 793.9126696063429, 849.583703985049, 850.1795767084762, 850.8298340331927, 850.8766228896807, 851.3529717414779, 689.472553496573, 710.7547895975906, 809.401043228007, 835.6490274084899, 849.3799526345771, 614.2659521871366, 614.8124821929309, 615.7383112177307, 616.6824085595922, 616.7255571270787, 14436.0, 14449.205293708841, 14460.204688742115, 14475.78286325706, 14488.0, 13768.24274664893, 14270.714585708332, 14493.347799349054, 14542.27288635564, 14642.41430342785, 11545.365004924726, 11671.533138674442, 12351.683034673042, 12572.119951603392, 13240.404181811842, 4449.7330160190495, 4488.7531185784765, 4488.8877778055485, 4684.297355396718, 4693.718376897397, 69758.0, 70087.0, 70573.2942670577, 71857.28142718558, 72774.27225727728, 11414.828777568344, 11514.136439767051, 11554.306741595532, 11589.420528973518, 11653.53385864573, 19322.130504127348, 19594.70607940882, 19658.803411965982, 19670.213191472467, 19707.704384434244, 7922.0, 8126.634301456449, 8163.428560000743, 8176.01887773471, 8244.54654993981, 4682.297655351725, 4701.764911754399, 4714.834980775725, 4751.548602882721, 4890.804367825318, 3266.5263536787033, 3375.628680845105, 3387.4749413840896, 3394.0666316762595, 3394.490826376014, 573.0744847071949, 577.4023885278716, 577.6534079552235, 585.5783835638333, 597.3399393670019, 585.6983653418492, 592.386879579633, 671.9092922455503, 679.0120374854673, 692.9307069293131, 8839.69061082859, 9203.309751768644, 9342.159205671522, 9379.24966002718, 9476.50285190963, 542.9348478182643, 558.7988324203284, 564.4271064869079, 582.7843697831829, 598.7305712429425, 3822.1782316802023, 4047.0489434982755, 4206.747595144301, 4756.357891684578, 4801.207800712913, 117643.0, 125254.0, 129686.0, 129819.35090324488, 129939.0, 86104.0, 109842.0, 110391.44804276088, 111205.44397277961, 112575.4371228155, 92245.53877230705, 94081.0, 96246.9999999986, 96951.51524242334, 99255.0, 9338.338573506519, 9538.618455261712, 9576.952115239379, 9599.456483729347, 9713.0, 54925.17612235899, 55128.173077404674, 55379.16931246115, 55760.44239557715, 55885.72057139851, 74969.62515187389, 81404.59297703474, 82153.58923205346, 82254.58872705598, 82981.0, 12619.87380126187, 12690.712854393618, 12701.87298127007, 12908.354582271037, 12976.545820896223, 13781.448742050206, 13795.310234488436, 13940.79088813689, 14255.287235638383, 14432.350544225324, 12978.415971281127, 13105.737885242432, 13234.376014503834, 13320.467181313026, 14022.579322620337, 12475.0, 12874.227546347249, 12916.160449570747, 12972.221666700028, 13144.737105257651, 12966.416511256828, 13213.669658258621, 13254.403551840383, 13257.933710331386, 13318.267495287851, 8950.373473856767, 9242.768930776785, 9297.442153470813, 9449.338546301968, 9851.359661621971, 9217.446953182562, 9305.627774889199, 9758.530733585738, 9806.705798826046, 9919.2560557957], "value": 7376.273260481149, "unit": "score"}], "name": "dromaeo_css", "value": 7275.326960800068, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 112.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 143.0, 155.0, 127.0, 160.0, 158.0, 126.0, 190.0, 126.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 130.0, 75.0, 75.0, 74.0, 74.0, 98.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 114.0, 85.0, 84.0, 86.0, 125.0, 85.0, 85.0, 127.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 52.0, 54.0, 66.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 79.0, 85.0, 80.0, 80.0, 82.0, 114.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 121.0, 129.0, 121.0, 121.0, 122.0, 126.0, 126.0, 140.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 162.0, 161.0, 159.0, 159.0, 162.0, 168.0, 159.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 64.0, 70.0, 65.0, 69.0, 63.0, 63.0, 64.0, 62.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1504.3, "alertThreshold": 2.0}]} 02:21:01 INFO - Return code: 0 02:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:21:01 ERROR - # TBPL SUCCESS # 02:21:01 INFO - Running post-action listener: _resource_record_post_action 02:21:01 INFO - ##### 02:21:01 INFO - ##### Finished run-tests step (success) 02:21:01 INFO - ##### 02:21:01 INFO - Running post-run listener: _resource_record_post_run 02:21:01 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544026624; Read time: 12; Write time: 462724 02:21:01 INFO - TinderboxPrint: CPU usage
13.2% 02:21:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:21:01 INFO - TinderboxPrint: I/O write bytes / time
544,026,624 / 462,724 02:21:01 INFO - TinderboxPrint: CPU idle
8,263.9 (86.8%) 02:21:01 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 02:21:01 INFO - TinderboxPrint: Swap in / out
0 / 0 02:21:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248258560; Read time: 0; Write time: 231744 02:21:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295182336; Read time: 12; Write time: 230972 02:21:01 INFO - Running post-run listener: _upload_blobber_files 02:21:01 INFO - Blob upload gear active. 02:21:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:21:02 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:02 INFO - (blobuploader) - INFO - Done attempting. 02:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:07 INFO - (blobuploader) - INFO - Done attempting. 02:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:07 INFO - (blobuploader) - INFO - Done attempting. 02:21:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:07 INFO - Return code: 0 02:21:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5529364dcda361621a11bd55537c8e59210ebea31151ca6c4eab0ad2b93f693d8b54954fa33dfa795195e1c526b7f570c165fda53ffed99b65f10cc1c544657a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56dd743c37331391db5ae038ee6cf1a199fec305baefb47768fe3d8c570c2c38f6f33a17afac6ade80a04592c2d9f1c31e56f54f54ab7707d9b68928688d5696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d10f292484f1bceceaf2a77d41691ee9539e7e63405f6d6e782f0f0cd99ae7be360c4c103155284e8c3f8cc902f92619baadb8e9e797535aba5794ea5f618eed"} 02:21:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:07 INFO - Contents: 02:21:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5529364dcda361621a11bd55537c8e59210ebea31151ca6c4eab0ad2b93f693d8b54954fa33dfa795195e1c526b7f570c165fda53ffed99b65f10cc1c544657a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56dd743c37331391db5ae038ee6cf1a199fec305baefb47768fe3d8c570c2c38f6f33a17afac6ade80a04592c2d9f1c31e56f54f54ab7707d9b68928688d5696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d10f292484f1bceceaf2a77d41691ee9539e7e63405f6d6e782f0f0cd99ae7be360c4c103155284e8c3f8cc902f92619baadb8e9e797535aba5794ea5f618eed"} 02:21:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:07 INFO - Copying logs to upload dir... 02:21:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.677483 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-10 02:21:07.665628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 02:21:07.669120) ========= 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=ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159 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/5529364dcda361621a11bd55537c8e59210ebea31151ca6c4eab0ad2b93f693d8b54954fa33dfa795195e1c526b7f570c165fda53ffed99b65f10cc1c544657a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56dd743c37331391db5ae038ee6cf1a199fec305baefb47768fe3d8c570c2c38f6f33a17afac6ade80a04592c2d9f1c31e56f54f54ab7707d9b68928688d5696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d10f292484f1bceceaf2a77d41691ee9539e7e63405f6d6e782f0f0cd99ae7be360c4c103155284e8c3f8cc902f92619baadb8e9e797535aba5794ea5f618eed"} build_url:https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5529364dcda361621a11bd55537c8e59210ebea31151ca6c4eab0ad2b93f693d8b54954fa33dfa795195e1c526b7f570c165fda53ffed99b65f10cc1c544657a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56dd743c37331391db5ae038ee6cf1a199fec305baefb47768fe3d8c570c2c38f6f33a17afac6ade80a04592c2d9f1c31e56f54f54ab7707d9b68928688d5696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d10f292484f1bceceaf2a77d41691ee9539e7e63405f6d6e782f0f0cd99ae7be360c4c103155284e8c3f8cc902f92619baadb8e9e797535aba5794ea5f618eed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 02:21:07.694862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:21:07.695209) ========= 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=ed14279e38b05397cf4aa391000001a4-1465549205.302600-1501636159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:21:07.780597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 02:21:07.780927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 02:21:07.781282) ========= ========= Total master_lag: 0.18 =========