builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1464105908.5 results: success (0) buildid: 20160524053015 builduid: 074b7b464a554b7ca7879b1248dcec14 revision: 74fe05a5f015f517f835f0b560b074a941103481 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.498366) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.498853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.499133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.512744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.513046) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 09:05:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-24 09:05:08 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.626307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.626672) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:08.676399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 09:05:08.676861) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74fe05a5f015f517f835f0b560b074a941103481 --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 74fe05a5f015f517f835f0b560b074a941103481 --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=d6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 09:05:08,926 truncating revision to first 12 chars 2016-05-24 09:05:08,926 Setting DEBUG logging. 2016-05-24 09:05:08,926 attempt 1/10 2016-05-24 09:05:08,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74fe05a5f015?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 09:05:09,903 unpacking tar archive at: fx-team-74fe05a5f015/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 09:05:09.958889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:09.959213) ========= script_repo_revision: 74fe05a5f015f517f835f0b560b074a941103481 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:09.959683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:09.959959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 09:05:09.972522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-24 09:05:09.972851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:10 INFO - MultiFileLogger online at 20160524 09:05:10 in /builds/slave/test 09:05:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:05:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:10 INFO - {'append_to_log': False, 09:05:10 INFO - 'base_work_dir': '/builds/slave/test', 09:05:10 INFO - 'blob_upload_branch': 'Fx-Team', 09:05:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:10 INFO - 'branch': 'Fx-Team', 09:05:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:10 INFO - 'config_files': ('talos/linux_config.py',), 09:05:10 INFO - 'default_actions': ('clobber', 09:05:10 INFO - 'read-buildbot-config', 09:05:10 INFO - 'download-and-extract', 09:05:10 INFO - 'populate-webroot', 09:05:10 INFO - 'create-virtualenv', 09:05:10 INFO - 'install', 09:05:10 INFO - 'run-tests'), 09:05:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:10 INFO - 'download_minidump_stackwalk': True, 09:05:10 INFO - 'download_symbols': 'ondemand', 09:05:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:10 INFO - 'installer_path': 'installer.exe', 09:05:10 INFO - 'log_level': 'info', 09:05:10 INFO - 'log_name': 'talos', 09:05:10 INFO - 'log_to_console': True, 09:05:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:10 INFO - 'opt_config_files': (), 09:05:10 INFO - 'pip_index': False, 09:05:10 INFO - 'sps_profile': False, 09:05:10 INFO - 'sps_profile_interval': 0, 09:05:10 INFO - 'suite': 'dromaeojs', 09:05:10 INFO - 'system_bits': '32', 09:05:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:10 INFO - 'title': 'talos-linux64-ix-034', 09:05:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:10 INFO - 'use_talos_json': True, 09:05:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:10 INFO - 'work_dir': 'build'} 09:05:10 INFO - ##### 09:05:10 INFO - ##### Running clobber step. 09:05:10 INFO - ##### 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: clobber 09:05:10 INFO - rmtree: /builds/slave/test/build 09:05:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - ##### 09:05:10 INFO - ##### Finished clobber step (success) 09:05:10 INFO - ##### 09:05:10 INFO - ##### 09:05:10 INFO - ##### Running read-buildbot-config step. 09:05:10 INFO - ##### 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: read_buildbot_config 09:05:10 INFO - Using buildbot properties: 09:05:10 INFO - { 09:05:10 INFO - "project": "", 09:05:10 INFO - "product": "firefox", 09:05:10 INFO - "script_repo_revision": "production", 09:05:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:05:10 INFO - "repository": "", 09:05:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:05:10 INFO - "buildid": "20160524053015", 09:05:10 INFO - "pgo_build": "True", 09:05:10 INFO - "basedir": "/builds/slave/test", 09:05:10 INFO - "buildnumber": 709, 09:05:10 INFO - "slavename": "talos-linux64-ix-034", 09:05:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:05:10 INFO - "platform": "ubuntu64_hw", 09:05:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:05:10 INFO - "branch": "fx-team", 09:05:10 INFO - "repo_path": "integration/fx-team", 09:05:10 INFO - "revision": "74fe05a5f015f517f835f0b560b074a941103481", 09:05:10 INFO - "stage_platform": "linux64-pgo", 09:05:10 INFO - "builduid": "074b7b464a554b7ca7879b1248dcec14", 09:05:10 INFO - "slavebuilddir": "test" 09:05:10 INFO - } 09:05:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - ##### 09:05:10 INFO - ##### Finished read-buildbot-config step (success) 09:05:10 INFO - ##### 09:05:10 INFO - ##### 09:05:10 INFO - ##### Running download-and-extract step. 09:05:10 INFO - ##### 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: download_and_extract 09:05:10 INFO - mkdir: /builds/slave/test/build/tests 09:05:10 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:05:10 INFO - https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:11 INFO - Downloaded 1361 bytes. 09:05:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:05:11 INFO - Using the following test package requirements: 09:05:11 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:05:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:05:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'jsshell-linux-x86_64.zip'], 09:05:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:05:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:05:11 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:05:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:05:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:05:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:11 INFO - https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:05:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:05:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:05:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:12 INFO - Downloaded 24388238 bytes. 09:05:12 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:05:12 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:05:13 INFO - Return code: 0 09:05:13 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:05:13 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:05:13 INFO - https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:05:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:05:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:05:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:15 INFO - Downloaded 24388238 bytes. 09:05:15 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:05:15 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:05:16 INFO - Return code: 0 09:05: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:05:16 INFO - https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:17 INFO - Downloaded 10840359 bytes. 09:05:17 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:05:17 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:05:17 INFO - Return code: 0 09:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:17 INFO - https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:05:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:05:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:05:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZN7Y1F3QZqIf4_ixflGNA/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:05:19 INFO - Downloaded 58562153 bytes. 09:05:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:05:19 INFO - mkdir: /builds/slave/test/properties 09:05:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:19 INFO - Contents: 09:05:19 INFO - build_url:https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:05:19 INFO - Running post-action listener: _resource_record_post_action 09:05:19 INFO - Running post-action listener: set_extra_try_arguments 09:05:19 INFO - ##### 09:05:19 INFO - ##### Finished download-and-extract step (success) 09:05:19 INFO - ##### 09:05:19 INFO - ##### 09:05:19 INFO - ##### Running populate-webroot step. 09:05:19 INFO - ##### 09:05:19 INFO - Running pre-action listener: _resource_record_pre_action 09:05:19 INFO - Running main action method: populate_webroot 09:05:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:19 INFO - '--tppagecycles', 09:05:19 INFO - '7'], 09:05:19 INFO - 'tests': ['tsvgm']}}, 09:05:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['damp', 'tps']}, 09:05:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'tests': ['damp', 'tps']}, 09:05:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['dromaeo_dom']}, 09:05:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tsvgx', 09:05:19 INFO - 'tsvgr_opacity', 09:05:19 INFO - 'tart', 09:05:19 INFO - 'tscrollx', 09:05:19 INFO - 'cart']}, 09:05:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:19 INFO - 'tsvgr_opacity', 09:05:19 INFO - 'tart', 09:05:19 INFO - 'tscrollx', 09:05:19 INFO - 'cart']}, 09:05:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tp5o']}, 09:05:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'tests': ['tp5o']}, 09:05:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s', 09:05:19 INFO - '--xperf_path', 09:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:19 INFO - 'tests': ['tp5n']}, 09:05:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:19 INFO - 'talos_options': ['--xperf_path', 09:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:19 INFO - 'tests': ['tp5n']}}, 09:05:19 INFO - 'talos.zip': {'path': '', 09:05:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:19 INFO - Running post-action listener: _resource_record_post_action 09:05:19 INFO - ##### 09:05:19 INFO - ##### Finished populate-webroot step (success) 09:05:19 INFO - ##### 09:05:19 INFO - ##### 09:05:19 INFO - ##### Running create-virtualenv step. 09:05:19 INFO - ##### 09:05:19 INFO - Running pre-action listener: _resource_record_pre_action 09:05:19 INFO - Running main action method: create_virtualenv 09:05:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:19 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:05:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:20 INFO - Using real prefix '/usr' 09:05:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:22 INFO - Installing pip.................done. 09:05:22 INFO - Return code: 0 09:05:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:22 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:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:22 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:05:22 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:05:22 INFO - Using env: {'DISPLAY': ':0', 09:05:22 INFO - 'HOME': '/home/cltbld', 09:05:22 INFO - 'LANG': 'en_US.UTF-8', 09:05:22 INFO - 'LANGUAGE': 'en_US:en', 09:05:22 INFO - 'LOGNAME': 'cltbld', 09:05:22 INFO - 'MAIL': '/var/mail/cltbld', 09:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:22 INFO - 'MOZ_NO_REMOTE': '1', 09:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:22 INFO - 'NO_EM_RESTART': '1', 09:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:22 INFO - 'PWD': '/builds/slave/test', 09:05:22 INFO - 'SHELL': '/bin/bash', 09:05:22 INFO - 'SHLVL': '1', 09:05:22 INFO - 'TERM': 'linux', 09:05:22 INFO - 'TMOUT': '86400', 09:05:22 INFO - 'USER': 'cltbld', 09:05:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:22 INFO - '_': '/tools/buildbot/bin/python'} 09:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:22 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:05:22 INFO - Cleaning up... 09:05:22 INFO - Return code: 0 09:05:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:22 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:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:22 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:05:22 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:05:22 INFO - Using env: {'DISPLAY': ':0', 09:05:22 INFO - 'HOME': '/home/cltbld', 09:05:22 INFO - 'LANG': 'en_US.UTF-8', 09:05:22 INFO - 'LANGUAGE': 'en_US:en', 09:05:22 INFO - 'LOGNAME': 'cltbld', 09:05:22 INFO - 'MAIL': '/var/mail/cltbld', 09:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:22 INFO - 'MOZ_NO_REMOTE': '1', 09:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:22 INFO - 'NO_EM_RESTART': '1', 09:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:22 INFO - 'PWD': '/builds/slave/test', 09:05:22 INFO - 'SHELL': '/bin/bash', 09:05:22 INFO - 'SHLVL': '1', 09:05:22 INFO - 'TERM': 'linux', 09:05:22 INFO - 'TMOUT': '86400', 09:05:22 INFO - 'USER': 'cltbld', 09:05:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:22 INFO - '_': '/tools/buildbot/bin/python'} 09:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:22 INFO - Downloading/unpacking psutil>=3.1.1 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:24 INFO - Installing collected packages: psutil 09:05:24 INFO - Running setup.py install for psutil 09:05:24 INFO - building 'psutil._psutil_linux' extension 09:05:24 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:05:25 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:05:25 INFO - building 'psutil._psutil_posix' extension 09:05:25 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:05:25 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:05:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:25 INFO - Successfully installed psutil 09:05:25 INFO - Cleaning up... 09:05:25 INFO - Return code: 0 09:05:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:25 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:05:25 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:05:25 INFO - Using env: {'DISPLAY': ':0', 09:05:25 INFO - 'HOME': '/home/cltbld', 09:05:25 INFO - 'LANG': 'en_US.UTF-8', 09:05:25 INFO - 'LANGUAGE': 'en_US:en', 09:05:25 INFO - 'LOGNAME': 'cltbld', 09:05:25 INFO - 'MAIL': '/var/mail/cltbld', 09:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:25 INFO - 'MOZ_NO_REMOTE': '1', 09:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:25 INFO - 'NO_EM_RESTART': '1', 09:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:25 INFO - 'PWD': '/builds/slave/test', 09:05:25 INFO - 'SHELL': '/bin/bash', 09:05:25 INFO - 'SHLVL': '1', 09:05:25 INFO - 'TERM': 'linux', 09:05:25 INFO - 'TMOUT': '86400', 09:05:25 INFO - 'USER': 'cltbld', 09:05:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:25 INFO - '_': '/tools/buildbot/bin/python'} 09:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:25 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:05:25 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:05:25 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:05:25 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:05:25 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:05:25 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:05:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:27 INFO - Installing collected packages: mozsystemmonitor 09:05:27 INFO - Running setup.py install for mozsystemmonitor 09:05:27 INFO - Successfully installed mozsystemmonitor 09:05:27 INFO - Cleaning up... 09:05:27 INFO - Return code: 0 09:05:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:27 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:27 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:05:27 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:05:27 INFO - Using env: {'DISPLAY': ':0', 09:05:27 INFO - 'HOME': '/home/cltbld', 09:05:27 INFO - 'LANG': 'en_US.UTF-8', 09:05:27 INFO - 'LANGUAGE': 'en_US:en', 09:05:27 INFO - 'LOGNAME': 'cltbld', 09:05:27 INFO - 'MAIL': '/var/mail/cltbld', 09:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:27 INFO - 'MOZ_NO_REMOTE': '1', 09:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:27 INFO - 'NO_EM_RESTART': '1', 09:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:27 INFO - 'PWD': '/builds/slave/test', 09:05:27 INFO - 'SHELL': '/bin/bash', 09:05:27 INFO - 'SHLVL': '1', 09:05:27 INFO - 'TERM': 'linux', 09:05:27 INFO - 'TMOUT': '86400', 09:05:27 INFO - 'USER': 'cltbld', 09:05:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:27 INFO - '_': '/tools/buildbot/bin/python'} 09:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:27 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:05:27 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:05:27 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:05:27 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:05:27 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:05:27 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:05:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:30 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:05:30 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:05:30 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:05:30 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:05:30 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:05:30 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:05:30 INFO - Downloading docopt-0.6.1.tar.gz 09:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:30 INFO - Running setup.py install for blobuploader 09:05:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:30 INFO - Running setup.py install for requests 09:05:31 INFO - Running setup.py install for docopt 09:05:31 INFO - Successfully installed blobuploader requests docopt 09:05:31 INFO - Cleaning up... 09:05:31 INFO - Return code: 0 09:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:31 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:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:31 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:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:31 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:31 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:05:31 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:05:31 INFO - Using env: {'DISPLAY': ':0', 09:05:31 INFO - 'HOME': '/home/cltbld', 09:05:31 INFO - 'LANG': 'en_US.UTF-8', 09:05:31 INFO - 'LANGUAGE': 'en_US:en', 09:05:31 INFO - 'LOGNAME': 'cltbld', 09:05:31 INFO - 'MAIL': '/var/mail/cltbld', 09:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:31 INFO - 'MOZ_NO_REMOTE': '1', 09:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:31 INFO - 'NO_EM_RESTART': '1', 09:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:31 INFO - 'PWD': '/builds/slave/test', 09:05:31 INFO - 'SHELL': '/bin/bash', 09:05:31 INFO - 'SHLVL': '1', 09:05:31 INFO - 'TERM': 'linux', 09:05:31 INFO - 'TMOUT': '86400', 09:05:31 INFO - 'USER': 'cltbld', 09:05:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:31 INFO - '_': '/tools/buildbot/bin/python'} 09:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:31 INFO - Running setup.py (path:/tmp/pip-gMQ6dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:31 INFO - Running setup.py (path:/tmp/pip-yXQtaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:31 INFO - Running setup.py (path:/tmp/pip-OyxqRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:31 INFO - Running setup.py (path:/tmp/pip-504zYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:31 INFO - Running setup.py (path:/tmp/pip-cS9dsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:31 INFO - Running setup.py (path:/tmp/pip-YuoK9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:31 INFO - Running setup.py (path:/tmp/pip-924urB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:31 INFO - Running setup.py (path:/tmp/pip-5fp9QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:32 INFO - Running setup.py (path:/tmp/pip-lq6FSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:32 INFO - Running setup.py (path:/tmp/pip-RsIDdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:32 INFO - Running setup.py (path:/tmp/pip-ihvPdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:32 INFO - Running setup.py (path:/tmp/pip-OYAOe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:32 INFO - Running setup.py (path:/tmp/pip-4sN8ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:32 INFO - Running setup.py (path:/tmp/pip-pyjohl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:32 INFO - Running setup.py (path:/tmp/pip-jSO5_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:32 INFO - Running setup.py (path:/tmp/pip-nPWumK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:32 INFO - Running setup.py (path:/tmp/pip-xh6eRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:32 INFO - Running setup.py install for manifestparser 09:05:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:32 INFO - Running setup.py install for mozcrash 09:05:32 INFO - Running setup.py install for mozdebug 09:05:33 INFO - Running setup.py install for mozdevice 09:05:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Running setup.py install for mozfile 09:05:33 INFO - Running setup.py install for mozhttpd 09:05:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Running setup.py install for mozinfo 09:05:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Running setup.py install for mozInstall 09:05:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Running setup.py install for mozleak 09:05:33 INFO - Running setup.py install for mozlog 09:05:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Running setup.py install for moznetwork 09:05:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:33 INFO - Running setup.py install for mozprocess 09:05:33 INFO - Running setup.py install for mozprofile 09:05:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Running setup.py install for mozrunner 09:05:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Running setup.py install for mozscreenshot 09:05:34 INFO - Running setup.py install for moztest 09:05:34 INFO - Running setup.py install for mozversion 09:05:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:34 INFO - Cleaning up... 09:05:34 INFO - Return code: 0 09:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:34 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:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:34 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:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:34 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:34 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:05:34 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:05:34 INFO - Using env: {'DISPLAY': ':0', 09:05:34 INFO - 'HOME': '/home/cltbld', 09:05:34 INFO - 'LANG': 'en_US.UTF-8', 09:05:34 INFO - 'LANGUAGE': 'en_US:en', 09:05:34 INFO - 'LOGNAME': 'cltbld', 09:05:34 INFO - 'MAIL': '/var/mail/cltbld', 09:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:34 INFO - 'MOZ_NO_REMOTE': '1', 09:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:34 INFO - 'NO_EM_RESTART': '1', 09:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:34 INFO - 'PWD': '/builds/slave/test', 09:05:34 INFO - 'SHELL': '/bin/bash', 09:05:34 INFO - 'SHLVL': '1', 09:05:34 INFO - 'TERM': 'linux', 09:05:34 INFO - 'TMOUT': '86400', 09:05:34 INFO - 'USER': 'cltbld', 09:05:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:34 INFO - '_': '/tools/buildbot/bin/python'} 09:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:34 INFO - Running setup.py (path:/tmp/pip-Em_6dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:34 INFO - Running setup.py (path:/tmp/pip-2VrzQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:34 INFO - Running setup.py (path:/tmp/pip-2QYThO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:34 INFO - Running setup.py (path:/tmp/pip-tLGn8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:35 INFO - Running setup.py (path:/tmp/pip-vIBtiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:35 INFO - Running setup.py (path:/tmp/pip-2k6hrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:35 INFO - Running setup.py (path:/tmp/pip-n2Dq5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:35 INFO - Running setup.py (path:/tmp/pip-_urj_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:35 INFO - Running setup.py (path:/tmp/pip-Kv_Brx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:35 INFO - Running setup.py (path:/tmp/pip-wx_Vk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:35 INFO - Running setup.py (path:/tmp/pip-6mCK6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:35 INFO - Running setup.py (path:/tmp/pip-iNbNOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:35 INFO - Running setup.py (path:/tmp/pip-cRNJBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:35 INFO - Running setup.py (path:/tmp/pip-oXrpOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:35 INFO - Running setup.py (path:/tmp/pip-xnIrKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:35 INFO - Running setup.py (path:/tmp/pip-xNAPxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:35 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:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:35 INFO - Running setup.py (path:/tmp/pip-6jZ4FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:35 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:05:35 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:05:35 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:05:35 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:05:35 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:05:35 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:05:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:35 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:05:35 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:05:35 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:05:35 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:05:35 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:05:35 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:05:37 INFO - Downloading blessings-1.6.tar.gz 09:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:37 INFO - Installing collected packages: blessings 09:05:37 INFO - Running setup.py install for blessings 09:05:38 INFO - Successfully installed blessings 09:05:38 INFO - Cleaning up... 09:05:38 INFO - Return code: 0 09:05:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:38 INFO - Reading from file tmpfile_stdout 09:05:38 INFO - Current package versions: 09:05:38 INFO - argparse == 1.2.1 09:05:38 INFO - blessings == 1.6 09:05:38 INFO - blobuploader == 1.2.4 09:05:38 INFO - docopt == 0.6.1 09:05:38 INFO - manifestparser == 1.1 09:05:38 INFO - mozInstall == 1.12 09:05:38 INFO - mozcrash == 0.17 09:05:38 INFO - mozdebug == 0.1 09:05:38 INFO - mozdevice == 0.48 09:05:38 INFO - mozfile == 1.2 09:05:38 INFO - mozhttpd == 0.7 09:05:38 INFO - mozinfo == 0.9 09:05:38 INFO - mozleak == 0.1 09:05:38 INFO - mozlog == 3.2 09:05:38 INFO - moznetwork == 0.27 09:05:38 INFO - mozprocess == 0.22 09:05:38 INFO - mozprofile == 0.28 09:05:38 INFO - mozrunner == 6.11 09:05:38 INFO - mozscreenshot == 0.1 09:05:38 INFO - mozsystemmonitor == 0.3 09:05:38 INFO - moztest == 0.7 09:05:38 INFO - mozversion == 1.4 09:05:38 INFO - psutil == 3.1.1 09:05:38 INFO - requests == 1.2.3 09:05:38 INFO - wsgiref == 0.1.2 09:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05: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:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:38 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:38 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:05:38 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:05:38 INFO - Using env: {'DISPLAY': ':0', 09:05:38 INFO - 'HOME': '/home/cltbld', 09:05:38 INFO - 'LANG': 'en_US.UTF-8', 09:05:38 INFO - 'LANGUAGE': 'en_US:en', 09:05:38 INFO - 'LOGNAME': 'cltbld', 09:05:38 INFO - 'MAIL': '/var/mail/cltbld', 09:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:38 INFO - 'MOZ_NO_REMOTE': '1', 09:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:38 INFO - 'NO_EM_RESTART': '1', 09:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:38 INFO - 'PWD': '/builds/slave/test', 09:05:38 INFO - 'SHELL': '/bin/bash', 09:05:38 INFO - 'SHLVL': '1', 09:05:38 INFO - 'TERM': 'linux', 09:05:38 INFO - 'TMOUT': '86400', 09:05:38 INFO - 'USER': 'cltbld', 09:05:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:38 INFO - '_': '/tools/buildbot/bin/python'} 09:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 INFO - Cleaning up... 09:05:38 INFO - Return code: 0 09:05:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05: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:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:38 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:38 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:05:38 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:05:38 INFO - Using env: {'DISPLAY': ':0', 09:05:38 INFO - 'HOME': '/home/cltbld', 09:05:38 INFO - 'LANG': 'en_US.UTF-8', 09:05:38 INFO - 'LANGUAGE': 'en_US:en', 09:05:38 INFO - 'LOGNAME': 'cltbld', 09:05:38 INFO - 'MAIL': '/var/mail/cltbld', 09:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:38 INFO - 'MOZ_NO_REMOTE': '1', 09:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:38 INFO - 'NO_EM_RESTART': '1', 09:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:38 INFO - 'PWD': '/builds/slave/test', 09:05:38 INFO - 'SHELL': '/bin/bash', 09:05:38 INFO - 'SHLVL': '1', 09:05:38 INFO - 'TERM': 'linux', 09:05:38 INFO - 'TMOUT': '86400', 09:05:38 INFO - 'USER': 'cltbld', 09:05:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:38 INFO - '_': '/tools/buildbot/bin/python'} 09:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:38 INFO - Downloading/unpacking jsonschema 09:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:38 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:05:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:40 INFO - Downloading/unpacking functools32 (from jsonschema) 09:05:40 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:05:40 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:05:40 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:05:40 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:05:40 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:05:40 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:05:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:40 INFO - warning: no files found matching '*.txt' 09:05:40 INFO - no previously-included directories found matching 'build' 09:05:40 INFO - no previously-included directories found matching 'dist' 09:05:40 INFO - no previously-included directories found matching '.git*' 09:05:40 INFO - Installing collected packages: jsonschema, functools32 09:05:41 INFO - Running setup.py install for functools32 09:05:41 INFO - warning: no files found matching '*.txt' 09:05:41 INFO - no previously-included directories found matching 'build' 09:05:41 INFO - no previously-included directories found matching 'dist' 09:05:41 INFO - no previously-included directories found matching '.git*' 09:05:41 INFO - Successfully installed jsonschema functools32 09:05:41 INFO - Cleaning up... 09:05:41 INFO - Return code: 0 09:05:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:05:41 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:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:41 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:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:41 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 0x7fe1f68ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', '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:05:41 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:05:41 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:05:41 INFO - Using env: {'DISPLAY': ':0', 09:05:41 INFO - 'HOME': '/home/cltbld', 09:05:41 INFO - 'LANG': 'en_US.UTF-8', 09:05:41 INFO - 'LANGUAGE': 'en_US:en', 09:05:41 INFO - 'LOGNAME': 'cltbld', 09:05:41 INFO - 'MAIL': '/var/mail/cltbld', 09:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:41 INFO - 'MOZ_NO_REMOTE': '1', 09:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:41 INFO - 'NO_EM_RESTART': '1', 09:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:41 INFO - 'PWD': '/builds/slave/test', 09:05:41 INFO - 'SHELL': '/bin/bash', 09:05:41 INFO - 'SHLVL': '1', 09:05:41 INFO - 'TERM': 'linux', 09:05:41 INFO - 'TMOUT': '86400', 09:05:41 INFO - 'USER': 'cltbld', 09:05:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:41 INFO - '_': '/tools/buildbot/bin/python'} 09:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:41 INFO - Downloading/unpacking flake8 09:05:41 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:05:41 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:05:41 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:05:41 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:05:41 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:05:41 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:05:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:05:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:05:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:05:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:43 INFO - no previously-included directories found matching 'docs/_build' 09:05:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:05:44 INFO - Running setup.py install for pep8 09:05:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:44 INFO - no previously-included directories found matching 'docs/_build' 09:05:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:05:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:05:44 INFO - Cleaning up... 09:05:44 INFO - Return code: 0 09:05:44 INFO - Running post-action listener: _resource_record_post_action 09:05:44 INFO - Running post-action listener: _start_resource_monitoring 09:05:44 INFO - Starting resource monitoring. 09:05:44 INFO - ##### 09:05:44 INFO - ##### Finished create-virtualenv step (success) 09:05:44 INFO - ##### 09:05:44 INFO - ##### 09:05:44 INFO - ##### Running install step. 09:05:44 INFO - ##### 09:05:44 INFO - Running pre-action listener: _resource_record_pre_action 09:05:44 INFO - Running main action method: install 09:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:44 INFO - Reading from file tmpfile_stdout 09:05:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:44 INFO - Reading from file tmpfile_stdout 09:05:44 INFO - Output received: 09:05:44 INFO - Usage: mozinstall [options] installer 09:05:44 INFO - Options: 09:05:44 INFO - -h, --help show this help message and exit 09:05:44 INFO - -d DEST, --destination=DEST 09:05:44 INFO - Directory to install application into. [default: 09:05:44 INFO - "/builds/slave/test"] 09:05:44 INFO - --app=APP Application being installed. [default: firefox] 09:05:44 INFO - mkdir: /builds/slave/test/build/application 09:05:44 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:05:44 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:06:01 INFO - Reading from file tmpfile_stdout 09:06:01 INFO - Output received: 09:06:01 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:01 INFO - Running post-action listener: _resource_record_post_action 09:06:01 INFO - ##### 09:06:01 INFO - ##### Finished install step (success) 09:06:01 INFO - ##### 09:06:01 INFO - ##### 09:06:01 INFO - ##### Running run-tests step. 09:06:01 INFO - ##### 09:06:01 INFO - Running pre-action listener: _resource_record_pre_action 09:06:01 INFO - Running main action method: run_tests 09:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:01 INFO - Python 2.7.3 09:06:01 INFO - Return code: 0 09:06:01 INFO - grabbing minidump binary from tooltool 09:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:01 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 0x110e9c0>, '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 0x110f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:01 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:06:01 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:06:01 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:06:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:01 INFO - Return code: 0 09:06:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:06:02 INFO - Return code: 0 09:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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:06:02 INFO - Using env: {'DISPLAY': ':0', 09:06:02 INFO - 'HOME': '/home/cltbld', 09:06:02 INFO - 'LANG': 'en_US.UTF-8', 09:06:02 INFO - 'LANGUAGE': 'en_US:en', 09:06:02 INFO - 'LOGNAME': 'cltbld', 09:06:02 INFO - 'MAIL': '/var/mail/cltbld', 09:06:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:02 INFO - 'MOZ_NO_REMOTE': '1', 09:06:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:02 INFO - 'NO_EM_RESTART': '1', 09:06:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:02 INFO - 'PWD': '/builds/slave/test', 09:06:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:02 INFO - 'SHELL': '/bin/bash', 09:06:02 INFO - 'SHLVL': '1', 09:06:02 INFO - 'TERM': 'linux', 09:06:02 INFO - 'TMOUT': '86400', 09:06:02 INFO - 'USER': 'cltbld', 09:06:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106', 09:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:02 INFO - '_': '/tools/buildbot/bin/python'} 09:06:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:06:02 INFO - mozversion application_buildid: 20160524053015 09:06:02 INFO - mozversion application_changeset: 74fe05a5f015f517f835f0b560b074a941103481 09:06:02 INFO - mozversion application_display_name: Nightly 09:06:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:02 INFO - mozversion application_name: Firefox 09:06:02 INFO - mozversion application_remotingname: firefox 09:06:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:06:02 INFO - mozversion application_vendor: Mozilla 09:06:02 INFO - mozversion application_version: 49.0a1 09:06:02 INFO - mozversion platform_buildid: 20160524053015 09:06:02 INFO - mozversion platform_changeset: 74fe05a5f015f517f835f0b560b074a941103481 09:06:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:06:02 INFO - mozversion platform_version: 49.0a1 09:06:02 INFO - using testdate: 1464105962 09:06:02 INFO - actual date: 1464105962 09:06:02 INFO - starting webserver on 'localhost:45037' 09:06:02 INFO - SUITE-START | Running 2 tests 09:06:02 INFO - TEST-START | dromaeo_css 09:06:02 INFO - operating with platform_type : linux_ 09:06:02 INFO - Initialising browser for dromaeo_css test... 09:06:02 INFO - TEST-INFO | started process 6605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3EYuV8/profile http://localhost:45037/getInfo.html) 09:06:06 INFO - PROCESS | 6605 | __metrics Screen width/height:1600/1200 09:06:06 INFO - PROCESS | 6605 | colorDepth:24 09:06:06 INFO - PROCESS | 6605 | Browser inner width/height: 1024/697 09:06:06 INFO - PROCESS | 6605 | __metrics 09:06:07 ERROR - PROCESS | 6605 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:06:08 INFO - TEST-INFO | 6605: exit 0 09:06:08 INFO - Browser initialized. 09:06:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:08 INFO - TEST-INFO | started process 6686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3EYuV8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:20 INFO - PROCESS | 6686 | RSS: Main: 152793088 09:06:20 INFO - PROCESS | 6686 | 09:07:11 INFO - PROCESS | 6686 | 1464106031150 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:09:19 INFO - PROCESS | 6686 | Cycle 1(1): loaded http://localhost:45037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45037/tests/dromaeo/cssquery-ext.html) 09:09:20 INFO - PROCESS | 6686 | RSS: Main: 255217664 09:09:20 INFO - PROCESS | 6686 | 09:12:22 INFO - PROCESS | 6686 | Cycle 1(1): loaded http://localhost:45037/tests/dromaeo/cssquery-ext.html (next: http://localhost:45037/tests/dromaeo/cssquery-jquery.html) 09:12:22 INFO - PROCESS | 6686 | RSS: Main: 239472640 09:12:22 INFO - PROCESS | 6686 | 09:15:25 INFO - PROCESS | 6686 | Cycle 1(1): loaded http://localhost:45037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45037/tests/dromaeo/cssquery-mootools.html) 09:15:25 INFO - PROCESS | 6686 | RSS: Main: 237486080 09:15:25 INFO - PROCESS | 6686 | 09:18:27 INFO - PROCESS | 6686 | Cycle 1(1): loaded http://localhost:45037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45037/tests/dromaeo/cssquery-prototype.html) 09:18:28 INFO - PROCESS | 6686 | RSS: Main: 232054784 09:18:28 INFO - PROCESS | 6686 | 09:21:30 INFO - PROCESS | 6686 | Cycle 1(1): loaded http://localhost:45037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45037/tests/dromaeo/cssquery-yui.html) 09:21:31 INFO - PROCESS | 6686 | RSS: Main: 222150656 09:21:31 INFO - PROCESS | 6686 | 09:24:33 INFO - PROCESS | 6686 | Cycle 1(1): loaded http://localhost:45037/tests/dromaeo/cssquery-yui.html (next: http://localhost:45037/tests/dromaeo/cssquery-dojo.html) 09:24:34 INFO - PROCESS | 6686 | RSS: Main: 274444288 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | __start_tp_report 09:24:34 INFO - PROCESS | 6686 | _x_x_mozilla_page_load 09:24:34 INFO - PROCESS | 6686 | _x_x_mozilla_page_load_details 09:24:34 INFO - PROCESS | 6686 | |i|pagename|runs| 09:24:34 INFO - PROCESS | 6686 | |0;dojo.html;3090.8145511269327;3113.922151946201;3141.214696325918;3154.2114471382156;3161.3045130071378;5278.6568873023225;5323.387810401805;5386.353637563493;5395.595330350229;5441.0750172470725;5319;5333.679979201251;5404.91892621611;5426.104692725696;5461;4781.497942716017;4865.927011094836;4873.805047798084;4893.070316639845;5065.696058236499;4984.875378115558;5006.349174607296;5043.420006699222;5045.747712614355;5057.772400241998;4849.806007759686;4872.269159626049;4893.461719210902;4893.584045356149;4899.55903968641;4878.634102442331;4896.314515967767;4981.866958120139;4983.401991760976;5029.471905449948;4789.904201915977;4941.160002799533;4950.183219768734;4964.900701985976;4980.551750342486;5320.973395133038;5410.134378499461;5411.080116380225;5459.781608735646;5462.8361149165585;5824.184614154022;5866.911996320058;5900.704964751788;5905.350411454737;5907;5599.580031497613;5810.389909059572;5890.882182356372;5954.166416701665;5960.552958528085;5454.154606036071;5555.916661250085;5557.916631250535;5561.165825126263;5562.916556251659;6038.151355533753;6041.395860413923;6080.422359875804;6087.026075827846;6088.665123418166;5486.753096110685;5606.803761868397;5648.8870222595315;5817.76728930838;5824.359320474744;5756.251687280626;5809.390014048548;5828.708564571754;5833.854153646193;5836.591438599257;5717.22817419643;5738.397468265772;5749.425057494301;5759.913601295984;5769.451902069297;5579.832605021856;5738.426157384228;5786.189933409326;5796.130580412888;5834.883302334015;4410.713303635253;4419.580139886705;4422.977885110554;4432.246518091933;4442.42248507692;3955.0705584187695;3969.702272329587;3977.6618987386396;4015.5181378234797;4017.015831121394;5314.813981510629;5421.620486565981;5518.613697041249;5586.636868603528;5588.91616625751;5894.6757928314355;5923.585349025613;5926.377730338252;5937.406259374028;5997.250343707036;5583.330000399978;5590.161475778666;5601.915971260434;5605.887882242332;5608.4111168326735;4864.391951006124;4953.801847926043;4997.375328083989;5006.123928312531;5014.974925125351;6032.54755893301;6033.366496517802;6036.0644100164545;6038.879222415527;6057.061155520902;5671.801486947937;5831.650100993954;5855.912161317498;5856.648601083949;5862.706864656835;5983.132445795422;6047.213862197887;6051.818445446644;6086.3305036446845;6096.573239873166;5730.856728581819;5764.538836893123;5770.682612456355;5779.653220806596;5786.132080188006;5686.744096515749;5819.098039803837;5884.735186916513;5900.232969713909;5911.586188966731;5679.716014199356;5680.488756011979;5688.061469857427;5716.399778023248;5745.6552606843725;5653.745581448927;5658.321001479849;5665.801696940752;5668.093105103164;5676.403977582295;5375.220593014069;5592.3009623797025;5595.328560572757;5600.103983362643;5648.124540696199;5822.70886455667;5853.824385268449;5863.2670916135485;5864.970675146597;5869.589128761117;5637;5681.375048744718;5687.289088863892;5693;5733.168690539932 09:24:34 INFO - PROCESS | 6686 | |1;ext.html;593.6942474625569;618.7555915413411;626.5582764151274;640.2125385775496;642.2710223895882;31944.84027579862;34560.48159277613;34568;34615.30769384614;34628;43396.34905476413;44378.33432498515;44535.77732111343;47883.52116478834;47898.52101478984;8598.742037738877;8771.561421928878;8776.297896168324;8777.7805554861;8780.429272097294;8627.137286271385;8768.956155219246;8788.209061184492;8793.912060879373;8794.42836215644;8852.734417967471;8858.512781796999;8876.289896808272;8893.42192757472;8897.377183597151;8724.171203735666;8780.560971951441;8782.64869405223;8804.163604457566;8812.911870881273;8680.175383338636;8723.563821808884;8771.517566533837;8782.516961567111;8782.56087195644;41370;41707.582924170674;41763.582364176276;41770.79114604438;41776.37335439971;3511.4206155984234;3619.9638003620153;3649.562052553684;3790.2798468290935;4146.688998325138;31747;32028.199295017577;32384.02847914566;32420.027399178063;33231.667683323096;4233.153369326147;4295.613394794453;4329.393884856123;4418.977905110454;4426.535213802536;236810.99999999828;237047;238048;238266;238410;54142.45857541453;55413;55577.72211138919;55667.721661391435;55748.72125639346;53645;58811.117833232536;59253.703731481066;59263;59311.70344148252;16927;17139;17167.399141030004;17168.055756933238;17186.828131718772;13249;13304.667383315495;13310.201387916755;13319.06766526334;13324.6668833278;13796.724065518634;15606.3757449703;15785.68428631421;15852.60368490797;16066.598335041717;5320.733963301819;5409.5131438169965;5418.376886658006;6151.630902145886;6329.208848893888;1016.8881423043459;1027.5544204792695;1082.5561519776854;1122.3826895207603;1153.8211577205548;31260.84369578183;31501.212469688442;31537.684623153935;31645;32101.197470063435;1081.1512962324537;1116.9553217871357;1161.2219812725493;1171.7246447084929;1227.5642147037852;16609.916950415412;16629.417970370978;16741.665166696843;16747.83252167487;16800.74798878018;481109;481597;484096;485156;485619;57804.71097644485;57975.71012144912;57994;58047;58170.709146454;1253.4798058805675;1331.9134256273505;1343.596920923719;1364.0860623382357;1409.8167238258961;32023;32765.836170818995;32988;33140.668593313756;33919.66080339165;48635;48834.511654884416;49110.26334605055;49132;49146;381742;381818;382024;382055;383209;34459.31081378408;34655.65344346625;35290.47064294089;35497.467537986435;35538.82230588934;47556;47980.5201947976;48461;48903.26645100255;49350.50649493459;40625.1874962505;40721.79639101786;40907.795461022506;41144.588554114074;41496.792516037225;39451.60548394479;40074;40377.39433908435;40900.1819963605;41654.37518437165;40371.79814100911;40840.59159408368;42106.733585109134;43165.3525197116;43453;34067.82966085154;36683;37138.25723485569;37542.2491550162;37690.811545942095;26809.731902681502;27393.178204653894;27620.44759104847;29211.41577168487;29541.409171816013 09:24:34 INFO - PROCESS | 6686 | |2;jquery.html;387.271928773905;389.56757998621526;394.201741473516;407.15921621850873;418.2437735324213;14022;16272;17975.55061123471;18675.813241867578;18726.063696815156;14182.929085354559;17212.311507539715;17833.91083044583;17865.91067044663;18378.448646540593;5612.382637909826;5784.971075144618;5794;5796.536277097822;5798.449147330997;4168.145530166324;5729.0833466645345;6064.636121832682;6396.392342727433;6397.61614303141;6190.226221722285;6432.356764323554;6443.645599492026;6459.6447195404235;6479.1253180820695;6417.711202995876;6429.260635026962;6436.48508119354;6446;6451.774187903425;5479.232907392969;5611.298587676541;5628.352739434977;5670.206171136044;5679.801206957778;20881;21907.890460547755;22019.11923523057;22026.229081982216;22164.445888852748;2355.3051849704207;2471.3203868936007;2524.255344673326;2631.8947242110294;2848.9145325640056;13864.861351386458;14128.081674691111;14224.715505689932;14294.428222871073;14535.055221410574;1889.754331936853;1937.7577802774654;1946.2993322403922;1994.4216177308563;2047.14020111552;71008;71683.64158179176;73266.26733732648;73736;73900.6304968477;9576.90423095774;9616.423014619146;9923.454210018373;9959.701208963743;10158.238132140119;13754.31228438574;13840.169589824442;13870.930645346709;13906.443742250196;13922.373493192628;7824.37405007598;7944.285014348621;8018.55897925608;8084.7574572762915;8110.918890811135;6767.424768894601;7458;7741.961290193513;7777.377809775205;7978.800529986796;6349.142865713162;6443.677816109176;6455.903161452582;6471.417572418411;6497;1818.2181661885252;1894.8863068215676;1912.9011002176285;1913.6891229507833;1913.7894831568517;936.1901954809041;1000.9949950250202;1004.5379125602159;1018.6129270877168;1068.4550879051585;18330.175142118638;18591.907040464983;18850.622987540173;18928.337508187422;19034.143463543896;991.3803872579638;992.9056739609725;994.5226291380178;997.9051990060933;1026.6355443817486;10497.790044199073;10708.82202957674;10734.19493537972;10796.730081748019;10807.67576972692;412554.93283071276;420622;434138;450645;453835.3849384524;78386;78409.60795195987;79182.60408697919;79414;79943;945;977.2426369563503;1006.7030226083323;1008.0977525114981;1016.1413605503337;16538;16960.915195423942;17067.231974561422;17116.229769660644;17325.22036508335;41523.169536609705;41528.58471415368;42376;42998.14003719971;43040.569594303655;55253.447465526435;56590.7170464145;56777.14834277572;57351.426485734606;57359.426405737075;8249.216324449168;8324.958375208327;8348.749537513884;8445.282151017233;8856.778580535538;8712.564371781258;11791.76416471683;12021.278723276631;13035.15271507349;13174.077814553273;11139.944300278446;11413.429328533706;11785.941070294937;11873.525058997544;11945.820812687643;11204.943975280072;11253.549858005588;11388.487518061542;11590.250724203646;11643.243189192675;11337.206395552563;11664.300141991169;11753.47109380097;12208.877911221129;12209.389530523616;8416.789580260542;8482.406231563731;8562.100979397073;8593.484390936565;8659.220670139717;10439.425831579032;10624.150067994697;11091.33451992883;11193.776124477303;11393.088552915913 09:24:34 INFO - PROCESS | 6686 | |3;mootools.html;1294.2169987157763;1455.5778824140996;1494.1334026264767;1620.983790162098;1779.5106345754916;7350.558966462009;7644.159142494321;7653.69385224591;7895.8026049348655;7910.169432209607;7811.570363629998;7981.523418167643;7987.600619968993;8012.639431225594;8016.358691304697;1912.8565357598166;2203.394066631673;2208.7901649343366;2237.7874101960288;2282.9086836526517;2246.6854640350284;2262.1290803040865;2271.716035495563;2275.7610450902666;2276.3057267533395;2195.209724499187;2214.689943407924;2215.7562668106493;2232.430730163806;2239.74242962059;1782.7593274907915;2168.4687251623373;2238.708967834187;2238.955220895573;2253.9549209015727;2144.3888491779767;2161.5460753241837;2175.4670105824016;2176.7714389988982;2185.868847869117;7877.842443151162;7932.246436588515;7934.44458887878;7939;7946.205379462065;4931.112399768041;5045.772940217699;5050.015247026831;5050.924236136424;5058.342415485963;3098.814071155738;3117.423276693796;3144.339688665383;3267.787593806419;3272.4109660261142;1026.1021606094666;1061.9203559732973;1069.9625513107003;1087.0977089016098;1097.8682558093;11531.538738450536;11539.134564907665;11559.94220028903;11584.18910676253;11603.767924641545;4257.680673949404;4301.741895486281;4359.912801743947;4385.824567017284;4405.229084910128;9970.900290997142;9983.850242246372;9984.500774961223;9985.60057597688;9996.950015249877;4338.652907767371;4774.236122220497;4876.146674331978;4881.658283920092;4884.877878053077;4241.4698162729655;4413.1394378095965;4425.424694789656;4429.933550996738;4437.844675436344;3751.549814022335;3814.1799513104816;3854.9036274093373;3900;3963.841446342172;1166.3293606176483;1181.8227265910182;1183.6153250193722;1198.0475521960063;1225.859026211997;723.8914162875506;734.4088009152576;780.3640033372897;859.5959898847532;905.7735566108473;5302.549283310885;5379.327584051994;5383.246345511631;5484.890302194013;5525.917111243334;936.6955739384728;949.4635530925005;953.823542644613;964.4117088575963;990.232569758443;3538.663826936437;3596.8021758803516;3638.235970446183;3742.3825068863875;3838.5201849768778;9444.669436569824;9625.807483850424;9762.853557196648;9763.26775491841;9780.804383912424;9546.761330966643;9638.180754635934;9677.080677335642;9685.6610018649;9743.123118919331;7363.484556081023;7795.493292935941;7819.100803407681;7823.100343460461;7838.647260873275;5232.581393488588;5235.764390602356;5275.393329767126;5427.348718153688;5518.2826232589505;8121.066077401175;8290.83418331618;8343.95828020856;9063.048379920014;9162.541872906462;8505.87241191395;8517.148285171681;8524.104968978168;8566.314694824274;8600.612972416382;6182.845428864314;6814.727410903508;6835;7062.3996960258955;7081.610511421715;7693.461457698131;7700.229977002479;7730.729424470116;7764.417668674985;7769.72805951789;6877.89683154743;7164.462665300019;7200.243974382824;7303.233160518069;7309.378702810321;7110.644467776487;7121.359077683033;7130.251323611154;7252.347288744038;7256.346928776436;5797.91303130445;6034.668093254913;6059.939400605937;6191.597546159485;6206.348333424925;4817.78319975609;4892.339534162842;4912.950870491392;4939.061578300111;4939.753012349296;4835.927461088017;4859.805607775649;4889.3888263967;4896.461389247109;4922.655414120977 09:24:34 INFO - PROCESS | 6686 | |4;prototype.html;319.5127430668231;319.98880039198633;322.67248742526357;323.0905002418194;326.9035634487827;5138.588912886969;5239.480550640319;5241.685498870066;5254.922740838128;5270.183121616146;5143.151380022301;5206.24509446131;5210.921836172461;5210.9478905210935;5214.217867319904;3926.254011737775;3970.900727481822;4010.4585880906143;4046.4739583854057;4047.6357127858487;3642.235130622559;4092.9386059209137;4094.89762755932;4097.364908439182;4112;4003.0792917628964;4049.602887003979;4050.655694265991;4078.3474644056955;4080.041190320287;3858.4791053207737;3931.528216613996;4050.5949405059555;4058.9594104059024;4072.1448495815916;3588.4079126944025;3597.280543891206;3598.7300952428673;3602.486955478705;3612.151144481045;4987.251912213161;5002.674826136289;5017.623678224148;5018.899622007576;5053.9241911371355;4418.513963464016;4616.307553866914;4621.861344159681;4628.953710462886;4640.350350950869;5339.359276886798;5381.650192737498;5394.32570928634;5454.672719636835;5462.525118218098;3942.64516193544;3949.881503554898;3957.98021009896;3975.403689446577;3979.6668116181113;5189.896202075937;5364.865878353034;5657.236273103161;5708.914366284509;5715.771369145229;3982.4026396040827;3984.7609143451486;3990.5809889961715;4054.614811592894;4056.7971601419813;4059.289624315733;4079.6124368184974;4083.959160408417;4087.7751723654887;4105.856295029719;4603.930941035887;4604.539546045436;4634.814607415733;4658.091672123971;4689.320048592935;5283.867903302371;5391.35303763543;5409.890972350738;5435.510804027656;5497.257870187474;1386.6671998720235;1393.5819254223693;1395.9092658977133;1405.7399381114526;1406.8171137752026;858.4334339336008;900.7477906186278;901.9143181397757;902.7336935604012;908.5321059654283;4699.4726713818145;4710.317004034396;4726.109556177487;4732.787024583902;4755.952440475551;4908.901821963612;4956.950430495721;4958.479359667255;4976.959446626865;5001.34928487902;4670.929936050962;4757.3101900224965;4763.595094417014;4771.73755443454;4909.901801963941;2968.777341699338;2972.836493992851;2996.6104406427025;3002.9249268768453;3004.5793588897573;5758.913616295759;5762.337331206965;5807.738651760681;5813.7383817728305;5835.503982161479;5558.805441809517;5646.576506761927;5684.516816070598;5758.280214973129;5784.681842498703;5577.386487486373;5740.770369185269;5767.250257466502;5895.115732640138;5912.290525136925;5546.500814926676;5550.639208451437;5559.193916881949;5570.777168913198;5575.9163612545035;5529.529989950899;5540.371056957699;5553.527950124285;5555.2778138841695;5582.190582365453;5542.196381524575;5807.303123625192;5829.941700583109;5837.766489340549;5847.736851841592;3987.3221552335594;4013.2776100302226;4017;4048.676105911461;4058.573849745734;5390.865228369322;5735.25441692594;5738.713064346683;5745.454181852718;5759.510441612342;5518.868631930525;5543.72281385921;5547.1679248113105;5552.556335352757;5555.805546805843;5410.1343784994215;5420.720464119151;5495.835124946258;5498.340199176125;5507.669539827623;5242.737863106906;5376.462353764592;5426.565874730091;5448.45515448452;5448.972755136199;5490.752916118704;5492.642978206404;5499.395066542597;5519.31008623922;5525.640833345819;5357.089294819812;5403.13549832025;5422.403535611001;5438.613153645795;5445.59158063139 09:24:34 INFO - PROCESS | 6686 | |5;yui.html;644.4168027934718;645.2386184302521;660.250615551349;667.266007391869;669.1969636436278;14460.92769536152;15329.463468778595;15425.228738563055;15445.84554154458;15486.69026619467;13838.930805345984;13948.372323245452;14271.286435678201;14275.78586321206;14299.356528956196;675.8918573028317;798.2297083314601;818.8034871630825;821.0639870547581;828.6064119543229;823.4647479138548;824.221111050058;825.3273582030625;827.5779352530222;827.9047909490396;862.0861886400404;862.5859587398021;865.523961820999;865.645085514939;867.8351113288487;706.2055187913597;835.5446281776447;849.6643825688818;850.6512329944693;862.7023676831483;622.5890911998105;623.847157446424;624.0545573456218;624.8625302433458;624.96875156242;13893.722125557431;13978.720425591431;13987.510437134652;13989.440422383092;14004.22976736279;12591.685207869876;12953;13233.206007639572;13251.271180085092;13682.657933551742;11096.55613775448;11434.714132146679;11484.196106272564;11656.88343116575;11824.408779560987;4318.611324980767;4340.348947657877;4363.694541382105;4364.978175109104;4406.530255125381;52033.739831300976;53391.19913201305;58513.41486585122;59251.40748592502;59543.702281488746;10800.29798063139;10906.890931090746;11008.449577521093;11014.614488492864;11157.72105697364;18860;18877.244910203437;18946.052697365078;18994.905025474785;19017.429477115707;8250;8271.710490132937;8382.161783821692;8573.571321433903;8597.5701214939;4568.027766637449;4659.930101048487;4800.039992001613;4828.806847726122;4911.312416261726;3355.697987181117;3423.6747508987105;3431.553897993245;3440.9827950860085;3441.2773317603082;579.4466284698187;606.8573885136989;612.0543759890979;613.3284053960906;615.3077787489075;565.3244372974339;699.9965000174966;710.2577806192438;723.8371366442508;727.581640556682;8519.616617252239;8924.464532128093;9004.099590041074;9075.863862042075;9090.999720859736;564.8277275430951;651.4657980456076;653.6796969485014;720.495653042872;749.8912657664717;4311.310190369526;4703;4765.1660959331975;4770.737609431515;4775.2359622460235;62905.05642415368;64428.67785661042;64622;65208;65847.34152658508;59027;59629;59706.40293597009;60479.395206047375;60618.09072863911;53666.73166634142;54301.72849135729;54445;54700.90598188014;55960.72019639876;9159.450432974043;9251.722448326562;9281.582328795355;9297;9528.094830991045;37090.25819483649;37119.44320835244;37447.063823404635;37596.556223846455;37762.24475510419;45303;49038.26442603435;50309.24536132034;50546.7472662649;50965.49034509608;11349.943250284026;11350;11460.140489463156;11553.13351498624;12230.082743794073;12557.74884502323;12863.549775757803;12983.480660773463;13015.284159371326;13251.536196233086;11256.437178141225;11315.151363647594;11584.536618535165;11807.468663910317;12063.457144428698;11517.769644607228;11594.246373985665;11885.524579016743;12316.076294277786;12635.494580216688;12169.513219471477;12224.938875305566;12525.624231273076;12621.684457888627;12943.935280323914;9463.526823658927;9813.165880900204;9819.656312029045;9843.261755368232;9915.950420247853;10362.844557331797;10430.269881108554;10580.575690200094;10642.521086550969;10657.25399222047 09:24:34 INFO - PROCESS | 6686 | __end_tp_report 09:24:34 INFO - PROCESS | 6686 | __start_cc_report 09:24:34 INFO - PROCESS | 6686 | _x_x_mozilla_cycle_collect,930 09:24:34 INFO - PROCESS | 6686 | __end_cc_report 09:24:34 INFO - PROCESS | 6686 | __startTimestamp1464107074231__endTimestamp 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | ------- Summary: start ------- 09:24:34 INFO - PROCESS | 6686 | Number of tests: 6 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | [#0] dojo.html Cycles:165 Average:5414.61 Median:5608.41 stddev:629.51 (11.2%) stddev-sans-first:604.47 09:24:34 INFO - PROCESS | 6686 | Values: 3090.8 3113.9 3141.2 3154.2 3161.3 5278.7 5323.4 5386.4 5395.6 5441.1 5319.0 5333.7 5404.9 5426.1 5461.0 4781.5 4865.9 4873.8 4893.1 5065.7 4984.9 5006.3 5043.4 5045.7 5057.8 4849.8 4872.3 4893.5 4893.6 4899.6 4878.6 4896.3 4981.9 4983.4 5029.5 4789.9 4941.2 4950.2 4964.9 4980.6 5321.0 5410.1 5411.1 5459.8 5462.8 5824.2 5866.9 5900.7 5905.4 5907.0 5599.6 5810.4 5890.9 5954.2 5960.6 5454.2 5555.9 5557.9 5561.2 5562.9 6038.2 6041.4 6080.4 6087.0 6088.7 5486.8 5606.8 5648.9 5817.8 5824.4 5756.3 5809.4 5828.7 5833.9 5836.6 5717.2 5738.4 5749.4 5759.9 5769.5 5579.8 5738.4 5786.2 5796.1 5834.9 4410.7 4419.6 4423.0 4432.2 4442.4 3955.1 3969.7 3977.7 4015.5 4017.0 5314.8 5421.6 5518.6 5586.6 5588.9 5894.7 5923.6 5926.4 5937.4 5997.3 5583.3 5590.2 5601.9 5605.9 5608.4 4864.4 4953.8 4997.4 5006.1 5015.0 6032.5 6033.4 6036.1 6038.9 6057.1 5671.8 5831.7 5855.9 5856.6 5862.7 5983.1 6047.2 6051.8 6086.3 6096.6 5730.9 5764.5 5770.7 5779.7 5786.1 5686.7 5819.1 5884.7 5900.2 5911.6 5679.7 5680.5 5688.1 5716.4 5745.7 5653.7 5658.3 5665.8 5668.1 5676.4 5375.2 5592.3 5595.3 5600.1 5648.1 5822.7 5853.8 5863.3 5865.0 5869.6 5637.0 5681.4 5687.3 5693.0 5733.2 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | [#1] ext.html Cycles:180 Average:53839.65 Median:40870.39 stddev:100911.52 (246.9%) stddev-sans-first:101115.41 09:24:34 INFO - PROCESS | 6686 | Values: 593.7 618.8 626.6 640.2 642.3 31944.8 34560.5 34568.0 34615.3 34628.0 43396.3 44378.3 44535.8 47883.5 47898.5 8598.7 8771.6 8776.3 8777.8 8780.4 8627.1 8769.0 8788.2 8793.9 8794.4 8852.7 8858.5 8876.3 8893.4 8897.4 8724.2 8780.6 8782.6 8804.2 8812.9 8680.2 8723.6 8771.5 8782.5 8782.6 41370.0 41707.6 41763.6 41770.8 41776.4 3511.4 3620.0 3649.6 3790.3 4146.7 31747.0 32028.2 32384.0 32420.0 33231.7 4233.2 4295.6 4329.4 4419.0 4426.5 236811.0 237047.0 238048.0 238266.0 238410.0 54142.5 55413.0 55577.7 55667.7 55748.7 53645.0 58811.1 59253.7 59263.0 59311.7 16927.0 17139.0 17167.4 17168.1 17186.8 13249.0 13304.7 13310.2 13319.1 13324.7 13796.7 15606.4 15785.7 15852.6 16066.6 5320.7 5409.5 5418.4 6151.6 6329.2 1016.9 1027.6 1082.6 1122.4 1153.8 31260.8 31501.2 31537.7 31645.0 32101.2 1081.2 1117.0 1161.2 1171.7 1227.6 16609.9 16629.4 16741.7 16747.8 16800.7 481109.0 481597.0 484096.0 485156.0 485619.0 57804.7 57975.7 57994.0 58047.0 58170.7 1253.5 1331.9 1343.6 1364.1 1409.8 32023.0 32765.8 32988.0 33140.7 33919.7 48635.0 48834.5 49110.3 49132.0 49146.0 381742.0 381818.0 382024.0 382055.0 383209.0 34459.3 34655.7 35290.5 35497.5 35538.8 47556.0 47980.5 48461.0 48903.3 49350.5 40625.2 40721.8 40907.8 41144.6 41496.8 39451.6 40074.0 40377.4 40900.2 41654.4 40371.8 40840.6 42106.7 43165.4 43453.0 34067.8 36683.0 37138.3 37542.2 37690.8 26809.7 27393.2 27620.4 29211.4 29541.4 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | [#2] jquery.html Cycles:180 Average:26717.57 Median:400.68 stddev:71546.85 (17856.3%) stddev-sans-first:71720.24 09:24:34 INFO - PROCESS | 6686 | Values: 387.3 389.6 394.2 407.2 418.2 14022.0 16272.0 17975.6 18675.8 18726.1 14182.9 17212.3 17833.9 17865.9 18378.4 5612.4 5785.0 5794.0 5796.5 5798.4 4168.1 5729.1 6064.6 6396.4 6397.6 6190.2 6432.4 6443.6 6459.6 6479.1 6417.7 6429.3 6436.5 6446.0 6451.8 5479.2 5611.3 5628.4 5670.2 5679.8 20881.0 21907.9 22019.1 22026.2 22164.4 2355.3 2471.3 2524.3 2631.9 2848.9 13864.9 14128.1 14224.7 14294.4 14535.1 1889.8 1937.8 1946.3 1994.4 2047.1 71008.0 71683.6 73266.3 73736.0 73900.6 9576.9 9616.4 9923.5 9959.7 10158.2 13754.3 13840.2 13870.9 13906.4 13922.4 7824.4 7944.3 8018.6 8084.8 8110.9 6767.4 7458.0 7742.0 7777.4 7978.8 6349.1 6443.7 6455.9 6471.4 6497.0 1818.2 1894.9 1912.9 1913.7 1913.8 936.2 1001.0 1004.5 1018.6 1068.5 18330.2 18591.9 18850.6 18928.3 19034.1 991.4 992.9 994.5 997.9 1026.6 10497.8 10708.8 10734.2 10796.7 10807.7 412554.9 420622.0 434138.0 450645.0 453835.4 78386.0 78409.6 79182.6 79414.0 79943.0 945.0 977.2 1006.7 1008.1 1016.1 16538.0 16960.9 17067.2 17116.2 17325.2 41523.2 41528.6 42376.0 42998.1 43040.6 55253.4 56590.7 56777.1 57351.4 57359.4 8249.2 8325.0 8348.7 8445.3 8856.8 8712.6 11791.8 12021.3 13035.2 13174.1 11139.9 11413.4 11785.9 11873.5 11945.8 11204.9 11253.5 11388.5 11590.3 11643.2 11337.2 11664.3 11753.5 12208.9 12209.4 8416.8 8482.4 8562.1 8593.5 8659.2 10439.4 10624.2 11091.3 11193.8 11393.1 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | [#3] mootools.html Cycles:180 Average:5292.20 Median:5234.17 stddev:2946.25 (56.3%) stddev-sans-first:2939.20 09:24:34 INFO - PROCESS | 6686 | Values: 1294.2 1455.6 1494.1 1621.0 1779.5 7350.6 7644.2 7653.7 7895.8 7910.2 7811.6 7981.5 7987.6 8012.6 8016.4 1912.9 2203.4 2208.8 2237.8 2282.9 2246.7 2262.1 2271.7 2275.8 2276.3 2195.2 2214.7 2215.8 2232.4 2239.7 1782.8 2168.5 2238.7 2239.0 2254.0 2144.4 2161.5 2175.5 2176.8 2185.9 7877.8 7932.2 7934.4 7939.0 7946.2 4931.1 5045.8 5050.0 5050.9 5058.3 3098.8 3117.4 3144.3 3267.8 3272.4 1026.1 1061.9 1070.0 1087.1 1097.9 11531.5 11539.1 11559.9 11584.2 11603.8 4257.7 4301.7 4359.9 4385.8 4405.2 9970.9 9983.9 9984.5 9985.6 9997.0 4338.7 4774.2 4876.1 4881.7 4884.9 4241.5 4413.1 4425.4 4429.9 4437.8 3751.5 3814.2 3854.9 3900.0 3963.8 1166.3 1181.8 1183.6 1198.0 1225.9 723.9 734.4 780.4 859.6 905.8 5302.5 5379.3 5383.2 5484.9 5525.9 936.7 949.5 953.8 964.4 990.2 3538.7 3596.8 3638.2 3742.4 3838.5 9444.7 9625.8 9762.9 9763.3 9780.8 9546.8 9638.2 9677.1 9685.7 9743.1 7363.5 7795.5 7819.1 7823.1 7838.6 5232.6 5235.8 5275.4 5427.3 5518.3 8121.1 8290.8 8344.0 9063.0 9162.5 8505.9 8517.1 8524.1 8566.3 8600.6 6182.8 6814.7 6835.0 7062.4 7081.6 7693.5 7700.2 7730.7 7764.4 7769.7 6877.9 7164.5 7200.2 7303.2 7309.4 7110.6 7121.4 7130.3 7252.3 7256.3 5797.9 6034.7 6059.9 6191.6 6206.3 4817.8 4892.3 4913.0 4939.1 4939.8 4835.9 4859.8 4889.4 4896.5 4922.7 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | [#4] prototype.html Cycles:180 Average:4553.97 Median:5140.87 stddev:1337.81 (26.0%) stddev-sans-first:1303.27 09:24:34 INFO - PROCESS | 6686 | Values: 319.5 320.0 322.7 323.1 326.9 5138.6 5239.5 5241.7 5254.9 5270.2 5143.2 5206.2 5210.9 5210.9 5214.2 3926.3 3970.9 4010.5 4046.5 4047.6 3642.2 4092.9 4094.9 4097.4 4112.0 4003.1 4049.6 4050.7 4078.3 4080.0 3858.5 3931.5 4050.6 4059.0 4072.1 3588.4 3597.3 3598.7 3602.5 3612.2 4987.3 5002.7 5017.6 5018.9 5053.9 4418.5 4616.3 4621.9 4629.0 4640.4 5339.4 5381.7 5394.3 5454.7 5462.5 3942.6 3949.9 3958.0 3975.4 3979.7 5189.9 5364.9 5657.2 5708.9 5715.8 3982.4 3984.8 3990.6 4054.6 4056.8 4059.3 4079.6 4084.0 4087.8 4105.9 4603.9 4604.5 4634.8 4658.1 4689.3 5283.9 5391.4 5409.9 5435.5 5497.3 1386.7 1393.6 1395.9 1405.7 1406.8 858.4 900.7 901.9 902.7 908.5 4699.5 4710.3 4726.1 4732.8 4756.0 4908.9 4957.0 4958.5 4977.0 5001.3 4670.9 4757.3 4763.6 4771.7 4909.9 2968.8 2972.8 2996.6 3002.9 3004.6 5758.9 5762.3 5807.7 5813.7 5835.5 5558.8 5646.6 5684.5 5758.3 5784.7 5577.4 5740.8 5767.3 5895.1 5912.3 5546.5 5550.6 5559.2 5570.8 5575.9 5529.5 5540.4 5553.5 5555.3 5582.2 5542.2 5807.3 5829.9 5837.8 5847.7 3987.3 4013.3 4017.0 4048.7 4058.6 5390.9 5735.3 5738.7 5745.5 5759.5 5518.9 5543.7 5547.2 5552.6 5555.8 5410.1 5420.7 5495.8 5498.3 5507.7 5242.7 5376.5 5426.6 5448.5 5449.0 5490.8 5492.6 5499.4 5519.3 5525.6 5357.1 5403.1 5422.4 5438.6 5445.6 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - PROCESS | 6686 | [#5] yui.html Cycles:180 Average:15318.78 Median:26974.79 stddev:18311.02 (67.9%) stddev-sans-first:18329.23 09:24:34 INFO - PROCESS | 6686 | Values: 644.4 645.2 660.3 667.3 669.2 14460.9 15329.5 15425.2 15445.8 15486.7 13838.9 13948.4 14271.3 14275.8 14299.4 675.9 798.2 818.8 821.1 828.6 823.5 824.2 825.3 827.6 827.9 862.1 862.6 865.5 865.6 867.8 706.2 835.5 849.7 850.7 862.7 622.6 623.8 624.1 624.9 625.0 13893.7 13978.7 13987.5 13989.4 14004.2 12591.7 12953.0 13233.2 13251.3 13682.7 11096.6 11434.7 11484.2 11656.9 11824.4 4318.6 4340.3 4363.7 4365.0 4406.5 52033.7 53391.2 58513.4 59251.4 59543.7 10800.3 10906.9 11008.4 11014.6 11157.7 18860.0 18877.2 18946.1 18994.9 19017.4 8250.0 8271.7 8382.2 8573.6 8597.6 4568.0 4659.9 4800.0 4828.8 4911.3 3355.7 3423.7 3431.6 3441.0 3441.3 579.4 606.9 612.1 613.3 615.3 565.3 700.0 710.3 723.8 727.6 8519.6 8924.5 9004.1 9075.9 9091.0 564.8 651.5 653.7 720.5 749.9 4311.3 4703.0 4765.2 4770.7 4775.2 62905.1 64428.7 64622.0 65208.0 65847.3 59027.0 59629.0 59706.4 60479.4 60618.1 53666.7 54301.7 54445.0 54700.9 55960.7 9159.5 9251.7 9281.6 9297.0 9528.1 37090.3 37119.4 37447.1 37596.6 37762.2 45303.0 49038.3 50309.2 50546.7 50965.5 11349.9 11350.0 11460.1 11553.1 12230.1 12557.7 12863.5 12983.5 13015.3 13251.5 11256.4 11315.2 11584.5 11807.5 12063.5 11517.8 11594.2 11885.5 12316.1 12635.5 12169.5 12224.9 12525.6 12621.7 12943.9 9463.5 9813.2 9819.7 9843.3 9916.0 10362.8 10430.3 10580.6 10642.5 10657.3 09:24:34 INFO - PROCESS | 6686 | -------- Summary: end -------- 09:24:34 INFO - PROCESS | 6686 | 09:24:34 INFO - TEST-INFO | 6686: exit 0 09:24:34 INFO - TEST-OK | dromaeo_css | took 1112450ms 09:24:34 INFO - TEST-START | kraken 09:24:34 INFO - operating with platform_type : linux_ 09:24:34 INFO - Initialising browser for kraken test... 09:24:34 INFO - TEST-INFO | started process 6870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VJOFV/profile http://localhost:45037/getInfo.html) 09:24:38 INFO - PROCESS | 6870 | __metrics Screen width/height:1600/1200 09:24:38 INFO - PROCESS | 6870 | colorDepth:24 09:24:38 INFO - PROCESS | 6870 | Browser inner width/height: 1024/697 09:24:38 INFO - PROCESS | 6870 | __metrics 09:24:39 ERROR - PROCESS | 6870 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:24:40 INFO - TEST-INFO | 6870: exit 0 09:24:40 INFO - Browser initialized. 09:24:40 INFO - Running cycle 1/1 for kraken test... 09:24:40 INFO - TEST-INFO | started process 6953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VJOFV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:52 INFO - PROCESS | 6953 | RSS: Main: 152834048 09:24:52 INFO - PROCESS | 6953 | 09:24:55 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45037/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:55 INFO - PROCESS | 6953 | RSS: Main: 209489920 09:24:55 INFO - PROCESS | 6953 | 09:24:58 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45037/tests/kraken/driver.html?testName=audio-dft) 09:24:59 INFO - PROCESS | 6953 | RSS: Main: 197771264 09:24:59 INFO - PROCESS | 6953 | 09:25:02 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45037/tests/kraken/driver.html?testName=audio-fft) 09:25:03 INFO - PROCESS | 6953 | RSS: Main: 266162176 09:25:03 INFO - PROCESS | 6953 | 09:25:05 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45037/tests/kraken/driver.html?testName=audio-oscillator) 09:25:05 INFO - PROCESS | 6953 | RSS: Main: 175562752 09:25:05 INFO - PROCESS | 6953 | 09:25:08 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:08 INFO - PROCESS | 6953 | RSS: Main: 179539968 09:25:08 INFO - PROCESS | 6953 | 09:25:11 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45037/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:12 INFO - PROCESS | 6953 | RSS: Main: 215347200 09:25:12 INFO - PROCESS | 6953 | 09:25:16 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45037/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:16 INFO - PROCESS | 6953 | RSS: Main: 213024768 09:25:16 INFO - PROCESS | 6953 | 09:25:19 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45037/tests/kraken/driver.html?testName=json-parse-financial) 09:25:20 INFO - PROCESS | 6953 | RSS: Main: 213966848 09:25:20 INFO - PROCESS | 6953 | 09:25:22 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:22 INFO - PROCESS | 6953 | RSS: Main: 204992512 09:25:22 INFO - PROCESS | 6953 | 09:25:24 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:25 INFO - PROCESS | 6953 | RSS: Main: 206983168 09:25:25 INFO - PROCESS | 6953 | 09:25:27 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:27 INFO - PROCESS | 6953 | RSS: Main: 216530944 09:25:27 INFO - PROCESS | 6953 | 09:25:30 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:31 INFO - PROCESS | 6953 | RSS: Main: 223047680 09:25:31 INFO - PROCESS | 6953 | 09:25:33 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:34 INFO - PROCESS | 6953 | RSS: Main: 219373568 09:25:34 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:45037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45037/tests/kraken/driver.html?testName=ai-astar) 09:25:36 INFO - PROCESS | 6953 | RSS: Main: 265756672 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | __start_tp_report 09:25:36 INFO - PROCESS | 6953 | _x_x_mozilla_page_load 09:25:36 INFO - PROCESS | 6953 | _x_x_mozilla_page_load_details 09:25:36 INFO - PROCESS | 6953 | |i|pagename|runs| 09:25:36 INFO - PROCESS | 6953 | |0;ai-astar;112;105;113;113;110;111;110;110;110;111 09:25:36 INFO - PROCESS | 6953 | |1;audio-beat-detection;150;136;134;214;126;152;148;128;198;124 09:25:36 INFO - PROCESS | 6953 | |2;audio-dft;162;162;160;161;159;162;161;161;161;167 09:25:36 INFO - PROCESS | 6953 | |3;audio-fft;75;77;76;149;77;75;76;76;115;75 09:25:36 INFO - PROCESS | 6953 | |4;audio-oscillator;93;92;158;92;91;92;125;92;92;133 09:25:36 INFO - PROCESS | 6953 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 09:25:36 INFO - PROCESS | 6953 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;146;145 09:25:36 INFO - PROCESS | 6953 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;94 09:25:36 INFO - PROCESS | 6953 | |8;json-parse-financial;53;55;53;54;54;53;53;112;51;51 09:25:36 INFO - PROCESS | 6953 | |9;json-stringify-tinderbox;62;62;62;62;62;63;62;62;61;62 09:25:36 INFO - PROCESS | 6953 | |10;stanford-crypto-aes;83;81;78;84;79;79;80;84;81;81 09:25:36 INFO - PROCESS | 6953 | |11;stanford-crypto-ccm;122;119;117;132;118;121;132;118;195;137 09:25:36 INFO - PROCESS | 6953 | |12;stanford-crypto-pbkdf2;161;163;159;162;161;162;157;156;166;157 09:25:36 INFO - PROCESS | 6953 | |13;stanford-crypto-sha256-iterative;64;63;62;63;63;62;64;61;61;63 09:25:36 INFO - PROCESS | 6953 | __end_tp_report 09:25:36 INFO - PROCESS | 6953 | __start_cc_report 09:25:36 INFO - PROCESS | 6953 | _x_x_mozilla_cycle_collect,1900 09:25:36 INFO - PROCESS | 6953 | __end_cc_report 09:25:36 INFO - PROCESS | 6953 | __startTimestamp1464107136444__endTimestamp 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | ------- Summary: start ------- 09:25:36 INFO - PROCESS | 6953 | Number of tests: 14 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.27 (2.0%) stddev-sans-first:2.35 09:25:36 INFO - PROCESS | 6953 | Values: 112.0 105.0 113.0 113.0 110.0 111.0 110.0 110.0 110.0 111.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:149.00 stddev:30.89 (20.7%) stddev-sans-first:32.76 09:25:36 INFO - PROCESS | 6953 | Values: 150.0 136.0 134.0 214.0 126.0 152.0 148.0 128.0 198.0 124.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 09:25:36 INFO - PROCESS | 6953 | Values: 162.0 162.0 160.0 161.0 159.0 162.0 161.0 161.0 161.0 167.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#3] audio-fft Cycles:10 Average:87.10 Median:76.00 stddev:25.00 (32.9%) stddev-sans-first:26.13 09:25:36 INFO - PROCESS | 6953 | Values: 75.0 77.0 76.0 149.0 77.0 75.0 76.0 76.0 115.0 75.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.00 stddev:23.96 (26.0%) stddev-sans-first:24.95 09:25:36 INFO - PROCESS | 6953 | Values: 93.0 92.0 158.0 92.0 91.0 92.0 125.0 92.0 92.0 133.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:25:36 INFO - PROCESS | 6953 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:25:36 INFO - PROCESS | 6953 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:25:36 INFO - PROCESS | 6953 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:53.00 stddev:18.70 (35.3%) stddev-sans-first:19.71 09:25:36 INFO - PROCESS | 6953 | Values: 53.0 55.0 53.0 54.0 54.0 53.0 53.0 112.0 51.0 51.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 09:25:36 INFO - PROCESS | 6953 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 61.0 62.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:2.11 (2.6%) stddev-sans-first:2.11 09:25:36 INFO - PROCESS | 6953 | Values: 83.0 81.0 78.0 84.0 79.0 79.0 80.0 84.0 81.0 81.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:127.00 stddev:23.55 (18.5%) stddev-sans-first:24.75 09:25:36 INFO - PROCESS | 6953 | Values: 122.0 119.0 117.0 132.0 118.0 121.0 132.0 118.0 195.0 137.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.50 stddev:3.13 (1.9%) stddev-sans-first:3.32 09:25:36 INFO - PROCESS | 6953 | Values: 161.0 163.0 159.0 162.0 161.0 162.0 157.0 156.0 166.0 157.0 09:25:36 INFO - PROCESS | 6953 | 09:25:36 INFO - PROCESS | 6953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:1.01 09:25:36 INFO - PROCESS | 6953 | Values: 64.0 63.0 62.0 63.0 63.0 62.0 64.0 61.0 61.0 63.0 09:25:36 INFO - PROCESS | 6953 | -------- Summary: end -------- 09:25:36 INFO - PROCESS | 6953 | 09:25:37 INFO - TEST-INFO | 6953: exit 0 09:25:37 INFO - TEST-OK | kraken | took 62556ms 09:25:37 INFO - SUITE-END | took 1175s 09:25:37 INFO - Completed test suite (00:19:35) 09:25:37 INFO - javascript benchmark 09:25:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.8145511269327, 3113.922151946201, 3141.214696325918, 3154.2114471382156, 3161.3045130071378, 5278.6568873023225, 5323.387810401805, 5386.353637563493, 5395.595330350229, 5441.0750172470725, 5319.0, 5333.679979201251, 5404.91892621611, 5426.104692725696, 5461.0, 4781.497942716017, 4865.927011094836, 4873.805047798084, 4893.070316639845, 5065.696058236499, 4984.875378115558, 5006.349174607296, 5043.420006699222, 5045.747712614355, 5057.772400241998, 4849.806007759686, 4872.269159626049, 4893.461719210902, 4893.584045356149, 4899.55903968641, 4878.634102442331, 4896.314515967767, 4981.866958120139, 4983.401991760976, 5029.471905449948, 4789.904201915977, 4941.160002799533, 4950.183219768734, 4964.900701985976, 4980.551750342486, 5320.973395133038, 5410.134378499461, 5411.080116380225, 5459.781608735646, 5462.8361149165585, 5824.184614154022, 5866.911996320058, 5900.704964751788, 5905.350411454737, 5907.0, 5599.580031497613, 5810.389909059572, 5890.882182356372, 5954.166416701665, 5960.552958528085, 5454.154606036071, 5555.916661250085, 5557.916631250535, 5561.165825126263, 5562.916556251659, 6038.151355533753, 6041.395860413923, 6080.422359875804, 6087.026075827846, 6088.665123418166, 5486.753096110685, 5606.803761868397, 5648.8870222595315, 5817.76728930838, 5824.359320474744, 5756.251687280626, 5809.390014048548, 5828.708564571754, 5833.854153646193, 5836.591438599257, 5717.22817419643, 5738.397468265772, 5749.425057494301, 5759.913601295984, 5769.451902069297, 5579.832605021856, 5738.426157384228, 5786.189933409326, 5796.130580412888, 5834.883302334015, 4410.713303635253, 4419.580139886705, 4422.977885110554, 4432.246518091933, 4442.42248507692, 3955.0705584187695, 3969.702272329587, 3977.6618987386396, 4015.5181378234797, 4017.015831121394, 5314.813981510629, 5421.620486565981, 5518.613697041249, 5586.636868603528, 5588.91616625751, 5894.6757928314355, 5923.585349025613, 5926.377730338252, 5937.406259374028, 5997.250343707036, 5583.330000399978, 5590.161475778666, 5601.915971260434, 5605.887882242332, 5608.4111168326735, 4864.391951006124, 4953.801847926043, 4997.375328083989, 5006.123928312531, 5014.974925125351, 6032.54755893301, 6033.366496517802, 6036.0644100164545, 6038.879222415527, 6057.061155520902, 5671.801486947937, 5831.650100993954, 5855.912161317498, 5856.648601083949, 5862.706864656835, 5983.132445795422, 6047.213862197887, 6051.818445446644, 6086.3305036446845, 6096.573239873166, 5730.856728581819, 5764.538836893123, 5770.682612456355, 5779.653220806596, 5786.132080188006, 5686.744096515749, 5819.098039803837, 5884.735186916513, 5900.232969713909, 5911.586188966731, 5679.716014199356, 5680.488756011979, 5688.061469857427, 5716.399778023248, 5745.6552606843725, 5653.745581448927, 5658.321001479849, 5665.801696940752, 5668.093105103164, 5676.403977582295, 5375.220593014069, 5592.3009623797025, 5595.328560572757, 5600.103983362643, 5648.124540696199, 5822.70886455667, 5853.824385268449, 5863.2670916135485, 5864.970675146597, 5869.589128761117, 5637.0, 5681.375048744718, 5687.289088863892, 5693.0, 5733.168690539932], "value": 5371.311085404773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.6942474625569, 618.7555915413411, 626.5582764151274, 640.2125385775496, 642.2710223895882, 31944.84027579862, 34560.48159277613, 34568.0, 34615.30769384614, 34628.0, 43396.34905476413, 44378.33432498515, 44535.77732111343, 47883.52116478834, 47898.52101478984, 8598.742037738877, 8771.561421928878, 8776.297896168324, 8777.7805554861, 8780.429272097294, 8627.137286271385, 8768.956155219246, 8788.209061184492, 8793.912060879373, 8794.42836215644, 8852.734417967471, 8858.512781796999, 8876.289896808272, 8893.42192757472, 8897.377183597151, 8724.171203735666, 8780.560971951441, 8782.64869405223, 8804.163604457566, 8812.911870881273, 8680.175383338636, 8723.563821808884, 8771.517566533837, 8782.516961567111, 8782.56087195644, 41370.0, 41707.582924170674, 41763.582364176276, 41770.79114604438, 41776.37335439971, 3511.4206155984234, 3619.9638003620153, 3649.562052553684, 3790.2798468290935, 4146.688998325138, 31747.0, 32028.199295017577, 32384.02847914566, 32420.027399178063, 33231.667683323096, 4233.153369326147, 4295.613394794453, 4329.393884856123, 4418.977905110454, 4426.535213802536, 236810.99999999828, 237047.0, 238048.0, 238266.0, 238410.0, 54142.45857541453, 55413.0, 55577.72211138919, 55667.721661391435, 55748.72125639346, 53645.0, 58811.117833232536, 59253.703731481066, 59263.0, 59311.70344148252, 16927.0, 17139.0, 17167.399141030004, 17168.055756933238, 17186.828131718772, 13249.0, 13304.667383315495, 13310.201387916755, 13319.06766526334, 13324.6668833278, 13796.724065518634, 15606.3757449703, 15785.68428631421, 15852.60368490797, 16066.598335041717, 5320.733963301819, 5409.5131438169965, 5418.376886658006, 6151.630902145886, 6329.208848893888, 1016.8881423043459, 1027.5544204792695, 1082.5561519776854, 1122.3826895207603, 1153.8211577205548, 31260.84369578183, 31501.212469688442, 31537.684623153935, 31645.0, 32101.197470063435, 1081.1512962324537, 1116.9553217871357, 1161.2219812725493, 1171.7246447084929, 1227.5642147037852, 16609.916950415412, 16629.417970370978, 16741.665166696843, 16747.83252167487, 16800.74798878018, 481109.0, 481597.0, 484096.0, 485156.0, 485619.0, 57804.71097644485, 57975.71012144912, 57994.0, 58047.0, 58170.709146454, 1253.4798058805675, 1331.9134256273505, 1343.596920923719, 1364.0860623382357, 1409.8167238258961, 32023.0, 32765.836170818995, 32988.0, 33140.668593313756, 33919.66080339165, 48635.0, 48834.511654884416, 49110.26334605055, 49132.0, 49146.0, 381742.0, 381818.0, 382024.0, 382055.0, 383209.0, 34459.31081378408, 34655.65344346625, 35290.47064294089, 35497.467537986435, 35538.82230588934, 47556.0, 47980.5201947976, 48461.0, 48903.26645100255, 49350.50649493459, 40625.1874962505, 40721.79639101786, 40907.795461022506, 41144.588554114074, 41496.792516037225, 39451.60548394479, 40074.0, 40377.39433908435, 40900.1819963605, 41654.37518437165, 40371.79814100911, 40840.59159408368, 42106.733585109134, 43165.3525197116, 43453.0, 34067.82966085154, 36683.0, 37138.25723485569, 37542.2491550162, 37690.811545942095, 26809.731902681502, 27393.178204653894, 27620.44759104847, 29211.41577168487, 29541.409171816013], "value": 19576.254582303503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.271928773905, 389.56757998621526, 394.201741473516, 407.15921621850873, 418.2437735324213, 14022.0, 16272.0, 17975.55061123471, 18675.813241867578, 18726.063696815156, 14182.929085354559, 17212.311507539715, 17833.91083044583, 17865.91067044663, 18378.448646540593, 5612.382637909826, 5784.971075144618, 5794.0, 5796.536277097822, 5798.449147330997, 4168.145530166324, 5729.0833466645345, 6064.636121832682, 6396.392342727433, 6397.61614303141, 6190.226221722285, 6432.356764323554, 6443.645599492026, 6459.6447195404235, 6479.1253180820695, 6417.711202995876, 6429.260635026962, 6436.48508119354, 6446.0, 6451.774187903425, 5479.232907392969, 5611.298587676541, 5628.352739434977, 5670.206171136044, 5679.801206957778, 20881.0, 21907.890460547755, 22019.11923523057, 22026.229081982216, 22164.445888852748, 2355.3051849704207, 2471.3203868936007, 2524.255344673326, 2631.8947242110294, 2848.9145325640056, 13864.861351386458, 14128.081674691111, 14224.715505689932, 14294.428222871073, 14535.055221410574, 1889.754331936853, 1937.7577802774654, 1946.2993322403922, 1994.4216177308563, 2047.14020111552, 71008.0, 71683.64158179176, 73266.26733732648, 73736.0, 73900.6304968477, 9576.90423095774, 9616.423014619146, 9923.454210018373, 9959.701208963743, 10158.238132140119, 13754.31228438574, 13840.169589824442, 13870.930645346709, 13906.443742250196, 13922.373493192628, 7824.37405007598, 7944.285014348621, 8018.55897925608, 8084.7574572762915, 8110.918890811135, 6767.424768894601, 7458.0, 7741.961290193513, 7777.377809775205, 7978.800529986796, 6349.142865713162, 6443.677816109176, 6455.903161452582, 6471.417572418411, 6497.0, 1818.2181661885252, 1894.8863068215676, 1912.9011002176285, 1913.6891229507833, 1913.7894831568517, 936.1901954809041, 1000.9949950250202, 1004.5379125602159, 1018.6129270877168, 1068.4550879051585, 18330.175142118638, 18591.907040464983, 18850.622987540173, 18928.337508187422, 19034.143463543896, 991.3803872579638, 992.9056739609725, 994.5226291380178, 997.9051990060933, 1026.6355443817486, 10497.790044199073, 10708.82202957674, 10734.19493537972, 10796.730081748019, 10807.67576972692, 412554.93283071276, 420622.0, 434138.0, 450645.0, 453835.3849384524, 78386.0, 78409.60795195987, 79182.60408697919, 79414.0, 79943.0, 945.0, 977.2426369563503, 1006.7030226083323, 1008.0977525114981, 1016.1413605503337, 16538.0, 16960.915195423942, 17067.231974561422, 17116.229769660644, 17325.22036508335, 41523.169536609705, 41528.58471415368, 42376.0, 42998.14003719971, 43040.569594303655, 55253.447465526435, 56590.7170464145, 56777.14834277572, 57351.426485734606, 57359.426405737075, 8249.216324449168, 8324.958375208327, 8348.749537513884, 8445.282151017233, 8856.778580535538, 8712.564371781258, 11791.76416471683, 12021.278723276631, 13035.15271507349, 13174.077814553273, 11139.944300278446, 11413.429328533706, 11785.941070294937, 11873.525058997544, 11945.820812687643, 11204.943975280072, 11253.549858005588, 11388.487518061542, 11590.250724203646, 11643.243189192675, 11337.206395552563, 11664.300141991169, 11753.47109380097, 12208.877911221129, 12209.389530523616, 8416.789580260542, 8482.406231563731, 8562.100979397073, 8593.484390936565, 8659.220670139717, 10439.425831579032, 10624.150067994697, 11091.33451992883, 11193.776124477303, 11393.088552915913], "value": 9156.287870906946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.2169987157763, 1455.5778824140996, 1494.1334026264767, 1620.983790162098, 1779.5106345754916, 7350.558966462009, 7644.159142494321, 7653.69385224591, 7895.8026049348655, 7910.169432209607, 7811.570363629998, 7981.523418167643, 7987.600619968993, 8012.639431225594, 8016.358691304697, 1912.8565357598166, 2203.394066631673, 2208.7901649343366, 2237.7874101960288, 2282.9086836526517, 2246.6854640350284, 2262.1290803040865, 2271.716035495563, 2275.7610450902666, 2276.3057267533395, 2195.209724499187, 2214.689943407924, 2215.7562668106493, 2232.430730163806, 2239.74242962059, 1782.7593274907915, 2168.4687251623373, 2238.708967834187, 2238.955220895573, 2253.9549209015727, 2144.3888491779767, 2161.5460753241837, 2175.4670105824016, 2176.7714389988982, 2185.868847869117, 7877.842443151162, 7932.246436588515, 7934.44458887878, 7939.0, 7946.205379462065, 4931.112399768041, 5045.772940217699, 5050.015247026831, 5050.924236136424, 5058.342415485963, 3098.814071155738, 3117.423276693796, 3144.339688665383, 3267.787593806419, 3272.4109660261142, 1026.1021606094666, 1061.9203559732973, 1069.9625513107003, 1087.0977089016098, 1097.8682558093, 11531.538738450536, 11539.134564907665, 11559.94220028903, 11584.18910676253, 11603.767924641545, 4257.680673949404, 4301.741895486281, 4359.912801743947, 4385.824567017284, 4405.229084910128, 9970.900290997142, 9983.850242246372, 9984.500774961223, 9985.60057597688, 9996.950015249877, 4338.652907767371, 4774.236122220497, 4876.146674331978, 4881.658283920092, 4884.877878053077, 4241.4698162729655, 4413.1394378095965, 4425.424694789656, 4429.933550996738, 4437.844675436344, 3751.549814022335, 3814.1799513104816, 3854.9036274093373, 3900.0, 3963.841446342172, 1166.3293606176483, 1181.8227265910182, 1183.6153250193722, 1198.0475521960063, 1225.859026211997, 723.8914162875506, 734.4088009152576, 780.3640033372897, 859.5959898847532, 905.7735566108473, 5302.549283310885, 5379.327584051994, 5383.246345511631, 5484.890302194013, 5525.917111243334, 936.6955739384728, 949.4635530925005, 953.823542644613, 964.4117088575963, 990.232569758443, 3538.663826936437, 3596.8021758803516, 3638.235970446183, 3742.3825068863875, 3838.5201849768778, 9444.669436569824, 9625.807483850424, 9762.853557196648, 9763.26775491841, 9780.804383912424, 9546.761330966643, 9638.180754635934, 9677.080677335642, 9685.6610018649, 9743.123118919331, 7363.484556081023, 7795.493292935941, 7819.100803407681, 7823.100343460461, 7838.647260873275, 5232.581393488588, 5235.764390602356, 5275.393329767126, 5427.348718153688, 5518.2826232589505, 8121.066077401175, 8290.83418331618, 8343.95828020856, 9063.048379920014, 9162.541872906462, 8505.87241191395, 8517.148285171681, 8524.104968978168, 8566.314694824274, 8600.612972416382, 6182.845428864314, 6814.727410903508, 6835.0, 7062.3996960258955, 7081.610511421715, 7693.461457698131, 7700.229977002479, 7730.729424470116, 7764.417668674985, 7769.72805951789, 6877.89683154743, 7164.462665300019, 7200.243974382824, 7303.233160518069, 7309.378702810321, 7110.644467776487, 7121.359077683033, 7130.251323611154, 7252.347288744038, 7256.346928776436, 5797.91303130445, 6034.668093254913, 6059.939400605937, 6191.597546159485, 6206.348333424925, 4817.78319975609, 4892.339534162842, 4912.950870491392, 4939.061578300111, 4939.753012349296, 4835.927461088017, 4859.805607775649, 4889.3888263967, 4896.461389247109, 4922.655414120977], "value": 4276.22613267111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.5127430668231, 319.98880039198633, 322.67248742526357, 323.0905002418194, 326.9035634487827, 5138.588912886969, 5239.480550640319, 5241.685498870066, 5254.922740838128, 5270.183121616146, 5143.151380022301, 5206.24509446131, 5210.921836172461, 5210.9478905210935, 5214.217867319904, 3926.254011737775, 3970.900727481822, 4010.4585880906143, 4046.4739583854057, 4047.6357127858487, 3642.235130622559, 4092.9386059209137, 4094.89762755932, 4097.364908439182, 4112.0, 4003.0792917628964, 4049.602887003979, 4050.655694265991, 4078.3474644056955, 4080.041190320287, 3858.4791053207737, 3931.528216613996, 4050.5949405059555, 4058.9594104059024, 4072.1448495815916, 3588.4079126944025, 3597.280543891206, 3598.7300952428673, 3602.486955478705, 3612.151144481045, 4987.251912213161, 5002.674826136289, 5017.623678224148, 5018.899622007576, 5053.9241911371355, 4418.513963464016, 4616.307553866914, 4621.861344159681, 4628.953710462886, 4640.350350950869, 5339.359276886798, 5381.650192737498, 5394.32570928634, 5454.672719636835, 5462.525118218098, 3942.64516193544, 3949.881503554898, 3957.98021009896, 3975.403689446577, 3979.6668116181113, 5189.896202075937, 5364.865878353034, 5657.236273103161, 5708.914366284509, 5715.771369145229, 3982.4026396040827, 3984.7609143451486, 3990.5809889961715, 4054.614811592894, 4056.7971601419813, 4059.289624315733, 4079.6124368184974, 4083.959160408417, 4087.7751723654887, 4105.856295029719, 4603.930941035887, 4604.539546045436, 4634.814607415733, 4658.091672123971, 4689.320048592935, 5283.867903302371, 5391.35303763543, 5409.890972350738, 5435.510804027656, 5497.257870187474, 1386.6671998720235, 1393.5819254223693, 1395.9092658977133, 1405.7399381114526, 1406.8171137752026, 858.4334339336008, 900.7477906186278, 901.9143181397757, 902.7336935604012, 908.5321059654283, 4699.4726713818145, 4710.317004034396, 4726.109556177487, 4732.787024583902, 4755.952440475551, 4908.901821963612, 4956.950430495721, 4958.479359667255, 4976.959446626865, 5001.34928487902, 4670.929936050962, 4757.3101900224965, 4763.595094417014, 4771.73755443454, 4909.901801963941, 2968.777341699338, 2972.836493992851, 2996.6104406427025, 3002.9249268768453, 3004.5793588897573, 5758.913616295759, 5762.337331206965, 5807.738651760681, 5813.7383817728305, 5835.503982161479, 5558.805441809517, 5646.576506761927, 5684.516816070598, 5758.280214973129, 5784.681842498703, 5577.386487486373, 5740.770369185269, 5767.250257466502, 5895.115732640138, 5912.290525136925, 5546.500814926676, 5550.639208451437, 5559.193916881949, 5570.777168913198, 5575.9163612545035, 5529.529989950899, 5540.371056957699, 5553.527950124285, 5555.2778138841695, 5582.190582365453, 5542.196381524575, 5807.303123625192, 5829.941700583109, 5837.766489340549, 5847.736851841592, 3987.3221552335594, 4013.2776100302226, 4017.0, 4048.676105911461, 4058.573849745734, 5390.865228369322, 5735.25441692594, 5738.713064346683, 5745.454181852718, 5759.510441612342, 5518.868631930525, 5543.72281385921, 5547.1679248113105, 5552.556335352757, 5555.805546805843, 5410.1343784994215, 5420.720464119151, 5495.835124946258, 5498.340199176125, 5507.669539827623, 5242.737863106906, 5376.462353764592, 5426.565874730091, 5448.45515448452, 5448.972755136199, 5490.752916118704, 5492.642978206404, 5499.395066542597, 5519.31008623922, 5525.640833345819, 5357.089294819812, 5403.13549832025, 5422.403535611001, 5438.613153645795, 5445.59158063139], "value": 4126.531598944524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.4168027934718, 645.2386184302521, 660.250615551349, 667.266007391869, 669.1969636436278, 14460.92769536152, 15329.463468778595, 15425.228738563055, 15445.84554154458, 15486.69026619467, 13838.930805345984, 13948.372323245452, 14271.286435678201, 14275.78586321206, 14299.356528956196, 675.8918573028317, 798.2297083314601, 818.8034871630825, 821.0639870547581, 828.6064119543229, 823.4647479138548, 824.221111050058, 825.3273582030625, 827.5779352530222, 827.9047909490396, 862.0861886400404, 862.5859587398021, 865.523961820999, 865.645085514939, 867.8351113288487, 706.2055187913597, 835.5446281776447, 849.6643825688818, 850.6512329944693, 862.7023676831483, 622.5890911998105, 623.847157446424, 624.0545573456218, 624.8625302433458, 624.96875156242, 13893.722125557431, 13978.720425591431, 13987.510437134652, 13989.440422383092, 14004.22976736279, 12591.685207869876, 12953.0, 13233.206007639572, 13251.271180085092, 13682.657933551742, 11096.55613775448, 11434.714132146679, 11484.196106272564, 11656.88343116575, 11824.408779560987, 4318.611324980767, 4340.348947657877, 4363.694541382105, 4364.978175109104, 4406.530255125381, 52033.739831300976, 53391.19913201305, 58513.41486585122, 59251.40748592502, 59543.702281488746, 10800.29798063139, 10906.890931090746, 11008.449577521093, 11014.614488492864, 11157.72105697364, 18860.0, 18877.244910203437, 18946.052697365078, 18994.905025474785, 19017.429477115707, 8250.0, 8271.710490132937, 8382.161783821692, 8573.571321433903, 8597.5701214939, 4568.027766637449, 4659.930101048487, 4800.039992001613, 4828.806847726122, 4911.312416261726, 3355.697987181117, 3423.6747508987105, 3431.553897993245, 3440.9827950860085, 3441.2773317603082, 579.4466284698187, 606.8573885136989, 612.0543759890979, 613.3284053960906, 615.3077787489075, 565.3244372974339, 699.9965000174966, 710.2577806192438, 723.8371366442508, 727.581640556682, 8519.616617252239, 8924.464532128093, 9004.099590041074, 9075.863862042075, 9090.999720859736, 564.8277275430951, 651.4657980456076, 653.6796969485014, 720.495653042872, 749.8912657664717, 4311.310190369526, 4703.0, 4765.1660959331975, 4770.737609431515, 4775.2359622460235, 62905.05642415368, 64428.67785661042, 64622.0, 65208.0, 65847.34152658508, 59027.0, 59629.0, 59706.40293597009, 60479.395206047375, 60618.09072863911, 53666.73166634142, 54301.72849135729, 54445.0, 54700.90598188014, 55960.72019639876, 9159.450432974043, 9251.722448326562, 9281.582328795355, 9297.0, 9528.094830991045, 37090.25819483649, 37119.44320835244, 37447.063823404635, 37596.556223846455, 37762.24475510419, 45303.0, 49038.26442603435, 50309.24536132034, 50546.7472662649, 50965.49034509608, 11349.943250284026, 11350.0, 11460.140489463156, 11553.13351498624, 12230.082743794073, 12557.74884502323, 12863.549775757803, 12983.480660773463, 13015.284159371326, 13251.536196233086, 11256.437178141225, 11315.151363647594, 11584.536618535165, 11807.468663910317, 12063.457144428698, 11517.769644607228, 11594.246373985665, 11885.524579016743, 12316.076294277786, 12635.494580216688, 12169.513219471477, 12224.938875305566, 12525.624231273076, 12621.684457888627, 12943.935280323914, 9463.526823658927, 9813.165880900204, 9819.656312029045, 9843.261755368232, 9915.950420247853, 10362.844557331797, 10430.269881108554, 10580.575690200094, 10642.521086550969, 10657.25399222047], "value": 6741.169789686826, "unit": "score"}], "name": "dromaeo_css", "value": 6968.827323033821, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 113.0, 113.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 136.0, 134.0, 214.0, 126.0, 152.0, 148.0, 128.0, 198.0, 124.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 159.0, 162.0, 161.0, 161.0, 161.0, 167.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 149.0, 77.0, 75.0, 76.0, 76.0, 115.0, 75.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 158.0, 92.0, 91.0, 92.0, 125.0, 92.0, 92.0, 133.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 54.0, 53.0, 53.0, 112.0, 51.0, 51.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 78.0, 84.0, 79.0, 79.0, 80.0, 84.0, 81.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 117.0, 132.0, 118.0, 121.0, 132.0, 118.0, 195.0, 137.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 159.0, 162.0, 161.0, 162.0, 157.0, 156.0, 166.0, 157.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 63.0, 62.0, 64.0, 61.0, 61.0, 63.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1529.6, "alertThreshold": 2.0}]} 09:25:37 INFO - Return code: 0 09:25:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:25:37 ERROR - # TBPL SUCCESS # 09:25:37 INFO - Running post-action listener: _resource_record_post_action 09:25:37 INFO - ##### 09:25:37 INFO - ##### Finished run-tests step (success) 09:25:37 INFO - ##### 09:25:37 INFO - Running post-run listener: _resource_record_post_run 09:25:37 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553345024; Read time: 16; Write time: 556264 09:25:37 INFO - TinderboxPrint: CPU usage
13.1% 09:25:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:25:37 INFO - TinderboxPrint: I/O write bytes / time
553,345,024 / 556,264 09:25:37 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 09:25:37 INFO - TinderboxPrint: CPU user
1,207.5 (12.7%) 09:25:37 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247193600; Read time: 0; Write time: 318728 09:25:37 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290521088; Read time: 16; Write time: 232140 09:25:38 INFO - Running post-run listener: _upload_blobber_files 09:25:38 INFO - Blob upload gear active. 09:25:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:38 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 09:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:25:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:39 INFO - (blobuploader) - INFO - Done attempting. 09:25:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:40 INFO - (blobuploader) - INFO - Done attempting. 09:25:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:45 INFO - (blobuploader) - INFO - Done attempting. 09:25:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:45 INFO - Return code: 0 09:25:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b33f0caff9543867ce66f67f0f54abe33ee36edef9f84dd66aa9bcbfe081323af97e6576f9b22e73bb7447f97e8bb34c272cff36dff7c66419b9505a4ff427f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29d755bf988225c70063a0a5de1288706d35e33a04dad404e013c9129c4f6330aeab5c1e2e992513a9cd8e89754872b980453547a391cee621073081b74e3d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c626898de268c4e9a0d742af6d7b1918be25e5a2c60afe32822ce1be740bf34e42eda9bd2e81cb85fe5359969e6f8808c4955d142dcff6799cd47a456c6f1111"} 09:25:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:45 INFO - Contents: 09:25:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b33f0caff9543867ce66f67f0f54abe33ee36edef9f84dd66aa9bcbfe081323af97e6576f9b22e73bb7447f97e8bb34c272cff36dff7c66419b9505a4ff427f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29d755bf988225c70063a0a5de1288706d35e33a04dad404e013c9129c4f6330aeab5c1e2e992513a9cd8e89754872b980453547a391cee621073081b74e3d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c626898de268c4e9a0d742af6d7b1918be25e5a2c60afe32822ce1be740bf34e42eda9bd2e81cb85fe5359969e6f8808c4955d142dcff6799cd47a456c6f1111"} 09:25:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:45 INFO - Copying logs to upload dir... 09:25:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.206153 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-24 09:25:45.189794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 09:25:45.192929) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b33f0caff9543867ce66f67f0f54abe33ee36edef9f84dd66aa9bcbfe081323af97e6576f9b22e73bb7447f97e8bb34c272cff36dff7c66419b9505a4ff427f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29d755bf988225c70063a0a5de1288706d35e33a04dad404e013c9129c4f6330aeab5c1e2e992513a9cd8e89754872b980453547a391cee621073081b74e3d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c626898de268c4e9a0d742af6d7b1918be25e5a2c60afe32822ce1be740bf34e42eda9bd2e81cb85fe5359969e6f8808c4955d142dcff6799cd47a456c6f1111"} build_url:https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/IZN7Y1F3QZqIf4_ixflGNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b33f0caff9543867ce66f67f0f54abe33ee36edef9f84dd66aa9bcbfe081323af97e6576f9b22e73bb7447f97e8bb34c272cff36dff7c66419b9505a4ff427f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29d755bf988225c70063a0a5de1288706d35e33a04dad404e013c9129c4f6330aeab5c1e2e992513a9cd8e89754872b980453547a391cee621073081b74e3d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c626898de268c4e9a0d742af6d7b1918be25e5a2c60afe32822ce1be740bf34e42eda9bd2e81cb85fe5359969e6f8808c4955d142dcff6799cd47a456c6f1111"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 09:25:45.218204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:25:45.218551) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464105900.290667-919977106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:25:45.301849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 09:25:45.302279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 09:25:45.302632) ========= ========= Total master_lag: 0.16 =========