builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1466764705.47 results: success (0) buildid: 20160624022607 builduid: 3ff0b37f932c4c7a9c414116f1f3575c revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.469968) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.470366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.470688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.498775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.499057) ========= 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=232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 03:38:26-- 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% 30.8M=0s 2016-06-24 03:38:26 (30.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.615266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.615874) ========= 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=232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015834 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.666079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:25.666408) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f27664669366144c1756f0b416277c16ac96ac2 --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 9f27664669366144c1756f0b416277c16ac96ac2 --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=232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 03:38:26,858 truncating revision to first 12 chars 2016-06-24 03:38:26,858 Setting DEBUG logging. 2016-06-24 03:38:26,858 attempt 1/10 2016-06-24 03:38:26,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f2766466936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 03:38:27,161 unpacking tar archive at: fx-team-9f2766466936/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:26.328226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:26.328587) ========= script_repo_revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:26.328966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:26.329289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:38:26.348517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-24 03:38:26.348790) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:38:27 INFO - MultiFileLogger online at 20160624 03:38:27 in /builds/slave/test 03:38:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:38:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:27 INFO - {'append_to_log': False, 03:38:27 INFO - 'base_work_dir': '/builds/slave/test', 03:38:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:38:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:27 INFO - 'branch': 'Fx-Team-Non-PGO', 03:38:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:27 INFO - 'config_files': ('talos/linux_config.py',), 03:38:27 INFO - 'default_actions': ('clobber', 03:38:27 INFO - 'read-buildbot-config', 03:38:27 INFO - 'download-and-extract', 03:38:27 INFO - 'populate-webroot', 03:38:27 INFO - 'create-virtualenv', 03:38:27 INFO - 'install', 03:38:27 INFO - 'run-tests'), 03:38:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:27 INFO - 'download_minidump_stackwalk': True, 03:38:27 INFO - 'download_symbols': 'ondemand', 03:38:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:27 INFO - 'installer_path': 'installer.exe', 03:38:27 INFO - 'log_level': 'info', 03:38:27 INFO - 'log_name': 'talos', 03:38:27 INFO - 'log_to_console': True, 03:38:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:38:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:38:27 INFO - 'opt_config_files': (), 03:38:27 INFO - 'pip_index': False, 03:38:27 INFO - 'sps_profile': False, 03:38:27 INFO - 'sps_profile_interval': 0, 03:38:27 INFO - 'suite': 'dromaeojs', 03:38:27 INFO - 'system_bits': '32', 03:38:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:27 INFO - 'title': 'talos-linux64-ix-025', 03:38:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:27 INFO - 'use_talos_json': True, 03:38:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:27 INFO - 'work_dir': 'build'} 03:38:27 INFO - ##### 03:38:27 INFO - ##### Running clobber step. 03:38:27 INFO - ##### 03:38:27 INFO - Running pre-action listener: _resource_record_pre_action 03:38:27 INFO - Running main action method: clobber 03:38:27 INFO - rmtree: /builds/slave/test/build 03:38:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:28 INFO - Running post-action listener: _resource_record_post_action 03:38:28 INFO - ##### 03:38:28 INFO - ##### Finished clobber step (success) 03:38:28 INFO - ##### 03:38:28 INFO - ##### 03:38:28 INFO - ##### Running read-buildbot-config step. 03:38:28 INFO - ##### 03:38:28 INFO - Running pre-action listener: _resource_record_pre_action 03:38:28 INFO - Running main action method: read_buildbot_config 03:38:28 INFO - Using buildbot properties: 03:38:28 INFO - { 03:38:28 INFO - "project": "", 03:38:28 INFO - "product": "firefox", 03:38:28 INFO - "script_repo_revision": "production", 03:38:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:38:28 INFO - "repository": "", 03:38:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:38:28 INFO - "buildid": "20160624022607", 03:38:28 INFO - "pgo_build": "False", 03:38:28 INFO - "basedir": "/builds/slave/test", 03:38:28 INFO - "buildnumber": 1882, 03:38:28 INFO - "slavename": "talos-linux64-ix-025", 03:38:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:38:28 INFO - "platform": "ubuntu64_hw", 03:38:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:38:28 INFO - "branch": "fx-team", 03:38:28 INFO - "repo_path": "integration/fx-team", 03:38:28 INFO - "revision": "9f27664669366144c1756f0b416277c16ac96ac2", 03:38:28 INFO - "stage_platform": "linux64", 03:38:28 INFO - "builduid": "3ff0b37f932c4c7a9c414116f1f3575c", 03:38:28 INFO - "slavebuilddir": "test" 03:38:28 INFO - } 03:38:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:38:28 INFO - Running post-action listener: _resource_record_post_action 03:38:28 INFO - ##### 03:38:28 INFO - ##### Finished read-buildbot-config step (success) 03:38:28 INFO - ##### 03:38:28 INFO - ##### 03:38:28 INFO - ##### Running download-and-extract step. 03:38:28 INFO - ##### 03:38:28 INFO - Running pre-action listener: _resource_record_pre_action 03:38:28 INFO - Running main action method: download_and_extract 03:38:28 INFO - mkdir: /builds/slave/test/build/tests 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:28 INFO - Downloaded 1361 bytes. 03:38:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:38:28 INFO - Using the following test package requirements: 03:38:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:38:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:38:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:38:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'jsshell-linux-x86_64.zip'], 03:38:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:38:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:38:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:38:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:38:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:38:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:38:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:34 INFO - Downloaded 22710890 bytes. 03:38:34 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'] 03:38:34 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 03:38:35 INFO - Return code: 0 03:38:35 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 03:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:35 INFO - https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:37 INFO - Downloaded 22710890 bytes. 03:38: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'] 03:38: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 03:38:38 INFO - Return code: 0 03:38:38 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')]} 03:38:38 INFO - https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:40 INFO - Downloaded 14405518 bytes. 03:38: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'] 03:38: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 03:38:40 INFO - Return code: 0 03:38: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')]} 03:38:40 INFO - https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN8iqcMLTLmF751GY2yrjw/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 03:38:42 INFO - Downloaded 56260774 bytes. 03:38:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:38:42 INFO - mkdir: /builds/slave/test/properties 03:38:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:42 INFO - Contents: 03:38:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:38:43 INFO - Running post-action listener: _resource_record_post_action 03:38:43 INFO - Running post-action listener: set_extra_try_arguments 03:38:43 INFO - ##### 03:38:43 INFO - ##### Finished download-and-extract step (success) 03:38:43 INFO - ##### 03:38:43 INFO - ##### 03:38:43 INFO - ##### Running populate-webroot step. 03:38:43 INFO - ##### 03:38:43 INFO - Running pre-action listener: _resource_record_pre_action 03:38:43 INFO - Running main action method: populate_webroot 03:38:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:43 INFO - '--tppagecycles', 03:38:43 INFO - '7'], 03:38:43 INFO - 'tests': ['tsvgm']}}, 03:38:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['damp', 'tps']}, 03:38:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'tests': ['damp', 'tps']}, 03:38:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['dromaeo_dom']}, 03:38:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['basic_compositor_video']}, 03:38:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:38:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['a11yr', 03:38:43 INFO - 'ts_paint', 03:38:43 INFO - 'tpaint', 03:38:43 INFO - 'sessionrestore', 03:38:43 INFO - 'sessionrestore_no_auto_restore', 03:38:43 INFO - 'tabpaint']}, 03:38:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:43 INFO - 'ts_paint', 03:38:43 INFO - 'tpaint', 03:38:43 INFO - 'sessionrestore', 03:38:43 INFO - 'sessionrestore_no_auto_restore', 03:38:43 INFO - 'tabpaint']}, 03:38:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:43 INFO - 'ts_paint', 03:38:43 INFO - 'tpaint', 03:38:43 INFO - 'sessionrestore', 03:38:43 INFO - 'sessionrestore_no_auto_restore', 03:38:43 INFO - 'tabpaint']}, 03:38:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:43 INFO - 'ts_paint', 03:38:43 INFO - 'tpaint', 03:38:43 INFO - 'sessionrestore', 03:38:43 INFO - 'sessionrestore_no_auto_restore', 03:38:43 INFO - 'tabpaint']}, 03:38:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['a11yr', 03:38:43 INFO - 'ts_paint', 03:38:43 INFO - 'tpaint', 03:38:43 INFO - 'sessionrestore', 03:38:43 INFO - 'sessionrestore_no_auto_restore', 03:38:43 INFO - 'tabpaint']}, 03:38:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['a11yr', 03:38:43 INFO - 'ts_paint', 03:38:43 INFO - 'tpaint', 03:38:43 INFO - 'sessionrestore', 03:38:43 INFO - 'sessionrestore_no_auto_restore', 03:38:43 INFO - 'tabpaint']}, 03:38:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['tsvgx', 03:38:43 INFO - 'tsvgr_opacity', 03:38:43 INFO - 'tart', 03:38:43 INFO - 'tscrollx', 03:38:43 INFO - 'cart']}, 03:38:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:43 INFO - 'tsvgr_opacity', 03:38:43 INFO - 'tart', 03:38:43 INFO - 'tscrollx', 03:38:43 INFO - 'cart']}, 03:38:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'talos_options': ['--disable-e10s'], 03:38:43 INFO - 'tests': ['tp5o']}, 03:38:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'tests': ['tp5o']}, 03:38:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'talos_options': ['--disable-e10s', 03:38:43 INFO - '--xperf_path', 03:38:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:43 INFO - 'tests': ['tp5n']}, 03:38:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:43 INFO - 'talos_options': ['--xperf_path', 03:38:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:43 INFO - 'tests': ['tp5n']}}, 03:38:43 INFO - 'talos.zip': {'path': '', 03:38:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:43 INFO - Running post-action listener: _resource_record_post_action 03:38:43 INFO - ##### 03:38:43 INFO - ##### Finished populate-webroot step (success) 03:38:43 INFO - ##### 03:38:43 INFO - ##### 03:38:43 INFO - ##### Running create-virtualenv step. 03:38:43 INFO - ##### 03:38:43 INFO - Running pre-action listener: _resource_record_pre_action 03:38:43 INFO - Running main action method: create_virtualenv 03:38:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:38:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:43 INFO - Using real prefix '/usr' 03:38:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:45 INFO - Installing pip.................done. 03:38:45 INFO - Return code: 0 03:38:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:38: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 03:38: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 03:38:45 INFO - Using env: {'DISPLAY': ':0', 03:38:45 INFO - 'HOME': '/home/cltbld', 03:38:45 INFO - 'LANG': 'en_US.UTF-8', 03:38:45 INFO - 'LANGUAGE': 'en_US:en', 03:38:45 INFO - 'LOGNAME': 'cltbld', 03:38:45 INFO - 'MAIL': '/var/mail/cltbld', 03:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:45 INFO - 'MOZ_NO_REMOTE': '1', 03:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:45 INFO - 'NO_EM_RESTART': '1', 03:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:45 INFO - 'PWD': '/builds/slave/test', 03:38:45 INFO - 'SHELL': '/bin/bash', 03:38:45 INFO - 'SHLVL': '1', 03:38:45 INFO - 'TERM': 'linux', 03:38:45 INFO - 'TMOUT': '86400', 03:38:45 INFO - 'USER': 'cltbld', 03:38:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:45 INFO - '_': '/tools/buildbot/bin/python'} 03:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38: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 03:38:45 INFO - Cleaning up... 03:38:45 INFO - Return code: 0 03:38:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:38: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 03:38: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 03:38:45 INFO - Using env: {'DISPLAY': ':0', 03:38:45 INFO - 'HOME': '/home/cltbld', 03:38:45 INFO - 'LANG': 'en_US.UTF-8', 03:38:45 INFO - 'LANGUAGE': 'en_US:en', 03:38:45 INFO - 'LOGNAME': 'cltbld', 03:38:45 INFO - 'MAIL': '/var/mail/cltbld', 03:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:45 INFO - 'MOZ_NO_REMOTE': '1', 03:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:45 INFO - 'NO_EM_RESTART': '1', 03:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:45 INFO - 'PWD': '/builds/slave/test', 03:38:45 INFO - 'SHELL': '/bin/bash', 03:38:45 INFO - 'SHLVL': '1', 03:38:45 INFO - 'TERM': 'linux', 03:38:45 INFO - 'TMOUT': '86400', 03:38:45 INFO - 'USER': 'cltbld', 03:38:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:45 INFO - '_': '/tools/buildbot/bin/python'} 03:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:46 INFO - Downloading/unpacking psutil>=3.1.1 03:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:48 INFO - Installing collected packages: psutil 03:38:48 INFO - Running setup.py install for psutil 03:38:48 INFO - building 'psutil._psutil_linux' extension 03:38:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:38: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 03:38:48 INFO - building 'psutil._psutil_posix' extension 03:38: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 03:38: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 03:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:48 INFO - Successfully installed psutil 03:38:48 INFO - Cleaning up... 03:38:48 INFO - Return code: 0 03:38:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:38: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 03:38: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 03:38:48 INFO - Using env: {'DISPLAY': ':0', 03:38:48 INFO - 'HOME': '/home/cltbld', 03:38:48 INFO - 'LANG': 'en_US.UTF-8', 03:38:48 INFO - 'LANGUAGE': 'en_US:en', 03:38:48 INFO - 'LOGNAME': 'cltbld', 03:38:48 INFO - 'MAIL': '/var/mail/cltbld', 03:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:48 INFO - 'MOZ_NO_REMOTE': '1', 03:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:48 INFO - 'NO_EM_RESTART': '1', 03:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:48 INFO - 'PWD': '/builds/slave/test', 03:38:48 INFO - 'SHELL': '/bin/bash', 03:38:48 INFO - 'SHLVL': '1', 03:38:48 INFO - 'TERM': 'linux', 03:38:48 INFO - 'TMOUT': '86400', 03:38:48 INFO - 'USER': 'cltbld', 03:38:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:48 INFO - '_': '/tools/buildbot/bin/python'} 03:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:38:50 INFO - Installing collected packages: mozsystemmonitor 03:38:50 INFO - Running setup.py install for mozsystemmonitor 03:38:50 INFO - Successfully installed mozsystemmonitor 03:38:50 INFO - Cleaning up... 03:38:50 INFO - Return code: 0 03:38:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:38: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 03:38: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 03:38:50 INFO - Using env: {'DISPLAY': ':0', 03:38:50 INFO - 'HOME': '/home/cltbld', 03:38:50 INFO - 'LANG': 'en_US.UTF-8', 03:38:50 INFO - 'LANGUAGE': 'en_US:en', 03:38:50 INFO - 'LOGNAME': 'cltbld', 03:38:50 INFO - 'MAIL': '/var/mail/cltbld', 03:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:50 INFO - 'MOZ_NO_REMOTE': '1', 03:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:50 INFO - 'NO_EM_RESTART': '1', 03:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:51 INFO - 'PWD': '/builds/slave/test', 03:38:51 INFO - 'SHELL': '/bin/bash', 03:38:51 INFO - 'SHLVL': '1', 03:38:51 INFO - 'TERM': 'linux', 03:38:51 INFO - 'TMOUT': '86400', 03:38:51 INFO - 'USER': 'cltbld', 03:38:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:51 INFO - '_': '/tools/buildbot/bin/python'} 03:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:38:51 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 03:38:51 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 03:38:51 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 03:38:51 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 03:38:51 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 03:38:51 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 03:38:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:53 INFO - warning: no files found matching '*.txt' 03:38:53 INFO - no previously-included directories found matching 'build' 03:38:53 INFO - no previously-included directories found matching 'dist' 03:38:53 INFO - no previously-included directories found matching '.git*' 03:38:53 INFO - Installing collected packages: jsonschema, functools32 03:38:53 INFO - Running setup.py install for functools32 03:38:53 INFO - warning: no files found matching '*.txt' 03:38:53 INFO - no previously-included directories found matching 'build' 03:38:53 INFO - no previously-included directories found matching 'dist' 03:38:53 INFO - no previously-included directories found matching '.git*' 03:38:53 INFO - Successfully installed jsonschema functools32 03:38:53 INFO - Cleaning up... 03:38:53 INFO - Return code: 0 03:38:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:38: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 03:38: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 03:38:53 INFO - Using env: {'DISPLAY': ':0', 03:38:53 INFO - 'HOME': '/home/cltbld', 03:38:53 INFO - 'LANG': 'en_US.UTF-8', 03:38:53 INFO - 'LANGUAGE': 'en_US:en', 03:38:53 INFO - 'LOGNAME': 'cltbld', 03:38:53 INFO - 'MAIL': '/var/mail/cltbld', 03:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:53 INFO - 'MOZ_NO_REMOTE': '1', 03:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:53 INFO - 'NO_EM_RESTART': '1', 03:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:53 INFO - 'PWD': '/builds/slave/test', 03:38:53 INFO - 'SHELL': '/bin/bash', 03:38:53 INFO - 'SHLVL': '1', 03:38:53 INFO - 'TERM': 'linux', 03:38:53 INFO - 'TMOUT': '86400', 03:38:53 INFO - 'USER': 'cltbld', 03:38:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:53 INFO - '_': '/tools/buildbot/bin/python'} 03:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 INFO - Downloading docopt-0.6.1.tar.gz 03:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:56 INFO - Running setup.py install for blobuploader 03:38:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:56 INFO - Running setup.py install for requests 03:38:56 INFO - Running setup.py install for docopt 03:38:56 INFO - Successfully installed blobuploader requests docopt 03:38:56 INFO - Cleaning up... 03:38:57 INFO - Return code: 0 03:38:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:57 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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:38:57 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 03:38:57 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 03:38:57 INFO - Using env: {'DISPLAY': ':0', 03:38:57 INFO - 'HOME': '/home/cltbld', 03:38:57 INFO - 'LANG': 'en_US.UTF-8', 03:38:57 INFO - 'LANGUAGE': 'en_US:en', 03:38:57 INFO - 'LOGNAME': 'cltbld', 03:38:57 INFO - 'MAIL': '/var/mail/cltbld', 03:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:57 INFO - 'MOZ_NO_REMOTE': '1', 03:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:57 INFO - 'NO_EM_RESTART': '1', 03:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:57 INFO - 'PWD': '/builds/slave/test', 03:38:57 INFO - 'SHELL': '/bin/bash', 03:38:57 INFO - 'SHLVL': '1', 03:38:57 INFO - 'TERM': 'linux', 03:38:57 INFO - 'TMOUT': '86400', 03:38:57 INFO - 'USER': 'cltbld', 03:38:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:57 INFO - '_': '/tools/buildbot/bin/python'} 03:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:57 INFO - Running setup.py (path:/tmp/pip-gEIoE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:57 INFO - Running setup.py (path:/tmp/pip-49MkyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:57 INFO - Running setup.py (path:/tmp/pip-gFVNZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:57 INFO - Running setup.py (path:/tmp/pip-w8GFQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:57 INFO - Running setup.py (path:/tmp/pip-isYhWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:57 INFO - Running setup.py (path:/tmp/pip-wUAo4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:57 INFO - Running setup.py (path:/tmp/pip-36ke6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:57 INFO - Running setup.py (path:/tmp/pip-LDWpfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:57 INFO - Running setup.py (path:/tmp/pip-5NSCx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:57 INFO - Running setup.py (path:/tmp/pip-Rg6Wd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:57 INFO - Running setup.py (path:/tmp/pip-0mgeBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:58 INFO - Running setup.py (path:/tmp/pip-sGoL0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:58 INFO - Running setup.py (path:/tmp/pip-052xrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:58 INFO - Running setup.py (path:/tmp/pip-fu_TZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:58 INFO - Running setup.py (path:/tmp/pip-7drlsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:58 INFO - Running setup.py (path:/tmp/pip-MGPO19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:58 INFO - Running setup.py (path:/tmp/pip-6Zo5nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:58 INFO - Running setup.py install for manifestparser 03:38:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:58 INFO - Running setup.py install for mozcrash 03:38:58 INFO - Running setup.py install for mozdebug 03:38:58 INFO - Running setup.py install for mozdevice 03:38:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:58 INFO - Running setup.py install for mozfile 03:38:59 INFO - Running setup.py install for mozhttpd 03:38:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozinfo 03:38:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozInstall 03:38:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozleak 03:38:59 INFO - Running setup.py install for mozlog 03:38:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for moznetwork 03:38:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozprocess 03:38:59 INFO - Running setup.py install for mozprofile 03:38:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozrunner 03:38:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozscreenshot 03:39:00 INFO - Running setup.py install for moztest 03:39:00 INFO - Running setup.py install for mozversion 03:39:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:00 INFO - Cleaning up... 03:39:00 INFO - Return code: 0 03:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:39: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 03:39: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 03:39:00 INFO - Using env: {'DISPLAY': ':0', 03:39:00 INFO - 'HOME': '/home/cltbld', 03:39:00 INFO - 'LANG': 'en_US.UTF-8', 03:39:00 INFO - 'LANGUAGE': 'en_US:en', 03:39:00 INFO - 'LOGNAME': 'cltbld', 03:39:00 INFO - 'MAIL': '/var/mail/cltbld', 03:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:00 INFO - 'MOZ_NO_REMOTE': '1', 03:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:00 INFO - 'NO_EM_RESTART': '1', 03:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:00 INFO - 'PWD': '/builds/slave/test', 03:39:00 INFO - 'SHELL': '/bin/bash', 03:39:00 INFO - 'SHLVL': '1', 03:39:00 INFO - 'TERM': 'linux', 03:39:00 INFO - 'TMOUT': '86400', 03:39:00 INFO - 'USER': 'cltbld', 03:39:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:00 INFO - '_': '/tools/buildbot/bin/python'} 03:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:00 INFO - Running setup.py (path:/tmp/pip-FkMCBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:00 INFO - Running setup.py (path:/tmp/pip-mR0wWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:00 INFO - Running setup.py (path:/tmp/pip-pdqh7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:00 INFO - Running setup.py (path:/tmp/pip-nrel8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:00 INFO - Running setup.py (path:/tmp/pip-FoRCeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:00 INFO - Running setup.py (path:/tmp/pip-Pn3H4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:00 INFO - Running setup.py (path:/tmp/pip-iZBHYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39: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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:00 INFO - Running setup.py (path:/tmp/pip-nJ3Nuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:01 INFO - Running setup.py (path:/tmp/pip-_azBPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:01 INFO - Running setup.py (path:/tmp/pip-1RkPt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:01 INFO - Running setup.py (path:/tmp/pip-yaPtKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39: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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:01 INFO - Running setup.py (path:/tmp/pip-oHk2z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39: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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:01 INFO - Running setup.py (path:/tmp/pip-VvAm5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39: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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:01 INFO - Running setup.py (path:/tmp/pip-ug56yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39: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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:01 INFO - Running setup.py (path:/tmp/pip-CoUXI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39: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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:01 INFO - Running setup.py (path:/tmp/pip-oUvLMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39: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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:01 INFO - Running setup.py (path:/tmp/pip-tHRO5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39: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)) 03:39: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)) 03:39: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)) 03:39: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)) 03:39: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)) 03:39: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)) 03:39:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:04 INFO - Downloading blessings-1.6.tar.gz 03:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:04 INFO - Installing collected packages: blessings 03:39:04 INFO - Running setup.py install for blessings 03:39:04 INFO - Successfully installed blessings 03:39:04 INFO - Cleaning up... 03:39:04 INFO - Return code: 0 03:39:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:05 INFO - Reading from file tmpfile_stdout 03:39:05 INFO - Current package versions: 03:39:05 INFO - argparse == 1.2.1 03:39:05 INFO - blessings == 1.6 03:39:05 INFO - blobuploader == 1.2.4 03:39:05 INFO - docopt == 0.6.1 03:39:05 INFO - functools32 == 3.2.3-2 03:39:05 INFO - jsonschema == 2.5.1 03:39:05 INFO - manifestparser == 1.1 03:39:05 INFO - mozInstall == 1.12 03:39:05 INFO - mozcrash == 0.17 03:39:05 INFO - mozdebug == 0.1 03:39:05 INFO - mozdevice == 0.48 03:39:05 INFO - mozfile == 1.2 03:39:05 INFO - mozhttpd == 0.7 03:39:05 INFO - mozinfo == 0.9 03:39:05 INFO - mozleak == 0.1 03:39:05 INFO - mozlog == 3.2 03:39:05 INFO - moznetwork == 0.27 03:39:05 INFO - mozprocess == 0.22 03:39:05 INFO - mozprofile == 0.28 03:39:05 INFO - mozrunner == 6.11 03:39:05 INFO - mozscreenshot == 0.1 03:39:05 INFO - mozsystemmonitor == 0.3 03:39:05 INFO - moztest == 0.7 03:39:05 INFO - mozversion == 1.4 03:39:05 INFO - psutil == 3.1.1 03:39:05 INFO - requests == 1.2.3 03:39:05 INFO - wsgiref == 0.1.2 03:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:05 INFO - Using env: {'DISPLAY': ':0', 03:39:05 INFO - 'HOME': '/home/cltbld', 03:39:05 INFO - 'LANG': 'en_US.UTF-8', 03:39:05 INFO - 'LANGUAGE': 'en_US:en', 03:39:05 INFO - 'LOGNAME': 'cltbld', 03:39:05 INFO - 'MAIL': '/var/mail/cltbld', 03:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:05 INFO - 'MOZ_NO_REMOTE': '1', 03:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:05 INFO - 'NO_EM_RESTART': '1', 03:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:05 INFO - 'PWD': '/builds/slave/test', 03:39:05 INFO - 'SHELL': '/bin/bash', 03:39:05 INFO - 'SHLVL': '1', 03:39:05 INFO - 'TERM': 'linux', 03:39:05 INFO - 'TMOUT': '86400', 03:39:05 INFO - 'USER': 'cltbld', 03:39:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:05 INFO - '_': '/tools/buildbot/bin/python'} 03:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 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)) 03:39:05 INFO - Cleaning up... 03:39:05 INFO - Return code: 0 03:39:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:05 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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:39:05 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 03:39:05 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 03:39:05 INFO - Using env: {'DISPLAY': ':0', 03:39:05 INFO - 'HOME': '/home/cltbld', 03:39:05 INFO - 'LANG': 'en_US.UTF-8', 03:39:05 INFO - 'LANGUAGE': 'en_US:en', 03:39:05 INFO - 'LOGNAME': 'cltbld', 03:39:05 INFO - 'MAIL': '/var/mail/cltbld', 03:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:05 INFO - 'MOZ_NO_REMOTE': '1', 03:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:05 INFO - 'NO_EM_RESTART': '1', 03:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:05 INFO - 'PWD': '/builds/slave/test', 03:39:05 INFO - 'SHELL': '/bin/bash', 03:39:05 INFO - 'SHLVL': '1', 03:39:05 INFO - 'TERM': 'linux', 03:39:05 INFO - 'TMOUT': '86400', 03:39:05 INFO - 'USER': 'cltbld', 03:39:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:05 INFO - '_': '/tools/buildbot/bin/python'} 03:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:39:05 INFO - Cleaning up... 03:39:05 INFO - Return code: 0 03:39:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:05 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 0x7f290a657f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, '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': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', '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 03:39:05 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 03:39:05 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 03:39:05 INFO - Using env: {'DISPLAY': ':0', 03:39:05 INFO - 'HOME': '/home/cltbld', 03:39:05 INFO - 'LANG': 'en_US.UTF-8', 03:39:05 INFO - 'LANGUAGE': 'en_US:en', 03:39:05 INFO - 'LOGNAME': 'cltbld', 03:39:05 INFO - 'MAIL': '/var/mail/cltbld', 03:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:05 INFO - 'MOZ_NO_REMOTE': '1', 03:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:05 INFO - 'NO_EM_RESTART': '1', 03:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:05 INFO - 'PWD': '/builds/slave/test', 03:39:05 INFO - 'SHELL': '/bin/bash', 03:39:05 INFO - 'SHLVL': '1', 03:39:05 INFO - 'TERM': 'linux', 03:39:05 INFO - 'TMOUT': '86400', 03:39:05 INFO - 'USER': 'cltbld', 03:39:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:05 INFO - '_': '/tools/buildbot/bin/python'} 03:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:05 INFO - Downloading/unpacking flake8 03:39:05 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 03:39:05 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 03:39:05 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 03:39:05 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 03:39:05 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 03:39:05 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 03:39:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:39:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:39:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:08 INFO - no previously-included directories found matching 'docs/_build' 03:39:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:39:08 INFO - Running setup.py install for pep8 03:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:08 INFO - no previously-included directories found matching 'docs/_build' 03:39:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:39:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:39:08 INFO - Cleaning up... 03:39:08 INFO - Return code: 0 03:39:08 INFO - Running post-action listener: _resource_record_post_action 03:39:08 INFO - Running post-action listener: _start_resource_monitoring 03:39:08 INFO - Starting resource monitoring. 03:39:08 INFO - ##### 03:39:08 INFO - ##### Finished create-virtualenv step (success) 03:39:08 INFO - ##### 03:39:08 INFO - ##### 03:39:08 INFO - ##### Running install step. 03:39:08 INFO - ##### 03:39:08 INFO - Running pre-action listener: _resource_record_pre_action 03:39:08 INFO - Running main action method: install 03:39:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:08 INFO - Reading from file tmpfile_stdout 03:39:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:08 INFO - Reading from file tmpfile_stdout 03:39:08 INFO - Output received: 03:39:08 INFO - Usage: mozinstall [options] installer 03:39:08 INFO - Options: 03:39:08 INFO - -h, --help show this help message and exit 03:39:08 INFO - -d DEST, --destination=DEST 03:39:08 INFO - Directory to install application into. [default: 03:39:08 INFO - "/builds/slave/test"] 03:39:08 INFO - --app=APP Application being installed. [default: firefox] 03:39:08 INFO - mkdir: /builds/slave/test/build/application 03:39:08 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'] 03:39:08 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 03:39:25 INFO - Reading from file tmpfile_stdout 03:39:25 INFO - Output received: 03:39:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:39:25 INFO - Running post-action listener: _resource_record_post_action 03:39:25 INFO - ##### 03:39:25 INFO - ##### Finished install step (success) 03:39:25 INFO - ##### 03:39:25 INFO - ##### 03:39:25 INFO - ##### Running run-tests step. 03:39:25 INFO - ##### 03:39:25 INFO - Running pre-action listener: _resource_record_pre_action 03:39:25 INFO - Running main action method: run_tests 03:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:25 INFO - Python 2.7.3 03:39:25 INFO - Return code: 0 03:39:25 INFO - grabbing minidump binary from tooltool 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:25 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 0x144f1c0>, '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 0x14500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1450550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39:25 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 03:39:25 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 03:39:25 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 03:39:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:25 INFO - Return code: 0 03:39:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:39:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:39:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:39:26 INFO - Return code: 0 03:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 03:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 03:39:26 INFO - Using env: {'DISPLAY': ':0', 03:39:26 INFO - 'HOME': '/home/cltbld', 03:39:26 INFO - 'LANG': 'en_US.UTF-8', 03:39:26 INFO - 'LANGUAGE': 'en_US:en', 03:39:26 INFO - 'LOGNAME': 'cltbld', 03:39:26 INFO - 'MAIL': '/var/mail/cltbld', 03:39:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:26 INFO - 'MOZ_NO_REMOTE': '1', 03:39:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:26 INFO - 'NO_EM_RESTART': '1', 03:39:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:26 INFO - 'PWD': '/builds/slave/test', 03:39:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:26 INFO - 'SHELL': '/bin/bash', 03:39:26 INFO - 'SHLVL': '1', 03:39:26 INFO - 'TERM': 'linux', 03:39:26 INFO - 'TMOUT': '86400', 03:39:26 INFO - 'USER': 'cltbld', 03:39:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999', 03:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:26 INFO - '_': '/tools/buildbot/bin/python'} 03:39:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 03:39:26 INFO - mozversion application_buildid: 20160624022607 03:39:26 INFO - mozversion application_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 03:39:26 INFO - mozversion application_display_name: Nightly 03:39:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:26 INFO - mozversion application_name: Firefox 03:39:26 INFO - mozversion application_remotingname: firefox 03:39:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:39:26 INFO - mozversion application_vendor: Mozilla 03:39:26 INFO - mozversion application_version: 50.0a1 03:39:26 INFO - mozversion platform_buildid: 20160624022607 03:39:26 INFO - mozversion platform_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 03:39:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:39:26 INFO - mozversion platform_version: 50.0a1 03:39:26 INFO - using testdate: 1466764766 03:39:26 INFO - actual date: 1466764766 03:39:26 INFO - starting webserver on 'localhost:57209' 03:39:26 INFO - SUITE-START | Running 2 tests 03:39:26 INFO - TEST-START | dromaeo_css 03:39:26 INFO - operating with platform_type : linux_ 03:39:26 INFO - Initialising browser for dromaeo_css test... 03:39:26 INFO - TEST-INFO | started process 1081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZdqLyz/profile http://localhost:57209/getInfo.html) 03:39:30 INFO - PROCESS | 1081 | __metrics Screen width/height:1600/1200 03:39:30 INFO - PROCESS | 1081 | colorDepth:24 03:39:30 INFO - PROCESS | 1081 | Browser inner width/height: 1024/697 03:39:30 INFO - PROCESS | 1081 | __metrics 03:39:31 INFO - PROCESS | 1081 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:32 INFO - TEST-INFO | 1081: exit 0 03:39:32 INFO - Browser initialized. 03:39:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:32 INFO - TEST-INFO | started process 1232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZdqLyz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:44 INFO - PROCESS | 1232 | RSS: Main: 176037888 03:39:44 INFO - PROCESS | 1232 | 03:40:35 INFO - PROCESS | 1232 | 1466764835773 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] 03:42:48 INFO - PROCESS | 1232 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57209/tests/dromaeo/cssquery-ext.html) 03:42:49 INFO - PROCESS | 1232 | RSS: Main: 294080512 03:42:49 INFO - PROCESS | 1232 | 03:45:52 INFO - PROCESS | 1232 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-ext.html (next: http://localhost:57209/tests/dromaeo/cssquery-jquery.html) 03:45:53 INFO - PROCESS | 1232 | RSS: Main: 258043904 03:45:53 INFO - PROCESS | 1232 | 03:48:55 INFO - PROCESS | 1232 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57209/tests/dromaeo/cssquery-mootools.html) 03:48:56 INFO - PROCESS | 1232 | RSS: Main: 255442944 03:48:56 INFO - PROCESS | 1232 | 03:51:58 INFO - PROCESS | 1232 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57209/tests/dromaeo/cssquery-prototype.html) 03:51:58 INFO - PROCESS | 1232 | RSS: Main: 254668800 03:51:58 INFO - PROCESS | 1232 | 03:55:01 INFO - PROCESS | 1232 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57209/tests/dromaeo/cssquery-yui.html) 03:55:02 INFO - PROCESS | 1232 | RSS: Main: 233127936 03:55:02 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-yui.html (next: http://localhost:57209/tests/dromaeo/cssquery-dojo.html) 03:58:05 INFO - PROCESS | 1232 | RSS: Main: 287883264 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | __start_tp_report 03:58:05 INFO - PROCESS | 1232 | _x_x_mozilla_page_load 03:58:05 INFO - PROCESS | 1232 | _x_x_mozilla_page_load_details 03:58:05 INFO - PROCESS | 1232 | |i|pagename|runs| 03:58:05 INFO - PROCESS | 1232 | |0;dojo.html;2654.933626659333;2669;2702.7702645275144;2718.877650505727;2729.9590506142413;4610.63114950804;4691.554302341272;4789.544993225642;4872.2204447288395;4920.532549407805;4757.381540399743;4762;4788.329633851264;4813.157697402958;4836.9274460883025;4333.393324934512;4379.715318504287;4424.491183513905;4441.467023957113;4566.931496027562;4476.574725401098;4511.548845115495;4525.841595544157;4526.773661316921;4555.157295900252;4261.637760790337;4282.550332215135;4325.718828276184;4379.978100109511;4442.267025940716;4349.238883195429;4352.7605981670995;4357.934630980538;4479.5296493868;4509.594136527729;4441.467023957146;4444.911101777979;4447.043885564619;4449.310356894686;4497.595216430537;4624.213883639789;4635.582797548237;4678.3216433616935;4840.322354870321;4889.071076495455;5010.173321401964;5031;5101.897962040775;5109.923351149699;5110.386753589556;5066.898662026776;5084.339035925306;5103.387593488768;5142.434332223453;5143.331366922276;4657.068586282757;4738.2418812990445;4745.074710431501;4781.019890922318;4798.3042458843975;5198.792048318025;5231;5277.261183434322;5281.313429254173;5292.047431462373;5033.421156566968;5038.017586570657;5064.670796398223;5080.7205603692155;5100.591952643779;4892.486288939681;5077.7715002824225;5088.109580823341;5102.056119617882;5168.8966220675375;5103.770330335144;5111.591072714174;5121.231815227746;5131.999260144311;5133.332666753298;5109.821156259513;5111.7699703513435;5119.6188938553405;5124.359455068116;5172.896542069213;4265.4881414230495;4297.8495752648505;4335.436393268855;4409.581089796464;4454.153710794939;3831.9616803831605;3832.2718683450057;3835.2521258354354;3869.6130386961077;3917.334053210961;4370.431843860341;4379.408779814684;4384.517703052662;4408.4269045024585;4435.179491794029;4944.060628480577;5004.274380214922;5042.84871453857;5131.1277082895995;5188.11801993662;4314.02934339771;4332.501762297376;4332.956670433318;4365.388845561624;4370.541093185233;4581.083783243364;4590.9540904591195;4594.0582180653555;4599.5400459953735;4670;4608.746518941491;4704.388429504143;4723.031778485402;4739.289106633894;4773.498782627774;5093.643444958817;5099.311592935054;5112.642115051911;5118.744062796771;5174.896502069862;4745.264484004984;4760.357351757607;4778.1399348117675;4778.996410753781;4858.076965376567;4950.430700469348;5005.449400565862;5010.298558201927;5035.496450354935;5047;5091.541761241506;5118.641695081308;5119.616028797781;5133.820316288912;5167.147420675697;4850.563449289581;4950.158473059517;4957.380327459067;4966.006798640358;4979.178435558092;4964;5012.4736902626155;5029.949700502948;5032.874178145576;5033.345665063518;4948.604111670986;4988.351514303117;5028.874278143076;5031.144705400017;5033.823816166563;4801.807927682854;4995.650304478651;5074.137396642506;5079.746012699276;5121.974390128025;4774.164521208705;4833.468318485035;4841.733704646278;4933.013397320478;4956.578690811321 03:58:05 INFO - PROCESS | 1232 | |1;ext.html;543.5461389739568;585.1398444286897;587.9853003674905;591.1664552980297;614.2659521871365;29783.851080744593;40688.18623627526;41532.79233603835;41583.37624935621;45467.31799023017;41524.79237603808;42033.789831050875;42035.78982105093;42116.157676846444;42257.154856902845;7538.509996850187;7729.343005844482;7730.536167829948;7922.603869806516;8133.796655083611;7285.7814265572115;10152.796944061114;10350.792984140313;10403.219758518142;10728.78542429151;10626.62806801762;10662.093722033598;10688.091512221432;10692;10701.357918524913;7594.658240379196;7784.571848548328;10441.477926103702;10518.158547316196;10530.31552949056;7729.033870766154;10086.24353173515;10495.527701253463;10496.475176241158;10506.264561480699;37067.443988340194;37477;37492.625073749456;40413.79793101016;40525;2923.4883895318235;3085.5063189889734;3182.44307246231;3214.1321843102464;3568.7145028397667;30703.385932281453;30976.0707178785;31093.22266943322;31667.524987125213;31735.52396714051;3665.87169449068;3669.486271921933;3693.076730817296;3712.6658600726064;3738.495303134069;240465;242285;242552;242731;243353;57603.135952960736;57762;57788.71105644529;57830.71084644634;57916.42083579195;62379;62490;62563;62747;62780.686096569225;12605.810912836314;12762.361881905868;12771.808422873664;12773.61679149627;12790.29653369055;9150.81698366029;11395;11617.60588729358;11625.88374116265;11760.176787624785;19274.518137046405;19320;19328.516787080152;19331;19385.709214361796;6962.316176470544;7039.648017599202;7122;7126.429885609139;7312.96343518279;783.50247592779;806.9193080692002;939.902027161575;959.3428501476511;996.3473924579412;27568.44863102767;27701.86149069282;27766.305842354104;28131.296717582223;28246.43507129887;963.4845357733578;966.6085235479642;972.9659461918799;1004.1966426858484;1047.8480620310165;14134.434622614981;14585.708285834224;14587.927060364631;14941.925290373478;14964.625884352978;392372;394936;396639;396818;397162;51239.743801280754;51830.74084629553;51931.74034129805;51979;51985;1071.1484369925927;1166.6150170443734;1198.053537705203;1213.520659339556;1221.3465795799204;28009.579856301763;29566.704332956397;29570.556441653822;29608.851955740083;29842.552361715025;42110.36834447424;42665;42694;42716.78641606772;42730.57269427266;326688;336113;336952;337359;337480;22759;25297.343778903687;25585.744142558335;25936.610950835377;27562.310942225802;42569.87303057911;42906;42921.141577167655;42977;43055.354169686856;35217.64782352144;36190;36328.27343453063;36888.44667329938;37066.8146659265;36295.45556816597;36339.81830090833;36768.26463470769;36908.63091369052;38767.41848872213;36003.81998089993;36502.634973649925;36631.63368366389;36793.816030920745;36857.26285474329;32730.345393091528;33613.11828815549;33711;34076;34236.31527369488;25028.62457063109;25176;25207.49585008326;25569.872150639127;25781.484370312864 03:58:05 INFO - PROCESS | 1232 | |2;jquery.html;356.2234329162425;362.96551827576377;363.492927366324;377.45834727166516;380.1769169747497;15616.219189040545;16346.591335216626;17331.22009509572;17345.39291124811;17396.56508587286;15962.361505539793;16101.516954491384;16869;16872.409465668705;16906.492805215832;1470.7499725046769;1482.6960473103043;1483.1620134623956;1687.5865412973778;4883.145449546333;3637.854485820564;3789.2610940866543;5037.1940489521685;5739.569532285074;6053.455189032986;6064.363241859607;6064.4541991220785;6068.33248342682;6073.969630151865;6087.360827113133;5770.307563092435;5975.611585246967;5976.462118409364;5976.760929562813;5982.820515384546;3276.6231883333244;4942.1351263529095;5230.293910322096;5257.685578605348;5268.446813084647;20035;20515.48711282215;20641.690374644393;20880.269190578256;20903.163873445043;1724.542996106033;1818.209079050604;1831.9358822441284;2105.9157633694635;2289.8626082435107;9335.626574936994;9347.485888276142;9422.104900034486;9510.667126650535;9614.567344469446;1698.8131305556378;1740.338671304896;1770.530809335527;1786.5087101047316;1805.900675462849;67483;67628;68096.6595167021;69007.30992690059;71193.64403178003;9684.370515916444;9741.561629726679;9877.802443951081;10076.949615251877;10105.797884042278;13831;13911.86088139126;13939.581812545639;13939.790903136462;13950.883929285836;6753.08833307507;6944.375006249361;7060.7881763547175;7080.6105664187935;7445.776626701099;7041.788746337618;7075.2570980047385;7116.64416779159;7233.638318084075;7234;4314.633256173261;4333.609975102256;4341.15347507233;4372.409724687126;4433.977830110894;1617.6279455725248;1733.1247719901621;1802.8016918138994;1823.3253696132515;1837.0833810702716;805.7743831727125;827;842.869355249925;907.8138981508774;916.1754421021134;16224.756628650579;16416.425425110065;16455.42406015784;16782.328706851833;17239.44844963934;810.4326971120239;839.4627438439404;840.4915026409057;867.8394497018072;891.9063498332712;8934.776630584158;9607.183389411839;9614.95192524047;9628.229741620653;9765.267604929659;396614;404059;404686;409819;413916;79545.60227198827;80231.59884200658;80508.59745701234;80992;81070;787.165604459275;799.9640016199285;807.4186585658316;808.567416432206;822.2805045585233;14726.33055171517;15048.322825473098;15189.6202594936;15272.694546108793;15304.770428443804;36533.269334612625;37161.62838371582;37378.626213737516;37387.252254954205;37943.43084853785;51183.74408127936;52711;52992.73503632457;53668.46331536791;54031;7362.153352364547;7479.326860582573;7510.136334321623;7544.698212071456;7697.114831794415;10224.897751022394;11531.538738450703;11654.067674585844;11672.649820505398;11949.701257468285;9807.803843923224;10033.548490317808;10143.49282535885;10170.237232207466;10348.637797677346;10467.94766026165;10485.318454300446;10507.842382364424;10583.364998100138;10588.947055264674;10052.94973525157;10061;10064;10127.493625318852;10181.083702466814;6790.354916282945;6989.231184569591;7019.719211231493;7051.788446346618;7694.769156925301;7664.616769161631;10014.248931330034;10182.490875456346;10437.11284540792;11220.943895280472 03:58:05 INFO - PROCESS | 1232 | |3;mootools.html;1217.45214653406;1301.0567338679455;1373.0731756064656;1379.951701690441;1622.7809245751828;6614.768483103092;7344.22885597012;7544.886826697604;7595.810104747384;7806.570638614888;7609.315161635452;7622.695092196319;7670.194629563899;7671.462997590171;7682.308592226698;2174.3150907464137;2201.03154611971;2204.6913432119436;2205.3273751505785;2207.6798864164766;2137.6900349449397;2163.0915015693367;2203.4050806282294;2207.9668804967937;2210.4694873230387;2193.2104442400723;2197.8571392859494;2201.5376770878133;2216.6896634471186;2233.519793244452;2171.446281198292;2171.53312037911;2179.4878203622216;2180.3349978256706;2184.028107492167;2087.092114929995;2127.0428307261795;2128.4785227619177;2128.8509804313703;2130.3076500137518;7776.533407995538;7789.10425301092;7814.140444551095;7825.217478252129;7829.373650108035;4617.284320930261;4807.134715751164;4807.831725889577;4826.855194344175;4830.154722923475;2826.7879909006906;2979.329650828568;3041.300500884809;3045.8629361678554;3059.8470076496087;933.9859902101474;935.4013431403907;944.15026476172;956.7990721948399;973.9415635061919;10788.838167427495;10884.673459796219;10902.291351062235;10905.727356816144;10920.453977301104;4005.0788318686864;4112.650424713933;4114.506259248909;4177.3316269396755;4217.34631132175;8585.18440748128;8613.310935125175;8628.352873534384;8651.178138076873;8659.826803463895;4618.1918164321105;4618.330342100377;4621.884452888705;4626.121037003026;4634.95365046352;3554;3893.824777885002;4207.621314081747;4263.424437700933;4309.482862056573;3453.7755045921936;3512.2799826035603;3526.1360966562843;3531.152523394418;3532.275883443888;1048.5962904281907;1051.2588625019343;1055.7466208110152;1056.6777132974516;1058.3438268273567;781.6912319633713;797.2426195114548;809.6073404398862;820.7865954851662;823.4482896459386;5022.522860328263;5051.696898186121;5074.695518268842;5098.872528186751;5318.25544423781;390.3831945526062;402.7100487648888;406.3315845434244;411.47742367193496;414.8713898691415;3402.0644322811427;3425.9143521411665;3463.7748546344405;3473.4442489201606;3571.267890082579;9421.293402994803;10053.346532475513;10064.245181611263;10064.44645544502;10096.69709908704;9691.321607487549;9870.60517579303;9932.453715045598;9942.502874856229;9978.850317245247;7498.887516687254;7546.20764819708;7588.506747061423;7594.430417718582;7595.848083038309;4995.750212489288;5014.648974571745;5034.84895453137;5130.179171332569;5179.533841954242;9124.27005839518;9174.587143578421;9189;9204.447733136034;9303;8406.285465735236;9008.504532250789;9012.549372531215;9275.86086208721;9365.672201472917;6055.6063855849225;6398.360163983564;6718.563293385914;6729.0579318894415;6878.243393226641;7431.29402706742;7451.031365922396;7459.142198647225;7469.327760501581;7516.361109305771;6634;6744.62904540255;6770.8645827084165;6846.349596788297;6880.4839637026425;6638.701258443478;6696.83257918556;6709.630970296681;6713.664316784044;6814.284500127415;6249.093881387264;6296.244450665949;6325.146105275913;6410.583312084699;6419.518536109904;4330.69685122051;4385.429894113872;4448.399466072039;4449.13241917823;4492.865214043584;4535.115652447741;4554.544545545419;4581.908361832811;4635;4647.047355292225 03:58:05 INFO - PROCESS | 1232 | |4;prototype.html;297.23610321473814;302.9863656135474;303.543167532863;307.11550733886406;307.8106964217007;4846.733429661372;4860.951390486094;4874.951250487494;4884;4910.656254062217;4803.7357945313;4832.516748325165;4843.467218605951;4857.854264372066;4858.51414858514;3640.7451478396524;3715.6098609646006;3751.643593858579;3818.8663396781117;3861.2084522672785;3811.1615444602144;3838.539375274971;3846.403807409842;3869.9806500967456;3872.5546562145432;3569.4288913773803;3795.7722536647752;3803.8098095095274;3807.1053302473897;3824.1204522959597;3655.981720091396;3802.6310528209683;3814.141818090935;3815.1606646537716;3816;3334.9494909103555;3350.949735753966;3351.463765797461;3354.513595528659;3356.7146792522667;4727.739974301412;4744.478107408182;4765.332853400527;4766.165920963852;4773.95226047742;4218.789060546991;4328.610425061728;4337.587929146757;4371.650267978586;4374.868753937387;5043.36957880265;5059.380998080615;5084.9745751271375;5089.923651145199;5090.77091530882;3673;3683.208110256308;3687.649673281034;3690.5755838078694;3709.7774133552075;5118.539331460149;5238.266642670029;5311.150215965466;5330.360356757175;5330.440303768126;3749.1189570450924;3751.268502642013;3767.8869633911027;3780.1494663700996;3797.9240415192094;3780.584135745066;3784.7161462889844;3785.716071294664;3812.1613245086037;3818.3127037133027;4314.525402205755;4315.029118448324;4319.308910574293;4321.2653848845775;4328.156009578102;4873.902521949542;5101.69389836611;5105.698046997992;5106.387233532;5114.3095682083185;1296.623979046085;1313.9737205256033;1317.5915466205506;1328.4221363706818;1329.2423318708243;857.1043259793531;863.7797361672733;896.2202883491404;904.9185573298435;907.5689047702289;4382.496012958487;4388.407564978751;4391.824327026947;4396.834838767729;4399.450068741407;5130.640855140179;5184.585233181337;5190.987757387349;5200.843974680765;5215.5135786300725;4208.8316467340965;4393.824247030083;4399.714018588846;4400.427944367276;4403.735775853459;2743.629610002664;2747.2719729271757;2749.42262124956;2756.462489814507;2760.8619569021466;4841.273808928689;4841.903161936812;4842.467328593852;4852;4858.975705121452;5069.188929771292;5241.764120614582;5260.526552610207;5272.839975205448;5325.775071733446;4794.232922732346;4841.273808928689;4844.878878028007;4876.391130745034;4879.316895634614;5180.274761533313;5189.610779191651;5191.870203244949;5198.116320225495;5216.66091704038;4860.684055536379;5114.4629813869005;5118.564921981673;5213.191955246943;5232.659877107976;4939.061578300111;4941.517544736636;4948.6535942485125;4950.9257361140335;4958.570300552631;3722.571904231048;3727.7204209684924;3732.2908647356917;3733.226717309365;3742.85028598853;5108.438071812172;5245.160774276097;5291.894162116813;5299.205119232146;5299.708516031656;5104.03023425548;5118.718470484159;5127.769250383816;5141.28022076917;5143.151380022255;5129.179331306973;5134.280016194617;5139.152039913372;5139.743012849268;5144.434112247724;4920.507949205051;4961.362750292467;5023.196288593807;5038.571721403721;5083.262926875508;4856.757162141949;4979.950200498093;5128.1794912813775;5129.179141404897;5138.614603904647;5003.299538064746;5022.924656130088;5071.670341427795;5084.694918304914;5102.69383836971 03:58:05 INFO - PROCESS | 1232 | |5;yui.html;652.6834485274641;664.0470924223737;674.9325067493248;700.8247938015496;757.5303311946592;12452.501899924004;13605.115667481607;13609.523666671668;13621.25083120428;13622.38699258532;12673.619791406249;12793.424295906683;12816.102872798907;13217.93391033046;13329.266890321029;618.659737144571;769.273036980054;779.1312686354717;785.6268272570512;785.7917651822272;791.8376732769797;808.5633757770797;808.6361137488125;809.4778867630375;809.6356639512243;828.6312590897053;830.1408042675831;830.2320353672859;830.3315830756238;830.5847076461769;645.8546826963942;805.2068712318362;826.1614461321764;827.3918669777709;836.6277006732007;611.5841227964981;611.620795107032;611.9694015299217;612.13077430049;612.2377639838385;13491.123076999964;13513.32433378337;13542.93228533861;13559.186448813005;13563.321833908265;12189.390530473442;12804.871951280462;12890;12963.87036129636;13236.933815330958;11544.170576116416;11718.941405292919;11803.645890623295;11935.940320298343;11963.342016189106;4205.642520385771;4229.725067870579;4276.486821581399;4445.5776701213335;4448.532904045093;57685.423145768844;57921.42078579245;58391.70804145995;59644;59996.300351466976;10354.378737275787;10383.688489345332;10428.791424171473;10566.788664226673;10761.56953721858;19114.617707646048;19155.712664310046;19194.92881139039;19278.22887084529;19283.90358048201;6374.203224596926;6641.800745977628;6706.664666766642;6721.8655626887185;6724.4284235840505;3784.280986612535;3803.923921521554;3845.3270677631863;3850.8652197172964;3912.9804350978634;2668.5596876515156;2773.861306934645;2775.6114144019853;2776.250412388644;2781.5688568271544;487.95608395244597;497.66159011872276;498.4840689886023;516.2875232179568;519.4000928927095;423.208599918155;425.3555862867696;432.7100842435513;446.8279712310719;567.9237844285057;7535.651639628625;7655.1962043985695;7679.2704693054075;7741.845163096819;7769.650365733555;431.98920026998945;452.57684065398956;489.68170689051686;512.6975084700044;523.4797523385593;3431.2108215110666;3502.8073455960166;3566.8573257069424;3584.121890136881;3686.631336866292;55057;55207.17189242165;55298.17052744212;56318.71840640852;100647;76236;88373;88538.55730721305;89936.550317248;91184;48051.27923081157;56701;74194;76894.61552692088;79759;7800.921990780246;7927.5243485391065;8165.836683266421;8186.467879587808;8219.95890020546;43788;43824.342634859866;43866.56133438752;45012;46380.536194638975;39366.80316598398;45303;54808.725956371556;65580.67209664112;66621.66689166523;11314.660560183207;11399;11564.710882228012;11900.40497975115;12249.510019599116;12897.161684490478;12995.610131696065;13062.477500900237;13539.729205416033;13879.722405552035;11947.82078268844;12085.758284834079;12320.81518777237;12417.254964702146;12840;10964.890351096386;11221.382823944761;11289.20975531705;11722.531098755955;11859.762804744028;11908.225965312227;12250.632481025583;12308.876911231131;12575.182613130117;12810.615681529569;10106.898931010595;10166.796664066826;10423.114035307084;10583.576656933636;10707.357558546511;9508.429494230368;9960.55177516999;10084.193264538966;10195.69412917584;10203.795924081625 03:58:05 INFO - PROCESS | 1232 | __end_tp_report 03:58:05 INFO - PROCESS | 1232 | __start_cc_report 03:58:05 INFO - PROCESS | 1232 | _x_x_mozilla_cycle_collect,1118 03:58:05 INFO - PROCESS | 1232 | __end_cc_report 03:58:05 INFO - PROCESS | 1232 | __startTimestamp1466765885414__endTimestamp 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | ------- Summary: start ------- 03:58:05 INFO - PROCESS | 1232 | Number of tests: 6 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | [#0] dojo.html Cycles:165 Average:4724.82 Median:4836.93 stddev:486.73 (10.1%) stddev-sans-first:460.34 03:58:05 INFO - PROCESS | 1232 | Values: 2654.9 2669.0 2702.8 2718.9 2730.0 4610.6 4691.6 4789.5 4872.2 4920.5 4757.4 4762.0 4788.3 4813.2 4836.9 4333.4 4379.7 4424.5 4441.5 4566.9 4476.6 4511.5 4525.8 4526.8 4555.2 4261.6 4282.6 4325.7 4380.0 4442.3 4349.2 4352.8 4357.9 4479.5 4509.6 4441.5 4444.9 4447.0 4449.3 4497.6 4624.2 4635.6 4678.3 4840.3 4889.1 5010.2 5031.0 5101.9 5109.9 5110.4 5066.9 5084.3 5103.4 5142.4 5143.3 4657.1 4738.2 4745.1 4781.0 4798.3 5198.8 5231.0 5277.3 5281.3 5292.0 5033.4 5038.0 5064.7 5080.7 5100.6 4892.5 5077.8 5088.1 5102.1 5168.9 5103.8 5111.6 5121.2 5132.0 5133.3 5109.8 5111.8 5119.6 5124.4 5172.9 4265.5 4297.8 4335.4 4409.6 4454.2 3832.0 3832.3 3835.3 3869.6 3917.3 4370.4 4379.4 4384.5 4408.4 4435.2 4944.1 5004.3 5042.8 5131.1 5188.1 4314.0 4332.5 4333.0 4365.4 4370.5 4581.1 4591.0 4594.1 4599.5 4670.0 4608.7 4704.4 4723.0 4739.3 4773.5 5093.6 5099.3 5112.6 5118.7 5174.9 4745.3 4760.4 4778.1 4779.0 4858.1 4950.4 5005.4 5010.3 5035.5 5047.0 5091.5 5118.6 5119.6 5133.8 5167.1 4850.6 4950.2 4957.4 4966.0 4979.2 4964.0 5012.5 5029.9 5032.9 5033.3 4948.6 4988.4 5028.9 5031.1 5033.8 4801.8 4995.7 5074.1 5079.7 5122.0 4774.2 4833.5 4841.7 4933.0 4956.6 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | [#1] ext.html Cycles:180 Average:48794.36 Median:36242.73 stddev:86941.63 (239.9%) stddev-sans-first:87110.04 03:58:05 INFO - PROCESS | 1232 | Values: 543.5 585.1 588.0 591.2 614.3 29783.9 40688.2 41532.8 41583.4 45467.3 41524.8 42033.8 42035.8 42116.2 42257.2 7538.5 7729.3 7730.5 7922.6 8133.8 7285.8 10152.8 10350.8 10403.2 10728.8 10626.6 10662.1 10688.1 10692.0 10701.4 7594.7 7784.6 10441.5 10518.2 10530.3 7729.0 10086.2 10495.5 10496.5 10506.3 37067.4 37477.0 37492.6 40413.8 40525.0 2923.5 3085.5 3182.4 3214.1 3568.7 30703.4 30976.1 31093.2 31667.5 31735.5 3665.9 3669.5 3693.1 3712.7 3738.5 240465.0 242285.0 242552.0 242731.0 243353.0 57603.1 57762.0 57788.7 57830.7 57916.4 62379.0 62490.0 62563.0 62747.0 62780.7 12605.8 12762.4 12771.8 12773.6 12790.3 9150.8 11395.0 11617.6 11625.9 11760.2 19274.5 19320.0 19328.5 19331.0 19385.7 6962.3 7039.6 7122.0 7126.4 7313.0 783.5 806.9 939.9 959.3 996.3 27568.4 27701.9 27766.3 28131.3 28246.4 963.5 966.6 973.0 1004.2 1047.8 14134.4 14585.7 14587.9 14941.9 14964.6 392372.0 394936.0 396639.0 396818.0 397162.0 51239.7 51830.7 51931.7 51979.0 51985.0 1071.1 1166.6 1198.1 1213.5 1221.3 28009.6 29566.7 29570.6 29608.9 29842.6 42110.4 42665.0 42694.0 42716.8 42730.6 326688.0 336113.0 336952.0 337359.0 337480.0 22759.0 25297.3 25585.7 25936.6 27562.3 42569.9 42906.0 42921.1 42977.0 43055.4 35217.6 36190.0 36328.3 36888.4 37066.8 36295.5 36339.8 36768.3 36908.6 38767.4 36003.8 36502.6 36631.6 36793.8 36857.3 32730.3 33613.1 33711.0 34076.0 34236.3 25028.6 25176.0 25207.5 25569.9 25781.5 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | [#2] jquery.html Cycles:180 Average:24751.36 Median:411867.50 stddev:67045.09 (16.3%) stddev-sans-first:67208.15 03:58:05 INFO - PROCESS | 1232 | Values: 356.2 363.0 363.5 377.5 380.2 15616.2 16346.6 17331.2 17345.4 17396.6 15962.4 16101.5 16869.0 16872.4 16906.5 1470.7 1482.7 1483.2 1687.6 4883.1 3637.9 3789.3 5037.2 5739.6 6053.5 6064.4 6064.5 6068.3 6074.0 6087.4 5770.3 5975.6 5976.5 5976.8 5982.8 3276.6 4942.1 5230.3 5257.7 5268.4 20035.0 20515.5 20641.7 20880.3 20903.2 1724.5 1818.2 1831.9 2105.9 2289.9 9335.6 9347.5 9422.1 9510.7 9614.6 1698.8 1740.3 1770.5 1786.5 1805.9 67483.0 67628.0 68096.7 69007.3 71193.6 9684.4 9741.6 9877.8 10076.9 10105.8 13831.0 13911.9 13939.6 13939.8 13950.9 6753.1 6944.4 7060.8 7080.6 7445.8 7041.8 7075.3 7116.6 7233.6 7234.0 4314.6 4333.6 4341.2 4372.4 4434.0 1617.6 1733.1 1802.8 1823.3 1837.1 805.8 827.0 842.9 907.8 916.2 16224.8 16416.4 16455.4 16782.3 17239.4 810.4 839.5 840.5 867.8 891.9 8934.8 9607.2 9615.0 9628.2 9765.3 396614.0 404059.0 404686.0 409819.0 413916.0 79545.6 80231.6 80508.6 80992.0 81070.0 787.2 800.0 807.4 808.6 822.3 14726.3 15048.3 15189.6 15272.7 15304.8 36533.3 37161.6 37378.6 37387.3 37943.4 51183.7 52711.0 52992.7 53668.5 54031.0 7362.2 7479.3 7510.1 7544.7 7697.1 10224.9 11531.5 11654.1 11672.6 11949.7 9807.8 10033.5 10143.5 10170.2 10348.6 10467.9 10485.3 10507.8 10583.4 10588.9 10052.9 10061.0 10064.0 10127.5 10181.1 6790.4 6989.2 7019.7 7051.8 7694.8 7664.6 10014.2 10182.5 10437.1 11220.9 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | [#3] mootools.html Cycles:180 Average:5111.68 Median:4807.48 stddev:2933.38 (61.0%) stddev-sans-first:2927.01 03:58:05 INFO - PROCESS | 1232 | Values: 1217.5 1301.1 1373.1 1380.0 1622.8 6614.8 7344.2 7544.9 7595.8 7806.6 7609.3 7622.7 7670.2 7671.5 7682.3 2174.3 2201.0 2204.7 2205.3 2207.7 2137.7 2163.1 2203.4 2208.0 2210.5 2193.2 2197.9 2201.5 2216.7 2233.5 2171.4 2171.5 2179.5 2180.3 2184.0 2087.1 2127.0 2128.5 2128.9 2130.3 7776.5 7789.1 7814.1 7825.2 7829.4 4617.3 4807.1 4807.8 4826.9 4830.2 2826.8 2979.3 3041.3 3045.9 3059.8 934.0 935.4 944.2 956.8 973.9 10788.8 10884.7 10902.3 10905.7 10920.5 4005.1 4112.7 4114.5 4177.3 4217.3 8585.2 8613.3 8628.4 8651.2 8659.8 4618.2 4618.3 4621.9 4626.1 4635.0 3554.0 3893.8 4207.6 4263.4 4309.5 3453.8 3512.3 3526.1 3531.2 3532.3 1048.6 1051.3 1055.7 1056.7 1058.3 781.7 797.2 809.6 820.8 823.4 5022.5 5051.7 5074.7 5098.9 5318.3 390.4 402.7 406.3 411.5 414.9 3402.1 3425.9 3463.8 3473.4 3571.3 9421.3 10053.3 10064.2 10064.4 10096.7 9691.3 9870.6 9932.5 9942.5 9978.9 7498.9 7546.2 7588.5 7594.4 7595.8 4995.8 5014.6 5034.8 5130.2 5179.5 9124.3 9174.6 9189.0 9204.4 9303.0 8406.3 9008.5 9012.5 9275.9 9365.7 6055.6 6398.4 6718.6 6729.1 6878.2 7431.3 7451.0 7459.1 7469.3 7516.4 6634.0 6744.6 6770.9 6846.3 6880.5 6638.7 6696.8 6709.6 6713.7 6814.3 6249.1 6296.2 6325.1 6410.6 6419.5 4330.7 4385.4 4448.4 4449.1 4492.9 4535.1 4554.5 4581.9 4635.0 4647.0 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | [#4] prototype.html Cycles:180 Average:4222.10 Median:4842.19 stddev:1216.59 (25.1%) stddev-sans-first:1183.80 03:58:05 INFO - PROCESS | 1232 | Values: 297.2 303.0 303.5 307.1 307.8 4846.7 4861.0 4875.0 4884.0 4910.7 4803.7 4832.5 4843.5 4857.9 4858.5 3640.7 3715.6 3751.6 3818.9 3861.2 3811.2 3838.5 3846.4 3870.0 3872.6 3569.4 3795.8 3803.8 3807.1 3824.1 3656.0 3802.6 3814.1 3815.2 3816.0 3334.9 3350.9 3351.5 3354.5 3356.7 4727.7 4744.5 4765.3 4766.2 4774.0 4218.8 4328.6 4337.6 4371.7 4374.9 5043.4 5059.4 5085.0 5089.9 5090.8 3673.0 3683.2 3687.6 3690.6 3709.8 5118.5 5238.3 5311.2 5330.4 5330.4 3749.1 3751.3 3767.9 3780.1 3797.9 3780.6 3784.7 3785.7 3812.2 3818.3 4314.5 4315.0 4319.3 4321.3 4328.2 4873.9 5101.7 5105.7 5106.4 5114.3 1296.6 1314.0 1317.6 1328.4 1329.2 857.1 863.8 896.2 904.9 907.6 4382.5 4388.4 4391.8 4396.8 4399.5 5130.6 5184.6 5191.0 5200.8 5215.5 4208.8 4393.8 4399.7 4400.4 4403.7 2743.6 2747.3 2749.4 2756.5 2760.9 4841.3 4841.9 4842.5 4852.0 4859.0 5069.2 5241.8 5260.5 5272.8 5325.8 4794.2 4841.3 4844.9 4876.4 4879.3 5180.3 5189.6 5191.9 5198.1 5216.7 4860.7 5114.5 5118.6 5213.2 5232.7 4939.1 4941.5 4948.7 4950.9 4958.6 3722.6 3727.7 3732.3 3733.2 3742.9 5108.4 5245.2 5291.9 5299.2 5299.7 5104.0 5118.7 5127.8 5141.3 5143.2 5129.2 5134.3 5139.2 5139.7 5144.4 4920.5 4961.4 5023.2 5038.6 5083.3 4856.8 4980.0 5128.2 5129.2 5138.6 5003.3 5022.9 5071.7 5084.7 5102.7 03:58:05 INFO - PROCESS | 1232 | 03:58:05 INFO - PROCESS | 1232 | [#5] yui.html Cycles:180 Average:16514.63 Median:432.35 stddev:22363.74 (5172.6%) stddev-sans-first:22394.76 03:58:05 INFO - PROCESS | 1232 | Values: 652.7 664.0 674.9 700.8 757.5 12452.5 13605.1 13609.5 13621.3 13622.4 12673.6 12793.4 12816.1 13217.9 13329.3 618.7 769.3 779.1 785.6 785.8 791.8 808.6 808.6 809.5 809.6 828.6 830.1 830.2 830.3 830.6 645.9 805.2 826.2 827.4 836.6 611.6 611.6 612.0 612.1 612.2 13491.1 13513.3 13542.9 13559.2 13563.3 12189.4 12804.9 12890.0 12963.9 13236.9 11544.2 11718.9 11803.6 11935.9 11963.3 4205.6 4229.7 4276.5 4445.6 4448.5 57685.4 57921.4 58391.7 59644.0 59996.3 10354.4 10383.7 10428.8 10566.8 10761.6 19114.6 19155.7 19194.9 19278.2 19283.9 6374.2 6641.8 6706.7 6721.9 6724.4 3784.3 3803.9 3845.3 3850.9 3913.0 2668.6 2773.9 2775.6 2776.3 2781.6 488.0 497.7 498.5 516.3 519.4 423.2 425.4 432.7 446.8 567.9 7535.7 7655.2 7679.3 7741.8 7769.7 432.0 452.6 489.7 512.7 523.5 3431.2 3502.8 3566.9 3584.1 3686.6 55057.0 55207.2 55298.2 56318.7 100647.0 76236.0 88373.0 88538.6 89936.6 91184.0 48051.3 56701.0 74194.0 76894.6 79759.0 7800.9 7927.5 8165.8 8186.5 8220.0 43788.0 43824.3 43866.6 45012.0 46380.5 39366.8 45303.0 54808.7 65580.7 66621.7 11314.7 11399.0 11564.7 11900.4 12249.5 12897.2 12995.6 13062.5 13539.7 13879.7 11947.8 12085.8 12320.8 12417.3 12840.0 10964.9 11221.4 11289.2 11722.5 11859.8 11908.2 12250.6 12308.9 12575.2 12810.6 10106.9 10166.8 10423.1 10583.6 10707.4 9508.4 9960.6 10084.2 10195.7 10203.8 03:58:05 INFO - PROCESS | 1232 | -------- Summary: end -------- 03:58:05 INFO - PROCESS | 1232 | 03:58:06 INFO - TEST-INFO | 1232: exit 0 03:58:06 INFO - TEST-OK | dromaeo_css | took 1119844ms 03:58:06 INFO - TEST-START | kraken 03:58:06 INFO - operating with platform_type : linux_ 03:58:06 INFO - Initialising browser for kraken test... 03:58:06 INFO - TEST-INFO | started process 1412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFLQmW7/profile http://localhost:57209/getInfo.html) 03:58:10 INFO - PROCESS | 1412 | __metrics Screen width/height:1600/1200 03:58:10 INFO - PROCESS | 1412 | colorDepth:24 03:58:10 INFO - PROCESS | 1412 | Browser inner width/height: 1024/697 03:58:10 INFO - PROCESS | 1412 | __metrics 03:58:11 INFO - PROCESS | 1412 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:58:12 INFO - TEST-INFO | 1412: exit 0 03:58:12 INFO - Browser initialized. 03:58:12 INFO - Running cycle 1/1 for kraken test... 03:58:12 INFO - TEST-INFO | started process 1492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFLQmW7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:24 INFO - PROCESS | 1492 | RSS: Main: 176320512 03:58:24 INFO - PROCESS | 1492 | 03:58:27 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-beat-detection) 03:58:28 INFO - PROCESS | 1492 | RSS: Main: 234258432 03:58:28 INFO - PROCESS | 1492 | 03:58:31 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-dft) 03:58:31 INFO - PROCESS | 1492 | RSS: Main: 221593600 03:58:31 INFO - PROCESS | 1492 | 03:58:34 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-fft) 03:58:35 INFO - PROCESS | 1492 | RSS: Main: 289046528 03:58:35 INFO - PROCESS | 1492 | 03:58:37 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-oscillator) 03:58:38 INFO - PROCESS | 1492 | RSS: Main: 198799360 03:58:38 INFO - PROCESS | 1492 | 03:58:40 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:58:41 INFO - PROCESS | 1492 | RSS: Main: 202141696 03:58:41 INFO - PROCESS | 1492 | 03:58:44 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57209/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:44 INFO - PROCESS | 1492 | RSS: Main: 239411200 03:58:44 INFO - PROCESS | 1492 | 03:58:48 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57209/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:49 INFO - PROCESS | 1492 | RSS: Main: 240168960 03:58:49 INFO - PROCESS | 1492 | 03:58:51 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57209/tests/kraken/driver.html?testName=json-parse-financial) 03:58:52 INFO - PROCESS | 1492 | RSS: Main: 239337472 03:58:52 INFO - PROCESS | 1492 | 03:58:54 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:58:54 INFO - PROCESS | 1492 | RSS: Main: 227307520 03:58:54 INFO - PROCESS | 1492 | 03:58:56 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:58:57 INFO - PROCESS | 1492 | RSS: Main: 232140800 03:58:57 INFO - PROCESS | 1492 | 03:58:59 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:00 INFO - PROCESS | 1492 | RSS: Main: 239529984 03:59:00 INFO - PROCESS | 1492 | 03:59:03 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:03 INFO - PROCESS | 1492 | RSS: Main: 241471488 03:59:03 INFO - PROCESS | 1492 | 03:59:06 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:07 INFO - PROCESS | 1492 | RSS: Main: 242589696 03:59:07 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57209/tests/kraken/driver.html?testName=ai-astar) 03:59:09 INFO - PROCESS | 1492 | RSS: Main: 285118464 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | __start_tp_report 03:59:09 INFO - PROCESS | 1492 | _x_x_mozilla_page_load 03:59:09 INFO - PROCESS | 1492 | _x_x_mozilla_page_load_details 03:59:09 INFO - PROCESS | 1492 | |i|pagename|runs| 03:59:09 INFO - PROCESS | 1492 | |0;ai-astar;104;114;113;113;113;112;112;113;112;112 03:59:09 INFO - PROCESS | 1492 | |1;audio-beat-detection;165;133;130;189;132;136;173;131;200;140 03:59:09 INFO - PROCESS | 1492 | |2;audio-dft;161;161;162;163;161;163;162;162;162;160 03:59:09 INFO - PROCESS | 1492 | |3;audio-fft;75;76;76;101;76;77;76;77;103;83 03:59:09 INFO - PROCESS | 1492 | |4;audio-oscillator;87;86;128;86;86;85;120;86;85;131 03:59:09 INFO - PROCESS | 1492 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 03:59:09 INFO - PROCESS | 1492 | |6;imaging-darkroom;146;145;149;146;145;147;147;147;146;145 03:59:09 INFO - PROCESS | 1492 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;94 03:59:09 INFO - PROCESS | 1492 | |8;json-parse-financial;71;65;65;71;64;64;64;64;62;64 03:59:09 INFO - PROCESS | 1492 | |9;json-stringify-tinderbox;65;66;65;66;66;65;66;65;65;66 03:59:09 INFO - PROCESS | 1492 | |10;stanford-crypto-aes;82;82;80;83;89;90;84;85;98;91 03:59:09 INFO - PROCESS | 1492 | |11;stanford-crypto-ccm;136;131;141;130;142;135;129;127;145;136 03:59:09 INFO - PROCESS | 1492 | |12;stanford-crypto-pbkdf2;180;177;172;171;170;178;170;171;166;169 03:59:09 INFO - PROCESS | 1492 | |13;stanford-crypto-sha256-iterative;69;68;68;68;68;67;67;74;67;66 03:59:09 INFO - PROCESS | 1492 | __end_tp_report 03:59:09 INFO - PROCESS | 1492 | __start_cc_report 03:59:09 INFO - PROCESS | 1492 | _x_x_mozilla_cycle_collect,1916 03:59:09 INFO - PROCESS | 1492 | __end_cc_report 03:59:09 INFO - PROCESS | 1492 | __startTimestamp1466765949314__endTimestamp 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | ------- Summary: start ------- 03:59:09 INFO - PROCESS | 1492 | Number of tests: 14 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 03:59:09 INFO - PROCESS | 1492 | Values: 104.0 114.0 113.0 113.0 113.0 112.0 112.0 113.0 112.0 112.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:152.50 stddev:26.59 (17.4%) stddev-sans-first:27.83 03:59:09 INFO - PROCESS | 1492 | Values: 165.0 133.0 130.0 189.0 132.0 136.0 173.0 131.0 200.0 140.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 03:59:09 INFO - PROCESS | 1492 | Values: 161.0 161.0 162.0 163.0 161.0 163.0 162.0 162.0 162.0 160.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:10.78 (14.2%) stddev-sans-first:11.13 03:59:09 INFO - PROCESS | 1492 | Values: 75.0 76.0 76.0 101.0 76.0 77.0 76.0 77.0 103.0 83.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:86.00 stddev:19.74 (23.0%) stddev-sans-first:20.54 03:59:09 INFO - PROCESS | 1492 | Values: 87.0 86.0 128.0 86.0 86.0 85.0 120.0 86.0 85.0 131.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:59:09 INFO - PROCESS | 1492 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:1.25 (0.9%) stddev-sans-first:1.32 03:59:09 INFO - PROCESS | 1492 | Values: 146.0 145.0 149.0 146.0 145.0 147.0 147.0 147.0 146.0 145.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:59:09 INFO - PROCESS | 1492 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.50 stddev:3.06 (4.7%) stddev-sans-first:2.49 03:59:09 INFO - PROCESS | 1492 | Values: 71.0 65.0 65.0 71.0 64.0 64.0 64.0 64.0 62.0 64.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 03:59:09 INFO - PROCESS | 1492 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 66.0 65.0 65.0 66.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:5.52 (6.3%) stddev-sans-first:5.62 03:59:09 INFO - PROCESS | 1492 | Values: 82.0 82.0 80.0 83.0 89.0 90.0 84.0 85.0 98.0 91.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:136.00 stddev:6.03 (4.4%) stddev-sans-first:6.39 03:59:09 INFO - PROCESS | 1492 | Values: 136.0 131.0 141.0 130.0 142.0 135.0 129.0 127.0 145.0 136.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:171.50 stddev:4.45 (2.6%) stddev-sans-first:3.78 03:59:09 INFO - PROCESS | 1492 | Values: 180.0 177.0 172.0 171.0 170.0 178.0 170.0 171.0 166.0 169.0 03:59:09 INFO - PROCESS | 1492 | 03:59:09 INFO - PROCESS | 1492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.20 (3.2%) stddev-sans-first:2.32 03:59:09 INFO - PROCESS | 1492 | Values: 69.0 68.0 68.0 68.0 68.0 67.0 67.0 74.0 67.0 66.0 03:59:09 INFO - PROCESS | 1492 | -------- Summary: end -------- 03:59:09 INFO - PROCESS | 1492 | 03:59:10 INFO - TEST-INFO | 1492: exit 0 03:59:10 INFO - TEST-OK | kraken | took 64259ms 03:59:10 INFO - SUITE-END | took 1184s 03:59:10 INFO - Completed test suite (00:19:44) 03:59:10 INFO - javascript benchmark 03:59:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.933626659333, 2669.0, 2702.7702645275144, 2718.877650505727, 2729.9590506142413, 4610.63114950804, 4691.554302341272, 4789.544993225642, 4872.2204447288395, 4920.532549407805, 4757.381540399743, 4762.0, 4788.329633851264, 4813.157697402958, 4836.9274460883025, 4333.393324934512, 4379.715318504287, 4424.491183513905, 4441.467023957113, 4566.931496027562, 4476.574725401098, 4511.548845115495, 4525.841595544157, 4526.773661316921, 4555.157295900252, 4261.637760790337, 4282.550332215135, 4325.718828276184, 4379.978100109511, 4442.267025940716, 4349.238883195429, 4352.7605981670995, 4357.934630980538, 4479.5296493868, 4509.594136527729, 4441.467023957146, 4444.911101777979, 4447.043885564619, 4449.310356894686, 4497.595216430537, 4624.213883639789, 4635.582797548237, 4678.3216433616935, 4840.322354870321, 4889.071076495455, 5010.173321401964, 5031.0, 5101.897962040775, 5109.923351149699, 5110.386753589556, 5066.898662026776, 5084.339035925306, 5103.387593488768, 5142.434332223453, 5143.331366922276, 4657.068586282757, 4738.2418812990445, 4745.074710431501, 4781.019890922318, 4798.3042458843975, 5198.792048318025, 5231.0, 5277.261183434322, 5281.313429254173, 5292.047431462373, 5033.421156566968, 5038.017586570657, 5064.670796398223, 5080.7205603692155, 5100.591952643779, 4892.486288939681, 5077.7715002824225, 5088.109580823341, 5102.056119617882, 5168.8966220675375, 5103.770330335144, 5111.591072714174, 5121.231815227746, 5131.999260144311, 5133.332666753298, 5109.821156259513, 5111.7699703513435, 5119.6188938553405, 5124.359455068116, 5172.896542069213, 4265.4881414230495, 4297.8495752648505, 4335.436393268855, 4409.581089796464, 4454.153710794939, 3831.9616803831605, 3832.2718683450057, 3835.2521258354354, 3869.6130386961077, 3917.334053210961, 4370.431843860341, 4379.408779814684, 4384.517703052662, 4408.4269045024585, 4435.179491794029, 4944.060628480577, 5004.274380214922, 5042.84871453857, 5131.1277082895995, 5188.11801993662, 4314.02934339771, 4332.501762297376, 4332.956670433318, 4365.388845561624, 4370.541093185233, 4581.083783243364, 4590.9540904591195, 4594.0582180653555, 4599.5400459953735, 4670.0, 4608.746518941491, 4704.388429504143, 4723.031778485402, 4739.289106633894, 4773.498782627774, 5093.643444958817, 5099.311592935054, 5112.642115051911, 5118.744062796771, 5174.896502069862, 4745.264484004984, 4760.357351757607, 4778.1399348117675, 4778.996410753781, 4858.076965376567, 4950.430700469348, 5005.449400565862, 5010.298558201927, 5035.496450354935, 5047.0, 5091.541761241506, 5118.641695081308, 5119.616028797781, 5133.820316288912, 5167.147420675697, 4850.563449289581, 4950.158473059517, 4957.380327459067, 4966.006798640358, 4979.178435558092, 4964.0, 5012.4736902626155, 5029.949700502948, 5032.874178145576, 5033.345665063518, 4948.604111670986, 4988.351514303117, 5028.874278143076, 5031.144705400017, 5033.823816166563, 4801.807927682854, 4995.650304478651, 5074.137396642506, 5079.746012699276, 5121.974390128025, 4774.164521208705, 4833.468318485035, 4841.733704646278, 4933.013397320478, 4956.578690811321], "value": 4694.510533148185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5461389739568, 585.1398444286897, 587.9853003674905, 591.1664552980297, 614.2659521871365, 29783.851080744593, 40688.18623627526, 41532.79233603835, 41583.37624935621, 45467.31799023017, 41524.79237603808, 42033.789831050875, 42035.78982105093, 42116.157676846444, 42257.154856902845, 7538.509996850187, 7729.343005844482, 7730.536167829948, 7922.603869806516, 8133.796655083611, 7285.7814265572115, 10152.796944061114, 10350.792984140313, 10403.219758518142, 10728.78542429151, 10626.62806801762, 10662.093722033598, 10688.091512221432, 10692.0, 10701.357918524913, 7594.658240379196, 7784.571848548328, 10441.477926103702, 10518.158547316196, 10530.31552949056, 7729.033870766154, 10086.24353173515, 10495.527701253463, 10496.475176241158, 10506.264561480699, 37067.443988340194, 37477.0, 37492.625073749456, 40413.79793101016, 40525.0, 2923.4883895318235, 3085.5063189889734, 3182.44307246231, 3214.1321843102464, 3568.7145028397667, 30703.385932281453, 30976.0707178785, 31093.22266943322, 31667.524987125213, 31735.52396714051, 3665.87169449068, 3669.486271921933, 3693.076730817296, 3712.6658600726064, 3738.495303134069, 240465.0, 242285.0, 242552.0, 242731.0, 243353.0, 57603.135952960736, 57762.0, 57788.71105644529, 57830.71084644634, 57916.42083579195, 62379.0, 62490.0, 62563.0, 62747.0, 62780.686096569225, 12605.810912836314, 12762.361881905868, 12771.808422873664, 12773.61679149627, 12790.29653369055, 9150.81698366029, 11395.0, 11617.60588729358, 11625.88374116265, 11760.176787624785, 19274.518137046405, 19320.0, 19328.516787080152, 19331.0, 19385.709214361796, 6962.316176470544, 7039.648017599202, 7122.0, 7126.429885609139, 7312.96343518279, 783.50247592779, 806.9193080692002, 939.902027161575, 959.3428501476511, 996.3473924579412, 27568.44863102767, 27701.86149069282, 27766.305842354104, 28131.296717582223, 28246.43507129887, 963.4845357733578, 966.6085235479642, 972.9659461918799, 1004.1966426858484, 1047.8480620310165, 14134.434622614981, 14585.708285834224, 14587.927060364631, 14941.925290373478, 14964.625884352978, 392372.0, 394936.0, 396639.0, 396818.0, 397162.0, 51239.743801280754, 51830.74084629553, 51931.74034129805, 51979.0, 51985.0, 1071.1484369925927, 1166.6150170443734, 1198.053537705203, 1213.520659339556, 1221.3465795799204, 28009.579856301763, 29566.704332956397, 29570.556441653822, 29608.851955740083, 29842.552361715025, 42110.36834447424, 42665.0, 42694.0, 42716.78641606772, 42730.57269427266, 326688.0, 336113.0, 336952.0, 337359.0, 337480.0, 22759.0, 25297.343778903687, 25585.744142558335, 25936.610950835377, 27562.310942225802, 42569.87303057911, 42906.0, 42921.141577167655, 42977.0, 43055.354169686856, 35217.64782352144, 36190.0, 36328.27343453063, 36888.44667329938, 37066.8146659265, 36295.45556816597, 36339.81830090833, 36768.26463470769, 36908.63091369052, 38767.41848872213, 36003.81998089993, 36502.634973649925, 36631.63368366389, 36793.816030920745, 36857.26285474329, 32730.345393091528, 33613.11828815549, 33711.0, 34076.0, 34236.31527369488, 25028.62457063109, 25176.0, 25207.49585008326, 25569.872150639127, 25781.484370312864], "value": 18334.53075643493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2234329162425, 362.96551827576377, 363.492927366324, 377.45834727166516, 380.1769169747497, 15616.219189040545, 16346.591335216626, 17331.22009509572, 17345.39291124811, 17396.56508587286, 15962.361505539793, 16101.516954491384, 16869.0, 16872.409465668705, 16906.492805215832, 1470.7499725046769, 1482.6960473103043, 1483.1620134623956, 1687.5865412973778, 4883.145449546333, 3637.854485820564, 3789.2610940866543, 5037.1940489521685, 5739.569532285074, 6053.455189032986, 6064.363241859607, 6064.4541991220785, 6068.33248342682, 6073.969630151865, 6087.360827113133, 5770.307563092435, 5975.611585246967, 5976.462118409364, 5976.760929562813, 5982.820515384546, 3276.6231883333244, 4942.1351263529095, 5230.293910322096, 5257.685578605348, 5268.446813084647, 20035.0, 20515.48711282215, 20641.690374644393, 20880.269190578256, 20903.163873445043, 1724.542996106033, 1818.209079050604, 1831.9358822441284, 2105.9157633694635, 2289.8626082435107, 9335.626574936994, 9347.485888276142, 9422.104900034486, 9510.667126650535, 9614.567344469446, 1698.8131305556378, 1740.338671304896, 1770.530809335527, 1786.5087101047316, 1805.900675462849, 67483.0, 67628.0, 68096.6595167021, 69007.30992690059, 71193.64403178003, 9684.370515916444, 9741.561629726679, 9877.802443951081, 10076.949615251877, 10105.797884042278, 13831.0, 13911.86088139126, 13939.581812545639, 13939.790903136462, 13950.883929285836, 6753.08833307507, 6944.375006249361, 7060.7881763547175, 7080.6105664187935, 7445.776626701099, 7041.788746337618, 7075.2570980047385, 7116.64416779159, 7233.638318084075, 7234.0, 4314.633256173261, 4333.609975102256, 4341.15347507233, 4372.409724687126, 4433.977830110894, 1617.6279455725248, 1733.1247719901621, 1802.8016918138994, 1823.3253696132515, 1837.0833810702716, 805.7743831727125, 827.0, 842.869355249925, 907.8138981508774, 916.1754421021134, 16224.756628650579, 16416.425425110065, 16455.42406015784, 16782.328706851833, 17239.44844963934, 810.4326971120239, 839.4627438439404, 840.4915026409057, 867.8394497018072, 891.9063498332712, 8934.776630584158, 9607.183389411839, 9614.95192524047, 9628.229741620653, 9765.267604929659, 396614.0, 404059.0, 404686.0, 409819.0, 413916.0, 79545.60227198827, 80231.59884200658, 80508.59745701234, 80992.0, 81070.0, 787.165604459275, 799.9640016199285, 807.4186585658316, 808.567416432206, 822.2805045585233, 14726.33055171517, 15048.322825473098, 15189.6202594936, 15272.694546108793, 15304.770428443804, 36533.269334612625, 37161.62838371582, 37378.626213737516, 37387.252254954205, 37943.43084853785, 51183.74408127936, 52711.0, 52992.73503632457, 53668.46331536791, 54031.0, 7362.153352364547, 7479.326860582573, 7510.136334321623, 7544.698212071456, 7697.114831794415, 10224.897751022394, 11531.538738450703, 11654.067674585844, 11672.649820505398, 11949.701257468285, 9807.803843923224, 10033.548490317808, 10143.49282535885, 10170.237232207466, 10348.637797677346, 10467.94766026165, 10485.318454300446, 10507.842382364424, 10583.364998100138, 10588.947055264674, 10052.94973525157, 10061.0, 10064.0, 10127.493625318852, 10181.083702466814, 6790.354916282945, 6989.231184569591, 7019.719211231493, 7051.788446346618, 7694.769156925301, 7664.616769161631, 10014.248931330034, 10182.490875456346, 10437.11284540792, 11220.943895280472], "value": 7962.169265740461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.45214653406, 1301.0567338679455, 1373.0731756064656, 1379.951701690441, 1622.7809245751828, 6614.768483103092, 7344.22885597012, 7544.886826697604, 7595.810104747384, 7806.570638614888, 7609.315161635452, 7622.695092196319, 7670.194629563899, 7671.462997590171, 7682.308592226698, 2174.3150907464137, 2201.03154611971, 2204.6913432119436, 2205.3273751505785, 2207.6798864164766, 2137.6900349449397, 2163.0915015693367, 2203.4050806282294, 2207.9668804967937, 2210.4694873230387, 2193.2104442400723, 2197.8571392859494, 2201.5376770878133, 2216.6896634471186, 2233.519793244452, 2171.446281198292, 2171.53312037911, 2179.4878203622216, 2180.3349978256706, 2184.028107492167, 2087.092114929995, 2127.0428307261795, 2128.4785227619177, 2128.8509804313703, 2130.3076500137518, 7776.533407995538, 7789.10425301092, 7814.140444551095, 7825.217478252129, 7829.373650108035, 4617.284320930261, 4807.134715751164, 4807.831725889577, 4826.855194344175, 4830.154722923475, 2826.7879909006906, 2979.329650828568, 3041.300500884809, 3045.8629361678554, 3059.8470076496087, 933.9859902101474, 935.4013431403907, 944.15026476172, 956.7990721948399, 973.9415635061919, 10788.838167427495, 10884.673459796219, 10902.291351062235, 10905.727356816144, 10920.453977301104, 4005.0788318686864, 4112.650424713933, 4114.506259248909, 4177.3316269396755, 4217.34631132175, 8585.18440748128, 8613.310935125175, 8628.352873534384, 8651.178138076873, 8659.826803463895, 4618.1918164321105, 4618.330342100377, 4621.884452888705, 4626.121037003026, 4634.95365046352, 3554.0, 3893.824777885002, 4207.621314081747, 4263.424437700933, 4309.482862056573, 3453.7755045921936, 3512.2799826035603, 3526.1360966562843, 3531.152523394418, 3532.275883443888, 1048.5962904281907, 1051.2588625019343, 1055.7466208110152, 1056.6777132974516, 1058.3438268273567, 781.6912319633713, 797.2426195114548, 809.6073404398862, 820.7865954851662, 823.4482896459386, 5022.522860328263, 5051.696898186121, 5074.695518268842, 5098.872528186751, 5318.25544423781, 390.3831945526062, 402.7100487648888, 406.3315845434244, 411.47742367193496, 414.8713898691415, 3402.0644322811427, 3425.9143521411665, 3463.7748546344405, 3473.4442489201606, 3571.267890082579, 9421.293402994803, 10053.346532475513, 10064.245181611263, 10064.44645544502, 10096.69709908704, 9691.321607487549, 9870.60517579303, 9932.453715045598, 9942.502874856229, 9978.850317245247, 7498.887516687254, 7546.20764819708, 7588.506747061423, 7594.430417718582, 7595.848083038309, 4995.750212489288, 5014.648974571745, 5034.84895453137, 5130.179171332569, 5179.533841954242, 9124.27005839518, 9174.587143578421, 9189.0, 9204.447733136034, 9303.0, 8406.285465735236, 9008.504532250789, 9012.549372531215, 9275.86086208721, 9365.672201472917, 6055.6063855849225, 6398.360163983564, 6718.563293385914, 6729.0579318894415, 6878.243393226641, 7431.29402706742, 7451.031365922396, 7459.142198647225, 7469.327760501581, 7516.361109305771, 6634.0, 6744.62904540255, 6770.8645827084165, 6846.349596788297, 6880.4839637026425, 6638.701258443478, 6696.83257918556, 6709.630970296681, 6713.664316784044, 6814.284500127415, 6249.093881387264, 6296.244450665949, 6325.146105275913, 6410.583312084699, 6419.518536109904, 4330.69685122051, 4385.429894113872, 4448.399466072039, 4449.13241917823, 4492.865214043584, 4535.115652447741, 4554.544545545419, 4581.908361832811, 4635.0, 4647.047355292225], "value": 4019.7458241016157, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.23610321473814, 302.9863656135474, 303.543167532863, 307.11550733886406, 307.8106964217007, 4846.733429661372, 4860.951390486094, 4874.951250487494, 4884.0, 4910.656254062217, 4803.7357945313, 4832.516748325165, 4843.467218605951, 4857.854264372066, 4858.51414858514, 3640.7451478396524, 3715.6098609646006, 3751.643593858579, 3818.8663396781117, 3861.2084522672785, 3811.1615444602144, 3838.539375274971, 3846.403807409842, 3869.9806500967456, 3872.5546562145432, 3569.4288913773803, 3795.7722536647752, 3803.8098095095274, 3807.1053302473897, 3824.1204522959597, 3655.981720091396, 3802.6310528209683, 3814.141818090935, 3815.1606646537716, 3816.0, 3334.9494909103555, 3350.949735753966, 3351.463765797461, 3354.513595528659, 3356.7146792522667, 4727.739974301412, 4744.478107408182, 4765.332853400527, 4766.165920963852, 4773.95226047742, 4218.789060546991, 4328.610425061728, 4337.587929146757, 4371.650267978586, 4374.868753937387, 5043.36957880265, 5059.380998080615, 5084.9745751271375, 5089.923651145199, 5090.77091530882, 3673.0, 3683.208110256308, 3687.649673281034, 3690.5755838078694, 3709.7774133552075, 5118.539331460149, 5238.266642670029, 5311.150215965466, 5330.360356757175, 5330.440303768126, 3749.1189570450924, 3751.268502642013, 3767.8869633911027, 3780.1494663700996, 3797.9240415192094, 3780.584135745066, 3784.7161462889844, 3785.716071294664, 3812.1613245086037, 3818.3127037133027, 4314.525402205755, 4315.029118448324, 4319.308910574293, 4321.2653848845775, 4328.156009578102, 4873.902521949542, 5101.69389836611, 5105.698046997992, 5106.387233532, 5114.3095682083185, 1296.623979046085, 1313.9737205256033, 1317.5915466205506, 1328.4221363706818, 1329.2423318708243, 857.1043259793531, 863.7797361672733, 896.2202883491404, 904.9185573298435, 907.5689047702289, 4382.496012958487, 4388.407564978751, 4391.824327026947, 4396.834838767729, 4399.450068741407, 5130.640855140179, 5184.585233181337, 5190.987757387349, 5200.843974680765, 5215.5135786300725, 4208.8316467340965, 4393.824247030083, 4399.714018588846, 4400.427944367276, 4403.735775853459, 2743.629610002664, 2747.2719729271757, 2749.42262124956, 2756.462489814507, 2760.8619569021466, 4841.273808928689, 4841.903161936812, 4842.467328593852, 4852.0, 4858.975705121452, 5069.188929771292, 5241.764120614582, 5260.526552610207, 5272.839975205448, 5325.775071733446, 4794.232922732346, 4841.273808928689, 4844.878878028007, 4876.391130745034, 4879.316895634614, 5180.274761533313, 5189.610779191651, 5191.870203244949, 5198.116320225495, 5216.66091704038, 4860.684055536379, 5114.4629813869005, 5118.564921981673, 5213.191955246943, 5232.659877107976, 4939.061578300111, 4941.517544736636, 4948.6535942485125, 4950.9257361140335, 4958.570300552631, 3722.571904231048, 3727.7204209684924, 3732.2908647356917, 3733.226717309365, 3742.85028598853, 5108.438071812172, 5245.160774276097, 5291.894162116813, 5299.205119232146, 5299.708516031656, 5104.03023425548, 5118.718470484159, 5127.769250383816, 5141.28022076917, 5143.151380022255, 5129.179331306973, 5134.280016194617, 5139.152039913372, 5139.743012849268, 5144.434112247724, 4920.507949205051, 4961.362750292467, 5023.196288593807, 5038.571721403721, 5083.262926875508, 4856.757162141949, 4979.950200498093, 5128.1794912813775, 5129.179141404897, 5138.614603904647, 5003.299538064746, 5022.924656130088, 5071.670341427795, 5084.694918304914, 5102.69383836971], "value": 3837.9140340187887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.6834485274641, 664.0470924223737, 674.9325067493248, 700.8247938015496, 757.5303311946592, 12452.501899924004, 13605.115667481607, 13609.523666671668, 13621.25083120428, 13622.38699258532, 12673.619791406249, 12793.424295906683, 12816.102872798907, 13217.93391033046, 13329.266890321029, 618.659737144571, 769.273036980054, 779.1312686354717, 785.6268272570512, 785.7917651822272, 791.8376732769797, 808.5633757770797, 808.6361137488125, 809.4778867630375, 809.6356639512243, 828.6312590897053, 830.1408042675831, 830.2320353672859, 830.3315830756238, 830.5847076461769, 645.8546826963942, 805.2068712318362, 826.1614461321764, 827.3918669777709, 836.6277006732007, 611.5841227964981, 611.620795107032, 611.9694015299217, 612.13077430049, 612.2377639838385, 13491.123076999964, 13513.32433378337, 13542.93228533861, 13559.186448813005, 13563.321833908265, 12189.390530473442, 12804.871951280462, 12890.0, 12963.87036129636, 13236.933815330958, 11544.170576116416, 11718.941405292919, 11803.645890623295, 11935.940320298343, 11963.342016189106, 4205.642520385771, 4229.725067870579, 4276.486821581399, 4445.5776701213335, 4448.532904045093, 57685.423145768844, 57921.42078579245, 58391.70804145995, 59644.0, 59996.300351466976, 10354.378737275787, 10383.688489345332, 10428.791424171473, 10566.788664226673, 10761.56953721858, 19114.617707646048, 19155.712664310046, 19194.92881139039, 19278.22887084529, 19283.90358048201, 6374.203224596926, 6641.800745977628, 6706.664666766642, 6721.8655626887185, 6724.4284235840505, 3784.280986612535, 3803.923921521554, 3845.3270677631863, 3850.8652197172964, 3912.9804350978634, 2668.5596876515156, 2773.861306934645, 2775.6114144019853, 2776.250412388644, 2781.5688568271544, 487.95608395244597, 497.66159011872276, 498.4840689886023, 516.2875232179568, 519.4000928927095, 423.208599918155, 425.3555862867696, 432.7100842435513, 446.8279712310719, 567.9237844285057, 7535.651639628625, 7655.1962043985695, 7679.2704693054075, 7741.845163096819, 7769.650365733555, 431.98920026998945, 452.57684065398956, 489.68170689051686, 512.6975084700044, 523.4797523385593, 3431.2108215110666, 3502.8073455960166, 3566.8573257069424, 3584.121890136881, 3686.631336866292, 55057.0, 55207.17189242165, 55298.17052744212, 56318.71840640852, 100647.0, 76236.0, 88373.0, 88538.55730721305, 89936.550317248, 91184.0, 48051.27923081157, 56701.0, 74194.0, 76894.61552692088, 79759.0, 7800.921990780246, 7927.5243485391065, 8165.836683266421, 8186.467879587808, 8219.95890020546, 43788.0, 43824.342634859866, 43866.56133438752, 45012.0, 46380.536194638975, 39366.80316598398, 45303.0, 54808.725956371556, 65580.67209664112, 66621.66689166523, 11314.660560183207, 11399.0, 11564.710882228012, 11900.40497975115, 12249.510019599116, 12897.161684490478, 12995.610131696065, 13062.477500900237, 13539.729205416033, 13879.722405552035, 11947.82078268844, 12085.758284834079, 12320.81518777237, 12417.254964702146, 12840.0, 10964.890351096386, 11221.382823944761, 11289.20975531705, 11722.531098755955, 11859.762804744028, 11908.225965312227, 12250.632481025583, 12308.876911231131, 12575.182613130117, 12810.615681529569, 10106.898931010595, 10166.796664066826, 10423.114035307084, 10583.576656933636, 10707.357558546511, 9508.429494230368, 9960.55177516999, 10084.193264538966, 10195.69412917584, 10203.795924081625], "value": 6443.489266893854, "unit": "score"}], "name": "dromaeo_css", "value": 6390.865491665236, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 133.0, 130.0, 189.0, 132.0, 136.0, 173.0, 131.0, 200.0, 140.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 101.0, 76.0, 77.0, 76.0, 77.0, 103.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 128.0, 86.0, 86.0, 85.0, 120.0, 86.0, 85.0, 131.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 149.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 65.0, 71.0, 64.0, 64.0, 64.0, 64.0, 62.0, 64.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 80.0, 83.0, 89.0, 90.0, 84.0, 85.0, 98.0, 91.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 141.0, 130.0, 142.0, 135.0, 129.0, 127.0, 145.0, 136.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 172.0, 171.0, 170.0, 178.0, 170.0, 171.0, 166.0, 169.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 74.0, 67.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1557.7000000000003, "alertThreshold": 2.0}]} 03:59:10 INFO - Return code: 0 03:59:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:59:10 INFO - # TBPL SUCCESS # 03:59:10 INFO - Running post-action listener: _resource_record_post_action 03:59:10 INFO - ##### 03:59:10 INFO - ##### Finished run-tests step (success) 03:59:10 INFO - ##### 03:59:10 INFO - Running post-run listener: _resource_record_post_run 03:59:10 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534253568; Read time: 8; Write time: 596272 03:59:10 INFO - TinderboxPrint: CPU usage
13.2% 03:59:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:59:10 INFO - TinderboxPrint: I/O write bytes / time
534,253,568 / 596,272 03:59:10 INFO - TinderboxPrint: CPU idle
8,322.0 (86.8%) 03:59:10 INFO - TinderboxPrint: CPU user
1,212.6 (12.7%) 03:59:10 INFO - TinderboxPrint: Swap in / out
0 / 0 03:59:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 246517760; Read time: 0; Write time: 403288 03:59:10 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287735808; Read time: 8; Write time: 192984 03:59:11 INFO - Running post-run listener: _upload_blobber_files 03:59:11 INFO - Blob upload gear active. 03:59:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:59:11 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 03:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:59:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:59:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:12 INFO - (blobuploader) - INFO - Done attempting. 03:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:59:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:15 INFO - (blobuploader) - INFO - Done attempting. 03:59:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:59:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:16 INFO - (blobuploader) - INFO - Done attempting. 03:59:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:59:16 INFO - Return code: 0 03:59:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:59:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:59:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca027dec5841800852ae3aba1c3b74d2f03ad706c0d42e74502d8694b7906b7ff25fbbb9a812c7cc4b599cf1c3f95612456084eb9bca07027bae9af326a8905d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6bd369617861f1d2f7c112fcc791b8b5f858eaf76d77debb1826d07bbf4a445e159ad85603b50371ab15403ce9072cfff7dce8ba0e573aabe3b2646c6dd4f003", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/816b81e7fb61cbcd73feb13e66a228dbb60e28e226e5fa215634cb64282a8ce70f0faecc03185400d49a6225542e23cecda17071ffb0a9fe9119a514bf977f18"} 03:59:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:59:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:59:16 INFO - Contents: 03:59:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca027dec5841800852ae3aba1c3b74d2f03ad706c0d42e74502d8694b7906b7ff25fbbb9a812c7cc4b599cf1c3f95612456084eb9bca07027bae9af326a8905d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6bd369617861f1d2f7c112fcc791b8b5f858eaf76d77debb1826d07bbf4a445e159ad85603b50371ab15403ce9072cfff7dce8ba0e573aabe3b2646c6dd4f003", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/816b81e7fb61cbcd73feb13e66a228dbb60e28e226e5fa215634cb64282a8ce70f0faecc03185400d49a6225542e23cecda17071ffb0a9fe9119a514bf977f18"} 03:59:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:59:16 INFO - Copying logs to upload dir... 03:59:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:59:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.310002 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-24 03:59:15.663354) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:59:15.667043) ========= 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=232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca027dec5841800852ae3aba1c3b74d2f03ad706c0d42e74502d8694b7906b7ff25fbbb9a812c7cc4b599cf1c3f95612456084eb9bca07027bae9af326a8905d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6bd369617861f1d2f7c112fcc791b8b5f858eaf76d77debb1826d07bbf4a445e159ad85603b50371ab15403ce9072cfff7dce8ba0e573aabe3b2646c6dd4f003", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/816b81e7fb61cbcd73feb13e66a228dbb60e28e226e5fa215634cb64282a8ce70f0faecc03185400d49a6225542e23cecda17071ffb0a9fe9119a514bf977f18"} build_url:https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/YN8iqcMLTLmF751GY2yrjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca027dec5841800852ae3aba1c3b74d2f03ad706c0d42e74502d8694b7906b7ff25fbbb9a812c7cc4b599cf1c3f95612456084eb9bca07027bae9af326a8905d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6bd369617861f1d2f7c112fcc791b8b5f858eaf76d77debb1826d07bbf4a445e159ad85603b50371ab15403ce9072cfff7dce8ba0e573aabe3b2646c6dd4f003", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/816b81e7fb61cbcd73feb13e66a228dbb60e28e226e5fa215634cb64282a8ce70f0faecc03185400d49a6225542e23cecda17071ffb0a9fe9119a514bf977f18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:59:15.692467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:59:15.692835) ========= 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=232498196343f89f466a4a9a000001c8-1466764586.104441-1548940999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:59:15.774756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:59:15.775138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:59:15.775432) ========= ========= Total master_lag: 0.16 =========