builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1464987527.69 results: success (0) buildid: 20160603073911 builduid: 789b55693ca244739a418de3b3b8b116 revision: 99dacc787a59d79c080886f46bfe8daf61c1bd0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.693251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.693732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.694019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.709280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.709803) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 13:58:47-- 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% 88.8M=0s 2016-06-03 13:58:48 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.813876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.814188) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015536 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.863429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:47.863792) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99dacc787a59d79c080886f46bfe8daf61c1bd0a --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 99dacc787a59d79c080886f46bfe8daf61c1bd0a --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=31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 13:58:48,118 truncating revision to first 12 chars 2016-06-03 13:58:48,118 Setting DEBUG logging. 2016-06-03 13:58:48,118 attempt 1/10 2016-06-03 13:58:48,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99dacc787a59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 13:58:48,448 unpacking tar archive at: fx-team-99dacc787a59/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:48.546998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:48.547382) ========= script_repo_revision: 99dacc787a59d79c080886f46bfe8daf61c1bd0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:48.547826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:48.548102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 13:58:48.556702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-06-03 13:58:48.556986) ========= /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=31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:48 INFO - MultiFileLogger online at 20160603 13:58:48 in /builds/slave/test 13:58:48 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 13:58:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:48 INFO - {'append_to_log': False, 13:58:48 INFO - 'base_work_dir': '/builds/slave/test', 13:58:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:58:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:48 INFO - 'branch': 'Fx-Team-Non-PGO', 13:58:48 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:48 INFO - 'config_files': ('talos/linux_config.py',), 13:58:48 INFO - 'default_actions': ('clobber', 13:58:48 INFO - 'read-buildbot-config', 13:58:48 INFO - 'download-and-extract', 13:58:48 INFO - 'populate-webroot', 13:58:48 INFO - 'create-virtualenv', 13:58:48 INFO - 'install', 13:58:48 INFO - 'run-tests'), 13:58:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:48 INFO - 'download_minidump_stackwalk': True, 13:58:48 INFO - 'download_symbols': 'ondemand', 13:58:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:48 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:48 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:48 INFO - 'installer_path': 'installer.exe', 13:58:48 INFO - 'log_level': 'info', 13:58:48 INFO - 'log_name': 'talos', 13:58:48 INFO - 'log_to_console': True, 13:58:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:48 INFO - 'opt_config_files': (), 13:58:48 INFO - 'pip_index': False, 13:58:48 INFO - 'sps_profile': False, 13:58:48 INFO - 'sps_profile_interval': 0, 13:58:48 INFO - 'suite': 'dromaeojs', 13:58:48 INFO - 'system_bits': '32', 13:58:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:48 INFO - 'title': 'talos-linux64-ix-014', 13:58:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:48 INFO - 'use_talos_json': True, 13:58:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:48 INFO - 'work_dir': 'build'} 13:58:48 INFO - ##### 13:58:48 INFO - ##### Running clobber step. 13:58:48 INFO - ##### 13:58:48 INFO - Running pre-action listener: _resource_record_pre_action 13:58:48 INFO - Running main action method: clobber 13:58:48 INFO - rmtree: /builds/slave/test/build 13:58:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:49 INFO - Running post-action listener: _resource_record_post_action 13:58:49 INFO - ##### 13:58:49 INFO - ##### Finished clobber step (success) 13:58:49 INFO - ##### 13:58:49 INFO - ##### 13:58:49 INFO - ##### Running read-buildbot-config step. 13:58:49 INFO - ##### 13:58:49 INFO - Running pre-action listener: _resource_record_pre_action 13:58:49 INFO - Running main action method: read_buildbot_config 13:58:49 INFO - Using buildbot properties: 13:58:49 INFO - { 13:58:49 INFO - "project": "", 13:58:49 INFO - "product": "firefox", 13:58:49 INFO - "script_repo_revision": "production", 13:58:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:58:49 INFO - "repository": "", 13:58:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:58:49 INFO - "buildid": "20160603073911", 13:58:49 INFO - "pgo_build": "False", 13:58:49 INFO - "basedir": "/builds/slave/test", 13:58:49 INFO - "buildnumber": 1751, 13:58:49 INFO - "slavename": "talos-linux64-ix-014", 13:58:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:58:49 INFO - "platform": "ubuntu64_hw", 13:58:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:58:49 INFO - "branch": "fx-team", 13:58:49 INFO - "repo_path": "integration/fx-team", 13:58:49 INFO - "revision": "99dacc787a59d79c080886f46bfe8daf61c1bd0a", 13:58:49 INFO - "stage_platform": "linux64", 13:58:49 INFO - "builduid": "789b55693ca244739a418de3b3b8b116", 13:58:49 INFO - "slavebuilddir": "test" 13:58:49 INFO - } 13:58:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:58:49 INFO - Running post-action listener: _resource_record_post_action 13:58:49 INFO - ##### 13:58:49 INFO - ##### Finished read-buildbot-config step (success) 13:58:49 INFO - ##### 13:58:49 INFO - ##### 13:58:49 INFO - ##### Running download-and-extract step. 13:58:49 INFO - ##### 13:58:49 INFO - Running pre-action listener: _resource_record_pre_action 13:58:49 INFO - Running main action method: download_and_extract 13:58:49 INFO - mkdir: /builds/slave/test/build/tests 13:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:49 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:58:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:58:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:58:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:58:50 INFO - Downloaded 1361 bytes. 13:58:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:58:50 INFO - Using the following test package requirements: 13:58:50 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:50 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:50 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:58:50 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'jsshell-linux-x86_64.zip'], 13:58:50 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:50 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:50 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:50 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:50 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:50 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58: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')]} 13:58:50 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:59:16 INFO - Downloaded 22868152 bytes. 13:59:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:59:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:59:17 INFO - Return code: 0 13:59:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:17 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:59:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:59:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:59:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:59:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:59:19 INFO - Downloaded 22868152 bytes. 13:59:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:59:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:59:21 INFO - Return code: 0 13:59:21 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')]} 13:59:21 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:59:23 INFO - Downloaded 10833369 bytes. 13:59:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:59:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:59:23 INFO - Return code: 0 13:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:23 INFO - https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:59:56 INFO - Downloaded 55170158 bytes. 13:59:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:59:56 INFO - mkdir: /builds/slave/test/properties 13:59:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:59:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:59:56 INFO - Contents: 13:59:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:59:58 INFO - Running post-action listener: _resource_record_post_action 13:59:58 INFO - Running post-action listener: set_extra_try_arguments 13:59:58 INFO - ##### 13:59:58 INFO - ##### Finished download-and-extract step (success) 13:59:58 INFO - ##### 13:59:58 INFO - ##### 13:59:58 INFO - ##### Running populate-webroot step. 13:59:58 INFO - ##### 13:59:58 INFO - Running pre-action listener: _resource_record_pre_action 13:59:58 INFO - Running main action method: populate_webroot 13:59:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:58 INFO - '--tppagecycles', 13:59:58 INFO - '7'], 13:59:58 INFO - 'tests': ['tsvgm']}}, 13:59:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:59:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:59:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:59:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['damp', 'tps']}, 13:59:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'tests': ['damp', 'tps']}, 13:59:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['dromaeo_dom']}, 13:59:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['a11yr', 13:59:58 INFO - 'ts_paint', 13:59:58 INFO - 'tpaint', 13:59:58 INFO - 'sessionrestore', 13:59:58 INFO - 'sessionrestore_no_auto_restore', 13:59:58 INFO - 'tabpaint']}, 13:59:58 INFO - 'other-e10s': {'tests': ['a11yr', 13:59:58 INFO - 'ts_paint', 13:59:58 INFO - 'tpaint', 13:59:58 INFO - 'sessionrestore', 13:59:58 INFO - 'sessionrestore_no_auto_restore', 13:59:58 INFO - 'tabpaint']}, 13:59:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:59:58 INFO - 'ts_paint', 13:59:58 INFO - 'tpaint', 13:59:58 INFO - 'sessionrestore', 13:59:58 INFO - 'sessionrestore_no_auto_restore', 13:59:58 INFO - 'tabpaint']}, 13:59:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:59:58 INFO - 'ts_paint', 13:59:58 INFO - 'tpaint', 13:59:58 INFO - 'sessionrestore', 13:59:58 INFO - 'sessionrestore_no_auto_restore', 13:59:58 INFO - 'tabpaint']}, 13:59:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['a11yr', 13:59:58 INFO - 'ts_paint', 13:59:58 INFO - 'tpaint', 13:59:58 INFO - 'sessionrestore', 13:59:58 INFO - 'sessionrestore_no_auto_restore', 13:59:58 INFO - 'tabpaint']}, 13:59:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['a11yr', 13:59:58 INFO - 'ts_paint', 13:59:58 INFO - 'tpaint', 13:59:58 INFO - 'sessionrestore', 13:59:58 INFO - 'sessionrestore_no_auto_restore', 13:59:58 INFO - 'tabpaint']}, 13:59:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['tsvgx', 13:59:58 INFO - 'tsvgr_opacity', 13:59:58 INFO - 'tart', 13:59:58 INFO - 'tscrollx', 13:59:58 INFO - 'cart']}, 13:59:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:59:58 INFO - 'tsvgr_opacity', 13:59:58 INFO - 'tart', 13:59:58 INFO - 'tscrollx', 13:59:58 INFO - 'cart']}, 13:59:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'talos_options': ['--disable-e10s'], 13:59:58 INFO - 'tests': ['tp5o']}, 13:59:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'tests': ['tp5o']}, 13:59:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'talos_options': ['--disable-e10s', 13:59:58 INFO - '--xperf_path', 13:59:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:58 INFO - 'tests': ['tp5n']}, 13:59:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:58 INFO - 'talos_options': ['--xperf_path', 13:59:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:58 INFO - 'tests': ['tp5n']}}, 13:59:58 INFO - 'talos.zip': {'path': '', 13:59:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:58 INFO - Running post-action listener: _resource_record_post_action 13:59:58 INFO - ##### 13:59:58 INFO - ##### Finished populate-webroot step (success) 13:59:58 INFO - ##### 13:59:58 INFO - ##### 13:59:58 INFO - ##### Running create-virtualenv step. 13:59:58 INFO - ##### 13:59:58 INFO - Running pre-action listener: _resource_record_pre_action 13:59:58 INFO - Running main action method: create_virtualenv 13:59:58 INFO - Creating virtualenv /builds/slave/test/build/venv 13:59:58 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 13:59:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:59:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:58 INFO - Using real prefix '/usr' 13:59:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:59:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:00:01 INFO - Installing pip.................done. 14:00:01 INFO - Return code: 0 14:00:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:00:01 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')]} 14:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:01 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')]} 14:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:01 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:01 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 14:00:01 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 14:00:01 INFO - Using env: {'DISPLAY': ':0', 14:00:01 INFO - 'HOME': '/home/cltbld', 14:00:01 INFO - 'LANG': 'en_US.UTF-8', 14:00:01 INFO - 'LANGUAGE': 'en_US:en', 14:00:01 INFO - 'LOGNAME': 'cltbld', 14:00:01 INFO - 'MAIL': '/var/mail/cltbld', 14:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:01 INFO - 'MOZ_NO_REMOTE': '1', 14:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:01 INFO - 'NO_EM_RESTART': '1', 14:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:01 INFO - 'PWD': '/builds/slave/test', 14:00:01 INFO - 'SHELL': '/bin/bash', 14:00:01 INFO - 'SHLVL': '1', 14:00:01 INFO - 'TERM': 'linux', 14:00:01 INFO - 'TMOUT': '86400', 14:00:01 INFO - 'USER': 'cltbld', 14:00:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:01 INFO - '_': '/tools/buildbot/bin/python'} 14:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:01 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 14:00:01 INFO - Cleaning up... 14:00:01 INFO - Return code: 0 14:00:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:00:01 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')]} 14:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:01 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')]} 14:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:01 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:01 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 14:00:01 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 14:00:01 INFO - Using env: {'DISPLAY': ':0', 14:00:01 INFO - 'HOME': '/home/cltbld', 14:00:01 INFO - 'LANG': 'en_US.UTF-8', 14:00:01 INFO - 'LANGUAGE': 'en_US:en', 14:00:01 INFO - 'LOGNAME': 'cltbld', 14:00:01 INFO - 'MAIL': '/var/mail/cltbld', 14:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:01 INFO - 'MOZ_NO_REMOTE': '1', 14:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:01 INFO - 'NO_EM_RESTART': '1', 14:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:01 INFO - 'PWD': '/builds/slave/test', 14:00:01 INFO - 'SHELL': '/bin/bash', 14:00:01 INFO - 'SHLVL': '1', 14:00:01 INFO - 'TERM': 'linux', 14:00:01 INFO - 'TMOUT': '86400', 14:00:01 INFO - 'USER': 'cltbld', 14:00:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:01 INFO - '_': '/tools/buildbot/bin/python'} 14:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:01 INFO - Downloading/unpacking psutil>=3.1.1 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:03 INFO - Installing collected packages: psutil 14:00:03 INFO - Running setup.py install for psutil 14:00:03 INFO - building 'psutil._psutil_linux' extension 14:00:03 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 14:00:03 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 14:00:03 INFO - building 'psutil._psutil_posix' extension 14:00:03 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 14:00:03 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 14:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:04 INFO - Successfully installed psutil 14:00:04 INFO - Cleaning up... 14:00:04 INFO - Return code: 0 14:00:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:00:04 INFO - Using env: {'DISPLAY': ':0', 14:00:04 INFO - 'HOME': '/home/cltbld', 14:00:04 INFO - 'LANG': 'en_US.UTF-8', 14:00:04 INFO - 'LANGUAGE': 'en_US:en', 14:00:04 INFO - 'LOGNAME': 'cltbld', 14:00:04 INFO - 'MAIL': '/var/mail/cltbld', 14:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:04 INFO - 'MOZ_NO_REMOTE': '1', 14:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:04 INFO - 'NO_EM_RESTART': '1', 14:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:04 INFO - 'PWD': '/builds/slave/test', 14:00:04 INFO - 'SHELL': '/bin/bash', 14:00:04 INFO - 'SHLVL': '1', 14:00:04 INFO - 'TERM': 'linux', 14:00:04 INFO - 'TMOUT': '86400', 14:00:04 INFO - 'USER': 'cltbld', 14:00:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:04 INFO - '_': '/tools/buildbot/bin/python'} 14:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:00:06 INFO - Installing collected packages: mozsystemmonitor 14:00:06 INFO - Running setup.py install for mozsystemmonitor 14:00:06 INFO - Successfully installed mozsystemmonitor 14:00:06 INFO - Cleaning up... 14:00:06 INFO - Return code: 0 14:00:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:00:06 INFO - Using env: {'DISPLAY': ':0', 14:00:06 INFO - 'HOME': '/home/cltbld', 14:00:06 INFO - 'LANG': 'en_US.UTF-8', 14:00:06 INFO - 'LANGUAGE': 'en_US:en', 14:00:06 INFO - 'LOGNAME': 'cltbld', 14:00:06 INFO - 'MAIL': '/var/mail/cltbld', 14:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:06 INFO - 'MOZ_NO_REMOTE': '1', 14:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:06 INFO - 'NO_EM_RESTART': '1', 14:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:06 INFO - 'PWD': '/builds/slave/test', 14:00:06 INFO - 'SHELL': '/bin/bash', 14:00:06 INFO - 'SHLVL': '1', 14:00:06 INFO - 'TERM': 'linux', 14:00:06 INFO - 'TMOUT': '86400', 14:00:06 INFO - 'USER': 'cltbld', 14:00:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:06 INFO - '_': '/tools/buildbot/bin/python'} 14:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:06 INFO - Downloading/unpacking jsonschema==2.5.1 14:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:00:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 14:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:00:08 INFO - warning: no files found matching '*.txt' 14:00:08 INFO - no previously-included directories found matching 'build' 14:00:08 INFO - no previously-included directories found matching 'dist' 14:00:08 INFO - no previously-included directories found matching '.git*' 14:00:08 INFO - Installing collected packages: jsonschema, functools32 14:00:08 INFO - Running setup.py install for functools32 14:00:08 INFO - warning: no files found matching '*.txt' 14:00:08 INFO - no previously-included directories found matching 'build' 14:00:08 INFO - no previously-included directories found matching 'dist' 14:00:08 INFO - no previously-included directories found matching '.git*' 14:00:08 INFO - Successfully installed jsonschema functools32 14:00:08 INFO - Cleaning up... 14:00:09 INFO - Return code: 0 14:00:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:00:09 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')]} 14:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:09 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')]} 14:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:09 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:09 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 14:00:09 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 14:00:09 INFO - Using env: {'DISPLAY': ':0', 14:00:09 INFO - 'HOME': '/home/cltbld', 14:00:09 INFO - 'LANG': 'en_US.UTF-8', 14:00:09 INFO - 'LANGUAGE': 'en_US:en', 14:00:09 INFO - 'LOGNAME': 'cltbld', 14:00:09 INFO - 'MAIL': '/var/mail/cltbld', 14:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:09 INFO - 'MOZ_NO_REMOTE': '1', 14:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:09 INFO - 'NO_EM_RESTART': '1', 14:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:09 INFO - 'PWD': '/builds/slave/test', 14:00:09 INFO - 'SHELL': '/bin/bash', 14:00:09 INFO - 'SHLVL': '1', 14:00:09 INFO - 'TERM': 'linux', 14:00:09 INFO - 'TMOUT': '86400', 14:00:09 INFO - 'USER': 'cltbld', 14:00:09 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:09 INFO - '_': '/tools/buildbot/bin/python'} 14:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:09 INFO - Downloading/unpacking blobuploader==1.2.4 14:00:09 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 14:00:09 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 14:00:09 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 14:00:09 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 14:00:09 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 14:00:09 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 14:00:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:00:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 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 14:00:11 INFO - Downloading docopt-0.6.1.tar.gz 14:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:11 INFO - Running setup.py install for blobuploader 14:00:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:00:12 INFO - Running setup.py install for requests 14:00:12 INFO - Running setup.py install for docopt 14:00:12 INFO - Successfully installed blobuploader requests docopt 14:00:12 INFO - Cleaning up... 14:00:12 INFO - Return code: 0 14:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:12 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:12 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 14:00:12 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 14:00:12 INFO - Using env: {'DISPLAY': ':0', 14:00:12 INFO - 'HOME': '/home/cltbld', 14:00:12 INFO - 'LANG': 'en_US.UTF-8', 14:00:12 INFO - 'LANGUAGE': 'en_US:en', 14:00:12 INFO - 'LOGNAME': 'cltbld', 14:00:12 INFO - 'MAIL': '/var/mail/cltbld', 14:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:12 INFO - 'MOZ_NO_REMOTE': '1', 14:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:12 INFO - 'NO_EM_RESTART': '1', 14:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:12 INFO - 'PWD': '/builds/slave/test', 14:00:12 INFO - 'SHELL': '/bin/bash', 14:00:12 INFO - 'SHLVL': '1', 14:00:12 INFO - 'TERM': 'linux', 14:00:12 INFO - 'TMOUT': '86400', 14:00:12 INFO - 'USER': 'cltbld', 14:00:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:12 INFO - '_': '/tools/buildbot/bin/python'} 14:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:12 INFO - Running setup.py (path:/tmp/pip-eyQjTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:12 INFO - Running setup.py (path:/tmp/pip-LcNPI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:12 INFO - Running setup.py (path:/tmp/pip-mxgcpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:12 INFO - Running setup.py (path:/tmp/pip-ty3sbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:13 INFO - Running setup.py (path:/tmp/pip-FewtcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:13 INFO - Running setup.py (path:/tmp/pip-AVDHl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:13 INFO - Running setup.py (path:/tmp/pip-VssQJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:13 INFO - Running setup.py (path:/tmp/pip-OB3vcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:13 INFO - Running setup.py (path:/tmp/pip-ReN8Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:13 INFO - Running setup.py (path:/tmp/pip-ew7T6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:13 INFO - Running setup.py (path:/tmp/pip-DdFFec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:13 INFO - Running setup.py (path:/tmp/pip-5ZThyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:13 INFO - Running setup.py (path:/tmp/pip-psBUsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:13 INFO - Running setup.py (path:/tmp/pip-zmHeA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:13 INFO - Running setup.py (path:/tmp/pip-jy4iAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:13 INFO - Running setup.py (path:/tmp/pip-jWrl4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:13 INFO - Running setup.py (path:/tmp/pip-vi6gjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:13 INFO - Running setup.py install for manifestparser 14:00:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Running setup.py install for mozcrash 14:00:14 INFO - Running setup.py install for mozdebug 14:00:14 INFO - Running setup.py install for mozdevice 14:00:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Running setup.py install for mozfile 14:00:14 INFO - Running setup.py install for mozhttpd 14:00:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Running setup.py install for mozinfo 14:00:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Running setup.py install for mozInstall 14:00:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Running setup.py install for mozleak 14:00:14 INFO - Running setup.py install for mozlog 14:00:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:00:14 INFO - Running setup.py install for moznetwork 14:00:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Running setup.py install for mozprocess 14:00:15 INFO - Running setup.py install for mozprofile 14:00:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Running setup.py install for mozrunner 14:00:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Running setup.py install for mozscreenshot 14:00:15 INFO - Running setup.py install for moztest 14:00:15 INFO - Running setup.py install for mozversion 14:00:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:00:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:15 INFO - Cleaning up... 14:00:15 INFO - Return code: 0 14:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:15 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')]} 14:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:15 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')]} 14:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:15 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:15 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 14:00:15 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 14:00:15 INFO - Using env: {'DISPLAY': ':0', 14:00:15 INFO - 'HOME': '/home/cltbld', 14:00:15 INFO - 'LANG': 'en_US.UTF-8', 14:00:15 INFO - 'LANGUAGE': 'en_US:en', 14:00:15 INFO - 'LOGNAME': 'cltbld', 14:00:15 INFO - 'MAIL': '/var/mail/cltbld', 14:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:15 INFO - 'MOZ_NO_REMOTE': '1', 14:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:15 INFO - 'NO_EM_RESTART': '1', 14:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:15 INFO - 'PWD': '/builds/slave/test', 14:00:15 INFO - 'SHELL': '/bin/bash', 14:00:15 INFO - 'SHLVL': '1', 14:00:15 INFO - 'TERM': 'linux', 14:00:15 INFO - 'TMOUT': '86400', 14:00:15 INFO - 'USER': 'cltbld', 14:00:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:15 INFO - '_': '/tools/buildbot/bin/python'} 14:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:15 INFO - Running setup.py (path:/tmp/pip-zFQIyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:16 INFO - Running setup.py (path:/tmp/pip-Rfhqcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:16 INFO - Running setup.py (path:/tmp/pip-HDBybj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:16 INFO - Running setup.py (path:/tmp/pip-2AxdUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:16 INFO - Running setup.py (path:/tmp/pip-eWOMoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:16 INFO - Running setup.py (path:/tmp/pip-j4OUEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:16 INFO - Running setup.py (path:/tmp/pip-Z5PI5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:16 INFO - Running setup.py (path:/tmp/pip-I8h5J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:16 INFO - Running setup.py (path:/tmp/pip-kNb1tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:16 INFO - Running setup.py (path:/tmp/pip-4rKifz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:16 INFO - Running setup.py (path:/tmp/pip-K4MD4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:16 INFO - Running setup.py (path:/tmp/pip-ocY6z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:16 INFO - Running setup.py (path:/tmp/pip-z3TjEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:16 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)) 14:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:16 INFO - Running setup.py (path:/tmp/pip-GxpAyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:17 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)) 14:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:17 INFO - Running setup.py (path:/tmp/pip-oPuuCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:17 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)) 14:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:17 INFO - Running setup.py (path:/tmp/pip-c_2wUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:17 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)) 14:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:17 INFO - Running setup.py (path:/tmp/pip-9Yiwp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:17 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)) 14:00:17 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)) 14:00:17 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)) 14:00:17 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)) 14:00:17 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)) 14:00:17 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)) 14:00:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:19 INFO - Downloading blessings-1.6.tar.gz 14:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:19 INFO - Installing collected packages: blessings 14:00:19 INFO - Running setup.py install for blessings 14:00:19 INFO - Successfully installed blessings 14:00:19 INFO - Cleaning up... 14:00:19 INFO - Return code: 0 14:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:19 INFO - Reading from file tmpfile_stdout 14:00:19 INFO - Current package versions: 14:00:19 INFO - argparse == 1.2.1 14:00:19 INFO - blessings == 1.6 14:00:19 INFO - blobuploader == 1.2.4 14:00:19 INFO - docopt == 0.6.1 14:00:19 INFO - functools32 == 3.2.3-2 14:00:19 INFO - jsonschema == 2.5.1 14:00:19 INFO - manifestparser == 1.1 14:00:19 INFO - mozInstall == 1.12 14:00:19 INFO - mozcrash == 0.17 14:00:19 INFO - mozdebug == 0.1 14:00:19 INFO - mozdevice == 0.48 14:00:19 INFO - mozfile == 1.2 14:00:19 INFO - mozhttpd == 0.7 14:00:19 INFO - mozinfo == 0.9 14:00:19 INFO - mozleak == 0.1 14:00:19 INFO - mozlog == 3.2 14:00:19 INFO - moznetwork == 0.27 14:00:19 INFO - mozprocess == 0.22 14:00:19 INFO - mozprofile == 0.28 14:00:19 INFO - mozrunner == 6.11 14:00:19 INFO - mozscreenshot == 0.1 14:00:19 INFO - mozsystemmonitor == 0.3 14:00:19 INFO - moztest == 0.7 14:00:19 INFO - mozversion == 1.4 14:00:19 INFO - psutil == 3.1.1 14:00:19 INFO - requests == 1.2.3 14:00:19 INFO - wsgiref == 0.1.2 14:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:19 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')]} 14:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:19 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')]} 14:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:19 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:19 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 14:00:19 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 14:00:19 INFO - Using env: {'DISPLAY': ':0', 14:00:19 INFO - 'HOME': '/home/cltbld', 14:00:19 INFO - 'LANG': 'en_US.UTF-8', 14:00:19 INFO - 'LANGUAGE': 'en_US:en', 14:00:19 INFO - 'LOGNAME': 'cltbld', 14:00:19 INFO - 'MAIL': '/var/mail/cltbld', 14:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:19 INFO - 'MOZ_NO_REMOTE': '1', 14:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:19 INFO - 'NO_EM_RESTART': '1', 14:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:19 INFO - 'PWD': '/builds/slave/test', 14:00:19 INFO - 'SHELL': '/bin/bash', 14:00:19 INFO - 'SHLVL': '1', 14:00:19 INFO - 'TERM': 'linux', 14:00:19 INFO - 'TMOUT': '86400', 14:00:19 INFO - 'USER': 'cltbld', 14:00:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:19 INFO - '_': '/tools/buildbot/bin/python'} 14:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 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)) 14:00:19 INFO - Cleaning up... 14:00:19 INFO - Return code: 0 14:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00:19 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')]} 14:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:19 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')]} 14:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:19 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 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:19 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 14:00:19 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 14:00:19 INFO - Using env: {'DISPLAY': ':0', 14:00:19 INFO - 'HOME': '/home/cltbld', 14:00:19 INFO - 'LANG': 'en_US.UTF-8', 14:00:19 INFO - 'LANGUAGE': 'en_US:en', 14:00:19 INFO - 'LOGNAME': 'cltbld', 14:00:19 INFO - 'MAIL': '/var/mail/cltbld', 14:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:19 INFO - 'MOZ_NO_REMOTE': '1', 14:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:19 INFO - 'NO_EM_RESTART': '1', 14:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:19 INFO - 'PWD': '/builds/slave/test', 14:00:19 INFO - 'SHELL': '/bin/bash', 14:00:19 INFO - 'SHLVL': '1', 14:00:19 INFO - 'TERM': 'linux', 14:00:19 INFO - 'TMOUT': '86400', 14:00:19 INFO - 'USER': 'cltbld', 14:00:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:19 INFO - '_': '/tools/buildbot/bin/python'} 14:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:00:20 INFO - Cleaning up... 14:00:20 INFO - Return code: 0 14:00:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c7d9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, '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': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', '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 14:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:00:20 INFO - Using env: {'DISPLAY': ':0', 14:00:20 INFO - 'HOME': '/home/cltbld', 14:00:20 INFO - 'LANG': 'en_US.UTF-8', 14:00:20 INFO - 'LANGUAGE': 'en_US:en', 14:00:20 INFO - 'LOGNAME': 'cltbld', 14:00:20 INFO - 'MAIL': '/var/mail/cltbld', 14:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:20 INFO - 'MOZ_NO_REMOTE': '1', 14:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:20 INFO - 'NO_EM_RESTART': '1', 14:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:20 INFO - 'PWD': '/builds/slave/test', 14:00:20 INFO - 'SHELL': '/bin/bash', 14:00:20 INFO - 'SHLVL': '1', 14:00:20 INFO - 'TERM': 'linux', 14:00:20 INFO - 'TMOUT': '86400', 14:00:20 INFO - 'USER': 'cltbld', 14:00:20 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:20 INFO - '_': '/tools/buildbot/bin/python'} 14:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:20 INFO - Downloading/unpacking flake8 14:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:00:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:00:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:22 INFO - no previously-included directories found matching 'docs/_build' 14:00:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:00:22 INFO - Running setup.py install for pep8 14:00:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:23 INFO - no previously-included directories found matching 'docs/_build' 14:00:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:00:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:00:23 INFO - Cleaning up... 14:00:23 INFO - Return code: 0 14:00:23 INFO - Running post-action listener: _resource_record_post_action 14:00:23 INFO - Running post-action listener: _start_resource_monitoring 14:00:23 INFO - Starting resource monitoring. 14:00:23 INFO - ##### 14:00:23 INFO - ##### Finished create-virtualenv step (success) 14:00:23 INFO - ##### 14:00:23 INFO - ##### 14:00:23 INFO - ##### Running install step. 14:00:23 INFO - ##### 14:00:23 INFO - Running pre-action listener: _resource_record_pre_action 14:00:23 INFO - Running main action method: install 14:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:23 INFO - Reading from file tmpfile_stdout 14:00:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:23 INFO - Reading from file tmpfile_stdout 14:00:23 INFO - Output received: 14:00:23 INFO - Usage: mozinstall [options] installer 14:00:23 INFO - Options: 14:00:23 INFO - -h, --help show this help message and exit 14:00:23 INFO - -d DEST, --destination=DEST 14:00:23 INFO - Directory to install application into. [default: 14:00:23 INFO - "/builds/slave/test"] 14:00:23 INFO - --app=APP Application being installed. [default: firefox] 14:00:23 INFO - mkdir: /builds/slave/test/build/application 14:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:00:39 INFO - Reading from file tmpfile_stdout 14:00:39 INFO - Output received: 14:00:39 INFO - /builds/slave/test/build/application/firefox/firefox 14:00:39 INFO - Running post-action listener: _resource_record_post_action 14:00:39 INFO - ##### 14:00:39 INFO - ##### Finished install step (success) 14:00:39 INFO - ##### 14:00:39 INFO - ##### 14:00:39 INFO - ##### Running run-tests step. 14:00:39 INFO - ##### 14:00:39 INFO - Running pre-action listener: _resource_record_pre_action 14:00:39 INFO - Running main action method: run_tests 14:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:39 INFO - Python 2.7.3 14:00:39 INFO - Return code: 0 14:00:39 INFO - grabbing minidump binary from tooltool 14:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:39 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 0x18661c0>, '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 0x18670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1867550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:39 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 14:00:39 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 14:00:39 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 14:00:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:39 INFO - Return code: 0 14:00:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:00:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:00:40 INFO - Return code: 0 14:00:40 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/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 14:00:40 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/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 14:00:40 INFO - Using env: {'DISPLAY': ':0', 14:00:40 INFO - 'HOME': '/home/cltbld', 14:00:40 INFO - 'LANG': 'en_US.UTF-8', 14:00:40 INFO - 'LANGUAGE': 'en_US:en', 14:00:40 INFO - 'LOGNAME': 'cltbld', 14:00:40 INFO - 'MAIL': '/var/mail/cltbld', 14:00:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:40 INFO - 'MOZ_NO_REMOTE': '1', 14:00:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:40 INFO - 'NO_EM_RESTART': '1', 14:00:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:40 INFO - 'PWD': '/builds/slave/test', 14:00:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:40 INFO - 'SHELL': '/bin/bash', 14:00:40 INFO - 'SHLVL': '1', 14:00:40 INFO - 'TERM': 'linux', 14:00:40 INFO - 'TMOUT': '86400', 14:00:40 INFO - 'USER': 'cltbld', 14:00:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023', 14:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:40 INFO - '_': '/tools/buildbot/bin/python'} 14:00:40 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/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 14:00:40 INFO - mozversion application_buildid: 20160603073911 14:00:40 INFO - mozversion application_changeset: 99dacc787a59d79c080886f46bfe8daf61c1bd0a 14:00:40 INFO - mozversion application_display_name: Nightly 14:00:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:40 INFO - mozversion application_name: Firefox 14:00:40 INFO - mozversion application_remotingname: firefox 14:00:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:00:40 INFO - mozversion application_vendor: Mozilla 14:00:40 INFO - mozversion application_version: 49.0a1 14:00:40 INFO - mozversion platform_buildid: 20160603073911 14:00:40 INFO - mozversion platform_changeset: 99dacc787a59d79c080886f46bfe8daf61c1bd0a 14:00:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:00:40 INFO - mozversion platform_version: 49.0a1 14:00:40 INFO - using testdate: 1464987640 14:00:40 INFO - actual date: 1464987640 14:00:40 INFO - starting webserver on 'localhost:55704' 14:00:40 INFO - SUITE-START | Running 2 tests 14:00:40 INFO - TEST-START | dromaeo_css 14:00:40 INFO - operating with platform_type : linux_ 14:00:40 INFO - Initialising browser for dromaeo_css test... 14:00:40 INFO - TEST-INFO | started process 27125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2DPj9b/profile http://localhost:55704/getInfo.html) 14:00:44 INFO - PROCESS | 27125 | __metrics Screen width/height:1600/1200 14:00:44 INFO - PROCESS | 27125 | colorDepth:24 14:00:44 INFO - PROCESS | 27125 | Browser inner width/height: 1024/697 14:00:44 INFO - PROCESS | 27125 | __metrics 14:00:45 ERROR - PROCESS | 27125 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:00:46 INFO - TEST-INFO | 27125: exit 0 14:00:46 INFO - Browser initialized. 14:00:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:46 INFO - TEST-INFO | started process 27205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2DPj9b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:58 INFO - PROCESS | 27205 | RSS: Main: 157536256 14:00:58 INFO - PROCESS | 27205 | 14:01:50 INFO - PROCESS | 27205 | 1464987710176 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] 14:04:01 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:55704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55704/tests/dromaeo/cssquery-ext.html) 14:04:02 INFO - PROCESS | 27205 | RSS: Main: 232980480 14:04:02 INFO - PROCESS | 27205 | 14:07:05 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:55704/tests/dromaeo/cssquery-ext.html (next: http://localhost:55704/tests/dromaeo/cssquery-jquery.html) 14:07:06 INFO - PROCESS | 27205 | RSS: Main: 240365568 14:07:06 INFO - PROCESS | 27205 | 14:10:08 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:55704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55704/tests/dromaeo/cssquery-mootools.html) 14:10:09 INFO - PROCESS | 27205 | RSS: Main: 239067136 14:10:09 INFO - PROCESS | 27205 | 14:13:11 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:55704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55704/tests/dromaeo/cssquery-prototype.html) 14:13:11 INFO - PROCESS | 27205 | RSS: Main: 236232704 14:13:11 INFO - PROCESS | 27205 | 14:16:14 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:55704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55704/tests/dromaeo/cssquery-yui.html) 14:16:15 INFO - PROCESS | 27205 | RSS: Main: 223571968 14:16:15 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:55704/tests/dromaeo/cssquery-yui.html (next: http://localhost:55704/tests/dromaeo/cssquery-dojo.html) 14:19:18 INFO - PROCESS | 27205 | RSS: Main: 276189184 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | __start_tp_report 14:19:18 INFO - PROCESS | 27205 | _x_x_mozilla_page_load 14:19:18 INFO - PROCESS | 27205 | _x_x_mozilla_page_load_details 14:19:18 INFO - PROCESS | 27205 | |i|pagename|runs| 14:19:18 INFO - PROCESS | 27205 | |0;dojo.html;2676.611891275765;2708.2281549758322;2714.9864250678743;2737.1241202815095;2746.9175924722267;4573.039661671053;4654.743989080599;4662.883427914304;4734.881627959298;4796.16067188242;4676.438827340716;4697.553732395417;4713.151632706112;4738.71567705937;4758.310045043475;4261.893452663685;4335.609795118455;4378.978105109486;4408.845690400836;4485.102979404116;4405.05291362357;4432.97783511082;4444.488883778375;4474.507804141542;4494.280915053592;4246.447961764981;4292.570742925714;4307.849225277131;4336.8265269389185;4369.410129632491;4340.6093451589195;4343.869683909487;4346.391505189276;4403.669724770655;4459.219636563621;4388.385626012361;4403.537628548988;4435.60079592835;4449.288113901793;4450.5104438511735;4540;4615.607673347769;4664.346991421204;4717.457492388351;4764.809407623691;5193.558547523465;5199.766010529535;5210.244514545408;5211.609129315279;5212.322398088262;5220.086484865172;5236.21456781482;5240.161574148156;5250.317458730341;5250.7112108834;4641.721496710208;4797.95202047982;4838.080764654775;4850.054239423349;4894.779734911902;5345.904089661688;5363.865903352447;5381.973090134525;5384.78460861569;5388.084025715638;5141.76862041209;5152.458991805881;5155.381354237516;5155.61332900034;5161.354830646169;4928.8767780805765;5082.822101226439;5116.692998420107;5124.948750512522;5163.922541161885;5078.263651770547;5115.1559992600805;5116.923246151311;5117.817568612593;5167.992241512944;4926.285688575136;5088.262201980766;5101.51535604117;5102.591792656579;5110.182370820651;4236.4492615959725;4263.722858014219;4303.268444364466;4307.030918043478;4355.956440435619;3744.1762812181278;3758.4174452959833;3763.8870833875026;3804.6385593368586;3805.8858234253016;4406.162829062532;4411.404460397869;4415.84544540946;4464.732116073046;4467.396901418267;4944.851654450372;5092.236164575269;5125.564327032244;5140.588752899759;5171.456997015334;4392.4289842320295;4406.515283318832;4418;4418.513963464016;4462.754548499799;4473.1277400907165;4622.375979242826;4623.56076172763;4626.7223966562115;4675.462321832964;4808.927866082082;4854.563089321837;4858.1012512685265;4867.318575399376;4875.9512404875495;5143.768530416065;5178.97410512945;5181.611379146654;5184.066867963803;5236.10986132366;4650.20946439113;4727.929081063856;4833.226683730586;4858.246971719389;4913.336699545515;4967.82612608557;5031.094403007493;5058.038972595195;5058.418281897629;5101.005303965691;5124.256982737556;5124.9743751281;5128.410232823124;5131.769070391916;5183.688978661293;4898.902021959612;4928.728919909439;4956.801727930842;4988.376452943382;4998.450170481171;4992.226204938241;5015.473375295687;5017.071841709296;5017.24741288795;5051.949480505148;4903.190973489334;4905.828296009622;4938.925916111333;4954.752262386794;4956.900861982812;4851.490593487774;4948.579370753526;4957.206846904478;4994.875128121826;5083.085044691991;4833.202521583899;4862.82980095695;4873.780679869344;4889.315495830658;4931.753412329441 14:19:18 INFO - PROCESS | 27205 | |1;ext.html;561.8623437257872;590.6751286792264;593.780301288523;596.1028651878921;604.8850718363512;27410.86294568527;40972;41870.95322616936;42058;44641.330380044325;41553.37669934946;41751.582484175226;41895;42049.15901681964;42106.157876842444;7625.084989801232;7789.649465774026;7791.727289544867;7795.805104872366;7803.765887023398;7517.135529414105;7613.505122167041;7634.541927484369;7637.656305466239;7641.808954776147;6476.579022363555;6504.512161587876;6508.381703738138;6509.121268628722;6638.93361066388;6503.674816259216;6521.641309727963;6522.804315870531;6529.1512103426485;6653.401193892549;7686.3082322591235;7776.844463110706;7779.72770953014;7784.688612455495;7788.260115289038;37362.065948351235;37554.624453755656;37660.623393765985;37688;37707.811460942794;3004.324027093908;3088.8146711197173;3330.733541316689;3607.8556857725657;3776.358019136726;28722.42555148906;29208.269793255127;29537.70462295371;29559.113226603236;29983.550246746316;3422.6577342265823;3449.862005519776;3479.2693534357813;3540.168060505779;3593.9281214375565;266767;268027.999999998;268817;268936;269567;46122;53727.19409208865;54053;54130.45869541254;54145;54844.88663350265;56368;56583.717081415154;62163.689181553804;62211.688941555;13635.38640761168;13657.658558535917;13748.381322840296;13771.104878182887;13793.379297931617;9353;9722;9906.306558540833;9915.30592858493;9928.652497162564;14403.92798036024;14551.3451894665;15636;16193.514194574182;16295.266712997944;6088.573799834057;6296.275928268216;6338.144350512714;6343.175387199727;6350.618962862243;842.4776638484179;915.7252824152861;979.485769970771;986.659602437158;1000.8698869146964;26759.866200668872;28146.577801333;28539.71460285412;28696.856515717704;28853.27866803347;960.9477622003894;971.7522031881966;987.151050096916;1020.8979102089731;1060.9628662996759;13635.659108522366;14229;14461.13233206011;14473.92763036178;14518.927405362905;350848;353178;353677;355016;372851;46812.297815532795;46851.29723054157;47017.29474057823;47095;47119.29321060187;1118.9776204475866;1150.6375491720082;1202.3206888108366;1219.3720234079456;1230.4954968462887;25424.872875635505;25829.483410332065;26376.472470550867;26572.734272657028;26816.195514134608;41267.587324126376;41560.79219603883;41639.16721665489;41644;41644.375334369404;320376;321603;321807;321885;324292;22134.225302114348;24162.275131746075;25323.49353012966;25406.745932540438;25416.872915635304;32740.345193095527;42616.360754589325;44737.776311118236;45596.31605525853;45691.08617827691;35063.64936350706;36016.63983360238;36666.63333366632;37142.25715485621;41173.588264116974;35135.82432087823;35902;36127.27745445129;36172.27655446929;36595.26809463849;35146;35165;36422;36534.45198321974;36572.451413229355;30307;32336;32350.676493234765;32418.83790581032;32634.51048234231;24917.87541062283;25282;25346.493070138124;25544.10595629144;25723.099691511456 14:19:18 INFO - PROCESS | 27205 | |2;jquery.html;349.9352619765344;351.63956944132264;356.0653285126543;361.38925216384325;361.5264004154558;15519.767203491956;16727.83272167278;16872.83127168728;17364.652706945853;17387.826121738777;14628.268586570655;14935.7012859743;15149.54551363458;15386;15414.229288535584;4847.297141914429;4937.308776771255;5084.9745751271375;5091.567216786578;5097.082525145473;3619.981900090496;3792.696584273265;4980.452150263486;5472.753726082336;5750.884982300351;5782.277215348082;5784.363719990798;5792.942070579283;5805.941940580604;5818.563607729416;5650.29371328584;5685.459881311269;5726.455986681259;5734.426557344253;5810.970945145247;3305.2232725309773;4789.616830653539;5087.186050231982;5089.211172268304;5098.974505127488;19333.323333683395;20110.29613963519;20133.899330503402;20323.9838008099;20356.389308320773;1886.0852486544015;1887.6036032433205;1997.810208030235;2149.9462513437134;2304.20504925802;8779.165979231962;9229.907700922971;9455.716328510156;9635.325527213097;12981;1556.214111873508;1565.326909428945;1581.4069723853554;1631.6491954229898;1632.2410079313177;64650.676746615965;67372.663136684;67996.6600166996;68201.31798682;69303.99999999949;9924.851127233098;10010.749731256778;10020.799584008279;10104.09063184317;10342.638007669846;13794.65513362174;13815.792763108562;13882.93058534721;13903.930480347533;13921.164730116225;6884.931150688529;6934.930650693529;7003.404710599554;7081.398081163159;7105.75129870452;6421.101045853584;6440.967795160994;6475.352464753487;6554.246261679872;6569.704363303663;4333.111712099012;4341.435613370241;4384.5092668492225;4433;4435.3125265583885;1632.7714120022968;1683;1704.0542498912973;1806.1601355369817;1819.5392807875523;851.3104385447683;873.9606717697592;886.2599729226168;965.8116667249959;973.7906350134755;16354.836451635569;16693.415730449375;16859.83140168607;17107.48677539676;17276.395326163525;850.1116333431579;861.1345597674298;862.5730263519598;905.42053086025;919.7838507950627;9391.295652826066;9774.5601447935;9861.605535778632;9893.950530247303;10043.096121349114;353486;358893;359386;359905;360876;46999.29501057487;47682.761586191846;67907;77501;78135.21864781393;917.3257655623112;922.4280945813639;935.2751617496359;938.9718308450757;946.370663508759;14995;15104.773428398803;15141.091534507965;15319.923400383374;15418.537443876701;31660.683393166695;31895.681043190198;34437.827810860785;34695.47956780701;34718;46599.76700116478;48660.75669621629;49355.25967110424;49563.25655115104;49672.503274968236;7463.813404664927;7615.961920190363;7733.613319334123;7774.805629859299;7852.057753069668;10724.410157441103;12121.636350909486;12122;12258.570950016707;12319;5821.864736376366;6491.4806815455595;9688.612455501983;10397.58409663605;10788.248996505841;10495.47522623881;10546.947265263625;10592.576296948344;10649.89350106489;10739.516721747696;10488.842667360148;10508.737281567715;10629.574817007233;10666.20003499756;10797.24419290642;6893.172819261721;6923.93076069253;7041.964790176016;7696.15342312334;7754.961225193838;10283.794324113625;10478.842817357594;10501.212409069503;10567.52446139941;10800.567977280822 14:19:18 INFO - PROCESS | 27205 | |3;mootools.html;1241.3731065811764;1388.2087210290133;1422.324395911942;1460.5399299220744;1718.8195239499844;6687.1975362956455;7263.60050197239;7493.812654683622;7504.5872477013745;7591.051118610174;7518.060242469692;7538.321551060403;7590.430717696181;7592.620368981557;7593.886091708615;2154.644483660198;2175.445261458326;2179.3897708641607;2180.6838008488758;2183.759786423492;2103.200783702191;2164.448065743233;2190.8137808286233;2195.7804219578074;2195.934121976335;2155.461134716321;2173.022140036982;2175.6845257437662;2180.040782055898;2191.7260342457193;2062.453449835795;2063.7213976113185;2064.1021155797275;2066.9483262918397;2067.0491573876034;2035.155410504639;2122.352682431858;2123.9256626018014;2125.7130287411155;2127.5000374911883;7441.218672039412;7443.925560744432;7490.400767938606;7491.138519070268;7506.8123296917465;4218.725782824137;4385.605295523386;4390.8902277443;4395.846145384896;4397.384366188736;2754.504189245935;2820.746132848033;2832.1645114691214;2866.2834291427143;2874.4107457971068;848.9787755306105;917.2524392619994;930.734740598926;933.5752232734158;942.6323733743845;10277.17782577392;10362.948185259102;10376.740581485372;10385.324953877975;10391.688249352532;3896.688264938798;4016;4037.414574886625;4100.077482566398;4105.548389677133;8033.919660803434;8119.634616442274;8134.877976830352;8151.103378628346;8155.10293867674;4324.783760811947;4331.350297455344;4334.414853994734;4338;4366.323219900921;3607.350676878187;3896.688264938855;3918.9608103919168;3938.113924367052;4084.509858816961;3258.494933285297;3266.8856590019236;3324.135724711544;3332.0503656457795;3337.5327454156436;879.305348774461;945.2107490245722;948.3361646847235;952.1906379577442;954.370115723619;840.8738689196547;849.6856163219525;890.8129292848445;898.3442087276194;899.3120262998812;5329.094054010828;5399.352077750695;5557.666540007613;5585.636933599303;5657.80197693087;840.5881118252013;870.5908223135243;873.9650413983369;875.7504111328241;879.5426378283257;3847.2882516734494;3959.604039596017;3964.4251583520227;3978.124812541236;4034.45534852797;8985.056569060285;9329;9345.20565751905;9570.186534144537;9594.520273986273;9379.96820349761;9429.66996155145;9449.858252126223;9450.291228157916;9472.905270947202;6958.025876377311;7090.468214883905;7097.361237488651;7108.8933665995055;7110.431165506747;5317.175837745156;5558.944410556004;5611.663300202001;5611.915821262766;5698.373178950229;8448.324134069382;8505.192006759347;8589.269912057545;8806.779830504289;8827.779305517413;8770.649174033222;8843.823123537622;8885.511296878734;8895.154960278764;8902.73291801247;5956.731947062306;6092.055731361646;6199.535034872493;6290.49676025926;6303.527235457451;7083.6812343443635;7167.319104685047;7233.529820561646;7234.927650723425;7238.710451581877;6252.343503932022;6259.311475737756;6275.905861412174;6384.840378990562;6470.320616335405;6389.041643753474;6404.615723056445;6409.519286053472;6595.736170553316;6617.2721000688925;6438.356164383524;6480.027995800668;6520.608763474207;6529.771457998947;6535.379138981789;4579.93130103042;4587.472440669366;4664.137134630104;4717.339572459927;4725.692829966041;4484.955150448584;4523.547645235451;4528.071745292273;4529.32060190974;4556.908861822812 14:19:18 INFO - PROCESS | 27205 | |4;prototype.html;290.5525490744254;296.0806695211369;297.0760933496824;301.2363658126649;301.31901901702145;4740.123077230714;4767.451743049551;4769.666123371366;4798.112349215397;4805.399325084364;4717.57541821236;4721.527847215277;4746.430428348594;4751.263554149104;4764.166270902587;3571.8571257149747;3629.727770417216;3693.3905905525558;3706.147586055209;3795.772253664789;3744.1762812181278;3745.775253484786;3747.306748251582;3778.8110594470304;3787.1289603391238;3545.8227088645463;3700.9444858327147;3709.833057512405;3711.4618380334837;3727.273181729564;3623.7825730456125;3720.7023438124884;3726.347889119393;3731.179140589093;3768.7361884668085;3322.7175690066374;3328.3509715605464;3349.7990120592845;3351.044952188639;3353.9161520961925;4515.977420112911;4529.5243999380245;4529.909401811979;4550.704204226715;4575.787416334674;3974.8608798691907;4211.536730959592;4233.920350310651;4289.1850548395705;4310.331898555729;4948.975255123702;4950.925736113961;4969.453360130383;4975.179095449246;4991.201407774775;3540.929181416383;3541.11472131967;3549.6095429502734;3554.608993010767;3563.3051554946796;5044.39467263927;5176.870578235536;5232.189010703309;5235.267062611238;5241;3556.893293201208;3565.607783143852;3582.4089025311055;3584.4623306503713;3597.8380972856285;3628.2743451309316;3634.2186429917165;3635.7640051368217;3639.6906262967946;3643.526341575578;4154.31453810124;4165.416841642173;4169.854055108117;4193.6645068394455;4202.768847713344;4822.180229360947;4945.134601444733;4956.3804524434445;4960.776765045582;4987.177115775857;1243.8494392686728;1253.3106791264768;1257.849058113014;1258.9118761686593;1259.765429878724;800.2597597222546;802.0976401548259;891.4740303221131;918.2791508665665;921.1157289002632;4305.858947378947;4385.6052955233545;4401.361802538614;4405.207062728676;4418.8453404130705;5071.518205770446;5084.847454576368;5112.6421150519855;5147.845564633067;5162;4199.559046300094;4367.471385015283;4369.672274579356;4390.560943905648;4399.912001760011;2690.887653192274;2693.2324287577944;2708.702042775293;2712.250598364044;2718.7375149820296;4738.928916066262;4772.5943294819635;4795.856124316276;4806.399200099988;4818.301346304766;5062.367204099488;5073.79568333862;5127.410347809975;5128.538431541179;5162.174052151638;4750.311204875274;4772.0694464579765;4779.689320194246;4780.139574876555;4790.185668436374;5068.214426763858;5074.847754567369;5081.212412076134;5085.7457127144235;5100.79596816138;4793.161196790617;4918.778654960463;4920.852374428773;4930.126551910251;4980.228064649985;4711.316859055486;4732.19552676039;4745.413749506458;4747.8605134768095;4759.405074365704;3736.4582135589644;3763.3226019316785;3770.5663848657755;3774.8112594370723;3781.4327850822597;4886.828960986349;5063.822766203165;5096.592272618256;5103.719295438638;5112.667676601009;4918.426103646942;4926.729029903389;4946.727929963887;4947.975260123821;4958.950410495849;4923.433805112458;4925.876853078558;4947.307376967299;4947.381577302837;4959.900801984012;4608.861734147981;4827.806887724451;4835.564799168092;4838.419389673261;4871.780769865435;4830.734309613005;4936.3829521309835;4980.929100243465;4982.451930287738;4999.500049994971;4793.880152996203;4799.688020278671;4805.846596816669;4823.5658790709;4827.468978412302 14:19:18 INFO - PROCESS | 27205 | |5;yui.html;654.9607023578585;655.5411212151489;683.350816724112;707.8973548835419;738.8337624034593;11986.280823150617;12215.633530994073;12453.937730311347;12496.125271231018;12662.366881655926;12321.753564928697;12478.937605311983;12491.375431228447;12502.312372819491;12509.562165324216;636.341386664802;772.7334069745929;777.3004296133482;787.2206515549622;803.8432505661399;799.1489064146665;800.8558459477292;802.6348011654712;802.9397795165356;802.9718959836378;845.9407841451101;846.3525403066659;848.0205362805938;848.516345682961;848.8217474330368;660.0725979998086;811.111832543364;836.4646626159263;837.2548431895618;840.6427268410931;610.9114178444145;611.0498175337349;612.1429998002787;612.3356158567959;612.3662009819815;11747.29516229029;11769.470373833197;11793.115516336224;11798.41007949599;11801.763964720743;12079.396030198455;12572.182808117443;12596.118271720983;12663.430145643468;12926.224426534343;11264.831027534594;11289.379084150369;11293.435328233556;11327.150463715254;11492.770144597145;4056.310427227349;4109.178164367108;4133.173365326947;4135.9172816543805;4191.643710284629;55757.72121139409;56170.43829561693;57451;57592.42407575955;58098.419015809726;9549;9690.079442452956;9695.175910047585;9872.45701486425;10000.599976001024;17330.220140093727;17334.04662743561;17342.65314693699;17475.126243687766;17554.122293885255;6939.271376505495;7009.9299007010295;7062.752803651848;7071.04540886984;7132.108486439195;3408.84660190292;3422.8973130806116;3498.4052711039185;3549.5917969433845;3630.056185391817;3039.3921215756936;3143.135637699651;3145.9213519661735;3148.842557872097;3151.2279491524723;508.1640701046757;511.6265126457707;523.7119584228659;525.25938426818;567.1889198446262;539.5953035223582;572.977080916767;574.4944448884954;598.6797063571056;621.5245337316957;8386.67511487402;8724.781880452912;8750.606222719993;8774.824503509893;8858.975122600017;469.97650117493987;503.90173916086013;644.2011905237472;651.2478087808589;653.9607623542603;3931.76409415436;3993.281209382339;4032.6370626643743;4050.3519436889956;4112.814923328458;86297.5685121583;93813.53093234627;97404.51297743466;97741.51129244309;101150;53119;68805;78465.60767196241;80928.59535702401;86750.56624716836;46854.297185542244;73449.2655073453;74693.62653186808;74900.75694701319;75389.6230518844;8410.14284574247;8451.32389408858;8615.569221539023;8940.776480587778;9063.68277110298;39911.800440997606;42498.15003699847;42522.93692657708;43017.78491107524;43156.13687726291;47453;60540.69729651324;61368;61588;62333.68833155987;10879.673609791718;11105;11445.656630301104;12113.69715757078;12194.878051219373;11955.880441195477;12487.188332758706;12512.874871251171;12693.174943628635;13485.39315730814;11701.648950531498;12286.447109879899;12326.198797078161;12493.93753031229;12870.16343937641;10781.838272426077;11107.666769996913;11137.610183643857;11256.662300131009;11294.040006599202;11794.587189448328;11794.882051179378;11878.940605296919;12152.513899443924;12589.811152832532;9811.509424528602;10185.79628407413;10240.08423311135;10282.794344113225;10519.526621302213;10515.631952881613;10570.365778053341;10630.52162652698;10747.408892510986;10797.946010269898 14:19:18 INFO - PROCESS | 27205 | __end_tp_report 14:19:18 INFO - PROCESS | 27205 | __start_cc_report 14:19:18 INFO - PROCESS | 27205 | _x_x_mozilla_cycle_collect,1065 14:19:18 INFO - PROCESS | 27205 | __end_cc_report 14:19:18 INFO - PROCESS | 27205 | __startTimestamp1464988758527__endTimestamp 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | ------- Summary: start ------- 14:19:18 INFO - PROCESS | 27205 | Number of tests: 6 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | [#0] dojo.html Cycles:165 Average:4731.79 Median:4858.25 stddev:505.78 (10.4%) stddev-sans-first:480.95 14:19:18 INFO - PROCESS | 27205 | Values: 2676.6 2708.2 2715.0 2737.1 2746.9 4573.0 4654.7 4662.9 4734.9 4796.2 4676.4 4697.6 4713.2 4738.7 4758.3 4261.9 4335.6 4379.0 4408.8 4485.1 4405.1 4433.0 4444.5 4474.5 4494.3 4246.4 4292.6 4307.8 4336.8 4369.4 4340.6 4343.9 4346.4 4403.7 4459.2 4388.4 4403.5 4435.6 4449.3 4450.5 4540.0 4615.6 4664.3 4717.5 4764.8 5193.6 5199.8 5210.2 5211.6 5212.3 5220.1 5236.2 5240.2 5250.3 5250.7 4641.7 4798.0 4838.1 4850.1 4894.8 5345.9 5363.9 5382.0 5384.8 5388.1 5141.8 5152.5 5155.4 5155.6 5161.4 4928.9 5082.8 5116.7 5124.9 5163.9 5078.3 5115.2 5116.9 5117.8 5168.0 4926.3 5088.3 5101.5 5102.6 5110.2 4236.4 4263.7 4303.3 4307.0 4356.0 3744.2 3758.4 3763.9 3804.6 3805.9 4406.2 4411.4 4415.8 4464.7 4467.4 4944.9 5092.2 5125.6 5140.6 5171.5 4392.4 4406.5 4418.0 4418.5 4462.8 4473.1 4622.4 4623.6 4626.7 4675.5 4808.9 4854.6 4858.1 4867.3 4876.0 5143.8 5179.0 5181.6 5184.1 5236.1 4650.2 4727.9 4833.2 4858.2 4913.3 4967.8 5031.1 5058.0 5058.4 5101.0 5124.3 5125.0 5128.4 5131.8 5183.7 4898.9 4928.7 4956.8 4988.4 4998.5 4992.2 5015.5 5017.1 5017.2 5051.9 4903.2 4905.8 4938.9 4954.8 4956.9 4851.5 4948.6 4957.2 4994.9 5083.1 4833.2 4862.8 4873.8 4889.3 4931.8 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | [#1] ext.html Cycles:180 Average:46920.28 Median:36904.45 stddev:83634.06 (226.6%) stddev-sans-first:83796.24 14:19:18 INFO - PROCESS | 27205 | Values: 561.9 590.7 593.8 596.1 604.9 27410.9 40972.0 41871.0 42058.0 44641.3 41553.4 41751.6 41895.0 42049.2 42106.2 7625.1 7789.6 7791.7 7795.8 7803.8 7517.1 7613.5 7634.5 7637.7 7641.8 6476.6 6504.5 6508.4 6509.1 6638.9 6503.7 6521.6 6522.8 6529.2 6653.4 7686.3 7776.8 7779.7 7784.7 7788.3 37362.1 37554.6 37660.6 37688.0 37707.8 3004.3 3088.8 3330.7 3607.9 3776.4 28722.4 29208.3 29537.7 29559.1 29983.6 3422.7 3449.9 3479.3 3540.2 3593.9 266767.0 268028.0 268817.0 268936.0 269567.0 46122.0 53727.2 54053.0 54130.5 54145.0 54844.9 56368.0 56583.7 62163.7 62211.7 13635.4 13657.7 13748.4 13771.1 13793.4 9353.0 9722.0 9906.3 9915.3 9928.7 14403.9 14551.3 15636.0 16193.5 16295.3 6088.6 6296.3 6338.1 6343.2 6350.6 842.5 915.7 979.5 986.7 1000.9 26759.9 28146.6 28539.7 28696.9 28853.3 960.9 971.8 987.2 1020.9 1061.0 13635.7 14229.0 14461.1 14473.9 14518.9 350848.0 353178.0 353677.0 355016.0 372851.0 46812.3 46851.3 47017.3 47095.0 47119.3 1119.0 1150.6 1202.3 1219.4 1230.5 25424.9 25829.5 26376.5 26572.7 26816.2 41267.6 41560.8 41639.2 41644.0 41644.4 320376.0 321603.0 321807.0 321885.0 324292.0 22134.2 24162.3 25323.5 25406.7 25416.9 32740.3 42616.4 44737.8 45596.3 45691.1 35063.6 36016.6 36666.6 37142.3 41173.6 35135.8 35902.0 36127.3 36172.3 36595.3 35146.0 35165.0 36422.0 36534.5 36572.5 30307.0 32336.0 32350.7 32418.8 32634.5 24917.9 25282.0 25346.5 25544.1 25723.1 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | [#2] jquery.html Cycles:180 Average:22754.08 Median:4062.90 stddev:59101.41 (1454.7%) stddev-sans-first:59243.26 14:19:18 INFO - PROCESS | 27205 | Values: 349.9 351.6 356.1 361.4 361.5 15519.8 16727.8 16872.8 17364.7 17387.8 14628.3 14935.7 15149.5 15386.0 15414.2 4847.3 4937.3 5085.0 5091.6 5097.1 3620.0 3792.7 4980.5 5472.8 5750.9 5782.3 5784.4 5792.9 5805.9 5818.6 5650.3 5685.5 5726.5 5734.4 5811.0 3305.2 4789.6 5087.2 5089.2 5099.0 19333.3 20110.3 20133.9 20324.0 20356.4 1886.1 1887.6 1997.8 2149.9 2304.2 8779.2 9229.9 9455.7 9635.3 12981.0 1556.2 1565.3 1581.4 1631.6 1632.2 64650.7 67372.7 67996.7 68201.3 69304.0 9924.9 10010.7 10020.8 10104.1 10342.6 13794.7 13815.8 13882.9 13903.9 13921.2 6884.9 6934.9 7003.4 7081.4 7105.8 6421.1 6441.0 6475.4 6554.2 6569.7 4333.1 4341.4 4384.5 4433.0 4435.3 1632.8 1683.0 1704.1 1806.2 1819.5 851.3 874.0 886.3 965.8 973.8 16354.8 16693.4 16859.8 17107.5 17276.4 850.1 861.1 862.6 905.4 919.8 9391.3 9774.6 9861.6 9894.0 10043.1 353486.0 358893.0 359386.0 359905.0 360876.0 46999.3 47682.8 67907.0 77501.0 78135.2 917.3 922.4 935.3 939.0 946.4 14995.0 15104.8 15141.1 15319.9 15418.5 31660.7 31895.7 34437.8 34695.5 34718.0 46599.8 48660.8 49355.3 49563.3 49672.5 7463.8 7616.0 7733.6 7774.8 7852.1 10724.4 12121.6 12122.0 12258.6 12319.0 5821.9 6491.5 9688.6 10397.6 10788.2 10495.5 10546.9 10592.6 10649.9 10739.5 10488.8 10508.7 10629.6 10666.2 10797.2 6893.2 6923.9 7042.0 7696.2 7755.0 10283.8 10478.8 10501.2 10567.5 10800.6 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | [#3] mootools.html Cycles:180 Average:4987.61 Median:6024.39 stddev:2765.68 (45.9%) stddev-sans-first:2759.11 14:19:18 INFO - PROCESS | 27205 | Values: 1241.4 1388.2 1422.3 1460.5 1718.8 6687.2 7263.6 7493.8 7504.6 7591.1 7518.1 7538.3 7590.4 7592.6 7593.9 2154.6 2175.4 2179.4 2180.7 2183.8 2103.2 2164.4 2190.8 2195.8 2195.9 2155.5 2173.0 2175.7 2180.0 2191.7 2062.5 2063.7 2064.1 2066.9 2067.0 2035.2 2122.4 2123.9 2125.7 2127.5 7441.2 7443.9 7490.4 7491.1 7506.8 4218.7 4385.6 4390.9 4395.8 4397.4 2754.5 2820.7 2832.2 2866.3 2874.4 849.0 917.3 930.7 933.6 942.6 10277.2 10362.9 10376.7 10385.3 10391.7 3896.7 4016.0 4037.4 4100.1 4105.5 8033.9 8119.6 8134.9 8151.1 8155.1 4324.8 4331.4 4334.4 4338.0 4366.3 3607.4 3896.7 3919.0 3938.1 4084.5 3258.5 3266.9 3324.1 3332.1 3337.5 879.3 945.2 948.3 952.2 954.4 840.9 849.7 890.8 898.3 899.3 5329.1 5399.4 5557.7 5585.6 5657.8 840.6 870.6 874.0 875.8 879.5 3847.3 3959.6 3964.4 3978.1 4034.5 8985.1 9329.0 9345.2 9570.2 9594.5 9380.0 9429.7 9449.9 9450.3 9472.9 6958.0 7090.5 7097.4 7108.9 7110.4 5317.2 5558.9 5611.7 5611.9 5698.4 8448.3 8505.2 8589.3 8806.8 8827.8 8770.6 8843.8 8885.5 8895.2 8902.7 5956.7 6092.1 6199.5 6290.5 6303.5 7083.7 7167.3 7233.5 7234.9 7238.7 6252.3 6259.3 6275.9 6384.8 6470.3 6389.0 6404.6 6409.5 6595.7 6617.3 6438.4 6480.0 6520.6 6529.8 6535.4 4579.9 4587.5 4664.1 4717.3 4725.7 4485.0 4523.5 4528.1 4529.3 4556.9 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | [#4] prototype.html Cycles:180 Average:4113.45 Median:4739.53 stddev:1181.83 (24.9%) stddev-sans-first:1149.78 14:19:18 INFO - PROCESS | 27205 | Values: 290.6 296.1 297.1 301.2 301.3 4740.1 4767.5 4769.7 4798.1 4805.4 4717.6 4721.5 4746.4 4751.3 4764.2 3571.9 3629.7 3693.4 3706.1 3795.8 3744.2 3745.8 3747.3 3778.8 3787.1 3545.8 3700.9 3709.8 3711.5 3727.3 3623.8 3720.7 3726.3 3731.2 3768.7 3322.7 3328.4 3349.8 3351.0 3353.9 4516.0 4529.5 4529.9 4550.7 4575.8 3974.9 4211.5 4233.9 4289.2 4310.3 4949.0 4950.9 4969.5 4975.2 4991.2 3540.9 3541.1 3549.6 3554.6 3563.3 5044.4 5176.9 5232.2 5235.3 5241.0 3556.9 3565.6 3582.4 3584.5 3597.8 3628.3 3634.2 3635.8 3639.7 3643.5 4154.3 4165.4 4169.9 4193.7 4202.8 4822.2 4945.1 4956.4 4960.8 4987.2 1243.8 1253.3 1257.8 1258.9 1259.8 800.3 802.1 891.5 918.3 921.1 4305.9 4385.6 4401.4 4405.2 4418.8 5071.5 5084.8 5112.6 5147.8 5162.0 4199.6 4367.5 4369.7 4390.6 4399.9 2690.9 2693.2 2708.7 2712.3 2718.7 4738.9 4772.6 4795.9 4806.4 4818.3 5062.4 5073.8 5127.4 5128.5 5162.2 4750.3 4772.1 4779.7 4780.1 4790.2 5068.2 5074.8 5081.2 5085.7 5100.8 4793.2 4918.8 4920.9 4930.1 4980.2 4711.3 4732.2 4745.4 4747.9 4759.4 3736.5 3763.3 3770.6 3774.8 3781.4 4886.8 5063.8 5096.6 5103.7 5112.7 4918.4 4926.7 4946.7 4948.0 4959.0 4923.4 4925.9 4947.3 4947.4 4959.9 4608.9 4827.8 4835.6 4838.4 4871.8 4830.7 4936.4 4980.9 4982.5 4999.5 4793.9 4799.7 4805.8 4823.6 4827.5 14:19:18 INFO - PROCESS | 27205 | 14:19:18 INFO - PROCESS | 27205 | [#5] yui.html Cycles:180 Average:16929.42 Median:45005.22 stddev:23676.55 (52.6%) stddev-sans-first:23711.43 14:19:18 INFO - PROCESS | 27205 | Values: 655.0 655.5 683.4 707.9 738.8 11986.3 12215.6 12453.9 12496.1 12662.4 12321.8 12478.9 12491.4 12502.3 12509.6 636.3 772.7 777.3 787.2 803.8 799.1 800.9 802.6 802.9 803.0 845.9 846.4 848.0 848.5 848.8 660.1 811.1 836.5 837.3 840.6 610.9 611.0 612.1 612.3 612.4 11747.3 11769.5 11793.1 11798.4 11801.8 12079.4 12572.2 12596.1 12663.4 12926.2 11264.8 11289.4 11293.4 11327.2 11492.8 4056.3 4109.2 4133.2 4135.9 4191.6 55757.7 56170.4 57451.0 57592.4 58098.4 9549.0 9690.1 9695.2 9872.5 10000.6 17330.2 17334.0 17342.7 17475.1 17554.1 6939.3 7009.9 7062.8 7071.0 7132.1 3408.8 3422.9 3498.4 3549.6 3630.1 3039.4 3143.1 3145.9 3148.8 3151.2 508.2 511.6 523.7 525.3 567.2 539.6 573.0 574.5 598.7 621.5 8386.7 8724.8 8750.6 8774.8 8859.0 470.0 503.9 644.2 651.2 654.0 3931.8 3993.3 4032.6 4050.4 4112.8 86297.6 93813.5 97404.5 97741.5 101150.0 53119.0 68805.0 78465.6 80928.6 86750.6 46854.3 73449.3 74693.6 74900.8 75389.6 8410.1 8451.3 8615.6 8940.8 9063.7 39911.8 42498.2 42522.9 43017.8 43156.1 47453.0 60540.7 61368.0 61588.0 62333.7 10879.7 11105.0 11445.7 12113.7 12194.9 11955.9 12487.2 12512.9 12693.2 13485.4 11701.6 12286.4 12326.2 12493.9 12870.2 10781.8 11107.7 11137.6 11256.7 11294.0 11794.6 11794.9 11878.9 12152.5 12589.8 9811.5 10185.8 10240.1 10282.8 10519.5 10515.6 10570.4 10630.5 10747.4 10797.9 14:19:18 INFO - PROCESS | 27205 | -------- Summary: end -------- 14:19:18 INFO - PROCESS | 27205 | 14:19:19 INFO - TEST-INFO | 27205: exit 0 14:19:19 INFO - TEST-OK | dromaeo_css | took 1118787ms 14:19:19 INFO - TEST-START | kraken 14:19:19 INFO - operating with platform_type : linux_ 14:19:19 INFO - Initialising browser for kraken test... 14:19:19 INFO - TEST-INFO | started process 27387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4n4PVR/profile http://localhost:55704/getInfo.html) 14:19:23 INFO - PROCESS | 27387 | __metrics Screen width/height:1600/1200 14:19:23 INFO - PROCESS | 27387 | colorDepth:24 14:19:23 INFO - PROCESS | 27387 | Browser inner width/height: 1024/697 14:19:23 INFO - PROCESS | 27387 | __metrics 14:19:24 ERROR - PROCESS | 27387 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:19:25 INFO - TEST-INFO | 27387: exit 0 14:19:25 INFO - Browser initialized. 14:19:25 INFO - Running cycle 1/1 for kraken test... 14:19:25 INFO - TEST-INFO | started process 27467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4n4PVR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:37 INFO - PROCESS | 27467 | RSS: Main: 157458432 14:19:37 INFO - PROCESS | 27467 | 14:19:40 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55704/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:41 INFO - PROCESS | 27467 | RSS: Main: 216059904 14:19:41 INFO - PROCESS | 27467 | 14:19:43 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55704/tests/kraken/driver.html?testName=audio-dft) 14:19:44 INFO - PROCESS | 27467 | RSS: Main: 202944512 14:19:44 INFO - PROCESS | 27467 | 14:19:47 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55704/tests/kraken/driver.html?testName=audio-fft) 14:19:48 INFO - PROCESS | 27467 | RSS: Main: 270761984 14:19:48 INFO - PROCESS | 27467 | 14:19:50 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55704/tests/kraken/driver.html?testName=audio-oscillator) 14:19:51 INFO - PROCESS | 27467 | RSS: Main: 180764672 14:19:51 INFO - PROCESS | 27467 | 14:19:53 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:19:53 INFO - PROCESS | 27467 | RSS: Main: 185217024 14:19:53 INFO - PROCESS | 27467 | 14:19:57 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55704/tests/kraken/driver.html?testName=imaging-darkroom) 14:19:57 INFO - PROCESS | 27467 | RSS: Main: 221020160 14:19:57 INFO - PROCESS | 27467 | 14:20:01 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55704/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:01 INFO - PROCESS | 27467 | RSS: Main: 216883200 14:20:01 INFO - PROCESS | 27467 | 14:20:04 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55704/tests/kraken/driver.html?testName=json-parse-financial) 14:20:05 INFO - PROCESS | 27467 | RSS: Main: 219901952 14:20:05 INFO - PROCESS | 27467 | 14:20:07 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:07 INFO - PROCESS | 27467 | RSS: Main: 208117760 14:20:07 INFO - PROCESS | 27467 | 14:20:09 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:10 INFO - PROCESS | 27467 | RSS: Main: 212856832 14:20:10 INFO - PROCESS | 27467 | 14:20:12 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:13 INFO - PROCESS | 27467 | RSS: Main: 218558464 14:20:13 INFO - PROCESS | 27467 | 14:20:15 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:16 INFO - PROCESS | 27467 | RSS: Main: 223260672 14:20:16 INFO - PROCESS | 27467 | 14:20:19 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:20 INFO - PROCESS | 27467 | RSS: Main: 224186368 14:20:20 INFO - PROCESS | 27467 | 14:20:21 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:55704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55704/tests/kraken/driver.html?testName=ai-astar) 14:20:22 INFO - PROCESS | 27467 | RSS: Main: 265990144 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | __start_tp_report 14:20:22 INFO - PROCESS | 27467 | _x_x_mozilla_page_load 14:20:22 INFO - PROCESS | 27467 | _x_x_mozilla_page_load_details 14:20:22 INFO - PROCESS | 27467 | |i|pagename|runs| 14:20:22 INFO - PROCESS | 27467 | |0;ai-astar;114;109;111;112;113;112;113;112;112;113 14:20:22 INFO - PROCESS | 27467 | |1;audio-beat-detection;173;138;139;179;130;163;153;132;198;140 14:20:22 INFO - PROCESS | 27467 | |2;audio-dft;162;162;162;161;161;161;163;162;161;160 14:20:22 INFO - PROCESS | 27467 | |3;audio-fft;75;75;76;106;76;77;75;76;105;74 14:20:22 INFO - PROCESS | 27467 | |4;audio-oscillator;86;86;123;87;87;87;126;87;86;128 14:20:22 INFO - PROCESS | 27467 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;116;117 14:20:22 INFO - PROCESS | 27467 | |6;imaging-darkroom;146;145;146;145;146;147;146;145;145;146 14:20:22 INFO - PROCESS | 27467 | |7;imaging-desaturate;94;95;94;94;95;95;95;95;94;95 14:20:22 INFO - PROCESS | 27467 | |8;json-parse-financial;65;64;64;66;63;65;63;64;64;65 14:20:22 INFO - PROCESS | 27467 | |9;json-stringify-tinderbox;65;65;65;66;65;66;67;66;66;66 14:20:22 INFO - PROCESS | 27467 | |10;stanford-crypto-aes;85;83;83;83;85;85;83;85;118;86 14:20:22 INFO - PROCESS | 27467 | |11;stanford-crypto-ccm;150;131;141;132;138;147;133;137;137;135 14:20:22 INFO - PROCESS | 27467 | |12;stanford-crypto-pbkdf2;168;170;167;166;165;164;168;168;167;165 14:20:22 INFO - PROCESS | 27467 | |13;stanford-crypto-sha256-iterative;70;68;68;67;67;67;70;65;66;65 14:20:22 INFO - PROCESS | 27467 | __end_tp_report 14:20:22 INFO - PROCESS | 27467 | __start_cc_report 14:20:22 INFO - PROCESS | 27467 | _x_x_mozilla_cycle_collect,1910 14:20:22 INFO - PROCESS | 27467 | __end_cc_report 14:20:22 INFO - PROCESS | 27467 | __startTimestamp1464988822019__endTimestamp 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | ------- Summary: start ------- 14:20:22 INFO - PROCESS | 27467 | Number of tests: 14 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.37 (1.2%) stddev-sans-first:1.27 14:20:22 INFO - PROCESS | 27467 | Values: 114.0 109.0 111.0 112.0 113.0 112.0 113.0 112.0 112.0 113.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:158.00 stddev:22.95 (14.5%) stddev-sans-first:23.34 14:20:22 INFO - PROCESS | 27467 | Values: 173.0 138.0 139.0 179.0 130.0 163.0 153.0 132.0 198.0 140.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 14:20:22 INFO - PROCESS | 27467 | Values: 162.0 162.0 162.0 161.0 161.0 161.0 163.0 162.0 161.0 160.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.68 (16.8%) stddev-sans-first:13.23 14:20:22 INFO - PROCESS | 27467 | Values: 75.0 75.0 76.0 106.0 76.0 77.0 75.0 76.0 105.0 74.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:86.50 stddev:18.93 (21.9%) stddev-sans-first:19.54 14:20:22 INFO - PROCESS | 27467 | Values: 86.0 86.0 123.0 87.0 87.0 87.0 126.0 87.0 86.0 128.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:20:22 INFO - PROCESS | 27467 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:20:22 INFO - PROCESS | 27467 | Values: 146.0 145.0 146.0 145.0 146.0 147.0 146.0 145.0 145.0 146.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:20:22 INFO - PROCESS | 27467 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 14:20:22 INFO - PROCESS | 27467 | Values: 65.0 64.0 64.0 66.0 63.0 65.0 63.0 64.0 64.0 65.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 14:20:22 INFO - PROCESS | 27467 | Values: 65.0 65.0 65.0 66.0 65.0 66.0 67.0 66.0 66.0 66.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:85.00 stddev:10.74 (12.6%) stddev-sans-first:11.35 14:20:22 INFO - PROCESS | 27467 | Values: 85.0 83.0 83.0 83.0 85.0 85.0 83.0 85.0 118.0 86.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:137.50 stddev:6.28 (4.6%) stddev-sans-first:4.97 14:20:22 INFO - PROCESS | 27467 | Values: 150.0 131.0 141.0 132.0 138.0 147.0 133.0 137.0 137.0 135.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 14:20:22 INFO - PROCESS | 27467 | Values: 168.0 170.0 167.0 166.0 165.0 164.0 168.0 168.0 167.0 165.0 14:20:22 INFO - PROCESS | 27467 | 14:20:22 INFO - PROCESS | 27467 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.77 (2.6%) stddev-sans-first:1.58 14:20:22 INFO - PROCESS | 27467 | Values: 70.0 68.0 68.0 67.0 67.0 67.0 70.0 65.0 66.0 65.0 14:20:22 INFO - PROCESS | 27467 | -------- Summary: end -------- 14:20:22 INFO - PROCESS | 27467 | 14:20:23 INFO - TEST-INFO | 27467: exit 0 14:20:23 INFO - TEST-OK | kraken | took 63743ms 14:20:23 INFO - SUITE-END | took 1182s 14:20:23 INFO - Completed test suite (00:19:42) 14:20:23 INFO - javascript benchmark 14:20:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.611891275765, 2708.2281549758322, 2714.9864250678743, 2737.1241202815095, 2746.9175924722267, 4573.039661671053, 4654.743989080599, 4662.883427914304, 4734.881627959298, 4796.16067188242, 4676.438827340716, 4697.553732395417, 4713.151632706112, 4738.71567705937, 4758.310045043475, 4261.893452663685, 4335.609795118455, 4378.978105109486, 4408.845690400836, 4485.102979404116, 4405.05291362357, 4432.97783511082, 4444.488883778375, 4474.507804141542, 4494.280915053592, 4246.447961764981, 4292.570742925714, 4307.849225277131, 4336.8265269389185, 4369.410129632491, 4340.6093451589195, 4343.869683909487, 4346.391505189276, 4403.669724770655, 4459.219636563621, 4388.385626012361, 4403.537628548988, 4435.60079592835, 4449.288113901793, 4450.5104438511735, 4540.0, 4615.607673347769, 4664.346991421204, 4717.457492388351, 4764.809407623691, 5193.558547523465, 5199.766010529535, 5210.244514545408, 5211.609129315279, 5212.322398088262, 5220.086484865172, 5236.21456781482, 5240.161574148156, 5250.317458730341, 5250.7112108834, 4641.721496710208, 4797.95202047982, 4838.080764654775, 4850.054239423349, 4894.779734911902, 5345.904089661688, 5363.865903352447, 5381.973090134525, 5384.78460861569, 5388.084025715638, 5141.76862041209, 5152.458991805881, 5155.381354237516, 5155.61332900034, 5161.354830646169, 4928.8767780805765, 5082.822101226439, 5116.692998420107, 5124.948750512522, 5163.922541161885, 5078.263651770547, 5115.1559992600805, 5116.923246151311, 5117.817568612593, 5167.992241512944, 4926.285688575136, 5088.262201980766, 5101.51535604117, 5102.591792656579, 5110.182370820651, 4236.4492615959725, 4263.722858014219, 4303.268444364466, 4307.030918043478, 4355.956440435619, 3744.1762812181278, 3758.4174452959833, 3763.8870833875026, 3804.6385593368586, 3805.8858234253016, 4406.162829062532, 4411.404460397869, 4415.84544540946, 4464.732116073046, 4467.396901418267, 4944.851654450372, 5092.236164575269, 5125.564327032244, 5140.588752899759, 5171.456997015334, 4392.4289842320295, 4406.515283318832, 4418.0, 4418.513963464016, 4462.754548499799, 4473.1277400907165, 4622.375979242826, 4623.56076172763, 4626.7223966562115, 4675.462321832964, 4808.927866082082, 4854.563089321837, 4858.1012512685265, 4867.318575399376, 4875.9512404875495, 5143.768530416065, 5178.97410512945, 5181.611379146654, 5184.066867963803, 5236.10986132366, 4650.20946439113, 4727.929081063856, 4833.226683730586, 4858.246971719389, 4913.336699545515, 4967.82612608557, 5031.094403007493, 5058.038972595195, 5058.418281897629, 5101.005303965691, 5124.256982737556, 5124.9743751281, 5128.410232823124, 5131.769070391916, 5183.688978661293, 4898.902021959612, 4928.728919909439, 4956.801727930842, 4988.376452943382, 4998.450170481171, 4992.226204938241, 5015.473375295687, 5017.071841709296, 5017.24741288795, 5051.949480505148, 4903.190973489334, 4905.828296009622, 4938.925916111333, 4954.752262386794, 4956.900861982812, 4851.490593487774, 4948.579370753526, 4957.206846904478, 4994.875128121826, 5083.085044691991, 4833.202521583899, 4862.82980095695, 4873.780679869344, 4889.315495830658, 4931.753412329441], "value": 4699.587704226225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8623437257872, 590.6751286792264, 593.780301288523, 596.1028651878921, 604.8850718363512, 27410.86294568527, 40972.0, 41870.95322616936, 42058.0, 44641.330380044325, 41553.37669934946, 41751.582484175226, 41895.0, 42049.15901681964, 42106.157876842444, 7625.084989801232, 7789.649465774026, 7791.727289544867, 7795.805104872366, 7803.765887023398, 7517.135529414105, 7613.505122167041, 7634.541927484369, 7637.656305466239, 7641.808954776147, 6476.579022363555, 6504.512161587876, 6508.381703738138, 6509.121268628722, 6638.93361066388, 6503.674816259216, 6521.641309727963, 6522.804315870531, 6529.1512103426485, 6653.401193892549, 7686.3082322591235, 7776.844463110706, 7779.72770953014, 7784.688612455495, 7788.260115289038, 37362.065948351235, 37554.624453755656, 37660.623393765985, 37688.0, 37707.811460942794, 3004.324027093908, 3088.8146711197173, 3330.733541316689, 3607.8556857725657, 3776.358019136726, 28722.42555148906, 29208.269793255127, 29537.70462295371, 29559.113226603236, 29983.550246746316, 3422.6577342265823, 3449.862005519776, 3479.2693534357813, 3540.168060505779, 3593.9281214375565, 266767.0, 268027.999999998, 268817.0, 268936.0, 269567.0, 46122.0, 53727.19409208865, 54053.0, 54130.45869541254, 54145.0, 54844.88663350265, 56368.0, 56583.717081415154, 62163.689181553804, 62211.688941555, 13635.38640761168, 13657.658558535917, 13748.381322840296, 13771.104878182887, 13793.379297931617, 9353.0, 9722.0, 9906.306558540833, 9915.30592858493, 9928.652497162564, 14403.92798036024, 14551.3451894665, 15636.0, 16193.514194574182, 16295.266712997944, 6088.573799834057, 6296.275928268216, 6338.144350512714, 6343.175387199727, 6350.618962862243, 842.4776638484179, 915.7252824152861, 979.485769970771, 986.659602437158, 1000.8698869146964, 26759.866200668872, 28146.577801333, 28539.71460285412, 28696.856515717704, 28853.27866803347, 960.9477622003894, 971.7522031881966, 987.151050096916, 1020.8979102089731, 1060.9628662996759, 13635.659108522366, 14229.0, 14461.13233206011, 14473.92763036178, 14518.927405362905, 350848.0, 353178.0, 353677.0, 355016.0, 372851.0, 46812.297815532795, 46851.29723054157, 47017.29474057823, 47095.0, 47119.29321060187, 1118.9776204475866, 1150.6375491720082, 1202.3206888108366, 1219.3720234079456, 1230.4954968462887, 25424.872875635505, 25829.483410332065, 26376.472470550867, 26572.734272657028, 26816.195514134608, 41267.587324126376, 41560.79219603883, 41639.16721665489, 41644.0, 41644.375334369404, 320376.0, 321603.0, 321807.0, 321885.0, 324292.0, 22134.225302114348, 24162.275131746075, 25323.49353012966, 25406.745932540438, 25416.872915635304, 32740.345193095527, 42616.360754589325, 44737.776311118236, 45596.31605525853, 45691.08617827691, 35063.64936350706, 36016.63983360238, 36666.63333366632, 37142.25715485621, 41173.588264116974, 35135.82432087823, 35902.0, 36127.27745445129, 36172.27655446929, 36595.26809463849, 35146.0, 35165.0, 36422.0, 36534.45198321974, 36572.451413229355, 30307.0, 32336.0, 32350.676493234765, 32418.83790581032, 32634.51048234231, 24917.87541062283, 25282.0, 25346.493070138124, 25544.10595629144, 25723.099691511456], "value": 17172.827195674276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9352619765344, 351.63956944132264, 356.0653285126543, 361.38925216384325, 361.5264004154558, 15519.767203491956, 16727.83272167278, 16872.83127168728, 17364.652706945853, 17387.826121738777, 14628.268586570655, 14935.7012859743, 15149.54551363458, 15386.0, 15414.229288535584, 4847.297141914429, 4937.308776771255, 5084.9745751271375, 5091.567216786578, 5097.082525145473, 3619.981900090496, 3792.696584273265, 4980.452150263486, 5472.753726082336, 5750.884982300351, 5782.277215348082, 5784.363719990798, 5792.942070579283, 5805.941940580604, 5818.563607729416, 5650.29371328584, 5685.459881311269, 5726.455986681259, 5734.426557344253, 5810.970945145247, 3305.2232725309773, 4789.616830653539, 5087.186050231982, 5089.211172268304, 5098.974505127488, 19333.323333683395, 20110.29613963519, 20133.899330503402, 20323.9838008099, 20356.389308320773, 1886.0852486544015, 1887.6036032433205, 1997.810208030235, 2149.9462513437134, 2304.20504925802, 8779.165979231962, 9229.907700922971, 9455.716328510156, 9635.325527213097, 12981.0, 1556.214111873508, 1565.326909428945, 1581.4069723853554, 1631.6491954229898, 1632.2410079313177, 64650.676746615965, 67372.663136684, 67996.6600166996, 68201.31798682, 69303.99999999949, 9924.851127233098, 10010.749731256778, 10020.799584008279, 10104.09063184317, 10342.638007669846, 13794.65513362174, 13815.792763108562, 13882.93058534721, 13903.930480347533, 13921.164730116225, 6884.931150688529, 6934.930650693529, 7003.404710599554, 7081.398081163159, 7105.75129870452, 6421.101045853584, 6440.967795160994, 6475.352464753487, 6554.246261679872, 6569.704363303663, 4333.111712099012, 4341.435613370241, 4384.5092668492225, 4433.0, 4435.3125265583885, 1632.7714120022968, 1683.0, 1704.0542498912973, 1806.1601355369817, 1819.5392807875523, 851.3104385447683, 873.9606717697592, 886.2599729226168, 965.8116667249959, 973.7906350134755, 16354.836451635569, 16693.415730449375, 16859.83140168607, 17107.48677539676, 17276.395326163525, 850.1116333431579, 861.1345597674298, 862.5730263519598, 905.42053086025, 919.7838507950627, 9391.295652826066, 9774.5601447935, 9861.605535778632, 9893.950530247303, 10043.096121349114, 353486.0, 358893.0, 359386.0, 359905.0, 360876.0, 46999.29501057487, 47682.761586191846, 67907.0, 77501.0, 78135.21864781393, 917.3257655623112, 922.4280945813639, 935.2751617496359, 938.9718308450757, 946.370663508759, 14995.0, 15104.773428398803, 15141.091534507965, 15319.923400383374, 15418.537443876701, 31660.683393166695, 31895.681043190198, 34437.827810860785, 34695.47956780701, 34718.0, 46599.76700116478, 48660.75669621629, 49355.25967110424, 49563.25655115104, 49672.503274968236, 7463.813404664927, 7615.961920190363, 7733.613319334123, 7774.805629859299, 7852.057753069668, 10724.410157441103, 12121.636350909486, 12122.0, 12258.570950016707, 12319.0, 5821.864736376366, 6491.4806815455595, 9688.612455501983, 10397.58409663605, 10788.248996505841, 10495.47522623881, 10546.947265263625, 10592.576296948344, 10649.89350106489, 10739.516721747696, 10488.842667360148, 10508.737281567715, 10629.574817007233, 10666.20003499756, 10797.24419290642, 6893.172819261721, 6923.93076069253, 7041.964790176016, 7696.15342312334, 7754.961225193838, 10283.794324113625, 10478.842817357594, 10501.212409069503, 10567.52446139941, 10800.567977280822], "value": 8008.252203577434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.3731065811764, 1388.2087210290133, 1422.324395911942, 1460.5399299220744, 1718.8195239499844, 6687.1975362956455, 7263.60050197239, 7493.812654683622, 7504.5872477013745, 7591.051118610174, 7518.060242469692, 7538.321551060403, 7590.430717696181, 7592.620368981557, 7593.886091708615, 2154.644483660198, 2175.445261458326, 2179.3897708641607, 2180.6838008488758, 2183.759786423492, 2103.200783702191, 2164.448065743233, 2190.8137808286233, 2195.7804219578074, 2195.934121976335, 2155.461134716321, 2173.022140036982, 2175.6845257437662, 2180.040782055898, 2191.7260342457193, 2062.453449835795, 2063.7213976113185, 2064.1021155797275, 2066.9483262918397, 2067.0491573876034, 2035.155410504639, 2122.352682431858, 2123.9256626018014, 2125.7130287411155, 2127.5000374911883, 7441.218672039412, 7443.925560744432, 7490.400767938606, 7491.138519070268, 7506.8123296917465, 4218.725782824137, 4385.605295523386, 4390.8902277443, 4395.846145384896, 4397.384366188736, 2754.504189245935, 2820.746132848033, 2832.1645114691214, 2866.2834291427143, 2874.4107457971068, 848.9787755306105, 917.2524392619994, 930.734740598926, 933.5752232734158, 942.6323733743845, 10277.17782577392, 10362.948185259102, 10376.740581485372, 10385.324953877975, 10391.688249352532, 3896.688264938798, 4016.0, 4037.414574886625, 4100.077482566398, 4105.548389677133, 8033.919660803434, 8119.634616442274, 8134.877976830352, 8151.103378628346, 8155.10293867674, 4324.783760811947, 4331.350297455344, 4334.414853994734, 4338.0, 4366.323219900921, 3607.350676878187, 3896.688264938855, 3918.9608103919168, 3938.113924367052, 4084.509858816961, 3258.494933285297, 3266.8856590019236, 3324.135724711544, 3332.0503656457795, 3337.5327454156436, 879.305348774461, 945.2107490245722, 948.3361646847235, 952.1906379577442, 954.370115723619, 840.8738689196547, 849.6856163219525, 890.8129292848445, 898.3442087276194, 899.3120262998812, 5329.094054010828, 5399.352077750695, 5557.666540007613, 5585.636933599303, 5657.80197693087, 840.5881118252013, 870.5908223135243, 873.9650413983369, 875.7504111328241, 879.5426378283257, 3847.2882516734494, 3959.604039596017, 3964.4251583520227, 3978.124812541236, 4034.45534852797, 8985.056569060285, 9329.0, 9345.20565751905, 9570.186534144537, 9594.520273986273, 9379.96820349761, 9429.66996155145, 9449.858252126223, 9450.291228157916, 9472.905270947202, 6958.025876377311, 7090.468214883905, 7097.361237488651, 7108.8933665995055, 7110.431165506747, 5317.175837745156, 5558.944410556004, 5611.663300202001, 5611.915821262766, 5698.373178950229, 8448.324134069382, 8505.192006759347, 8589.269912057545, 8806.779830504289, 8827.779305517413, 8770.649174033222, 8843.823123537622, 8885.511296878734, 8895.154960278764, 8902.73291801247, 5956.731947062306, 6092.055731361646, 6199.535034872493, 6290.49676025926, 6303.527235457451, 7083.6812343443635, 7167.319104685047, 7233.529820561646, 7234.927650723425, 7238.710451581877, 6252.343503932022, 6259.311475737756, 6275.905861412174, 6384.840378990562, 6470.320616335405, 6389.041643753474, 6404.615723056445, 6409.519286053472, 6595.736170553316, 6617.2721000688925, 6438.356164383524, 6480.027995800668, 6520.608763474207, 6529.771457998947, 6535.379138981789, 4579.93130103042, 4587.472440669366, 4664.137134630104, 4717.339572459927, 4725.692829966041, 4484.955150448584, 4523.547645235451, 4528.071745292273, 4529.32060190974, 4556.908861822812], "value": 4024.1190814745146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.5525490744254, 296.0806695211369, 297.0760933496824, 301.2363658126649, 301.31901901702145, 4740.123077230714, 4767.451743049551, 4769.666123371366, 4798.112349215397, 4805.399325084364, 4717.57541821236, 4721.527847215277, 4746.430428348594, 4751.263554149104, 4764.166270902587, 3571.8571257149747, 3629.727770417216, 3693.3905905525558, 3706.147586055209, 3795.772253664789, 3744.1762812181278, 3745.775253484786, 3747.306748251582, 3778.8110594470304, 3787.1289603391238, 3545.8227088645463, 3700.9444858327147, 3709.833057512405, 3711.4618380334837, 3727.273181729564, 3623.7825730456125, 3720.7023438124884, 3726.347889119393, 3731.179140589093, 3768.7361884668085, 3322.7175690066374, 3328.3509715605464, 3349.7990120592845, 3351.044952188639, 3353.9161520961925, 4515.977420112911, 4529.5243999380245, 4529.909401811979, 4550.704204226715, 4575.787416334674, 3974.8608798691907, 4211.536730959592, 4233.920350310651, 4289.1850548395705, 4310.331898555729, 4948.975255123702, 4950.925736113961, 4969.453360130383, 4975.179095449246, 4991.201407774775, 3540.929181416383, 3541.11472131967, 3549.6095429502734, 3554.608993010767, 3563.3051554946796, 5044.39467263927, 5176.870578235536, 5232.189010703309, 5235.267062611238, 5241.0, 3556.893293201208, 3565.607783143852, 3582.4089025311055, 3584.4623306503713, 3597.8380972856285, 3628.2743451309316, 3634.2186429917165, 3635.7640051368217, 3639.6906262967946, 3643.526341575578, 4154.31453810124, 4165.416841642173, 4169.854055108117, 4193.6645068394455, 4202.768847713344, 4822.180229360947, 4945.134601444733, 4956.3804524434445, 4960.776765045582, 4987.177115775857, 1243.8494392686728, 1253.3106791264768, 1257.849058113014, 1258.9118761686593, 1259.765429878724, 800.2597597222546, 802.0976401548259, 891.4740303221131, 918.2791508665665, 921.1157289002632, 4305.858947378947, 4385.6052955233545, 4401.361802538614, 4405.207062728676, 4418.8453404130705, 5071.518205770446, 5084.847454576368, 5112.6421150519855, 5147.845564633067, 5162.0, 4199.559046300094, 4367.471385015283, 4369.672274579356, 4390.560943905648, 4399.912001760011, 2690.887653192274, 2693.2324287577944, 2708.702042775293, 2712.250598364044, 2718.7375149820296, 4738.928916066262, 4772.5943294819635, 4795.856124316276, 4806.399200099988, 4818.301346304766, 5062.367204099488, 5073.79568333862, 5127.410347809975, 5128.538431541179, 5162.174052151638, 4750.311204875274, 4772.0694464579765, 4779.689320194246, 4780.139574876555, 4790.185668436374, 5068.214426763858, 5074.847754567369, 5081.212412076134, 5085.7457127144235, 5100.79596816138, 4793.161196790617, 4918.778654960463, 4920.852374428773, 4930.126551910251, 4980.228064649985, 4711.316859055486, 4732.19552676039, 4745.413749506458, 4747.8605134768095, 4759.405074365704, 3736.4582135589644, 3763.3226019316785, 3770.5663848657755, 3774.8112594370723, 3781.4327850822597, 4886.828960986349, 5063.822766203165, 5096.592272618256, 5103.719295438638, 5112.667676601009, 4918.426103646942, 4926.729029903389, 4946.727929963887, 4947.975260123821, 4958.950410495849, 4923.433805112458, 4925.876853078558, 4947.307376967299, 4947.381577302837, 4959.900801984012, 4608.861734147981, 4827.806887724451, 4835.564799168092, 4838.419389673261, 4871.780769865435, 4830.734309613005, 4936.3829521309835, 4980.929100243465, 4982.451930287738, 4999.500049994971, 4793.880152996203, 4799.688020278671, 4805.846596816669, 4823.5658790709, 4827.468978412302], "value": 3739.626958259965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9607023578585, 655.5411212151489, 683.350816724112, 707.8973548835419, 738.8337624034593, 11986.280823150617, 12215.633530994073, 12453.937730311347, 12496.125271231018, 12662.366881655926, 12321.753564928697, 12478.937605311983, 12491.375431228447, 12502.312372819491, 12509.562165324216, 636.341386664802, 772.7334069745929, 777.3004296133482, 787.2206515549622, 803.8432505661399, 799.1489064146665, 800.8558459477292, 802.6348011654712, 802.9397795165356, 802.9718959836378, 845.9407841451101, 846.3525403066659, 848.0205362805938, 848.516345682961, 848.8217474330368, 660.0725979998086, 811.111832543364, 836.4646626159263, 837.2548431895618, 840.6427268410931, 610.9114178444145, 611.0498175337349, 612.1429998002787, 612.3356158567959, 612.3662009819815, 11747.29516229029, 11769.470373833197, 11793.115516336224, 11798.41007949599, 11801.763964720743, 12079.396030198455, 12572.182808117443, 12596.118271720983, 12663.430145643468, 12926.224426534343, 11264.831027534594, 11289.379084150369, 11293.435328233556, 11327.150463715254, 11492.770144597145, 4056.310427227349, 4109.178164367108, 4133.173365326947, 4135.9172816543805, 4191.643710284629, 55757.72121139409, 56170.43829561693, 57451.0, 57592.42407575955, 58098.419015809726, 9549.0, 9690.079442452956, 9695.175910047585, 9872.45701486425, 10000.599976001024, 17330.220140093727, 17334.04662743561, 17342.65314693699, 17475.126243687766, 17554.122293885255, 6939.271376505495, 7009.9299007010295, 7062.752803651848, 7071.04540886984, 7132.108486439195, 3408.84660190292, 3422.8973130806116, 3498.4052711039185, 3549.5917969433845, 3630.056185391817, 3039.3921215756936, 3143.135637699651, 3145.9213519661735, 3148.842557872097, 3151.2279491524723, 508.1640701046757, 511.6265126457707, 523.7119584228659, 525.25938426818, 567.1889198446262, 539.5953035223582, 572.977080916767, 574.4944448884954, 598.6797063571056, 621.5245337316957, 8386.67511487402, 8724.781880452912, 8750.606222719993, 8774.824503509893, 8858.975122600017, 469.97650117493987, 503.90173916086013, 644.2011905237472, 651.2478087808589, 653.9607623542603, 3931.76409415436, 3993.281209382339, 4032.6370626643743, 4050.3519436889956, 4112.814923328458, 86297.5685121583, 93813.53093234627, 97404.51297743466, 97741.51129244309, 101150.0, 53119.0, 68805.0, 78465.60767196241, 80928.59535702401, 86750.56624716836, 46854.297185542244, 73449.2655073453, 74693.62653186808, 74900.75694701319, 75389.6230518844, 8410.14284574247, 8451.32389408858, 8615.569221539023, 8940.776480587778, 9063.68277110298, 39911.800440997606, 42498.15003699847, 42522.93692657708, 43017.78491107524, 43156.13687726291, 47453.0, 60540.69729651324, 61368.0, 61588.0, 62333.68833155987, 10879.673609791718, 11105.0, 11445.656630301104, 12113.69715757078, 12194.878051219373, 11955.880441195477, 12487.188332758706, 12512.874871251171, 12693.174943628635, 13485.39315730814, 11701.648950531498, 12286.447109879899, 12326.198797078161, 12493.93753031229, 12870.16343937641, 10781.838272426077, 11107.666769996913, 11137.610183643857, 11256.662300131009, 11294.040006599202, 11794.587189448328, 11794.882051179378, 11878.940605296919, 12152.513899443924, 12589.811152832532, 9811.509424528602, 10185.79628407413, 10240.08423311135, 10282.794344113225, 10519.526621302213, 10515.631952881613, 10570.365778053341, 10630.52162652698, 10747.408892510986, 10797.946010269898], "value": 6546.30409603563, "unit": "score"}], "name": "dromaeo_css", "value": 6319.228946346429, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 111.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 138.0, 139.0, 179.0, 130.0, 163.0, 153.0, 132.0, 198.0, 140.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 162.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 106.0, 76.0, 77.0, 75.0, 76.0, 105.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 123.0, 87.0, 87.0, 87.0, 126.0, 87.0, 86.0, 128.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 66.0, 63.0, 65.0, 63.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 83.0, 85.0, 85.0, 83.0, 85.0, 118.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 131.0, 141.0, 132.0, 138.0, 147.0, 133.0, 137.0, 137.0, 135.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 167.0, 166.0, 165.0, 164.0, 168.0, 168.0, 167.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 67.0, 67.0, 67.0, 70.0, 65.0, 66.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1554.6, "alertThreshold": 2.0}]} 14:20:23 INFO - Return code: 0 14:20:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:20:23 ERROR - # TBPL SUCCESS # 14:20:23 INFO - Running post-action listener: _resource_record_post_action 14:20:23 INFO - ##### 14:20:23 INFO - ##### Finished run-tests step (success) 14:20:23 INFO - ##### 14:20:23 INFO - Running post-run listener: _resource_record_post_run 14:20:23 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 295903232; Read time: 0; Write time: 218292 14:20:23 INFO - TinderboxPrint: CPU usage
13.1% 14:20:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:20:23 INFO - TinderboxPrint: I/O write bytes / time
295,903,232 / 218,292 14:20:23 INFO - TinderboxPrint: CPU idle
8,324.7 (86.9%) 14:20:23 INFO - TinderboxPrint: CPU user
1,211.8 (12.7%) 14:20:23 INFO - TinderboxPrint: Swap in / out
0 / 0 14:20:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15331328; Read time: 0; Write time: 2096 14:20:23 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 280571904; Read time: 0; Write time: 216196 14:20:23 INFO - Running post-run listener: _upload_blobber_files 14:20:23 INFO - Blob upload gear active. 14:20:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:20:23 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 14:20:23 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'] 14:20:23 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 14:20:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:20:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:25 INFO - (blobuploader) - INFO - Done attempting. 14:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:31 INFO - (blobuploader) - INFO - Done attempting. 14:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:31 INFO - (blobuploader) - INFO - Done attempting. 14:20:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:31 INFO - Return code: 0 14:20:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:20:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c614322fc3d164b941761ced3f5e9dd71b06c953e42bdd59c67de0f9f5b81a9f48dbd307527f1e393d1393e3962fc161b1e8c026b5111eb98531385453421d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81996c47f9d93839e228cd79eeebbc93944c349d1e033a5e9f3ec273fa8cc07dcefc3d2871ec7fa0ead25f8c0c4a6713301e4e70b67da63cab63d2056de49f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ebd00eb6ee0b78a078964efee2372d8be06ef77163f30a95ab127afbee60efbbefaa2a3ec4bccd1de21df0454e1c0c189f84b2421e54801a01968d7755300"} 14:20:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:20:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:20:31 INFO - Contents: 14:20:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c614322fc3d164b941761ced3f5e9dd71b06c953e42bdd59c67de0f9f5b81a9f48dbd307527f1e393d1393e3962fc161b1e8c026b5111eb98531385453421d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81996c47f9d93839e228cd79eeebbc93944c349d1e033a5e9f3ec273fa8cc07dcefc3d2871ec7fa0ead25f8c0c4a6713301e4e70b67da63cab63d2056de49f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ebd00eb6ee0b78a078964efee2372d8be06ef77163f30a95ab127afbee60efbbefaa2a3ec4bccd1de21df0454e1c0c189f84b2421e54801a01968d7755300"} 14:20:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:20:31 INFO - Copying logs to upload dir... 14:20:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:20:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1303.104884 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-06-03 14:20:31.681410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:20:31.684971) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023 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/c614322fc3d164b941761ced3f5e9dd71b06c953e42bdd59c67de0f9f5b81a9f48dbd307527f1e393d1393e3962fc161b1e8c026b5111eb98531385453421d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81996c47f9d93839e228cd79eeebbc93944c349d1e033a5e9f3ec273fa8cc07dcefc3d2871ec7fa0ead25f8c0c4a6713301e4e70b67da63cab63d2056de49f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ebd00eb6ee0b78a078964efee2372d8be06ef77163f30a95ab127afbee60efbbefaa2a3ec4bccd1de21df0454e1c0c189f84b2421e54801a01968d7755300"} build_url:https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/Z1CdKKxtSOGt06EfBMa95A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c614322fc3d164b941761ced3f5e9dd71b06c953e42bdd59c67de0f9f5b81a9f48dbd307527f1e393d1393e3962fc161b1e8c026b5111eb98531385453421d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81996c47f9d93839e228cd79eeebbc93944c349d1e033a5e9f3ec273fa8cc07dcefc3d2871ec7fa0ead25f8c0c4a6713301e4e70b67da63cab63d2056de49f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/073ebd00eb6ee0b78a078964efee2372d8be06ef77163f30a95ab127afbee60efbbefaa2a3ec4bccd1de21df0454e1c0c189f84b2421e54801a01968d7755300"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:20:31.711603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:20:31.711996) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464987527.208089-1789540023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:20:31.765843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:20:31.766227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:20:31.766592) ========= ========= Total master_lag: 0.15 =========