builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1464281013.9 results: success (0) buildid: 20160526091355 builduid: 4b8a8ac26a5a48e7a8af3df2fac55a1f revision: 73912a342d3731b8e292229fa940b623a8719d7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:33.899268) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:33.899700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:33.899996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:33.922382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:33.922660) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 09:43:34-- 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% 26.5M=0s 2016-05-26 09:43:34 (26.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.071871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.072157) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.127551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.127870) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 73912a342d3731b8e292229fa940b623a8719d7b --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 73912a342d3731b8e292229fa940b623a8719d7b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 09:43:35,122 truncating revision to first 12 chars 2016-05-26 09:43:35,122 Setting DEBUG logging. 2016-05-26 09:43:35,122 attempt 1/10 2016-05-26 09:43:35,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/73912a342d37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 09:43:35,424 unpacking tar archive at: fx-team-73912a342d37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.804280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.805098) ========= script_repo_revision: 73912a342d3731b8e292229fa940b623a8719d7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.806162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.806884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 09:43:34.833507) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-26 09:43:34.834311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:35 INFO - MultiFileLogger online at 20160526 09:43:35 in /builds/slave/test 09:43:35 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 09:43:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:35 INFO - {'append_to_log': False, 09:43:35 INFO - 'base_work_dir': '/builds/slave/test', 09:43:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:43:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:35 INFO - 'branch': 'Fx-Team-Non-PGO', 09:43:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:35 INFO - 'config_files': ('talos/linux_config.py',), 09:43:35 INFO - 'default_actions': ('clobber', 09:43:35 INFO - 'read-buildbot-config', 09:43:35 INFO - 'download-and-extract', 09:43:35 INFO - 'populate-webroot', 09:43:35 INFO - 'create-virtualenv', 09:43:35 INFO - 'install', 09:43:35 INFO - 'run-tests'), 09:43:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:35 INFO - 'download_minidump_stackwalk': True, 09:43:35 INFO - 'download_symbols': 'ondemand', 09:43:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:35 INFO - 'installer_path': 'installer.exe', 09:43:35 INFO - 'log_level': 'info', 09:43:35 INFO - 'log_name': 'talos', 09:43:35 INFO - 'log_to_console': True, 09:43:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:35 INFO - 'opt_config_files': (), 09:43:35 INFO - 'pip_index': False, 09:43:35 INFO - 'sps_profile': False, 09:43:35 INFO - 'sps_profile_interval': 0, 09:43:35 INFO - 'suite': 'dromaeojs', 09:43:35 INFO - 'system_bits': '32', 09:43:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:35 INFO - 'title': 'talos-linux64-ix-012', 09:43:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:35 INFO - 'use_talos_json': True, 09:43:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:35 INFO - 'work_dir': 'build'} 09:43:35 INFO - ##### 09:43:35 INFO - ##### Running clobber step. 09:43:35 INFO - ##### 09:43:35 INFO - Running pre-action listener: _resource_record_pre_action 09:43:35 INFO - Running main action method: clobber 09:43:35 INFO - rmtree: /builds/slave/test/build 09:43:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:36 INFO - Running post-action listener: _resource_record_post_action 09:43:36 INFO - ##### 09:43:36 INFO - ##### Finished clobber step (success) 09:43:36 INFO - ##### 09:43:36 INFO - ##### 09:43:36 INFO - ##### Running read-buildbot-config step. 09:43:36 INFO - ##### 09:43:36 INFO - Running pre-action listener: _resource_record_pre_action 09:43:36 INFO - Running main action method: read_buildbot_config 09:43:36 INFO - Using buildbot properties: 09:43:36 INFO - { 09:43:36 INFO - "project": "", 09:43:36 INFO - "product": "firefox", 09:43:36 INFO - "script_repo_revision": "production", 09:43:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:43:36 INFO - "repository": "", 09:43:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:43:36 INFO - "buildid": "20160526091355", 09:43:36 INFO - "pgo_build": "False", 09:43:36 INFO - "basedir": "/builds/slave/test", 09:43:36 INFO - "buildnumber": 3009, 09:43:36 INFO - "slavename": "talos-linux64-ix-012", 09:43:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:43:36 INFO - "platform": "ubuntu64_hw", 09:43:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:43:36 INFO - "branch": "fx-team", 09:43:36 INFO - "repo_path": "integration/fx-team", 09:43:36 INFO - "revision": "73912a342d3731b8e292229fa940b623a8719d7b", 09:43:36 INFO - "stage_platform": "linux64", 09:43:36 INFO - "builduid": "4b8a8ac26a5a48e7a8af3df2fac55a1f", 09:43:36 INFO - "slavebuilddir": "test" 09:43:36 INFO - } 09:43:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:43:36 INFO - Running post-action listener: _resource_record_post_action 09:43:36 INFO - ##### 09:43:36 INFO - ##### Finished read-buildbot-config step (success) 09:43:36 INFO - ##### 09:43:36 INFO - ##### 09:43:36 INFO - ##### Running download-and-extract step. 09:43:36 INFO - ##### 09:43:36 INFO - Running pre-action listener: _resource_record_pre_action 09:43:36 INFO - Running main action method: download_and_extract 09:43:36 INFO - mkdir: /builds/slave/test/build/tests 09:43:36 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')]} 09:43:36 INFO - https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:43 INFO - Downloaded 1361 bytes. 09:43:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:43:43 INFO - Using the following test package requirements: 09:43:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:43:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:43:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'jsshell-linux-x86_64.zip'], 09:43:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:43:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:43:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:43:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:43:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:43:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:43:43 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')]} 09:43:43 INFO - https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:48 INFO - Downloaded 22835570 bytes. 09:43:48 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'] 09:43:48 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 09:43:50 INFO - Return code: 0 09:43:50 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 09:43: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')]} 09:43:50 INFO - https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:52 INFO - Downloaded 22835570 bytes. 09:43:52 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'] 09:43:52 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 09:43:53 INFO - Return code: 0 09:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:53 INFO - https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:55 INFO - Downloaded 10834034 bytes. 09:43:55 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'] 09:43:55 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 09:43:55 INFO - Return code: 0 09:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:55 INFO - https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:43:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:43:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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 09:43:56 INFO - Downloaded 54825195 bytes. 09:43:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:43:56 INFO - mkdir: /builds/slave/test/properties 09:43:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:43:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:43:56 INFO - Contents: 09:43:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:43:57 INFO - Running post-action listener: _resource_record_post_action 09:43:57 INFO - Running post-action listener: set_extra_try_arguments 09:43:57 INFO - ##### 09:43:57 INFO - ##### Finished download-and-extract step (success) 09:43:57 INFO - ##### 09:43:57 INFO - ##### 09:43:57 INFO - ##### Running populate-webroot step. 09:43:57 INFO - ##### 09:43:57 INFO - Running pre-action listener: _resource_record_pre_action 09:43:57 INFO - Running main action method: populate_webroot 09:43:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:57 INFO - '--tppagecycles', 09:43:57 INFO - '7'], 09:43:57 INFO - 'tests': ['tsvgm']}}, 09:43:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:43:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:43:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:43:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['damp', 'tps']}, 09:43:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'tests': ['damp', 'tps']}, 09:43:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['dromaeo_dom']}, 09:43:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['a11yr', 09:43:57 INFO - 'ts_paint', 09:43:57 INFO - 'tpaint', 09:43:57 INFO - 'sessionrestore', 09:43:57 INFO - 'sessionrestore_no_auto_restore', 09:43:57 INFO - 'tabpaint']}, 09:43:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:43:57 INFO - 'ts_paint', 09:43:57 INFO - 'tpaint', 09:43:57 INFO - 'sessionrestore', 09:43:57 INFO - 'sessionrestore_no_auto_restore', 09:43:57 INFO - 'tabpaint']}, 09:43:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:43:57 INFO - 'ts_paint', 09:43:57 INFO - 'tpaint', 09:43:57 INFO - 'sessionrestore', 09:43:57 INFO - 'sessionrestore_no_auto_restore', 09:43:57 INFO - 'tabpaint']}, 09:43:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:43:57 INFO - 'ts_paint', 09:43:57 INFO - 'tpaint', 09:43:57 INFO - 'sessionrestore', 09:43:57 INFO - 'sessionrestore_no_auto_restore', 09:43:57 INFO - 'tabpaint']}, 09:43:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['a11yr', 09:43:57 INFO - 'ts_paint', 09:43:57 INFO - 'tpaint', 09:43:57 INFO - 'sessionrestore', 09:43:57 INFO - 'sessionrestore_no_auto_restore', 09:43:57 INFO - 'tabpaint']}, 09:43:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['a11yr', 09:43:57 INFO - 'ts_paint', 09:43:57 INFO - 'tpaint', 09:43:57 INFO - 'sessionrestore', 09:43:57 INFO - 'sessionrestore_no_auto_restore', 09:43:57 INFO - 'tabpaint']}, 09:43:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['tsvgx', 09:43:57 INFO - 'tsvgr_opacity', 09:43:57 INFO - 'tart', 09:43:57 INFO - 'tscrollx', 09:43:57 INFO - 'cart']}, 09:43:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:43:57 INFO - 'tsvgr_opacity', 09:43:57 INFO - 'tart', 09:43:57 INFO - 'tscrollx', 09:43:57 INFO - 'cart']}, 09:43:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'talos_options': ['--disable-e10s'], 09:43:57 INFO - 'tests': ['tp5o']}, 09:43:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'tests': ['tp5o']}, 09:43:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'talos_options': ['--disable-e10s', 09:43:57 INFO - '--xperf_path', 09:43:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:57 INFO - 'tests': ['tp5n']}, 09:43:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:57 INFO - 'talos_options': ['--xperf_path', 09:43:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:57 INFO - 'tests': ['tp5n']}}, 09:43:57 INFO - 'talos.zip': {'path': '', 09:43:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:57 INFO - Running post-action listener: _resource_record_post_action 09:43:57 INFO - ##### 09:43:57 INFO - ##### Finished populate-webroot step (success) 09:43:57 INFO - ##### 09:43:57 INFO - ##### 09:43:57 INFO - ##### Running create-virtualenv step. 09:43:57 INFO - ##### 09:43:57 INFO - Running pre-action listener: _resource_record_pre_action 09:43:57 INFO - Running main action method: create_virtualenv 09:43:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:43:57 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 09:43:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:43:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:57 INFO - Using real prefix '/usr' 09:43:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:43:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:44:00 INFO - Installing pip.................done. 09:44:00 INFO - Return code: 0 09:44:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:00 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:00 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 09:44:00 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 09:44:00 INFO - Using env: {'DISPLAY': ':0', 09:44:00 INFO - 'HOME': '/home/cltbld', 09:44:00 INFO - 'LANG': 'en_US.UTF-8', 09:44:00 INFO - 'LANGUAGE': 'en_US:en', 09:44:00 INFO - 'LOGNAME': 'cltbld', 09:44:00 INFO - 'MAIL': '/var/mail/cltbld', 09:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:00 INFO - 'MOZ_NO_REMOTE': '1', 09:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:00 INFO - 'NO_EM_RESTART': '1', 09:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:00 INFO - 'PWD': '/builds/slave/test', 09:44:00 INFO - 'SHELL': '/bin/bash', 09:44:00 INFO - 'SHLVL': '1', 09:44:00 INFO - 'TERM': 'linux', 09:44:00 INFO - 'TMOUT': '86400', 09:44:00 INFO - 'USER': 'cltbld', 09:44:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:00 INFO - '_': '/tools/buildbot/bin/python'} 09:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:00 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 09:44:00 INFO - Cleaning up... 09:44:00 INFO - Return code: 0 09:44:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:00 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:00 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 09:44:00 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 09:44:00 INFO - Using env: {'DISPLAY': ':0', 09:44:00 INFO - 'HOME': '/home/cltbld', 09:44:00 INFO - 'LANG': 'en_US.UTF-8', 09:44:00 INFO - 'LANGUAGE': 'en_US:en', 09:44:00 INFO - 'LOGNAME': 'cltbld', 09:44:00 INFO - 'MAIL': '/var/mail/cltbld', 09:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:00 INFO - 'MOZ_NO_REMOTE': '1', 09:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:00 INFO - 'NO_EM_RESTART': '1', 09:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:00 INFO - 'PWD': '/builds/slave/test', 09:44:00 INFO - 'SHELL': '/bin/bash', 09:44:00 INFO - 'SHLVL': '1', 09:44:00 INFO - 'TERM': 'linux', 09:44:00 INFO - 'TMOUT': '86400', 09:44:00 INFO - 'USER': 'cltbld', 09:44:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:00 INFO - '_': '/tools/buildbot/bin/python'} 09:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:00 INFO - Downloading/unpacking psutil>=3.1.1 09:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:44:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:02 INFO - Installing collected packages: psutil 09:44:02 INFO - Running setup.py install for psutil 09:44:02 INFO - building 'psutil._psutil_linux' extension 09:44:02 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 09:44:02 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 09:44:02 INFO - building 'psutil._psutil_posix' extension 09:44:02 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 09:44: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 09:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:03 INFO - Successfully installed psutil 09:44:03 INFO - Cleaning up... 09:44:03 INFO - Return code: 0 09:44:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:03 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:03 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 09:44:03 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 09:44:03 INFO - Using env: {'DISPLAY': ':0', 09:44:03 INFO - 'HOME': '/home/cltbld', 09:44:03 INFO - 'LANG': 'en_US.UTF-8', 09:44:03 INFO - 'LANGUAGE': 'en_US:en', 09:44:03 INFO - 'LOGNAME': 'cltbld', 09:44:03 INFO - 'MAIL': '/var/mail/cltbld', 09:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:03 INFO - 'MOZ_NO_REMOTE': '1', 09:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:03 INFO - 'NO_EM_RESTART': '1', 09:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:03 INFO - 'PWD': '/builds/slave/test', 09:44:03 INFO - 'SHELL': '/bin/bash', 09:44:03 INFO - 'SHLVL': '1', 09:44:03 INFO - 'TERM': 'linux', 09:44:03 INFO - 'TMOUT': '86400', 09:44:03 INFO - 'USER': 'cltbld', 09:44:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:03 INFO - '_': '/tools/buildbot/bin/python'} 09:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:44:05 INFO - Installing collected packages: mozsystemmonitor 09:44:05 INFO - Running setup.py install for mozsystemmonitor 09:44:05 INFO - Successfully installed mozsystemmonitor 09:44:05 INFO - Cleaning up... 09:44:05 INFO - Return code: 0 09:44:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:44:05 INFO - Using env: {'DISPLAY': ':0', 09:44:05 INFO - 'HOME': '/home/cltbld', 09:44:05 INFO - 'LANG': 'en_US.UTF-8', 09:44:05 INFO - 'LANGUAGE': 'en_US:en', 09:44:05 INFO - 'LOGNAME': 'cltbld', 09:44:05 INFO - 'MAIL': '/var/mail/cltbld', 09:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:05 INFO - 'MOZ_NO_REMOTE': '1', 09:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:05 INFO - 'NO_EM_RESTART': '1', 09:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:05 INFO - 'PWD': '/builds/slave/test', 09:44:05 INFO - 'SHELL': '/bin/bash', 09:44:05 INFO - 'SHLVL': '1', 09:44:05 INFO - 'TERM': 'linux', 09:44:05 INFO - 'TMOUT': '86400', 09:44:05 INFO - 'USER': 'cltbld', 09:44:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:05 INFO - '_': '/tools/buildbot/bin/python'} 09:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:44:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:44:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:08 INFO - Downloading docopt-0.6.1.tar.gz 09:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:44:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:44:08 INFO - Running setup.py install for blobuploader 09:44:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:44:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:44:08 INFO - Running setup.py install for requests 09:44:08 INFO - Running setup.py install for docopt 09:44:08 INFO - Successfully installed blobuploader requests docopt 09:44:08 INFO - Cleaning up... 09:44:08 INFO - Return code: 0 09:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:08 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 09:44:08 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 09:44:09 INFO - Using env: {'DISPLAY': ':0', 09:44:09 INFO - 'HOME': '/home/cltbld', 09:44:09 INFO - 'LANG': 'en_US.UTF-8', 09:44:09 INFO - 'LANGUAGE': 'en_US:en', 09:44:09 INFO - 'LOGNAME': 'cltbld', 09:44:09 INFO - 'MAIL': '/var/mail/cltbld', 09:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:09 INFO - 'MOZ_NO_REMOTE': '1', 09:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:09 INFO - 'NO_EM_RESTART': '1', 09:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:09 INFO - 'PWD': '/builds/slave/test', 09:44:09 INFO - 'SHELL': '/bin/bash', 09:44:09 INFO - 'SHLVL': '1', 09:44:09 INFO - 'TERM': 'linux', 09:44:09 INFO - 'TMOUT': '86400', 09:44:09 INFO - 'USER': 'cltbld', 09:44:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:09 INFO - '_': '/tools/buildbot/bin/python'} 09:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:09 INFO - Running setup.py (path:/tmp/pip-rlL2tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:09 INFO - Running setup.py (path:/tmp/pip-uU0KKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:09 INFO - Running setup.py (path:/tmp/pip-4FrZo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:09 INFO - Running setup.py (path:/tmp/pip-aw0CD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:09 INFO - Running setup.py (path:/tmp/pip-NTZqLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:09 INFO - Running setup.py (path:/tmp/pip-_XrR8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:09 INFO - Running setup.py (path:/tmp/pip-fobbGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:09 INFO - Running setup.py (path:/tmp/pip-Sr9M4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:09 INFO - Running setup.py (path:/tmp/pip-Y6X3_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:09 INFO - Running setup.py (path:/tmp/pip-gQ9ifx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:09 INFO - Running setup.py (path:/tmp/pip-nItHQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:09 INFO - Running setup.py (path:/tmp/pip-Dj_Gjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:10 INFO - Running setup.py (path:/tmp/pip-e7MA_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:10 INFO - Running setup.py (path:/tmp/pip-gsrCzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:10 INFO - Running setup.py (path:/tmp/pip-rwHtuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:10 INFO - Running setup.py (path:/tmp/pip-yvXiMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:10 INFO - Running setup.py (path:/tmp/pip-ZmyiAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:44:10 INFO - Running setup.py install for manifestparser 09:44:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:44:10 INFO - Running setup.py install for mozcrash 09:44:10 INFO - Running setup.py install for mozdebug 09:44:10 INFO - Running setup.py install for mozdevice 09:44:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:44:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:44:10 INFO - Running setup.py install for mozfile 09:44:10 INFO - Running setup.py install for mozhttpd 09:44:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for mozinfo 09:44:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for mozInstall 09:44:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for mozleak 09:44:11 INFO - Running setup.py install for mozlog 09:44:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for moznetwork 09:44:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for mozprocess 09:44:11 INFO - Running setup.py install for mozprofile 09:44:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for mozrunner 09:44:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:44:11 INFO - Running setup.py install for mozscreenshot 09:44:11 INFO - Running setup.py install for moztest 09:44:12 INFO - Running setup.py install for mozversion 09:44:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:44:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:44:12 INFO - Cleaning up... 09:44:12 INFO - Return code: 0 09:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:12 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:12 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 09:44:12 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 09:44:12 INFO - Using env: {'DISPLAY': ':0', 09:44:12 INFO - 'HOME': '/home/cltbld', 09:44:12 INFO - 'LANG': 'en_US.UTF-8', 09:44:12 INFO - 'LANGUAGE': 'en_US:en', 09:44:12 INFO - 'LOGNAME': 'cltbld', 09:44:12 INFO - 'MAIL': '/var/mail/cltbld', 09:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:12 INFO - 'MOZ_NO_REMOTE': '1', 09:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:12 INFO - 'NO_EM_RESTART': '1', 09:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:12 INFO - 'PWD': '/builds/slave/test', 09:44:12 INFO - 'SHELL': '/bin/bash', 09:44:12 INFO - 'SHLVL': '1', 09:44:12 INFO - 'TERM': 'linux', 09:44:12 INFO - 'TMOUT': '86400', 09:44:12 INFO - 'USER': 'cltbld', 09:44:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:12 INFO - '_': '/tools/buildbot/bin/python'} 09:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:12 INFO - Running setup.py (path:/tmp/pip-IGrSPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:12 INFO - Running setup.py (path:/tmp/pip-FuU_xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:12 INFO - Running setup.py (path:/tmp/pip-gku1IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:12 INFO - Running setup.py (path:/tmp/pip-JmDXJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:12 INFO - Running setup.py (path:/tmp/pip-bVlckl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:12 INFO - Running setup.py (path:/tmp/pip-8T137r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:12 INFO - Running setup.py (path:/tmp/pip-XDFe2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:12 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)) 09:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:12 INFO - Running setup.py (path:/tmp/pip-PXVPmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:13 INFO - Running setup.py (path:/tmp/pip-uYY3lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:13 INFO - Running setup.py (path:/tmp/pip-5A2v5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:13 INFO - Running setup.py (path:/tmp/pip-bJegnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:13 INFO - Running setup.py (path:/tmp/pip-qZ89DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:13 INFO - Running setup.py (path:/tmp/pip-0zzPIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:13 INFO - Running setup.py (path:/tmp/pip-ehUoLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:13 INFO - Running setup.py (path:/tmp/pip-FKID1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:13 INFO - Running setup.py (path:/tmp/pip-uVjfwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:13 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)) 09:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:13 INFO - Running setup.py (path:/tmp/pip-Gxcajw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:13 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)) 09:44:13 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)) 09:44:13 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)) 09:44:13 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)) 09:44:13 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)) 09:44:13 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)) 09:44:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:13 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 09:44:13 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 09:44:13 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 09:44:13 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 09:44:13 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 09:44:13 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 09:44:15 INFO - Downloading blessings-1.6.tar.gz 09:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:15 INFO - Installing collected packages: blessings 09:44:15 INFO - Running setup.py install for blessings 09:44:15 INFO - Successfully installed blessings 09:44:15 INFO - Cleaning up... 09:44:15 INFO - Return code: 0 09:44:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:16 INFO - Reading from file tmpfile_stdout 09:44:16 INFO - Current package versions: 09:44:16 INFO - argparse == 1.2.1 09:44:16 INFO - blessings == 1.6 09:44:16 INFO - blobuploader == 1.2.4 09:44:16 INFO - docopt == 0.6.1 09:44:16 INFO - manifestparser == 1.1 09:44:16 INFO - mozInstall == 1.12 09:44:16 INFO - mozcrash == 0.17 09:44:16 INFO - mozdebug == 0.1 09:44:16 INFO - mozdevice == 0.48 09:44:16 INFO - mozfile == 1.2 09:44:16 INFO - mozhttpd == 0.7 09:44:16 INFO - mozinfo == 0.9 09:44:16 INFO - mozleak == 0.1 09:44:16 INFO - mozlog == 3.2 09:44:16 INFO - moznetwork == 0.27 09:44:16 INFO - mozprocess == 0.22 09:44:16 INFO - mozprofile == 0.28 09:44:16 INFO - mozrunner == 6.11 09:44:16 INFO - mozscreenshot == 0.1 09:44:16 INFO - mozsystemmonitor == 0.3 09:44:16 INFO - moztest == 0.7 09:44:16 INFO - mozversion == 1.4 09:44:16 INFO - psutil == 3.1.1 09:44:16 INFO - requests == 1.2.3 09:44:16 INFO - wsgiref == 0.1.2 09:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:16 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')]} 09:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:16 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')]} 09:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:16 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:16 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 09:44:16 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 09:44:16 INFO - Using env: {'DISPLAY': ':0', 09:44:16 INFO - 'HOME': '/home/cltbld', 09:44:16 INFO - 'LANG': 'en_US.UTF-8', 09:44:16 INFO - 'LANGUAGE': 'en_US:en', 09:44:16 INFO - 'LOGNAME': 'cltbld', 09:44:16 INFO - 'MAIL': '/var/mail/cltbld', 09:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:16 INFO - 'MOZ_NO_REMOTE': '1', 09:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:16 INFO - 'NO_EM_RESTART': '1', 09:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:16 INFO - 'PWD': '/builds/slave/test', 09:44:16 INFO - 'SHELL': '/bin/bash', 09:44:16 INFO - 'SHLVL': '1', 09:44:16 INFO - 'TERM': 'linux', 09:44:16 INFO - 'TMOUT': '86400', 09:44:16 INFO - 'USER': 'cltbld', 09:44:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:16 INFO - '_': '/tools/buildbot/bin/python'} 09:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 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)) 09:44:16 INFO - Cleaning up... 09:44:16 INFO - Return code: 0 09:44:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:44:16 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')]} 09:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:16 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')]} 09:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:16 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:16 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 09:44:16 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 09:44:16 INFO - Using env: {'DISPLAY': ':0', 09:44:16 INFO - 'HOME': '/home/cltbld', 09:44:16 INFO - 'LANG': 'en_US.UTF-8', 09:44:16 INFO - 'LANGUAGE': 'en_US:en', 09:44:16 INFO - 'LOGNAME': 'cltbld', 09:44:16 INFO - 'MAIL': '/var/mail/cltbld', 09:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:16 INFO - 'MOZ_NO_REMOTE': '1', 09:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:16 INFO - 'NO_EM_RESTART': '1', 09:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:16 INFO - 'PWD': '/builds/slave/test', 09:44:16 INFO - 'SHELL': '/bin/bash', 09:44:16 INFO - 'SHLVL': '1', 09:44:16 INFO - 'TERM': 'linux', 09:44:16 INFO - 'TMOUT': '86400', 09:44:16 INFO - 'USER': 'cltbld', 09:44:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:16 INFO - '_': '/tools/buildbot/bin/python'} 09:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:16 INFO - Downloading/unpacking jsonschema 09:44:16 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 09:44:16 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 09:44:16 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 09:44:16 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 09:44:16 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 09:44:16 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 09:44:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:44:18 INFO - Downloading/unpacking functools32 (from jsonschema) 09:44:18 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 09:44:18 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 09:44:18 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 09:44:18 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 09:44:18 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 09:44:18 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 09:44:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:44:18 INFO - warning: no files found matching '*.txt' 09:44:18 INFO - no previously-included directories found matching 'build' 09:44:18 INFO - no previously-included directories found matching 'dist' 09:44:18 INFO - no previously-included directories found matching '.git*' 09:44:18 INFO - Installing collected packages: jsonschema, functools32 09:44:18 INFO - Running setup.py install for functools32 09:44:18 INFO - warning: no files found matching '*.txt' 09:44:18 INFO - no previously-included directories found matching 'build' 09:44:18 INFO - no previously-included directories found matching 'dist' 09:44:18 INFO - no previously-included directories found matching '.git*' 09:44:18 INFO - Successfully installed jsonschema functools32 09:44:18 INFO - Cleaning up... 09:44:18 INFO - Return code: 0 09:44:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:18 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 0x7fa9a2429f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', '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 09:44:18 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 09:44:18 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 09:44:18 INFO - Using env: {'DISPLAY': ':0', 09:44:18 INFO - 'HOME': '/home/cltbld', 09:44:18 INFO - 'LANG': 'en_US.UTF-8', 09:44:18 INFO - 'LANGUAGE': 'en_US:en', 09:44:18 INFO - 'LOGNAME': 'cltbld', 09:44:18 INFO - 'MAIL': '/var/mail/cltbld', 09:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:18 INFO - 'MOZ_NO_REMOTE': '1', 09:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:18 INFO - 'NO_EM_RESTART': '1', 09:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:18 INFO - 'PWD': '/builds/slave/test', 09:44:18 INFO - 'SHELL': '/bin/bash', 09:44:18 INFO - 'SHLVL': '1', 09:44:18 INFO - 'TERM': 'linux', 09:44:18 INFO - 'TMOUT': '86400', 09:44:18 INFO - 'USER': 'cltbld', 09:44:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:18 INFO - '_': '/tools/buildbot/bin/python'} 09:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:19 INFO - Downloading/unpacking flake8 09:44:19 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 09:44:19 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 09:44:19 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 09:44:19 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 09:44:19 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 09:44:19 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 09:44:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:44:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:44:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 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 09:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:44:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:44:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:44:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:44:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:44:21 INFO - no previously-included directories found matching 'docs/_build' 09:44:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:44:21 INFO - Running setup.py install for pep8 09:44:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:44:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:44:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:44:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:44:21 INFO - no previously-included directories found matching 'docs/_build' 09:44:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:44:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:44:21 INFO - Cleaning up... 09:44:22 INFO - Return code: 0 09:44:22 INFO - Running post-action listener: _resource_record_post_action 09:44:22 INFO - Running post-action listener: _start_resource_monitoring 09:44:22 INFO - Starting resource monitoring. 09:44:22 INFO - ##### 09:44:22 INFO - ##### Finished create-virtualenv step (success) 09:44:22 INFO - ##### 09:44:22 INFO - ##### 09:44:22 INFO - ##### Running install step. 09:44:22 INFO - ##### 09:44:22 INFO - Running pre-action listener: _resource_record_pre_action 09:44:22 INFO - Running main action method: install 09:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:22 INFO - Reading from file tmpfile_stdout 09:44:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:22 INFO - Reading from file tmpfile_stdout 09:44:22 INFO - Output received: 09:44:22 INFO - Usage: mozinstall [options] installer 09:44:22 INFO - Options: 09:44:22 INFO - -h, --help show this help message and exit 09:44:22 INFO - -d DEST, --destination=DEST 09:44:22 INFO - Directory to install application into. [default: 09:44:22 INFO - "/builds/slave/test"] 09:44:22 INFO - --app=APP Application being installed. [default: firefox] 09:44:22 INFO - mkdir: /builds/slave/test/build/application 09:44:22 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'] 09:44:22 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 09:44:38 INFO - Reading from file tmpfile_stdout 09:44:38 INFO - Output received: 09:44:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:44:38 INFO - Running post-action listener: _resource_record_post_action 09:44:38 INFO - ##### 09:44:38 INFO - ##### Finished install step (success) 09:44:38 INFO - ##### 09:44:38 INFO - ##### 09:44:38 INFO - ##### Running run-tests step. 09:44:38 INFO - ##### 09:44:38 INFO - Running pre-action listener: _resource_record_pre_action 09:44:38 INFO - Running main action method: run_tests 09:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:38 INFO - Python 2.7.3 09:44:38 INFO - Return code: 0 09:44:38 INFO - grabbing minidump binary from tooltool 09:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:38 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 0x12429c0>, '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 0x12438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:38 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 09:44:38 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 09:44:38 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 09:44:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:38 INFO - Return code: 0 09:44:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:44:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:44:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:44:39 INFO - Return code: 0 09:44:39 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/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:44:39 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/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:44:39 INFO - Using env: {'DISPLAY': ':0', 09:44:39 INFO - 'HOME': '/home/cltbld', 09:44:39 INFO - 'LANG': 'en_US.UTF-8', 09:44:39 INFO - 'LANGUAGE': 'en_US:en', 09:44:39 INFO - 'LOGNAME': 'cltbld', 09:44:39 INFO - 'MAIL': '/var/mail/cltbld', 09:44:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:39 INFO - 'MOZ_NO_REMOTE': '1', 09:44:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:39 INFO - 'NO_EM_RESTART': '1', 09:44:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:39 INFO - 'PWD': '/builds/slave/test', 09:44:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:39 INFO - 'SHELL': '/bin/bash', 09:44:39 INFO - 'SHLVL': '1', 09:44:39 INFO - 'TERM': 'linux', 09:44:39 INFO - 'TMOUT': '86400', 09:44:39 INFO - 'USER': 'cltbld', 09:44:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238', 09:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:39 INFO - '_': '/tools/buildbot/bin/python'} 09:44:39 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/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:44:39 INFO - mozversion application_buildid: 20160526091355 09:44:39 INFO - mozversion application_changeset: 73912a342d3731b8e292229fa940b623a8719d7b 09:44:39 INFO - mozversion application_display_name: Nightly 09:44:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:39 INFO - mozversion application_name: Firefox 09:44:39 INFO - mozversion application_remotingname: firefox 09:44:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:44:39 INFO - mozversion application_vendor: Mozilla 09:44:39 INFO - mozversion application_version: 49.0a1 09:44:39 INFO - mozversion platform_buildid: 20160526091355 09:44:39 INFO - mozversion platform_changeset: 73912a342d3731b8e292229fa940b623a8719d7b 09:44:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:44:39 INFO - mozversion platform_version: 49.0a1 09:44:39 INFO - using testdate: 1464281079 09:44:39 INFO - actual date: 1464281079 09:44:39 INFO - starting webserver on 'localhost:46117' 09:44:39 INFO - SUITE-START | Running 2 tests 09:44:39 INFO - TEST-START | dromaeo_css 09:44:39 INFO - operating with platform_type : linux_ 09:44:39 INFO - Initialising browser for dromaeo_css test... 09:44:39 INFO - TEST-INFO | started process 22792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Ldzbx/profile http://localhost:46117/getInfo.html) 09:44:43 INFO - PROCESS | 22792 | __metrics Screen width/height:1600/1200 09:44:43 INFO - PROCESS | 22792 | colorDepth:24 09:44:43 INFO - PROCESS | 22792 | Browser inner width/height: 1024/697 09:44:43 INFO - PROCESS | 22792 | __metrics 09:44:44 ERROR - PROCESS | 22792 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:44:44 INFO - TEST-INFO | 22792: exit 0 09:44:44 INFO - Browser initialized. 09:44:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:44:44 INFO - TEST-INFO | started process 22873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Ldzbx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:56 INFO - PROCESS | 22873 | RSS: Main: 156520448 09:44:56 INFO - PROCESS | 22873 | 09:45:48 INFO - PROCESS | 22873 | 1464281148406 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] 09:48:00 INFO - PROCESS | 22873 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46117/tests/dromaeo/cssquery-ext.html) 09:48:01 INFO - PROCESS | 22873 | RSS: Main: 251895808 09:48:01 INFO - PROCESS | 22873 | 09:51:03 INFO - PROCESS | 22873 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-ext.html (next: http://localhost:46117/tests/dromaeo/cssquery-jquery.html) 09:51:04 INFO - PROCESS | 22873 | RSS: Main: 243589120 09:51:04 INFO - PROCESS | 22873 | 09:54:06 INFO - PROCESS | 22873 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46117/tests/dromaeo/cssquery-mootools.html) 09:54:06 INFO - PROCESS | 22873 | RSS: Main: 235352064 09:54:06 INFO - PROCESS | 22873 | 09:57:09 INFO - PROCESS | 22873 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46117/tests/dromaeo/cssquery-prototype.html) 09:57:09 INFO - PROCESS | 22873 | RSS: Main: 236253184 09:57:09 INFO - PROCESS | 22873 | 10:00:12 INFO - PROCESS | 22873 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46117/tests/dromaeo/cssquery-yui.html) 10:00:13 INFO - PROCESS | 22873 | RSS: Main: 226816000 10:00:13 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-yui.html (next: http://localhost:46117/tests/dromaeo/cssquery-dojo.html) 10:03:16 INFO - PROCESS | 22873 | RSS: Main: 267264000 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | __start_tp_report 10:03:16 INFO - PROCESS | 22873 | _x_x_mozilla_page_load 10:03:16 INFO - PROCESS | 22873 | _x_x_mozilla_page_load_details 10:03:16 INFO - PROCESS | 22873 | |i|pagename|runs| 10:03:16 INFO - PROCESS | 22873 | |0;dojo.html;2690.690570584381;2703.7296270372963;2727.3454370950967;2733.945321093577;2752.5045491811466;4656.348111264426;4735.597474214687;4784.545468180521;4853.6359773017075;4900.460949295579;4725.480197178316;4783.784729687164;4792.6165906727465;4793.400824896888;4800.8319708810195;4377.1464564410035;4378.343248512717;4461.259321290418;4515.164694531522;4559.156556037127;4477.686561940665;4512.661550383718;4525.230710779176;4528.8867778305475;4577.519360467137;4311.28863737483;4322.654187664979;4356.302991521341;4362.563743625644;4408.823647054146;4390.341448782676;4399.626031787302;4414.05097903949;4450.35469856869;4460.933086003713;4438.4451943507065;4450.799714012877;4451.287793952952;4497.235469970113;4508.729476231437;4658.58072773452;4669.136209801198;4701.0127873146685;4734.431868175807;4803.615710743132;5135.794568217267;5164.741762911839;5189.377274727057;5192.55863251624;5198.038362902875;5204.271402003723;5209.322788037569;5224.346956630421;5237.685738855681;5243.318368612094;4652.232381657022;4846.830360937351;4857.198562237262;4881.316615673809;4974.8756281093265;5442.346918369742;5452.045891968969;5461.535769459561;5471.50756431923;5476.863078423071;5173.870653233699;5226.63413561047;5229.843104706865;5231.136862417735;5232.581393488512;5069.619778516552;5088.135017047037;5117.8464646060675;5119.897602047939;5304.575633949275;5093.617978651542;5098.413682426569;5104.285400043997;5109.080365534165;5151.5106064923775;5017.623678224148;5048.343715317059;5053.69677819332;5053.84838454847;5055.241713742968;4346.239408103569;4388.648908087345;4392.231359512072;4458.06380660065;4460.665450091256;3858.2283543291455;3912.550056743454;3922.99963509309;3927.6857851371824;3929.6070392960473;4461.464624245112;4464.352668862996;4502.752348620792;4504.527024662429;4576.039031803359;5271.4464981176425;5271.499207575274;5277.973610131925;5280.207968804633;5281.524662780368;4519.7740112994215;4522.389477420572;4527.9547204527535;4557.498675145731;4558.384618076518;4613.423322084739;4616.630669546428;4621.168189725814;4624.468186158568;4632.907341853144;4780.378550788375;4783.712977221308;4785.210440277316;4817.084753896748;4820.39745031871;5071.13790655582;5089.0839648862075;5119.078565858182;5140.280360749423;5142.922856157086;4777.95222047775;4817.614590832795;4822.132016237111;4838.395200599925;4869.878253043702;5082.186850103965;5084.084864724237;5101.005303965691;5107.387113546398;5137;5055.797768089235;5118.846434606968;5160.870978225575;5177.197534382177;5182.041322355376;5040.470750571284;5101.591872650253;5102.69383836971;5116.437191908962;5163.586913047023;5108.974455127849;5120.155174396332;5122.168966738445;5123.052235336475;5171.741412929414;4824.807007719652;4962.156433406401;4988.625853060962;5024.723640199678;5038.924416133687;5125.333706618116;5130.102232109441;5144.125498665161;5145.253938179018;5182.300389447376;5032.421271553671;5041.495850414929;5044.041632089891;5047.772850221675;5098.566621837037 10:03:16 INFO - PROCESS | 22873 | |1;ext.html;553.8200084972383;593.4362355762025;605.6789901352284;606.9423404776547;618.6782872906091;27051.5942260866;29946.25134371639;38875;39833.601663983354;39844.402333965016;38850;39176.60823391765;39245.803770981176;39249.21501569974;39317.41023884644;7768.883466748018;7968.482048666847;7969.203079692043;7969.442139050268;7970;7731.458797884122;7879.763607091796;7880.36957043438;7881.330086942617;7886.250806173433;7833.569153696544;7931.087924888654;7942.205779422041;7942.444028917978;7946.324562412173;7840.764777056669;7881.014873140857;7884.053913530413;7895.249951254622;7897.960510197441;7758.379329653614;7844.411669124838;7845.725399610987;7850.685972561091;7851.05787305527;38075.238495230216;38427.615723842966;38438.23123537542;38487.615123848685;38513.807430962945;3099.4575949209025;3301.851416686255;3501.7898926064263;3691.667749902522;3785.4889589905288;29102.70897291021;29112;29718.108456746333;31839.84080079608;32662.83668581642;3328.8834890778708;3342.96657033429;3382.1375549235036;3398.04854640701;3430.5540279763723;263722;266617;266739.6663016692;266861;266888;31235.375292494024;32216.516752248735;54767;55556.16665750017;55611.72194139003;34324.656753432646;34429.48355774665;34508.309833803185;34530.48204276938;34553.48169777455;12747;12880.549180778627;12883.227006379648;12887.54893578739;12887.806682899763;10424.843627345595;10499.475026248658;10518.421486818146;10524.579016839241;10527.789444211227;7888.960555197302;7900.68397264103;7940.602969851484;7996.480228785111;8019.35845132388;3098.90703278902;3100.116466806949;3115.345777386774;3162.414953233659;3177.602799650044;857.9442336248123;862.8619420892627;884.1600479544459;963.4749061761357;1047.167501836027;27120.864395677894;27815.331080135256;28094.157175284774;28321.71678283232;28377.71622283792;905.6875377994581;914.6250037484599;922.3635691372931;968.0368033806267;1062.251112965373;14503.274836258144;14639.414423423157;14787.92606036963;14979.775303370458;15033.173175475455;384377;386530;387371;388491;390027.89748922735;48255.75872120617;48885.511144888806;48885.75557122192;48931;48941;960.4861399151421;1149.3276433286621;1167.241293159453;1168.7253495428567;1195.9940200299118;27937;28550.42899142047;28966.85516572488;28967.40405689424;29240.561391578718;41395.58604413917;41532.1693566133;41916.161676766904;42006.15987680291;42047;299566;299879;300377;301338;301451;21388.57222855503;21745.565088698455;21957.890210548845;22140.225092122342;24823.875880621203;40798.59201408067;40934.59065409427;41245.38131928084;41299;41585;34923;35243.82378088093;35563.11092222715;35901.1024724384;36040.819795900854;34582.654173457944;35563.644363556035;35627.64372356347;35808.28383432369;36116;34325.31349372949;34505.482417763254;34736.47895281624;34904.47643285403;35383;30867.228319292197;31710.207244819063;31746.841265793522;32061.198470038435;32155.196120097185;24242.393940151636;24428.389290267885;24603;25029.74970250274;25064.498710026062 10:03:16 INFO - PROCESS | 22873 | |2;jquery.html;368.52276302188665;372.34467337486024;375.6863019378822;376.97172712046597;392.707432962443;15714.449994250204;16618;16931.57671058224;17014.149292535356;17256.74114888278;16060;16639;17211.91394043028;17242.568935776613;17250.137493125356;4994.925076123861;5187.092258854705;5210.322658054448;5210.843674689765;5211.009908117446;3761.8119094045323;3898.8440462381473;5131.050755610206;5614.494695477406;5950.226470558821;5981.85045373867;5995.010823214165;6011.789587364443;6015.127806468059;6020.8494787630225;5851.239338885939;5881.411858814127;6036.7283472243635;6042.365551617061;6064;3408.812515311657;4992.700437973697;5295.549878260353;5304.708241046741;5306.70813105279;19781.40655780329;20623.381298561068;20674.17303307866;20682.069306881225;20755.792442075537;1875.3248830421037;1914.7606549181353;1977.4858536780396;1994.7905469925738;2040.6840827638434;8718.258947989429;8993.550322483916;9320.20778233844;9376.203022743075;9581.952090239574;1780.2256018631806;1793.2289115680253;1794.9641007179914;1817.318505560415;1886.6226754648987;58969.705151473965;59127.40872591262;59447;60101.39898601002;69268;10280.07479326864;10310.948445257876;10321.483925803679;10321.503382009567;10401.94799026;14059.78910316346;14063.648408789657;14193.225846769154;14201.218932958787;14208.715825683636;6933.2026816916705;7008.7546935857;7080.681369338392;7177.031100801325;7209.96395018032;6366.713497892606;6389.105525226472;6512.772052978123;6550.7707230246715;6649.833754156185;4228.957710422918;4435.467743870756;4439.156560253541;4458.576435238647;4508.616767574727;1705.4372057221087;1791.7176781515502;1800.6938820400562;1806.2323512507394;1811.0802549297787;808.3008197908766;819.148085990575;853.5177624642057;883.1786438612024;947.545178314413;16375.508734737978;17020.234089466005;17099.487015389557;17492.53167514165;17533.473995780147;873.4846440600077;881.4226681523612;913.2967614936595;945.6170251048336;949.4350861237552;9502.334836561513;9587.760305992266;9733.270004749673;9741.269404794668;10008.64969726056;373761;375468;375956;382159;382959;46007;58051.70974145102;77437.22562774413;78121.48453319614;78186.6090669543;946.7917058247175;964.4599024546277;968.3270127261626;969.8254314223367;971.1890571372842;15644.843551564794;15692.293846776694;15785.28966196547;15799.921000395385;16114.838851611803;34677;34856.30287394187;35439.82280088583;35449.82275088608;36224.27551449009;47106.528934710215;49475.25787113268;49501;49645.25532117093;49764;7192.496525243183;7200.53196542244;7226.421886248982;7308.671109799965;7430.368418684472;9151.496667683075;10611;10678.145748339959;10709.357438553712;11383.772324553629;8652.524111173945;8688.435251708619;8919.777005574913;9018.684346047858;9329.626814927598;5374.193870919394;9569.760755981157;9875.55559999816;9880.950595246977;9955.800883982425;9029.503377314311;9060.864087038568;9172.633094676405;9208;9255.167034966886;6775.661216939035;6874;6903.896441553481;7011.6494175292055;7150.499465037397;8800.779980500538;8802.779930501789;8841.734747957571;8930.151635594608;9199.678011269574 10:03:16 INFO - PROCESS | 22873 | |3;mootools.html;1284.9357532123404;1424.0063910525266;1451.941922323107;1581.8259991400944;1771.554326834307;6762.628055456948;7700;7906.2489063539015;7907.20927907209;8095.311898488636;7859.528428294307;7956.244156805109;8000.839983200332;8013.679452821894;8014.519128852273;1865.8600604954615;2158.967615485769;2172.142003908455;2186.6392045312505;2235.485838257194;2279.2022792022826;2300.0454811253308;2300.620397634388;2301.413139649387;2303.67748515208;2237.429455488848;2259.7966183043523;2260.3445000949705;2264.2867496738477;2270.3416009357265;1806.2774890043956;2087.3633541769755;2121.4908421978766;2140.7110040144535;2149;2107.136074209582;2122.278425335378;2125.203048856679;2128.404046866864;2128.4040468668795;7931.286184243446;7976.8404631907615;7984.840303193903;7984.880226796603;7990.960045199795;4587.7017993830295;4696.084263568606;4701.271302948048;4701.929471057937;4709.246520556729;2837.645294338208;2870.937753031371;3022.909312720622;3048.268415580245;3051.2219384056925;957.861110139026;960.2414092866627;980.4460479828874;984.3454103021483;984.6799790068185;10924.563017479291;10942.835857462223;10963.068139208177;10966.780664386668;10991.670249892515;4234.491860976703;4294.098239369768;4375.365571992107;4395.384646149541;4403.2734598791485;9207.033261507579;9229.861552076723;9236.261099112055;9243.722688319362;9260.351775375659;4573.039661671086;4583.610393116623;4584.4498660161;4585.243434833282;4586.4266966629175;3562.946555801665;4059.817308221137;4175.561566035583;4186;4257.297545904953;3700.518932538753;3728.813559322023;3802.524684414448;3846.615338466131;3871.3999330103316;1207.124834494984;1231.5751065882257;1236.116176933497;1256.39065053449;1268.2390565660714;770.9807254818562;803.9397045221632;822.9012518497699;826.1119296756011;841.2260720137489;4903.901921961541;5093.363329583802;5095.261187127846;5209.192575150858;5224.9738751306;830.0495932157646;844.1094645149426;865.4547634990042;870.9216170544555;880.5905254056894;3234.838258087086;3369.0735047862036;3384.7292216623105;3399.2351720862607;3411.5564976553387;9613.663521776703;9923.354981926152;9953.552090155961;9963.900360996297;9979.051990060932;9594.280428967715;9780.510974451248;9797.314188006914;9875.012498750211;9889.45607991553;7409.222031686703;7504.474686771873;7524.398048156135;7545.6981720730555;7551.244875512514;4749.2876068589985;4750.881227969328;4756.215224487921;4779.330893674819;4789.95210047909;8938;9205.677801277192;9217.539123043955;9235.953820230856;9342.673006444742;9296.814063718553;9360.625574976924;9398.342116052085;9413.388129771543;9418.058194180527;5225.294585230945;6264.686765661608;6441.5490915635455;6460.095586617971;6556;7472;7480.70077196906;7516.511426757462;7532.510386824839;7542.094948606203;6783.18601767791;6925.515213934977;6927.792166235021;7018.368346848808;7091.929080709333;6868.519203655696;6914.204866440424;6936.132983377078;6967.198772141269;7026.9648651756415;6435.678216089083;6438.5171112165835;6475.1582294303325;6485.28661847187;6506.902396463962;4370.344448332648;4410.735355878657;4420.690551661352;4438.178936896685;4476.597106260452;4393.978030109829;4403.295472724477;4416.4258646375765;4512.210363186495;4568.840090596813 10:03:16 INFO - PROCESS | 22873 | |4;prototype.html;306.7944477200276;308.87490566320633;311.12573667992956;313.59702781925216;314.1470906488883;4760.404949381327;4766.904661906759;4819.301201325806;4830;4853.131544355418;4686;4725.929111063337;4736.407949006374;4736.952630473695;4737.744497708101;3540.946885796715;3642.1623026703874;3663.120850995755;3789.0906182516137;3813.771173729578;3772.58501564829;3785.6403641654138;3787.602301758317;3791.6777073948747;3793.487879136309;3739.233457141293;3761.793101379423;3764.1530655602405;3766.171442282707;3785.5835858055593;3554.484599733037;3619.9276014479697;3766.566844812854;3770.377887648535;3774.4904437900805;3265.200025993623;3331.900042998714;3336.498575640947;3340.5657264555693;3344.5986481622117;4567.588916997486;4574.987005717474;4575.588197062247;4601.861944141681;4605.171069207541;4052.16558276423;4246.320588705792;4253.574642535753;4295.646871235582;4300.591443812864;4973.602111831045;4979.975100124512;4990.30135780991;4990.70427603303;4998.7250701211415;3602.603713591503;3603.1352475405974;3604.098975256186;3619.7647152934974;3636.436352365361;5145;5163.974180129113;5294.364676238876;5305.655132416419;5315.707636080014;3704.685101766326;3729.4778730977687;3733.6079711629886;3738.43923411485;3741.7380783345448;3799.8670046548236;3801.847926082926;3802.980985095057;3811.256804923069;3812.1041555234497;4283.81525422037;4296.462942132233;4302.655787537052;4305.203537345601;4322.3516472528745;4885.438174609894;4928.482509336468;4997;5024.547790698854;5046.275011493825;1312.1995582694549;1318.7955866840655;1332.7934170203634;1341.5170538606094;1342.8321459817523;802.6829402386024;837.8718056137343;842.2083241752733;845.5245596434262;846.3060290561804;4312.223799716018;4430.8701281173735;4464.30803225494;4464.772187648357;4472.284434490531;5115.232715092691;5140;5148.536631703165;5175.301334319894;5198.792048318101;4359.912801743947;4422.800973956179;4441.333799930037;4471.530489298577;4496.168208881302;2575.7424257574094;2725.74105459981;2750.6561679790025;2754.807163498576;2757.7931655125944;4835.274708793639;4852.902941941142;4858.392700912386;4859.562639362403;4878.75577234469;5060.367454068241;5246.606504512177;5295.549878260314;5298.788048478018;5320.388155362106;4890.801753570398;4893.877653058702;4898.975505122452;4906.705597664223;4920.950790492121;5193.480651934777;5195.480451954774;5198.428172901054;5198.792048318176;5206.177837756755;4887.975560122177;5081.44104148536;5086.516780905808;5116.923246151385;5125.846224613268;4844.297576851407;4851.878703032452;4865.489123642108;4886.144924638245;4892.877678057935;3625.2386998729507;3637.7635453696485;3670.7063434924607;3673.210259794157;3709.944350834686;4905.5094490550655;5199.66202196856;5203.271541984201;5247.842564723064;5259.237410575522;4903.583195428429;4965.453800081916;4981.37732783402;4981.452040275494;5035.874103147304;4963.230699241623;4989.875253118701;4992.475790042138;5002.799888004584;5020.974895125501;4767.570918617341;4942.456329803791;4947.897143713979;4962.379702537183;4964.255361695775;4795.376601041842;4898.7550622468025;4903.215485522299;4903.926441103315;5071.503906347562;4792.640551958547;4835.709857408567;4837.612990960785;4910.852674419773;4920.868200314019 10:03:16 INFO - PROCESS | 22873 | |5;yui.html;645.6739346629957;676.4115219758811;711.3633298198113;738.1326940844507;741.97774066778;12434.316112613802;12444.502219911205;12532.373381330932;13388;13781.448742050306;13717.65705857354;13747.175169489838;13771.65570860729;13891.166530008206;13893.722125557508;640.5356116815318;788.5071830106184;812;818.9222023907749;819.8811172380001;810.9878351824698;817.9141190175005;818.1981657975188;818.5088946632003;819.3199644295221;853.5476197615274;859.1365677494109;859.1751918158575;859.4198915731887;859.7893516088536;671.7279501801778;816.3428440105713;845.218173189797;855.8245559660286;855.8587833007547;622.4460230394952;622.7540121651922;623.1649589549979;623.183629445428;623.3050149083784;12865.549705760253;12869.806952895715;12877.484900603964;12891.484340626364;12892.419841107172;11375.772484550263;11490.597829076025;11675.182737208399;11677.824832627517;12257.448414821354;9940.254480913887;10033;11161.274517156358;11167.944160279147;11181.72045698856;3119.5788568543185;3140.2463408781955;3151.5745374374624;3229.2249860033658;3264.1676372524853;46801.76599117017;46909;47021.5297847024;47093.529064709255;47306.688531802785;9770.218382529381;9802.313838031268;9873.654422095193;10010.64962726301;10093.798124037477;17221.91389043072;17250.65498690044;17268.13659317029;17270.395536156175;17374.305027798746;6727.327267273234;6753.696083676246;6812.659367031629;6816.131877550844;6881.243063263037;3787.223619158066;3804.771713697187;3806.790626515513;3824.78963656996;3904.6876249899938;2878.9856050719613;2982.791204615656;2982.925426864302;2983.582298478215;2998.1755017370397;494.91833847415495;516.073647802196;516.7287174233483;532.2043544900399;568.3151802078486;465.42287563421115;578.1356871477169;578.8060999565192;582.4990508162977;595.5354823237882;7099.538529995637;7241.601711905791;7406.8888966665545;7433.10802703679;7490.737824176128;442.57512787724147;500.3220636038116;525.5244004176227;535.5073332534078;561.2899681902396;3214.148250713563;3434.8820257815673;3463.6709512596262;3498.1254686328416;3534.6465353464446;54292.45707542953;54867;55236.44763552393;55678.72160639252;55825.44174558202;48768.51231487711;48949.597565032826;49472.50527494751;49719.751401242764;50036;45498.31752523715;46591;46802;47316.2902556455;47485.28772068422;7879.487833291047;7986.520808751494;7993.240642138988;8009.919900800917;8026.8685107395895;31323.06030819079;31380.843095784374;31579;31703.524447133772;32306.192345191557;38481.23037539177;40081.39877901892;42069.15861682688;42155.789221053696;42241;9862;10292.897071029493;10320.43237621938;10364.274500784873;10393.168546516412;10587.311824731676;11866.406679666155;11917.404129793302;11961.521539138685;12253.774622537674;9825.705228843146;9948.104670579683;10148.695539133838;10452.372857628567;10479.63321283782;10990.17573681961;11302.660920172408;11415.714607134889;11451.656450306504;11550.826737598774;10383.480825958823;10412.791744164922;10418.895811041793;10463.372197668165;10668.573257069631;8703.738887833375;9161.816763664823;9194.31042671789;9295.442273463614;9312.953435232781;8365.456245344034;8467.068622451648;8525.658973640984;8544.487330760174;8794.692185773467 10:03:16 INFO - PROCESS | 22873 | __end_tp_report 10:03:16 INFO - PROCESS | 22873 | __start_cc_report 10:03:16 INFO - PROCESS | 22873 | _x_x_mozilla_cycle_collect,940 10:03:16 INFO - PROCESS | 22873 | __end_cc_report 10:03:16 INFO - PROCESS | 22873 | __startTimestamp1464282196288__endTimestamp 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | ------- Summary: start ------- 10:03:16 INFO - PROCESS | 22873 | Number of tests: 6 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | [#0] dojo.html Cycles:165 Average:4790.31 Median:4869.88 stddev:503.49 (10.3%) stddev-sans-first:477.33 10:03:16 INFO - PROCESS | 22873 | Values: 2690.7 2703.7 2727.3 2733.9 2752.5 4656.3 4735.6 4784.5 4853.6 4900.5 4725.5 4783.8 4792.6 4793.4 4800.8 4377.1 4378.3 4461.3 4515.2 4559.2 4477.7 4512.7 4525.2 4528.9 4577.5 4311.3 4322.7 4356.3 4362.6 4408.8 4390.3 4399.6 4414.1 4450.4 4460.9 4438.4 4450.8 4451.3 4497.2 4508.7 4658.6 4669.1 4701.0 4734.4 4803.6 5135.8 5164.7 5189.4 5192.6 5198.0 5204.3 5209.3 5224.3 5237.7 5243.3 4652.2 4846.8 4857.2 4881.3 4974.9 5442.3 5452.0 5461.5 5471.5 5476.9 5173.9 5226.6 5229.8 5231.1 5232.6 5069.6 5088.1 5117.8 5119.9 5304.6 5093.6 5098.4 5104.3 5109.1 5151.5 5017.6 5048.3 5053.7 5053.8 5055.2 4346.2 4388.6 4392.2 4458.1 4460.7 3858.2 3912.6 3923.0 3927.7 3929.6 4461.5 4464.4 4502.8 4504.5 4576.0 5271.4 5271.5 5278.0 5280.2 5281.5 4519.8 4522.4 4528.0 4557.5 4558.4 4613.4 4616.6 4621.2 4624.5 4632.9 4780.4 4783.7 4785.2 4817.1 4820.4 5071.1 5089.1 5119.1 5140.3 5142.9 4778.0 4817.6 4822.1 4838.4 4869.9 5082.2 5084.1 5101.0 5107.4 5137.0 5055.8 5118.8 5160.9 5177.2 5182.0 5040.5 5101.6 5102.7 5116.4 5163.6 5109.0 5120.2 5122.2 5123.1 5171.7 4824.8 4962.2 4988.6 5024.7 5038.9 5125.3 5130.1 5144.1 5145.3 5182.3 5032.4 5041.5 5044.0 5047.8 5098.6 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | [#1] ext.html Cycles:180 Average:45824.58 Median:35473.06 stddev:84962.90 (239.5%) stddev-sans-first:85133.26 10:03:16 INFO - PROCESS | 22873 | Values: 553.8 593.4 605.7 606.9 618.7 27051.6 29946.3 38875.0 39833.6 39844.4 38850.0 39176.6 39245.8 39249.2 39317.4 7768.9 7968.5 7969.2 7969.4 7970.0 7731.5 7879.8 7880.4 7881.3 7886.3 7833.6 7931.1 7942.2 7942.4 7946.3 7840.8 7881.0 7884.1 7895.2 7898.0 7758.4 7844.4 7845.7 7850.7 7851.1 38075.2 38427.6 38438.2 38487.6 38513.8 3099.5 3301.9 3501.8 3691.7 3785.5 29102.7 29112.0 29718.1 31839.8 32662.8 3328.9 3343.0 3382.1 3398.0 3430.6 263722.0 266617.0 266739.7 266861.0 266888.0 31235.4 32216.5 54767.0 55556.2 55611.7 34324.7 34429.5 34508.3 34530.5 34553.5 12747.0 12880.5 12883.2 12887.5 12887.8 10424.8 10499.5 10518.4 10524.6 10527.8 7889.0 7900.7 7940.6 7996.5 8019.4 3098.9 3100.1 3115.3 3162.4 3177.6 857.9 862.9 884.2 963.5 1047.2 27120.9 27815.3 28094.2 28321.7 28377.7 905.7 914.6 922.4 968.0 1062.3 14503.3 14639.4 14787.9 14979.8 15033.2 384377.0 386530.0 387371.0 388491.0 390027.9 48255.8 48885.5 48885.8 48931.0 48941.0 960.5 1149.3 1167.2 1168.7 1196.0 27937.0 28550.4 28966.9 28967.4 29240.6 41395.6 41532.2 41916.2 42006.2 42047.0 299566.0 299879.0 300377.0 301338.0 301451.0 21388.6 21745.6 21957.9 22140.2 24823.9 40798.6 40934.6 41245.4 41299.0 41585.0 34923.0 35243.8 35563.1 35901.1 36040.8 34582.7 35563.6 35627.6 35808.3 36116.0 34325.3 34505.5 34736.5 34904.5 35383.0 30867.2 31710.2 31746.8 32061.2 32155.2 24242.4 24428.4 24603.0 25029.7 25064.5 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | [#2] jquery.html Cycles:180 Average:23222.09 Median:5253.28 stddev:62207.35 (1184.2%) stddev-sans-first:62358.19 10:03:16 INFO - PROCESS | 22873 | Values: 368.5 372.3 375.7 377.0 392.7 15714.4 16618.0 16931.6 17014.1 17256.7 16060.0 16639.0 17211.9 17242.6 17250.1 4994.9 5187.1 5210.3 5210.8 5211.0 3761.8 3898.8 5131.1 5614.5 5950.2 5981.9 5995.0 6011.8 6015.1 6020.8 5851.2 5881.4 6036.7 6042.4 6064.0 3408.8 4992.7 5295.5 5304.7 5306.7 19781.4 20623.4 20674.2 20682.1 20755.8 1875.3 1914.8 1977.5 1994.8 2040.7 8718.3 8993.6 9320.2 9376.2 9582.0 1780.2 1793.2 1795.0 1817.3 1886.6 58969.7 59127.4 59447.0 60101.4 69268.0 10280.1 10310.9 10321.5 10321.5 10401.9 14059.8 14063.6 14193.2 14201.2 14208.7 6933.2 7008.8 7080.7 7177.0 7210.0 6366.7 6389.1 6512.8 6550.8 6649.8 4229.0 4435.5 4439.2 4458.6 4508.6 1705.4 1791.7 1800.7 1806.2 1811.1 808.3 819.1 853.5 883.2 947.5 16375.5 17020.2 17099.5 17492.5 17533.5 873.5 881.4 913.3 945.6 949.4 9502.3 9587.8 9733.3 9741.3 10008.6 373761.0 375468.0 375956.0 382159.0 382959.0 46007.0 58051.7 77437.2 78121.5 78186.6 946.8 964.5 968.3 969.8 971.2 15644.8 15692.3 15785.3 15799.9 16114.8 34677.0 34856.3 35439.8 35449.8 36224.3 47106.5 49475.3 49501.0 49645.3 49764.0 7192.5 7200.5 7226.4 7308.7 7430.4 9151.5 10611.0 10678.1 10709.4 11383.8 8652.5 8688.4 8919.8 9018.7 9329.6 5374.2 9569.8 9875.6 9881.0 9955.8 9029.5 9060.9 9172.6 9208.0 9255.2 6775.7 6874.0 6903.9 7011.6 7150.5 8800.8 8802.8 8841.7 8930.2 9199.7 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | [#3] mootools.html Cycles:180 Average:5177.35 Median:4998.63 stddev:2956.48 (59.1%) stddev-sans-first:2950.31 10:03:16 INFO - PROCESS | 22873 | Values: 1284.9 1424.0 1451.9 1581.8 1771.6 6762.6 7700.0 7906.2 7907.2 8095.3 7859.5 7956.2 8000.8 8013.7 8014.5 1865.9 2159.0 2172.1 2186.6 2235.5 2279.2 2300.0 2300.6 2301.4 2303.7 2237.4 2259.8 2260.3 2264.3 2270.3 1806.3 2087.4 2121.5 2140.7 2149.0 2107.1 2122.3 2125.2 2128.4 2128.4 7931.3 7976.8 7984.8 7984.9 7991.0 4587.7 4696.1 4701.3 4701.9 4709.2 2837.6 2870.9 3022.9 3048.3 3051.2 957.9 960.2 980.4 984.3 984.7 10924.6 10942.8 10963.1 10966.8 10991.7 4234.5 4294.1 4375.4 4395.4 4403.3 9207.0 9229.9 9236.3 9243.7 9260.4 4573.0 4583.6 4584.4 4585.2 4586.4 3562.9 4059.8 4175.6 4186.0 4257.3 3700.5 3728.8 3802.5 3846.6 3871.4 1207.1 1231.6 1236.1 1256.4 1268.2 771.0 803.9 822.9 826.1 841.2 4903.9 5093.4 5095.3 5209.2 5225.0 830.0 844.1 865.5 870.9 880.6 3234.8 3369.1 3384.7 3399.2 3411.6 9613.7 9923.4 9953.6 9963.9 9979.1 9594.3 9780.5 9797.3 9875.0 9889.5 7409.2 7504.5 7524.4 7545.7 7551.2 4749.3 4750.9 4756.2 4779.3 4790.0 8938.0 9205.7 9217.5 9236.0 9342.7 9296.8 9360.6 9398.3 9413.4 9418.1 5225.3 6264.7 6441.5 6460.1 6556.0 7472.0 7480.7 7516.5 7532.5 7542.1 6783.2 6925.5 6927.8 7018.4 7091.9 6868.5 6914.2 6936.1 6967.2 7027.0 6435.7 6438.5 6475.2 6485.3 6506.9 4370.3 4410.7 4420.7 4438.2 4476.6 4394.0 4403.3 4416.4 4512.2 4568.8 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | [#4] prototype.html Cycles:180 Average:4169.17 Median:4763.65 stddev:1200.25 (25.2%) stddev-sans-first:1168.08 10:03:16 INFO - PROCESS | 22873 | Values: 306.8 308.9 311.1 313.6 314.1 4760.4 4766.9 4819.3 4830.0 4853.1 4686.0 4725.9 4736.4 4737.0 4737.7 3540.9 3642.2 3663.1 3789.1 3813.8 3772.6 3785.6 3787.6 3791.7 3793.5 3739.2 3761.8 3764.2 3766.2 3785.6 3554.5 3619.9 3766.6 3770.4 3774.5 3265.2 3331.9 3336.5 3340.6 3344.6 4567.6 4575.0 4575.6 4601.9 4605.2 4052.2 4246.3 4253.6 4295.6 4300.6 4973.6 4980.0 4990.3 4990.7 4998.7 3602.6 3603.1 3604.1 3619.8 3636.4 5145.0 5164.0 5294.4 5305.7 5315.7 3704.7 3729.5 3733.6 3738.4 3741.7 3799.9 3801.8 3803.0 3811.3 3812.1 4283.8 4296.5 4302.7 4305.2 4322.4 4885.4 4928.5 4997.0 5024.5 5046.3 1312.2 1318.8 1332.8 1341.5 1342.8 802.7 837.9 842.2 845.5 846.3 4312.2 4430.9 4464.3 4464.8 4472.3 5115.2 5140.0 5148.5 5175.3 5198.8 4359.9 4422.8 4441.3 4471.5 4496.2 2575.7 2725.7 2750.7 2754.8 2757.8 4835.3 4852.9 4858.4 4859.6 4878.8 5060.4 5246.6 5295.5 5298.8 5320.4 4890.8 4893.9 4899.0 4906.7 4921.0 5193.5 5195.5 5198.4 5198.8 5206.2 4888.0 5081.4 5086.5 5116.9 5125.8 4844.3 4851.9 4865.5 4886.1 4892.9 3625.2 3637.8 3670.7 3673.2 3709.9 4905.5 5199.7 5203.3 5247.8 5259.2 4903.6 4965.5 4981.4 4981.5 5035.9 4963.2 4989.9 4992.5 5002.8 5021.0 4767.6 4942.5 4947.9 4962.4 4964.3 4795.4 4898.8 4903.2 4903.9 5071.5 4792.6 4835.7 4837.6 4910.9 4920.9 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - PROCESS | 22873 | [#5] yui.html Cycles:180 Average:13152.63 Median:47057.53 stddev:15377.78 (32.7%) stddev-sans-first:15392.24 10:03:16 INFO - PROCESS | 22873 | Values: 645.7 676.4 711.4 738.1 742.0 12434.3 12444.5 12532.4 13388.0 13781.4 13717.7 13747.2 13771.7 13891.2 13893.7 640.5 788.5 812.0 818.9 819.9 811.0 817.9 818.2 818.5 819.3 853.5 859.1 859.2 859.4 859.8 671.7 816.3 845.2 855.8 855.9 622.4 622.8 623.2 623.2 623.3 12865.5 12869.8 12877.5 12891.5 12892.4 11375.8 11490.6 11675.2 11677.8 12257.4 9940.3 10033.0 11161.3 11167.9 11181.7 3119.6 3140.2 3151.6 3229.2 3264.2 46801.8 46909.0 47021.5 47093.5 47306.7 9770.2 9802.3 9873.7 10010.6 10093.8 17221.9 17250.7 17268.1 17270.4 17374.3 6727.3 6753.7 6812.7 6816.1 6881.2 3787.2 3804.8 3806.8 3824.8 3904.7 2879.0 2982.8 2982.9 2983.6 2998.2 494.9 516.1 516.7 532.2 568.3 465.4 578.1 578.8 582.5 595.5 7099.5 7241.6 7406.9 7433.1 7490.7 442.6 500.3 525.5 535.5 561.3 3214.1 3434.9 3463.7 3498.1 3534.6 54292.5 54867.0 55236.4 55678.7 55825.4 48768.5 48949.6 49472.5 49719.8 50036.0 45498.3 46591.0 46802.0 47316.3 47485.3 7879.5 7986.5 7993.2 8009.9 8026.9 31323.1 31380.8 31579.0 31703.5 32306.2 38481.2 40081.4 42069.2 42155.8 42241.0 9862.0 10292.9 10320.4 10364.3 10393.2 10587.3 11866.4 11917.4 11961.5 12253.8 9825.7 9948.1 10148.7 10452.4 10479.6 10990.2 11302.7 11415.7 11451.7 11550.8 10383.5 10412.8 10418.9 10463.4 10668.6 8703.7 9161.8 9194.3 9295.4 9313.0 8365.5 8467.1 8525.7 8544.5 8794.7 10:03:16 INFO - PROCESS | 22873 | -------- Summary: end -------- 10:03:16 INFO - PROCESS | 22873 | 10:03:16 INFO - TEST-INFO | 22873: exit 0 10:03:16 INFO - TEST-OK | dromaeo_css | took 1117615ms 10:03:16 INFO - TEST-START | kraken 10:03:16 INFO - operating with platform_type : linux_ 10:03:16 INFO - Initialising browser for kraken test... 10:03:16 INFO - TEST-INFO | started process 23048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3o27lZ/profile http://localhost:46117/getInfo.html) 10:03:20 INFO - PROCESS | 23048 | __metrics Screen width/height:1600/1200 10:03:20 INFO - PROCESS | 23048 | colorDepth:24 10:03:20 INFO - PROCESS | 23048 | Browser inner width/height: 1024/697 10:03:20 INFO - PROCESS | 23048 | __metrics 10:03:21 ERROR - PROCESS | 23048 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:03:22 INFO - TEST-INFO | 23048: exit 0 10:03:22 INFO - Browser initialized. 10:03:22 INFO - Running cycle 1/1 for kraken test... 10:03:22 INFO - TEST-INFO | started process 23130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3o27lZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:34 INFO - PROCESS | 23130 | RSS: Main: 156409856 10:03:34 INFO - PROCESS | 23130 | 10:03:36 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-beat-detection) 10:03:37 INFO - PROCESS | 23130 | RSS: Main: 212029440 10:03:37 INFO - PROCESS | 23130 | 10:03:40 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-dft) 10:03:41 INFO - PROCESS | 23130 | RSS: Main: 200527872 10:03:41 INFO - PROCESS | 23130 | 10:03:44 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-fft) 10:03:45 INFO - PROCESS | 23130 | RSS: Main: 269508608 10:03:45 INFO - PROCESS | 23130 | 10:03:47 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-oscillator) 10:03:47 INFO - PROCESS | 23130 | RSS: Main: 177852416 10:03:47 INFO - PROCESS | 23130 | 10:03:50 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:50 INFO - PROCESS | 23130 | RSS: Main: 182177792 10:03:50 INFO - PROCESS | 23130 | 10:03:53 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:54 INFO - PROCESS | 23130 | RSS: Main: 218017792 10:03:54 INFO - PROCESS | 23130 | 10:03:57 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:58 INFO - PROCESS | 23130 | RSS: Main: 218378240 10:03:58 INFO - PROCESS | 23130 | 10:04:01 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46117/tests/kraken/driver.html?testName=json-parse-financial) 10:04:01 INFO - PROCESS | 23130 | RSS: Main: 219004928 10:04:01 INFO - PROCESS | 23130 | 10:04:03 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:04 INFO - PROCESS | 23130 | RSS: Main: 206110720 10:04:04 INFO - PROCESS | 23130 | 10:04:06 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:06 INFO - PROCESS | 23130 | RSS: Main: 208945152 10:04:06 INFO - PROCESS | 23130 | 10:04:08 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:09 INFO - PROCESS | 23130 | RSS: Main: 220356608 10:04:09 INFO - PROCESS | 23130 | 10:04:12 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:13 INFO - PROCESS | 23130 | RSS: Main: 225030144 10:04:13 INFO - PROCESS | 23130 | 10:04:15 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:16 INFO - PROCESS | 23130 | RSS: Main: 221794304 10:04:16 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46117/tests/kraken/driver.html?testName=ai-astar) 10:04:18 INFO - PROCESS | 23130 | RSS: Main: 267206656 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | __start_tp_report 10:04:18 INFO - PROCESS | 23130 | _x_x_mozilla_page_load 10:04:18 INFO - PROCESS | 23130 | _x_x_mozilla_page_load_details 10:04:18 INFO - PROCESS | 23130 | |i|pagename|runs| 10:04:18 INFO - PROCESS | 23130 | |0;ai-astar;112;109;112;114;112;113;113;112;113;113 10:04:18 INFO - PROCESS | 23130 | |1;audio-beat-detection;159;128;133;180;139;131;152;130;171;130 10:04:18 INFO - PROCESS | 23130 | |2;audio-dft;161;161;162;161;161;161;162;162;163;163 10:04:18 INFO - PROCESS | 23130 | |3;audio-fft;75;77;74;118;75;75;75;76;104;75 10:04:18 INFO - PROCESS | 23130 | |4;audio-oscillator;83;83;123;84;84;84;117;83;83;131 10:04:18 INFO - PROCESS | 23130 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;117;117;117 10:04:18 INFO - PROCESS | 23130 | |6;imaging-darkroom;146;146;145;145;145;146;145;148;145;147 10:04:18 INFO - PROCESS | 23130 | |7;imaging-desaturate;95;95;95;96;95;94;95;95;95;94 10:04:18 INFO - PROCESS | 23130 | |8;json-parse-financial;65;65;66;65;65;66;66;81;64;65 10:04:18 INFO - PROCESS | 23130 | |9;json-stringify-tinderbox;66;65;66;66;67;66;67;66;66;66 10:04:18 INFO - PROCESS | 23130 | |10;stanford-crypto-aes;82;82;82;82;84;84;83;84;89;83 10:04:18 INFO - PROCESS | 23130 | |11;stanford-crypto-ccm;136;130;138;128;128;129;135;128;164;132 10:04:18 INFO - PROCESS | 23130 | |12;stanford-crypto-pbkdf2;173;172;169;174;169;171;173;185;172;168 10:04:18 INFO - PROCESS | 23130 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;65;67;66;65 10:04:18 INFO - PROCESS | 23130 | __end_tp_report 10:04:18 INFO - PROCESS | 23130 | __start_cc_report 10:04:18 INFO - PROCESS | 23130 | _x_x_mozilla_cycle_collect,1884 10:04:18 INFO - PROCESS | 23130 | __end_cc_report 10:04:18 INFO - PROCESS | 23130 | __startTimestamp1464282258551__endTimestamp 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | ------- Summary: start ------- 10:04:18 INFO - PROCESS | 23130 | Number of tests: 14 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.41 10:04:18 INFO - PROCESS | 23130 | Values: 112.0 109.0 112.0 114.0 112.0 113.0 113.0 112.0 113.0 113.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:145.50 stddev:19.03 (13.1%) stddev-sans-first:19.53 10:04:18 INFO - PROCESS | 23130 | Values: 159.0 128.0 133.0 180.0 139.0 131.0 152.0 130.0 171.0 130.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 10:04:18 INFO - PROCESS | 23130 | Values: 161.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 163.0 163.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.45 (20.6%) stddev-sans-first:16.15 10:04:18 INFO - PROCESS | 23130 | Values: 75.0 77.0 74.0 118.0 75.0 75.0 75.0 76.0 104.0 75.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:83.00 stddev:19.72 (23.8%) stddev-sans-first:20.39 10:04:18 INFO - PROCESS | 23130 | Values: 83.0 83.0 123.0 84.0 84.0 84.0 117.0 83.0 83.0 131.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:04:18 INFO - PROCESS | 23130 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 10:04:18 INFO - PROCESS | 23130 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 148.0 145.0 147.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:04:18 INFO - PROCESS | 23130 | Values: 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 94.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:65.50 stddev:5.03 (7.7%) stddev-sans-first:5.29 10:04:18 INFO - PROCESS | 23130 | Values: 65.0 65.0 66.0 65.0 65.0 66.0 66.0 81.0 64.0 65.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:04:18 INFO - PROCESS | 23130 | Values: 66.0 65.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 66.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:2.12 (2.5%) stddev-sans-first:2.18 10:04:18 INFO - PROCESS | 23130 | Values: 82.0 82.0 82.0 82.0 84.0 84.0 83.0 84.0 89.0 83.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:133.50 stddev:10.89 (8.2%) stddev-sans-first:11.54 10:04:18 INFO - PROCESS | 23130 | Values: 136.0 130.0 138.0 128.0 128.0 129.0 135.0 128.0 164.0 132.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:172.50 stddev:4.79 (2.8%) stddev-sans-first:5.08 10:04:18 INFO - PROCESS | 23130 | Values: 173.0 172.0 169.0 174.0 169.0 171.0 173.0 185.0 172.0 168.0 10:04:18 INFO - PROCESS | 23130 | 10:04:18 INFO - PROCESS | 23130 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 10:04:18 INFO - PROCESS | 23130 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 65.0 67.0 66.0 65.0 10:04:18 INFO - PROCESS | 23130 | -------- Summary: end -------- 10:04:18 INFO - PROCESS | 23130 | 10:04:19 INFO - TEST-INFO | 23130: exit 0 10:04:19 INFO - TEST-OK | kraken | took 62554ms 10:04:19 INFO - SUITE-END | took 1180s 10:04:19 INFO - Completed test suite (00:19:40) 10:04:19 INFO - javascript benchmark 10:04:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2690.690570584381, 2703.7296270372963, 2727.3454370950967, 2733.945321093577, 2752.5045491811466, 4656.348111264426, 4735.597474214687, 4784.545468180521, 4853.6359773017075, 4900.460949295579, 4725.480197178316, 4783.784729687164, 4792.6165906727465, 4793.400824896888, 4800.8319708810195, 4377.1464564410035, 4378.343248512717, 4461.259321290418, 4515.164694531522, 4559.156556037127, 4477.686561940665, 4512.661550383718, 4525.230710779176, 4528.8867778305475, 4577.519360467137, 4311.28863737483, 4322.654187664979, 4356.302991521341, 4362.563743625644, 4408.823647054146, 4390.341448782676, 4399.626031787302, 4414.05097903949, 4450.35469856869, 4460.933086003713, 4438.4451943507065, 4450.799714012877, 4451.287793952952, 4497.235469970113, 4508.729476231437, 4658.58072773452, 4669.136209801198, 4701.0127873146685, 4734.431868175807, 4803.615710743132, 5135.794568217267, 5164.741762911839, 5189.377274727057, 5192.55863251624, 5198.038362902875, 5204.271402003723, 5209.322788037569, 5224.346956630421, 5237.685738855681, 5243.318368612094, 4652.232381657022, 4846.830360937351, 4857.198562237262, 4881.316615673809, 4974.8756281093265, 5442.346918369742, 5452.045891968969, 5461.535769459561, 5471.50756431923, 5476.863078423071, 5173.870653233699, 5226.63413561047, 5229.843104706865, 5231.136862417735, 5232.581393488512, 5069.619778516552, 5088.135017047037, 5117.8464646060675, 5119.897602047939, 5304.575633949275, 5093.617978651542, 5098.413682426569, 5104.285400043997, 5109.080365534165, 5151.5106064923775, 5017.623678224148, 5048.343715317059, 5053.69677819332, 5053.84838454847, 5055.241713742968, 4346.239408103569, 4388.648908087345, 4392.231359512072, 4458.06380660065, 4460.665450091256, 3858.2283543291455, 3912.550056743454, 3922.99963509309, 3927.6857851371824, 3929.6070392960473, 4461.464624245112, 4464.352668862996, 4502.752348620792, 4504.527024662429, 4576.039031803359, 5271.4464981176425, 5271.499207575274, 5277.973610131925, 5280.207968804633, 5281.524662780368, 4519.7740112994215, 4522.389477420572, 4527.9547204527535, 4557.498675145731, 4558.384618076518, 4613.423322084739, 4616.630669546428, 4621.168189725814, 4624.468186158568, 4632.907341853144, 4780.378550788375, 4783.712977221308, 4785.210440277316, 4817.084753896748, 4820.39745031871, 5071.13790655582, 5089.0839648862075, 5119.078565858182, 5140.280360749423, 5142.922856157086, 4777.95222047775, 4817.614590832795, 4822.132016237111, 4838.395200599925, 4869.878253043702, 5082.186850103965, 5084.084864724237, 5101.005303965691, 5107.387113546398, 5137.0, 5055.797768089235, 5118.846434606968, 5160.870978225575, 5177.197534382177, 5182.041322355376, 5040.470750571284, 5101.591872650253, 5102.69383836971, 5116.437191908962, 5163.586913047023, 5108.974455127849, 5120.155174396332, 5122.168966738445, 5123.052235336475, 5171.741412929414, 4824.807007719652, 4962.156433406401, 4988.625853060962, 5024.723640199678, 5038.924416133687, 5125.333706618116, 5130.102232109441, 5144.125498665161, 5145.253938179018, 5182.300389447376, 5032.421271553671, 5041.495850414929, 5044.041632089891, 5047.772850221675, 5098.566621837037], "value": 4758.363435595232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8200084972383, 593.4362355762025, 605.6789901352284, 606.9423404776547, 618.6782872906091, 27051.5942260866, 29946.25134371639, 38875.0, 39833.601663983354, 39844.402333965016, 38850.0, 39176.60823391765, 39245.803770981176, 39249.21501569974, 39317.41023884644, 7768.883466748018, 7968.482048666847, 7969.203079692043, 7969.442139050268, 7970.0, 7731.458797884122, 7879.763607091796, 7880.36957043438, 7881.330086942617, 7886.250806173433, 7833.569153696544, 7931.087924888654, 7942.205779422041, 7942.444028917978, 7946.324562412173, 7840.764777056669, 7881.014873140857, 7884.053913530413, 7895.249951254622, 7897.960510197441, 7758.379329653614, 7844.411669124838, 7845.725399610987, 7850.685972561091, 7851.05787305527, 38075.238495230216, 38427.615723842966, 38438.23123537542, 38487.615123848685, 38513.807430962945, 3099.4575949209025, 3301.851416686255, 3501.7898926064263, 3691.667749902522, 3785.4889589905288, 29102.70897291021, 29112.0, 29718.108456746333, 31839.84080079608, 32662.83668581642, 3328.8834890778708, 3342.96657033429, 3382.1375549235036, 3398.04854640701, 3430.5540279763723, 263722.0, 266617.0, 266739.6663016692, 266861.0, 266888.0, 31235.375292494024, 32216.516752248735, 54767.0, 55556.16665750017, 55611.72194139003, 34324.656753432646, 34429.48355774665, 34508.309833803185, 34530.48204276938, 34553.48169777455, 12747.0, 12880.549180778627, 12883.227006379648, 12887.54893578739, 12887.806682899763, 10424.843627345595, 10499.475026248658, 10518.421486818146, 10524.579016839241, 10527.789444211227, 7888.960555197302, 7900.68397264103, 7940.602969851484, 7996.480228785111, 8019.35845132388, 3098.90703278902, 3100.116466806949, 3115.345777386774, 3162.414953233659, 3177.602799650044, 857.9442336248123, 862.8619420892627, 884.1600479544459, 963.4749061761357, 1047.167501836027, 27120.864395677894, 27815.331080135256, 28094.157175284774, 28321.71678283232, 28377.71622283792, 905.6875377994581, 914.6250037484599, 922.3635691372931, 968.0368033806267, 1062.251112965373, 14503.274836258144, 14639.414423423157, 14787.92606036963, 14979.775303370458, 15033.173175475455, 384377.0, 386530.0, 387371.0, 388491.0, 390027.89748922735, 48255.75872120617, 48885.511144888806, 48885.75557122192, 48931.0, 48941.0, 960.4861399151421, 1149.3276433286621, 1167.241293159453, 1168.7253495428567, 1195.9940200299118, 27937.0, 28550.42899142047, 28966.85516572488, 28967.40405689424, 29240.561391578718, 41395.58604413917, 41532.1693566133, 41916.161676766904, 42006.15987680291, 42047.0, 299566.0, 299879.0, 300377.0, 301338.0, 301451.0, 21388.57222855503, 21745.565088698455, 21957.890210548845, 22140.225092122342, 24823.875880621203, 40798.59201408067, 40934.59065409427, 41245.38131928084, 41299.0, 41585.0, 34923.0, 35243.82378088093, 35563.11092222715, 35901.1024724384, 36040.819795900854, 34582.654173457944, 35563.644363556035, 35627.64372356347, 35808.28383432369, 36116.0, 34325.31349372949, 34505.482417763254, 34736.47895281624, 34904.47643285403, 35383.0, 30867.228319292197, 31710.207244819063, 31746.841265793522, 32061.198470038435, 32155.196120097185, 24242.393940151636, 24428.389290267885, 24603.0, 25029.74970250274, 25064.498710026062], "value": 16296.523793196307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.52276302188665, 372.34467337486024, 375.6863019378822, 376.97172712046597, 392.707432962443, 15714.449994250204, 16618.0, 16931.57671058224, 17014.149292535356, 17256.74114888278, 16060.0, 16639.0, 17211.91394043028, 17242.568935776613, 17250.137493125356, 4994.925076123861, 5187.092258854705, 5210.322658054448, 5210.843674689765, 5211.009908117446, 3761.8119094045323, 3898.8440462381473, 5131.050755610206, 5614.494695477406, 5950.226470558821, 5981.85045373867, 5995.010823214165, 6011.789587364443, 6015.127806468059, 6020.8494787630225, 5851.239338885939, 5881.411858814127, 6036.7283472243635, 6042.365551617061, 6064.0, 3408.812515311657, 4992.700437973697, 5295.549878260353, 5304.708241046741, 5306.70813105279, 19781.40655780329, 20623.381298561068, 20674.17303307866, 20682.069306881225, 20755.792442075537, 1875.3248830421037, 1914.7606549181353, 1977.4858536780396, 1994.7905469925738, 2040.6840827638434, 8718.258947989429, 8993.550322483916, 9320.20778233844, 9376.203022743075, 9581.952090239574, 1780.2256018631806, 1793.2289115680253, 1794.9641007179914, 1817.318505560415, 1886.6226754648987, 58969.705151473965, 59127.40872591262, 59447.0, 60101.39898601002, 69268.0, 10280.07479326864, 10310.948445257876, 10321.483925803679, 10321.503382009567, 10401.94799026, 14059.78910316346, 14063.648408789657, 14193.225846769154, 14201.218932958787, 14208.715825683636, 6933.2026816916705, 7008.7546935857, 7080.681369338392, 7177.031100801325, 7209.96395018032, 6366.713497892606, 6389.105525226472, 6512.772052978123, 6550.7707230246715, 6649.833754156185, 4228.957710422918, 4435.467743870756, 4439.156560253541, 4458.576435238647, 4508.616767574727, 1705.4372057221087, 1791.7176781515502, 1800.6938820400562, 1806.2323512507394, 1811.0802549297787, 808.3008197908766, 819.148085990575, 853.5177624642057, 883.1786438612024, 947.545178314413, 16375.508734737978, 17020.234089466005, 17099.487015389557, 17492.53167514165, 17533.473995780147, 873.4846440600077, 881.4226681523612, 913.2967614936595, 945.6170251048336, 949.4350861237552, 9502.334836561513, 9587.760305992266, 9733.270004749673, 9741.269404794668, 10008.64969726056, 373761.0, 375468.0, 375956.0, 382159.0, 382959.0, 46007.0, 58051.70974145102, 77437.22562774413, 78121.48453319614, 78186.6090669543, 946.7917058247175, 964.4599024546277, 968.3270127261626, 969.8254314223367, 971.1890571372842, 15644.843551564794, 15692.293846776694, 15785.28966196547, 15799.921000395385, 16114.838851611803, 34677.0, 34856.30287394187, 35439.82280088583, 35449.82275088608, 36224.27551449009, 47106.528934710215, 49475.25787113268, 49501.0, 49645.25532117093, 49764.0, 7192.496525243183, 7200.53196542244, 7226.421886248982, 7308.671109799965, 7430.368418684472, 9151.496667683075, 10611.0, 10678.145748339959, 10709.357438553712, 11383.772324553629, 8652.524111173945, 8688.435251708619, 8919.777005574913, 9018.684346047858, 9329.626814927598, 5374.193870919394, 9569.760755981157, 9875.55559999816, 9880.950595246977, 9955.800883982425, 9029.503377314311, 9060.864087038568, 9172.633094676405, 9208.0, 9255.167034966886, 6775.661216939035, 6874.0, 6903.896441553481, 7011.6494175292055, 7150.499465037397, 8800.779980500538, 8802.779930501789, 8841.734747957571, 8930.151635594608, 9199.678011269574], "value": 7990.675785042561, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.9357532123404, 1424.0063910525266, 1451.941922323107, 1581.8259991400944, 1771.554326834307, 6762.628055456948, 7700.0, 7906.2489063539015, 7907.20927907209, 8095.311898488636, 7859.528428294307, 7956.244156805109, 8000.839983200332, 8013.679452821894, 8014.519128852273, 1865.8600604954615, 2158.967615485769, 2172.142003908455, 2186.6392045312505, 2235.485838257194, 2279.2022792022826, 2300.0454811253308, 2300.620397634388, 2301.413139649387, 2303.67748515208, 2237.429455488848, 2259.7966183043523, 2260.3445000949705, 2264.2867496738477, 2270.3416009357265, 1806.2774890043956, 2087.3633541769755, 2121.4908421978766, 2140.7110040144535, 2149.0, 2107.136074209582, 2122.278425335378, 2125.203048856679, 2128.404046866864, 2128.4040468668795, 7931.286184243446, 7976.8404631907615, 7984.840303193903, 7984.880226796603, 7990.960045199795, 4587.7017993830295, 4696.084263568606, 4701.271302948048, 4701.929471057937, 4709.246520556729, 2837.645294338208, 2870.937753031371, 3022.909312720622, 3048.268415580245, 3051.2219384056925, 957.861110139026, 960.2414092866627, 980.4460479828874, 984.3454103021483, 984.6799790068185, 10924.563017479291, 10942.835857462223, 10963.068139208177, 10966.780664386668, 10991.670249892515, 4234.491860976703, 4294.098239369768, 4375.365571992107, 4395.384646149541, 4403.2734598791485, 9207.033261507579, 9229.861552076723, 9236.261099112055, 9243.722688319362, 9260.351775375659, 4573.039661671086, 4583.610393116623, 4584.4498660161, 4585.243434833282, 4586.4266966629175, 3562.946555801665, 4059.817308221137, 4175.561566035583, 4186.0, 4257.297545904953, 3700.518932538753, 3728.813559322023, 3802.524684414448, 3846.615338466131, 3871.3999330103316, 1207.124834494984, 1231.5751065882257, 1236.116176933497, 1256.39065053449, 1268.2390565660714, 770.9807254818562, 803.9397045221632, 822.9012518497699, 826.1119296756011, 841.2260720137489, 4903.901921961541, 5093.363329583802, 5095.261187127846, 5209.192575150858, 5224.9738751306, 830.0495932157646, 844.1094645149426, 865.4547634990042, 870.9216170544555, 880.5905254056894, 3234.838258087086, 3369.0735047862036, 3384.7292216623105, 3399.2351720862607, 3411.5564976553387, 9613.663521776703, 9923.354981926152, 9953.552090155961, 9963.900360996297, 9979.051990060932, 9594.280428967715, 9780.510974451248, 9797.314188006914, 9875.012498750211, 9889.45607991553, 7409.222031686703, 7504.474686771873, 7524.398048156135, 7545.6981720730555, 7551.244875512514, 4749.2876068589985, 4750.881227969328, 4756.215224487921, 4779.330893674819, 4789.95210047909, 8938.0, 9205.677801277192, 9217.539123043955, 9235.953820230856, 9342.673006444742, 9296.814063718553, 9360.625574976924, 9398.342116052085, 9413.388129771543, 9418.058194180527, 5225.294585230945, 6264.686765661608, 6441.5490915635455, 6460.095586617971, 6556.0, 7472.0, 7480.70077196906, 7516.511426757462, 7532.510386824839, 7542.094948606203, 6783.18601767791, 6925.515213934977, 6927.792166235021, 7018.368346848808, 7091.929080709333, 6868.519203655696, 6914.204866440424, 6936.132983377078, 6967.198772141269, 7026.9648651756415, 6435.678216089083, 6438.5171112165835, 6475.1582294303325, 6485.28661847187, 6506.902396463962, 4370.344448332648, 4410.735355878657, 4420.690551661352, 4438.178936896685, 4476.597106260452, 4393.978030109829, 4403.295472724477, 4416.4258646375765, 4512.210363186495, 4568.840090596813], "value": 4155.978425427084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.7944477200276, 308.87490566320633, 311.12573667992956, 313.59702781925216, 314.1470906488883, 4760.404949381327, 4766.904661906759, 4819.301201325806, 4830.0, 4853.131544355418, 4686.0, 4725.929111063337, 4736.407949006374, 4736.952630473695, 4737.744497708101, 3540.946885796715, 3642.1623026703874, 3663.120850995755, 3789.0906182516137, 3813.771173729578, 3772.58501564829, 3785.6403641654138, 3787.602301758317, 3791.6777073948747, 3793.487879136309, 3739.233457141293, 3761.793101379423, 3764.1530655602405, 3766.171442282707, 3785.5835858055593, 3554.484599733037, 3619.9276014479697, 3766.566844812854, 3770.377887648535, 3774.4904437900805, 3265.200025993623, 3331.900042998714, 3336.498575640947, 3340.5657264555693, 3344.5986481622117, 4567.588916997486, 4574.987005717474, 4575.588197062247, 4601.861944141681, 4605.171069207541, 4052.16558276423, 4246.320588705792, 4253.574642535753, 4295.646871235582, 4300.591443812864, 4973.602111831045, 4979.975100124512, 4990.30135780991, 4990.70427603303, 4998.7250701211415, 3602.603713591503, 3603.1352475405974, 3604.098975256186, 3619.7647152934974, 3636.436352365361, 5145.0, 5163.974180129113, 5294.364676238876, 5305.655132416419, 5315.707636080014, 3704.685101766326, 3729.4778730977687, 3733.6079711629886, 3738.43923411485, 3741.7380783345448, 3799.8670046548236, 3801.847926082926, 3802.980985095057, 3811.256804923069, 3812.1041555234497, 4283.81525422037, 4296.462942132233, 4302.655787537052, 4305.203537345601, 4322.3516472528745, 4885.438174609894, 4928.482509336468, 4997.0, 5024.547790698854, 5046.275011493825, 1312.1995582694549, 1318.7955866840655, 1332.7934170203634, 1341.5170538606094, 1342.8321459817523, 802.6829402386024, 837.8718056137343, 842.2083241752733, 845.5245596434262, 846.3060290561804, 4312.223799716018, 4430.8701281173735, 4464.30803225494, 4464.772187648357, 4472.284434490531, 5115.232715092691, 5140.0, 5148.536631703165, 5175.301334319894, 5198.792048318101, 4359.912801743947, 4422.800973956179, 4441.333799930037, 4471.530489298577, 4496.168208881302, 2575.7424257574094, 2725.74105459981, 2750.6561679790025, 2754.807163498576, 2757.7931655125944, 4835.274708793639, 4852.902941941142, 4858.392700912386, 4859.562639362403, 4878.75577234469, 5060.367454068241, 5246.606504512177, 5295.549878260314, 5298.788048478018, 5320.388155362106, 4890.801753570398, 4893.877653058702, 4898.975505122452, 4906.705597664223, 4920.950790492121, 5193.480651934777, 5195.480451954774, 5198.428172901054, 5198.792048318176, 5206.177837756755, 4887.975560122177, 5081.44104148536, 5086.516780905808, 5116.923246151385, 5125.846224613268, 4844.297576851407, 4851.878703032452, 4865.489123642108, 4886.144924638245, 4892.877678057935, 3625.2386998729507, 3637.7635453696485, 3670.7063434924607, 3673.210259794157, 3709.944350834686, 4905.5094490550655, 5199.66202196856, 5203.271541984201, 5247.842564723064, 5259.237410575522, 4903.583195428429, 4965.453800081916, 4981.37732783402, 4981.452040275494, 5035.874103147304, 4963.230699241623, 4989.875253118701, 4992.475790042138, 5002.799888004584, 5020.974895125501, 4767.570918617341, 4942.456329803791, 4947.897143713979, 4962.379702537183, 4964.255361695775, 4795.376601041842, 4898.7550622468025, 4903.215485522299, 4903.926441103315, 5071.503906347562, 4792.640551958547, 4835.709857408567, 4837.612990960785, 4910.852674419773, 4920.868200314019], "value": 3791.2897951317445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6739346629957, 676.4115219758811, 711.3633298198113, 738.1326940844507, 741.97774066778, 12434.316112613802, 12444.502219911205, 12532.373381330932, 13388.0, 13781.448742050306, 13717.65705857354, 13747.175169489838, 13771.65570860729, 13891.166530008206, 13893.722125557508, 640.5356116815318, 788.5071830106184, 812.0, 818.9222023907749, 819.8811172380001, 810.9878351824698, 817.9141190175005, 818.1981657975188, 818.5088946632003, 819.3199644295221, 853.5476197615274, 859.1365677494109, 859.1751918158575, 859.4198915731887, 859.7893516088536, 671.7279501801778, 816.3428440105713, 845.218173189797, 855.8245559660286, 855.8587833007547, 622.4460230394952, 622.7540121651922, 623.1649589549979, 623.183629445428, 623.3050149083784, 12865.549705760253, 12869.806952895715, 12877.484900603964, 12891.484340626364, 12892.419841107172, 11375.772484550263, 11490.597829076025, 11675.182737208399, 11677.824832627517, 12257.448414821354, 9940.254480913887, 10033.0, 11161.274517156358, 11167.944160279147, 11181.72045698856, 3119.5788568543185, 3140.2463408781955, 3151.5745374374624, 3229.2249860033658, 3264.1676372524853, 46801.76599117017, 46909.0, 47021.5297847024, 47093.529064709255, 47306.688531802785, 9770.218382529381, 9802.313838031268, 9873.654422095193, 10010.64962726301, 10093.798124037477, 17221.91389043072, 17250.65498690044, 17268.13659317029, 17270.395536156175, 17374.305027798746, 6727.327267273234, 6753.696083676246, 6812.659367031629, 6816.131877550844, 6881.243063263037, 3787.223619158066, 3804.771713697187, 3806.790626515513, 3824.78963656996, 3904.6876249899938, 2878.9856050719613, 2982.791204615656, 2982.925426864302, 2983.582298478215, 2998.1755017370397, 494.91833847415495, 516.073647802196, 516.7287174233483, 532.2043544900399, 568.3151802078486, 465.42287563421115, 578.1356871477169, 578.8060999565192, 582.4990508162977, 595.5354823237882, 7099.538529995637, 7241.601711905791, 7406.8888966665545, 7433.10802703679, 7490.737824176128, 442.57512787724147, 500.3220636038116, 525.5244004176227, 535.5073332534078, 561.2899681902396, 3214.148250713563, 3434.8820257815673, 3463.6709512596262, 3498.1254686328416, 3534.6465353464446, 54292.45707542953, 54867.0, 55236.44763552393, 55678.72160639252, 55825.44174558202, 48768.51231487711, 48949.597565032826, 49472.50527494751, 49719.751401242764, 50036.0, 45498.31752523715, 46591.0, 46802.0, 47316.2902556455, 47485.28772068422, 7879.487833291047, 7986.520808751494, 7993.240642138988, 8009.919900800917, 8026.8685107395895, 31323.06030819079, 31380.843095784374, 31579.0, 31703.524447133772, 32306.192345191557, 38481.23037539177, 40081.39877901892, 42069.15861682688, 42155.789221053696, 42241.0, 9862.0, 10292.897071029493, 10320.43237621938, 10364.274500784873, 10393.168546516412, 10587.311824731676, 11866.406679666155, 11917.404129793302, 11961.521539138685, 12253.774622537674, 9825.705228843146, 9948.104670579683, 10148.695539133838, 10452.372857628567, 10479.63321283782, 10990.17573681961, 11302.660920172408, 11415.714607134889, 11451.656450306504, 11550.826737598774, 10383.480825958823, 10412.791744164922, 10418.895811041793, 10463.372197668165, 10668.573257069631, 8703.738887833375, 9161.816763664823, 9194.31042671789, 9295.442273463614, 9312.953435232781, 8365.456245344034, 8467.068622451648, 8525.658973640984, 8544.487330760174, 8794.692185773467], "value": 5917.43871466925, "unit": "score"}], "name": "dromaeo_css", "value": 6217.6932112624245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 114.0, 112.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 133.0, 180.0, 139.0, 131.0, 152.0, 130.0, 171.0, 130.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 118.0, 75.0, 75.0, 75.0, 76.0, 104.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 84.0, 84.0, 84.0, 117.0, 83.0, 83.0, 131.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 148.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 81.0, 64.0, 65.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 84.0, 84.0, 83.0, 84.0, 89.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 138.0, 128.0, 128.0, 129.0, 135.0, 128.0, 164.0, 132.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 169.0, 174.0, 169.0, 171.0, 173.0, 185.0, 172.0, 168.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 65.0, 67.0, 66.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1545.3, "alertThreshold": 2.0}]} 10:04:19 INFO - Return code: 0 10:04:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:04:19 ERROR - # TBPL SUCCESS # 10:04:19 INFO - Running post-action listener: _resource_record_post_action 10:04:19 INFO - ##### 10:04:19 INFO - ##### Finished run-tests step (success) 10:04:19 INFO - ##### 10:04:19 INFO - Running post-run listener: _resource_record_post_run 10:04:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522113024; Read time: 120; Write time: 364784 10:04:19 INFO - TinderboxPrint: CPU usage
13.0% 10:04:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 120 10:04:19 INFO - TinderboxPrint: I/O write bytes / time
522,113,024 / 364,784 10:04:19 INFO - TinderboxPrint: CPU idle
8,306.7 (86.9%) 10:04:19 INFO - TinderboxPrint: CPU user
1,208.2 (12.6%) 10:04:19 INFO - TinderboxPrint: Swap in / out
0 / 0 10:04:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236867584; Read time: 0; Write time: 186424 10:04:19 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285245440; Read time: 120; Write time: 178360 10:04:20 INFO - Running post-run listener: _upload_blobber_files 10:04:20 INFO - Blob upload gear active. 10:04:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:04:20 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 10:04:20 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'] 10:04:20 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 10:04:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:04:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:04:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:04:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:21 INFO - (blobuploader) - INFO - Done attempting. 10:04:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:04:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:04:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:27 INFO - (blobuploader) - INFO - Done attempting. 10:04:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:04:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:28 INFO - (blobuploader) - INFO - Done attempting. 10:04:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:04:28 INFO - Return code: 0 10:04:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:04:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:04:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16fcf9c936d81e9b232798620ef0c74f2dff39d8293af3e743343de4a877f56c743216ffb10ad5eb227a80f873bd173d590e733d8f0456993947d6461328312b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dccf711338cfb83e4925c5cf150fb359d645ef9ea161f6f3ef7366910e29be2b75f7fb7fb6f4aef98799126eeb0c9b868e135b718e5f906122c6179c6bd5f40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/961af60021868f96ca8bf39879265ce544a2f1c87781d8ca56aa9106bd5d862aac7bb644d4fed78f68101e7b9b02d43027c36fcb5e63629c0da39719d9dd8eb2"} 10:04:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:04:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:04:28 INFO - Contents: 10:04:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16fcf9c936d81e9b232798620ef0c74f2dff39d8293af3e743343de4a877f56c743216ffb10ad5eb227a80f873bd173d590e733d8f0456993947d6461328312b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dccf711338cfb83e4925c5cf150fb359d645ef9ea161f6f3ef7366910e29be2b75f7fb7fb6f4aef98799126eeb0c9b868e135b718e5f906122c6179c6bd5f40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/961af60021868f96ca8bf39879265ce544a2f1c87781d8ca56aa9106bd5d862aac7bb644d4fed78f68101e7b9b02d43027c36fcb5e63629c0da39719d9dd8eb2"} 10:04:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:04:28 INFO - Copying logs to upload dir... 10:04:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:04:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.394385 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-26 10:04:27.251119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 10:04:27.257206) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238 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/16fcf9c936d81e9b232798620ef0c74f2dff39d8293af3e743343de4a877f56c743216ffb10ad5eb227a80f873bd173d590e733d8f0456993947d6461328312b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dccf711338cfb83e4925c5cf150fb359d645ef9ea161f6f3ef7366910e29be2b75f7fb7fb6f4aef98799126eeb0c9b868e135b718e5f906122c6179c6bd5f40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/961af60021868f96ca8bf39879265ce544a2f1c87781d8ca56aa9106bd5d862aac7bb644d4fed78f68101e7b9b02d43027c36fcb5e63629c0da39719d9dd8eb2"} build_url:https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/Hi7ohWQwTBqKiRo1U11E5w/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/16fcf9c936d81e9b232798620ef0c74f2dff39d8293af3e743343de4a877f56c743216ffb10ad5eb227a80f873bd173d590e733d8f0456993947d6461328312b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dccf711338cfb83e4925c5cf150fb359d645ef9ea161f6f3ef7366910e29be2b75f7fb7fb6f4aef98799126eeb0c9b868e135b718e5f906122c6179c6bd5f40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/961af60021868f96ca8bf39879265ce544a2f1c87781d8ca56aa9106bd5d862aac7bb644d4fed78f68101e7b9b02d43027c36fcb5e63629c0da39719d9dd8eb2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 10:04:27.283600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:04:27.283981) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464280600.790805-152025238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:04:27.366532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 10:04:27.366857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 10:04:27.367148) ========= ========= Total master_lag: 0.19 =========