builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1464637788.93 results: success (0) buildid: 20160530112941 builduid: d47201bcb72e4bc3a54a6d62ecd58d25 revision: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:48.929425) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:48.929896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:48.930175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:48.984811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:48.985106) ========= 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=4300f881736b422476174874000001bc-1464630508.36670-87350152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 12:49:49-- 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% 22.6M=0.001s 2016-05-30 12:49:49 (22.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109386 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:49.109442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:49.109732) ========= 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=4300f881736b422476174874000001bc-1464630508.36670-87350152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017507 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:49.159387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 12:49:49.159894) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c8f09493cadc33fc6aa05f52cabbabb15b9593a --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 5c8f09493cadc33fc6aa05f52cabbabb15b9593a --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=4300f881736b422476174874000001bc-1464630508.36670-87350152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 12:49:49,626 truncating revision to first 12 chars 2016-05-30 12:49:49,626 Setting DEBUG logging. 2016-05-30 12:49:49,626 attempt 1/10 2016-05-30 12:49:49,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c8f09493cad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 12:49:50,490 unpacking tar archive at: fx-team-5c8f09493cad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.258199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 12:49:50.431716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:50.432021) ========= script_repo_revision: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:50.432420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:50.432698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 12:49:50.443497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-30 12:49:50.443878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1464630508.36670-87350152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:49:50 INFO - MultiFileLogger online at 20160530 12:49:50 in /builds/slave/test 12:49:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:49:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:49:50 INFO - {'append_to_log': False, 12:49:50 INFO - 'base_work_dir': '/builds/slave/test', 12:49:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:49:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:49:50 INFO - 'branch': 'Fx-Team-Non-PGO', 12:49:50 INFO - 'buildbot_json_path': 'buildprops.json', 12:49:50 INFO - 'config_files': ('talos/linux_config.py',), 12:49:50 INFO - 'default_actions': ('clobber', 12:49:51 INFO - 'read-buildbot-config', 12:49:51 INFO - 'download-and-extract', 12:49:51 INFO - 'populate-webroot', 12:49:51 INFO - 'create-virtualenv', 12:49:51 INFO - 'install', 12:49:51 INFO - 'run-tests'), 12:49:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:49:51 INFO - 'download_minidump_stackwalk': True, 12:49:51 INFO - 'download_symbols': 'ondemand', 12:49:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:49:51 INFO - 'tooltool.py': '/tools/tooltool.py', 12:49:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:49:51 INFO - '/tools/misc-python/virtualenv.py')}, 12:49:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:49:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:49:51 INFO - 'installer_path': 'installer.exe', 12:49:51 INFO - 'log_level': 'info', 12:49:51 INFO - 'log_name': 'talos', 12:49:51 INFO - 'log_to_console': True, 12:49:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:49:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:49:51 INFO - 'opt_config_files': (), 12:49:51 INFO - 'pip_index': False, 12:49:51 INFO - 'sps_profile': False, 12:49:51 INFO - 'sps_profile_interval': 0, 12:49:51 INFO - 'suite': 'dromaeojs', 12:49:51 INFO - 'system_bits': '32', 12:49:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:49:51 INFO - 'title': 'talos-linux64-ix-045', 12:49:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:49:51 INFO - 'use_talos_json': True, 12:49:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:49:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:49:51 INFO - 'work_dir': 'build'} 12:49:51 INFO - ##### 12:49:51 INFO - ##### Running clobber step. 12:49:51 INFO - ##### 12:49:51 INFO - Running pre-action listener: _resource_record_pre_action 12:49:51 INFO - Running main action method: clobber 12:49:51 INFO - rmtree: /builds/slave/test/build 12:49:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:49:51 INFO - Running post-action listener: _resource_record_post_action 12:49:51 INFO - ##### 12:49:51 INFO - ##### Finished clobber step (success) 12:49:51 INFO - ##### 12:49:51 INFO - ##### 12:49:51 INFO - ##### Running read-buildbot-config step. 12:49:51 INFO - ##### 12:49:51 INFO - Running pre-action listener: _resource_record_pre_action 12:49:51 INFO - Running main action method: read_buildbot_config 12:49:51 INFO - Using buildbot properties: 12:49:51 INFO - { 12:49:51 INFO - "project": "", 12:49:51 INFO - "product": "firefox", 12:49:51 INFO - "script_repo_revision": "production", 12:49:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:49:51 INFO - "repository": "", 12:49:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:49:51 INFO - "buildid": "20160530112941", 12:49:51 INFO - "pgo_build": "False", 12:49:51 INFO - "basedir": "/builds/slave/test", 12:49:51 INFO - "buildnumber": 3015, 12:49:51 INFO - "slavename": "talos-linux64-ix-045", 12:49:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:49:51 INFO - "platform": "ubuntu64_hw", 12:49:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:49:51 INFO - "branch": "fx-team", 12:49:51 INFO - "repo_path": "integration/fx-team", 12:49:51 INFO - "revision": "5c8f09493cadc33fc6aa05f52cabbabb15b9593a", 12:49:51 INFO - "stage_platform": "linux64", 12:49:51 INFO - "builduid": "d47201bcb72e4bc3a54a6d62ecd58d25", 12:49:51 INFO - "slavebuilddir": "test" 12:49:51 INFO - } 12:49:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:49:51 INFO - Running post-action listener: _resource_record_post_action 12:49:51 INFO - ##### 12:49:51 INFO - ##### Finished read-buildbot-config step (success) 12:49:51 INFO - ##### 12:49:51 INFO - ##### 12:49:51 INFO - ##### Running download-and-extract step. 12:49:51 INFO - ##### 12:49:51 INFO - Running pre-action listener: _resource_record_pre_action 12:49:51 INFO - Running main action method: download_and_extract 12:49:51 INFO - mkdir: /builds/slave/test/build/tests 12:49:51 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')]} 12:49:51 INFO - https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:49:53 INFO - Downloaded 1361 bytes. 12:49:53 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:49:53 INFO - Using the following test package requirements: 12:49:53 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:49:53 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:49:53 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:49:53 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'jsshell-linux-x86_64.zip'], 12:49:53 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:49:53 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:49:53 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:49:53 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:49:53 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:49:53 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:49:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:53 INFO - https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:49:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:49:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:49:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:49:54 INFO - Downloaded 22837967 bytes. 12:49:54 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'] 12:49:54 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 12:49:55 INFO - Return code: 0 12:49:55 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 12:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:55 INFO - https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:49:58 INFO - Downloaded 22837967 bytes. 12:49:58 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'] 12:49:58 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 12:50:00 INFO - Return code: 0 12:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:00 INFO - https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:50:01 INFO - Downloaded 10834055 bytes. 12:50:01 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'] 12:50:01 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 12:50:01 INFO - Return code: 0 12:50: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')]} 12:50:01 INFO - https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L95xscyyT-KYFFiUJNLHRQ/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 12:50:03 INFO - Downloaded 54990222 bytes. 12:50:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:03 INFO - mkdir: /builds/slave/test/properties 12:50:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:03 INFO - Contents: 12:50:03 INFO - build_url:https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:04 INFO - Running post-action listener: _resource_record_post_action 12:50:04 INFO - Running post-action listener: set_extra_try_arguments 12:50:04 INFO - ##### 12:50:04 INFO - ##### Finished download-and-extract step (success) 12:50:04 INFO - ##### 12:50:04 INFO - ##### 12:50:04 INFO - ##### Running populate-webroot step. 12:50:04 INFO - ##### 12:50:04 INFO - Running pre-action listener: _resource_record_pre_action 12:50:04 INFO - Running main action method: populate_webroot 12:50:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:04 INFO - '--tppagecycles', 12:50:04 INFO - '7'], 12:50:04 INFO - 'tests': ['tsvgm']}}, 12:50:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['damp', 'tps']}, 12:50:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'tests': ['damp', 'tps']}, 12:50:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['dromaeo_dom']}, 12:50:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['a11yr', 12:50:04 INFO - 'ts_paint', 12:50:04 INFO - 'tpaint', 12:50:04 INFO - 'sessionrestore', 12:50:04 INFO - 'sessionrestore_no_auto_restore', 12:50:04 INFO - 'tabpaint']}, 12:50:04 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:04 INFO - 'ts_paint', 12:50:04 INFO - 'tpaint', 12:50:04 INFO - 'sessionrestore', 12:50:04 INFO - 'sessionrestore_no_auto_restore', 12:50:04 INFO - 'tabpaint']}, 12:50:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:04 INFO - 'ts_paint', 12:50:04 INFO - 'tpaint', 12:50:04 INFO - 'sessionrestore', 12:50:04 INFO - 'sessionrestore_no_auto_restore', 12:50:04 INFO - 'tabpaint']}, 12:50:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:04 INFO - 'ts_paint', 12:50:04 INFO - 'tpaint', 12:50:04 INFO - 'sessionrestore', 12:50:04 INFO - 'sessionrestore_no_auto_restore', 12:50:04 INFO - 'tabpaint']}, 12:50:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['a11yr', 12:50:04 INFO - 'ts_paint', 12:50:04 INFO - 'tpaint', 12:50:04 INFO - 'sessionrestore', 12:50:04 INFO - 'sessionrestore_no_auto_restore', 12:50:04 INFO - 'tabpaint']}, 12:50:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['a11yr', 12:50:04 INFO - 'ts_paint', 12:50:04 INFO - 'tpaint', 12:50:04 INFO - 'sessionrestore', 12:50:04 INFO - 'sessionrestore_no_auto_restore', 12:50:04 INFO - 'tabpaint']}, 12:50:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['tsvgx', 12:50:04 INFO - 'tsvgr_opacity', 12:50:04 INFO - 'tart', 12:50:04 INFO - 'tscrollx', 12:50:04 INFO - 'cart']}, 12:50:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:04 INFO - 'tsvgr_opacity', 12:50:04 INFO - 'tart', 12:50:04 INFO - 'tscrollx', 12:50:04 INFO - 'cart']}, 12:50:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'talos_options': ['--disable-e10s'], 12:50:04 INFO - 'tests': ['tp5o']}, 12:50:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'tests': ['tp5o']}, 12:50:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'talos_options': ['--disable-e10s', 12:50:04 INFO - '--xperf_path', 12:50:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:04 INFO - 'tests': ['tp5n']}, 12:50:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:04 INFO - 'talos_options': ['--xperf_path', 12:50:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:04 INFO - 'tests': ['tp5n']}}, 12:50:04 INFO - 'talos.zip': {'path': '', 12:50:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:04 INFO - Running post-action listener: _resource_record_post_action 12:50:04 INFO - ##### 12:50:04 INFO - ##### Finished populate-webroot step (success) 12:50:04 INFO - ##### 12:50:04 INFO - ##### 12:50:04 INFO - ##### Running create-virtualenv step. 12:50:04 INFO - ##### 12:50:04 INFO - Running pre-action listener: _resource_record_pre_action 12:50:04 INFO - Running main action method: create_virtualenv 12:50:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:04 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 12:50:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:04 INFO - Using real prefix '/usr' 12:50:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:06 INFO - Installing pip.................done. 12:50:06 INFO - Return code: 0 12:50:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:50:06 INFO - Using env: {'DISPLAY': ':0', 12:50:06 INFO - 'HOME': '/home/cltbld', 12:50:06 INFO - 'LANG': 'en_US.UTF-8', 12:50:06 INFO - 'LANGUAGE': 'en_US:en', 12:50:06 INFO - 'LOGNAME': 'cltbld', 12:50:06 INFO - 'MAIL': '/var/mail/cltbld', 12:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:06 INFO - 'MOZ_NO_REMOTE': '1', 12:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:06 INFO - 'NO_EM_RESTART': '1', 12:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:06 INFO - 'PWD': '/builds/slave/test', 12:50:06 INFO - 'SHELL': '/bin/bash', 12:50:06 INFO - 'SHLVL': '1', 12:50:06 INFO - 'TERM': 'linux', 12:50:06 INFO - 'TMOUT': '86400', 12:50:06 INFO - 'USER': 'cltbld', 12:50:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:06 INFO - '_': '/tools/buildbot/bin/python'} 12:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:07 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 12:50:07 INFO - Cleaning up... 12:50:07 INFO - Return code: 0 12:50:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:50:07 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')]} 12:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:07 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')]} 12:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:07 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 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:07 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 12:50:07 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 12:50:07 INFO - Using env: {'DISPLAY': ':0', 12:50:07 INFO - 'HOME': '/home/cltbld', 12:50:07 INFO - 'LANG': 'en_US.UTF-8', 12:50:07 INFO - 'LANGUAGE': 'en_US:en', 12:50:07 INFO - 'LOGNAME': 'cltbld', 12:50:07 INFO - 'MAIL': '/var/mail/cltbld', 12:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:07 INFO - 'MOZ_NO_REMOTE': '1', 12:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:07 INFO - 'NO_EM_RESTART': '1', 12:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:07 INFO - 'PWD': '/builds/slave/test', 12:50:07 INFO - 'SHELL': '/bin/bash', 12:50:07 INFO - 'SHLVL': '1', 12:50:07 INFO - 'TERM': 'linux', 12:50:07 INFO - 'TMOUT': '86400', 12:50:07 INFO - 'USER': 'cltbld', 12:50:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:07 INFO - '_': '/tools/buildbot/bin/python'} 12:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:07 INFO - Downloading/unpacking psutil>=3.1.1 12:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:09 INFO - Installing collected packages: psutil 12:50:09 INFO - Running setup.py install for psutil 12:50:09 INFO - building 'psutil._psutil_linux' extension 12:50:09 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 12:50:09 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 12:50:09 INFO - building 'psutil._psutil_posix' extension 12:50:09 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 12:50:09 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 12:50:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:09 INFO - Successfully installed psutil 12:50:09 INFO - Cleaning up... 12:50:09 INFO - Return code: 0 12:50:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:50:09 INFO - Using env: {'DISPLAY': ':0', 12:50:09 INFO - 'HOME': '/home/cltbld', 12:50:09 INFO - 'LANG': 'en_US.UTF-8', 12:50:09 INFO - 'LANGUAGE': 'en_US:en', 12:50:09 INFO - 'LOGNAME': 'cltbld', 12:50:09 INFO - 'MAIL': '/var/mail/cltbld', 12:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:09 INFO - 'MOZ_NO_REMOTE': '1', 12:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:09 INFO - 'NO_EM_RESTART': '1', 12:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:09 INFO - 'PWD': '/builds/slave/test', 12:50:09 INFO - 'SHELL': '/bin/bash', 12:50:09 INFO - 'SHLVL': '1', 12:50:09 INFO - 'TERM': 'linux', 12:50:09 INFO - 'TMOUT': '86400', 12:50:09 INFO - 'USER': 'cltbld', 12:50:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:09 INFO - '_': '/tools/buildbot/bin/python'} 12:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:50:10 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 12:50:10 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 12:50:10 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 12:50:10 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 12:50:10 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 12:50:10 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 12:50:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:50:11 INFO - Installing collected packages: mozsystemmonitor 12:50:11 INFO - Running setup.py install for mozsystemmonitor 12:50:12 INFO - Successfully installed mozsystemmonitor 12:50:12 INFO - Cleaning up... 12:50:12 INFO - Return code: 0 12:50:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:12 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 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:12 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 12:50:12 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 12:50:12 INFO - Using env: {'DISPLAY': ':0', 12:50:12 INFO - 'HOME': '/home/cltbld', 12:50:12 INFO - 'LANG': 'en_US.UTF-8', 12:50:12 INFO - 'LANGUAGE': 'en_US:en', 12:50:12 INFO - 'LOGNAME': 'cltbld', 12:50:12 INFO - 'MAIL': '/var/mail/cltbld', 12:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:12 INFO - 'MOZ_NO_REMOTE': '1', 12:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:12 INFO - 'NO_EM_RESTART': '1', 12:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:12 INFO - 'PWD': '/builds/slave/test', 12:50:12 INFO - 'SHELL': '/bin/bash', 12:50:12 INFO - 'SHLVL': '1', 12:50:12 INFO - 'TERM': 'linux', 12:50:12 INFO - 'TMOUT': '86400', 12:50:12 INFO - 'USER': 'cltbld', 12:50:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:12 INFO - '_': '/tools/buildbot/bin/python'} 12:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:12 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:12 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 12:50:12 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 12:50:12 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 12:50:12 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 12:50:12 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 12:50:12 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 12:50:14 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 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 12:50:14 INFO - Downloading docopt-0.6.1.tar.gz 12:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:14 INFO - Running setup.py install for blobuploader 12:50:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:15 INFO - Running setup.py install for requests 12:50:15 INFO - Running setup.py install for docopt 12:50:15 INFO - Successfully installed blobuploader requests docopt 12:50:15 INFO - Cleaning up... 12:50:15 INFO - Return code: 0 12:50:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:15 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 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:15 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 12:50:15 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 12:50:15 INFO - Using env: {'DISPLAY': ':0', 12:50:15 INFO - 'HOME': '/home/cltbld', 12:50:15 INFO - 'LANG': 'en_US.UTF-8', 12:50:15 INFO - 'LANGUAGE': 'en_US:en', 12:50:15 INFO - 'LOGNAME': 'cltbld', 12:50:15 INFO - 'MAIL': '/var/mail/cltbld', 12:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:15 INFO - 'MOZ_NO_REMOTE': '1', 12:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:15 INFO - 'NO_EM_RESTART': '1', 12:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:15 INFO - 'PWD': '/builds/slave/test', 12:50:15 INFO - 'SHELL': '/bin/bash', 12:50:15 INFO - 'SHLVL': '1', 12:50:15 INFO - 'TERM': 'linux', 12:50:15 INFO - 'TMOUT': '86400', 12:50:15 INFO - 'USER': 'cltbld', 12:50:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:15 INFO - '_': '/tools/buildbot/bin/python'} 12:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:15 INFO - Running setup.py (path:/tmp/pip-ttNPFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:15 INFO - Running setup.py (path:/tmp/pip-TKnQzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:15 INFO - Running setup.py (path:/tmp/pip-L5zZON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:15 INFO - Running setup.py (path:/tmp/pip-TJ3if7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:16 INFO - Running setup.py (path:/tmp/pip-_3DgUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:16 INFO - Running setup.py (path:/tmp/pip-Tf1teM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:16 INFO - Running setup.py (path:/tmp/pip-jplwG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:16 INFO - Running setup.py (path:/tmp/pip-ern3p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:16 INFO - Running setup.py (path:/tmp/pip-apf17U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:16 INFO - Running setup.py (path:/tmp/pip-tWGVM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:16 INFO - Running setup.py (path:/tmp/pip-tPpLvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:16 INFO - Running setup.py (path:/tmp/pip-tJ4kWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:16 INFO - Running setup.py (path:/tmp/pip-VTHLZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:16 INFO - Running setup.py (path:/tmp/pip-yFkOc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:16 INFO - Running setup.py (path:/tmp/pip-OppiF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:16 INFO - Running setup.py (path:/tmp/pip-D7lCsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:16 INFO - Running setup.py (path:/tmp/pip-H_mJ3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:50:16 INFO - Running setup.py install for manifestparser 12:50:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Running setup.py install for mozcrash 12:50:17 INFO - Running setup.py install for mozdebug 12:50:17 INFO - Running setup.py install for mozdevice 12:50:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Running setup.py install for mozfile 12:50:17 INFO - Running setup.py install for mozhttpd 12:50:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Running setup.py install for mozinfo 12:50:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Running setup.py install for mozInstall 12:50:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:50:17 INFO - Running setup.py install for mozleak 12:50:17 INFO - Running setup.py install for mozlog 12:50:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Running setup.py install for moznetwork 12:50:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Running setup.py install for mozprocess 12:50:18 INFO - Running setup.py install for mozprofile 12:50:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Running setup.py install for mozrunner 12:50:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Running setup.py install for mozscreenshot 12:50:18 INFO - Running setup.py install for moztest 12:50:18 INFO - Running setup.py install for mozversion 12:50:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:50:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:50:18 INFO - Cleaning up... 12:50:18 INFO - Return code: 0 12:50:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:18 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 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:18 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 12:50:18 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 12:50:18 INFO - Using env: {'DISPLAY': ':0', 12:50:18 INFO - 'HOME': '/home/cltbld', 12:50:18 INFO - 'LANG': 'en_US.UTF-8', 12:50:18 INFO - 'LANGUAGE': 'en_US:en', 12:50:18 INFO - 'LOGNAME': 'cltbld', 12:50:18 INFO - 'MAIL': '/var/mail/cltbld', 12:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:18 INFO - 'MOZ_NO_REMOTE': '1', 12:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:18 INFO - 'NO_EM_RESTART': '1', 12:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:18 INFO - 'PWD': '/builds/slave/test', 12:50:18 INFO - 'SHELL': '/bin/bash', 12:50:18 INFO - 'SHLVL': '1', 12:50:18 INFO - 'TERM': 'linux', 12:50:18 INFO - 'TMOUT': '86400', 12:50:18 INFO - 'USER': 'cltbld', 12:50:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:18 INFO - '_': '/tools/buildbot/bin/python'} 12:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:18 INFO - Running setup.py (path:/tmp/pip-sUv_9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:19 INFO - Running setup.py (path:/tmp/pip-pGLQi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:19 INFO - Running setup.py (path:/tmp/pip-W8XOP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:19 INFO - Running setup.py (path:/tmp/pip-n2t7tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:19 INFO - Running setup.py (path:/tmp/pip-oy7Qpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:19 INFO - Running setup.py (path:/tmp/pip-ag0Fy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:19 INFO - Running setup.py (path:/tmp/pip-AF6DFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:19 INFO - Running setup.py (path:/tmp/pip-dZOlsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:19 INFO - Running setup.py (path:/tmp/pip-U2MzXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:19 INFO - Running setup.py (path:/tmp/pip-zeRSUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:19 INFO - Running setup.py (path:/tmp/pip-jpLgyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:19 INFO - Running setup.py (path:/tmp/pip-GTWPdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:19 INFO - Running setup.py (path:/tmp/pip-5jrK8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:19 INFO - Running setup.py (path:/tmp/pip-oiOZIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:19 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)) 12:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:19 INFO - Running setup.py (path:/tmp/pip-wQ_xQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:20 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)) 12:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:20 INFO - Running setup.py (path:/tmp/pip-AdhopA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:20 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)) 12:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:20 INFO - Running setup.py (path:/tmp/pip-_vYKjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:20 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)) 12:50:20 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)) 12:50:20 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)) 12:50:20 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)) 12:50:20 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)) 12:50:20 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)) 12:50:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:22 INFO - Downloading blessings-1.6.tar.gz 12:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:50:22 INFO - Installing collected packages: blessings 12:50:22 INFO - Running setup.py install for blessings 12:50:22 INFO - Successfully installed blessings 12:50:22 INFO - Cleaning up... 12:50:22 INFO - Return code: 0 12:50:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:50:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:50:22 INFO - Reading from file tmpfile_stdout 12:50:22 INFO - Current package versions: 12:50:22 INFO - argparse == 1.2.1 12:50:22 INFO - blessings == 1.6 12:50:22 INFO - blobuploader == 1.2.4 12:50:22 INFO - docopt == 0.6.1 12:50:22 INFO - manifestparser == 1.1 12:50:22 INFO - mozInstall == 1.12 12:50:22 INFO - mozcrash == 0.17 12:50:22 INFO - mozdebug == 0.1 12:50:22 INFO - mozdevice == 0.48 12:50:22 INFO - mozfile == 1.2 12:50:22 INFO - mozhttpd == 0.7 12:50:22 INFO - mozinfo == 0.9 12:50:22 INFO - mozleak == 0.1 12:50:22 INFO - mozlog == 3.2 12:50:22 INFO - moznetwork == 0.27 12:50:22 INFO - mozprocess == 0.22 12:50:22 INFO - mozprofile == 0.28 12:50:22 INFO - mozrunner == 6.11 12:50:22 INFO - mozscreenshot == 0.1 12:50:22 INFO - mozsystemmonitor == 0.3 12:50:22 INFO - moztest == 0.7 12:50:22 INFO - mozversion == 1.4 12:50:22 INFO - psutil == 3.1.1 12:50:22 INFO - requests == 1.2.3 12:50:22 INFO - wsgiref == 0.1.2 12:50:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:22 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 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50:22 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 12:50:22 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 12:50:22 INFO - Using env: {'DISPLAY': ':0', 12:50:22 INFO - 'HOME': '/home/cltbld', 12:50:22 INFO - 'LANG': 'en_US.UTF-8', 12:50:22 INFO - 'LANGUAGE': 'en_US:en', 12:50:22 INFO - 'LOGNAME': 'cltbld', 12:50:22 INFO - 'MAIL': '/var/mail/cltbld', 12:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:22 INFO - 'MOZ_NO_REMOTE': '1', 12:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:22 INFO - 'NO_EM_RESTART': '1', 12:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:22 INFO - 'PWD': '/builds/slave/test', 12:50:22 INFO - 'SHELL': '/bin/bash', 12:50:22 INFO - 'SHLVL': '1', 12:50:22 INFO - 'TERM': 'linux', 12:50:22 INFO - 'TMOUT': '86400', 12:50:22 INFO - 'USER': 'cltbld', 12:50:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:22 INFO - '_': '/tools/buildbot/bin/python'} 12:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 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)) 12:50:22 INFO - Cleaning up... 12:50:22 INFO - Return code: 0 12:50:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50: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', 'jsonschema'] in /builds/slave/test/build 12:50: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 jsonschema 12:50:22 INFO - Using env: {'DISPLAY': ':0', 12:50:22 INFO - 'HOME': '/home/cltbld', 12:50:22 INFO - 'LANG': 'en_US.UTF-8', 12:50:22 INFO - 'LANGUAGE': 'en_US:en', 12:50:22 INFO - 'LOGNAME': 'cltbld', 12:50:22 INFO - 'MAIL': '/var/mail/cltbld', 12:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:22 INFO - 'MOZ_NO_REMOTE': '1', 12:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:22 INFO - 'NO_EM_RESTART': '1', 12:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:22 INFO - 'PWD': '/builds/slave/test', 12:50:22 INFO - 'SHELL': '/bin/bash', 12:50:22 INFO - 'SHLVL': '1', 12:50:22 INFO - 'TERM': 'linux', 12:50:22 INFO - 'TMOUT': '86400', 12:50:22 INFO - 'USER': 'cltbld', 12:50:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:22 INFO - '_': '/tools/buildbot/bin/python'} 12:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:22 INFO - Downloading/unpacking jsonschema 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:50:24 INFO - Downloading/unpacking functools32 (from jsonschema) 12:50:24 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 12:50:24 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 12:50:24 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 12:50:24 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 12:50:24 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 12:50:24 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 12:50:25 INFO - Downloading functools32-3.2.3-2.tar.gz 12:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:50:25 INFO - warning: no files found matching '*.txt' 12:50:25 INFO - no previously-included directories found matching 'build' 12:50:25 INFO - no previously-included directories found matching 'dist' 12:50:25 INFO - no previously-included directories found matching '.git*' 12:50:25 INFO - Installing collected packages: jsonschema, functools32 12:50:25 INFO - Running setup.py install for functools32 12:50:25 INFO - warning: no files found matching '*.txt' 12:50:25 INFO - no previously-included directories found matching 'build' 12:50:25 INFO - no previously-included directories found matching 'dist' 12:50:25 INFO - no previously-included directories found matching '.git*' 12:50:25 INFO - Successfully installed jsonschema functools32 12:50:25 INFO - Cleaning up... 12:50:25 INFO - Return code: 0 12:50:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29bec49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26818e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, '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': '4300f881736b422476174874000001bc-1464630508.36670-87350152', '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 12:50: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', 'flake8'] in /builds/slave/test/build 12:50: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 flake8 12:50:25 INFO - Using env: {'DISPLAY': ':0', 12:50:25 INFO - 'HOME': '/home/cltbld', 12:50:25 INFO - 'LANG': 'en_US.UTF-8', 12:50:25 INFO - 'LANGUAGE': 'en_US:en', 12:50:25 INFO - 'LOGNAME': 'cltbld', 12:50:25 INFO - 'MAIL': '/var/mail/cltbld', 12:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:25 INFO - 'MOZ_NO_REMOTE': '1', 12:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:25 INFO - 'NO_EM_RESTART': '1', 12:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:25 INFO - 'PWD': '/builds/slave/test', 12:50:25 INFO - 'SHELL': '/bin/bash', 12:50:25 INFO - 'SHLVL': '1', 12:50:25 INFO - 'TERM': 'linux', 12:50:25 INFO - 'TMOUT': '86400', 12:50:25 INFO - 'USER': 'cltbld', 12:50:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:25 INFO - '_': '/tools/buildbot/bin/python'} 12:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:25 INFO - Downloading/unpacking flake8 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:50:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:50:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:50:28 INFO - no previously-included directories found matching 'docs/_build' 12:50:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:50:28 INFO - Running setup.py install for pep8 12:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:50:28 INFO - no previously-included directories found matching 'docs/_build' 12:50:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:50:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:50:28 INFO - Cleaning up... 12:50:28 INFO - Return code: 0 12:50:28 INFO - Running post-action listener: _resource_record_post_action 12:50:28 INFO - Running post-action listener: _start_resource_monitoring 12:50:28 INFO - Starting resource monitoring. 12:50:28 INFO - ##### 12:50:28 INFO - ##### Finished create-virtualenv step (success) 12:50:28 INFO - ##### 12:50:28 INFO - ##### 12:50:28 INFO - ##### Running install step. 12:50:28 INFO - ##### 12:50:28 INFO - Running pre-action listener: _resource_record_pre_action 12:50:28 INFO - Running main action method: install 12:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:50:28 INFO - Reading from file tmpfile_stdout 12:50:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:50:28 INFO - Reading from file tmpfile_stdout 12:50:28 INFO - Output received: 12:50:28 INFO - Usage: mozinstall [options] installer 12:50:28 INFO - Options: 12:50:28 INFO - -h, --help show this help message and exit 12:50:28 INFO - -d DEST, --destination=DEST 12:50:28 INFO - Directory to install application into. [default: 12:50:28 INFO - "/builds/slave/test"] 12:50:28 INFO - --app=APP Application being installed. [default: firefox] 12:50:28 INFO - mkdir: /builds/slave/test/build/application 12:50:28 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'] 12:50:28 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 12:50:44 INFO - Reading from file tmpfile_stdout 12:50:44 INFO - Output received: 12:50:44 INFO - /builds/slave/test/build/application/firefox/firefox 12:50:44 INFO - Running post-action listener: _resource_record_post_action 12:50:44 INFO - ##### 12:50:44 INFO - ##### Finished install step (success) 12:50:44 INFO - ##### 12:50:44 INFO - ##### 12:50:44 INFO - ##### Running run-tests step. 12:50:44 INFO - ##### 12:50:44 INFO - Running pre-action listener: _resource_record_pre_action 12:50:44 INFO - Running main action method: run_tests 12:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:50:44 INFO - Python 2.7.3 12:50:44 INFO - Return code: 0 12:50:44 INFO - grabbing minidump binary from tooltool 12:50:44 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')]} 12:50:44 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 0x2710b20>, '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 0x2711a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2711eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:50:44 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 12:50:44 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 12:50:44 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 12:50:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:50:44 INFO - Return code: 0 12:50:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:50:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:50:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:50:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:50:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:50:45 INFO - Return code: 0 12:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 12:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 12:50:45 INFO - Using env: {'DISPLAY': ':0', 12:50:45 INFO - 'HOME': '/home/cltbld', 12:50:45 INFO - 'LANG': 'en_US.UTF-8', 12:50:45 INFO - 'LANGUAGE': 'en_US:en', 12:50:45 INFO - 'LOGNAME': 'cltbld', 12:50:45 INFO - 'MAIL': '/var/mail/cltbld', 12:50:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:50:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:45 INFO - 'MOZ_NO_REMOTE': '1', 12:50:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:45 INFO - 'NO_EM_RESTART': '1', 12:50:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:45 INFO - 'PWD': '/builds/slave/test', 12:50:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:50:45 INFO - 'SHELL': '/bin/bash', 12:50:45 INFO - 'SHLVL': '1', 12:50:45 INFO - 'TERM': 'linux', 12:50:45 INFO - 'TMOUT': '86400', 12:50:45 INFO - 'USER': 'cltbld', 12:50:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464630508.36670-87350152', 12:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:45 INFO - '_': '/tools/buildbot/bin/python'} 12:50:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 12:50:45 INFO - mozversion application_buildid: 20160530112941 12:50:45 INFO - mozversion application_changeset: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a 12:50:45 INFO - mozversion application_display_name: Nightly 12:50:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:50:45 INFO - mozversion application_name: Firefox 12:50:45 INFO - mozversion application_remotingname: firefox 12:50:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:50:45 INFO - mozversion application_vendor: Mozilla 12:50:45 INFO - mozversion application_version: 49.0a1 12:50:45 INFO - mozversion platform_buildid: 20160530112941 12:50:45 INFO - mozversion platform_changeset: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a 12:50:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:50:45 INFO - mozversion platform_version: 49.0a1 12:50:45 INFO - using testdate: 1464637845 12:50:45 INFO - actual date: 1464637845 12:50:45 INFO - starting webserver on 'localhost:50622' 12:50:45 INFO - SUITE-START | Running 2 tests 12:50:45 INFO - TEST-START | dromaeo_css 12:50:45 INFO - operating with platform_type : linux_ 12:50:45 INFO - Initialising browser for dromaeo_css test... 12:50:45 INFO - TEST-INFO | started process 31316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgMN1H0/profile http://localhost:50622/getInfo.html) 12:50:50 INFO - PROCESS | 31316 | __metrics Screen width/height:1600/1200 12:50:50 INFO - PROCESS | 31316 | colorDepth:24 12:50:50 INFO - PROCESS | 31316 | Browser inner width/height: 1024/697 12:50:50 INFO - PROCESS | 31316 | __metrics 12:50:51 ERROR - PROCESS | 31316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:50:52 INFO - TEST-INFO | 31316: exit 0 12:50:52 INFO - Browser initialized. 12:50:52 INFO - Running cycle 1/1 for dromaeo_css test... 12:50:52 INFO - TEST-INFO | started process 31398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgMN1H0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:04 INFO - PROCESS | 31398 | RSS: Main: 157425664 12:51:04 INFO - PROCESS | 31398 | 12:51:55 INFO - PROCESS | 31398 | 1464637915969 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] 12:54:07 INFO - PROCESS | 31398 | Cycle 1(1): loaded http://localhost:50622/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50622/tests/dromaeo/cssquery-ext.html) 12:54:08 INFO - PROCESS | 31398 | RSS: Main: 266211328 12:54:08 INFO - PROCESS | 31398 | 12:57:11 INFO - PROCESS | 31398 | Cycle 1(1): loaded http://localhost:50622/tests/dromaeo/cssquery-ext.html (next: http://localhost:50622/tests/dromaeo/cssquery-jquery.html) 12:57:12 INFO - PROCESS | 31398 | RSS: Main: 235868160 12:57:12 INFO - PROCESS | 31398 | 13:00:14 INFO - PROCESS | 31398 | Cycle 1(1): loaded http://localhost:50622/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50622/tests/dromaeo/cssquery-mootools.html) 13:00:14 INFO - PROCESS | 31398 | RSS: Main: 238653440 13:00:14 INFO - PROCESS | 31398 | 13:03:17 INFO - PROCESS | 31398 | Cycle 1(1): loaded http://localhost:50622/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50622/tests/dromaeo/cssquery-prototype.html) 13:03:17 INFO - PROCESS | 31398 | RSS: Main: 231813120 13:03:17 INFO - PROCESS | 31398 | 13:06:20 INFO - PROCESS | 31398 | Cycle 1(1): loaded http://localhost:50622/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50622/tests/dromaeo/cssquery-yui.html) 13:06:21 INFO - PROCESS | 31398 | RSS: Main: 206868480 13:06:21 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | Cycle 1(1): loaded http://localhost:50622/tests/dromaeo/cssquery-yui.html (next: http://localhost:50622/tests/dromaeo/cssquery-dojo.html) 13:09:23 INFO - PROCESS | 31398 | RSS: Main: 272375808 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | __start_tp_report 13:09:23 INFO - PROCESS | 31398 | _x_x_mozilla_page_load 13:09:23 INFO - PROCESS | 31398 | _x_x_mozilla_page_load_details 13:09:23 INFO - PROCESS | 31398 | |i|pagename|runs| 13:09:23 INFO - PROCESS | 31398 | |0;dojo.html;2659.574468085106;2679.772219361354;2700.2709268497506;2714.8099633025695;2727.1682136948225;4668.346431499588;4675.4856965733825;4730.337752714623;4746.382970213867;4756.048790241953;4751.548602882729;4765.952340476594;4790.808367665298;4824.7587620618915;4825.78283977221;4289.571042895709;4324.286492728696;4328.935065974013;4386.846460373888;4425.867223983286;4447.288433850585;4475.619572336355;4483.820647174109;4522.954770452303;4531.569500897426;4308.74147551148;4384.758838263894;4419.867403977886;4437.578430049172;4445.377647129389;4330.610245077958;4334.1981733379425;4358.760268185249;4389.956100438987;4390.385346051556;4381.38660587518;4423.977880110611;4448.310511870633;4457.130859482402;4490.304002879526;4485.573870482299;4769.046190761862;4799.2801079837955;4802.471728109905;4811.061842940628;4992.201247800334;5045.823396181153;5050.772715227824;5110.565601923841;5129.743512824344;5109.974450127763;5136.357955255593;5150.459201783834;5157.974210128963;5172.456892026321;4641.605463535638;4708.976455117702;4722.433308003062;4756.595689366408;4772.427308722906;5233.215017747369;5276.445973172838;5279.313689220377;5308.761105750251;5329.147336426153;5023.623228257895;5076.162433198481;5079.31429257053;5079.923801142986;5081.8729531762;4980.228064649985;5054.721990290495;5106.055379754757;5186.429492755794;5203.947960520422;5075.56857667095;5079.644424890296;5094.414142373675;5105.0810854045885;5110.718910459886;5011.223260394645;5015.874603134951;5056.418511871182;5066.923996140061;5120.61595380348;4217.915641687149;4258.893527661771;4260.062786187033;4287.592678695519;4332.393464914914;3722.7952462614817;3753.756005859665;3755.9436608450897;3775.188334508039;3808.257389808961;4398.75806830621;4401.6698747594055;4412.0734645724115;4412.426384569985;4458.331250312414;5000.199968005102;5053.36832895888;5142.665726727825;5148.279240906276;5196.246544251138;4328.329108988112;4377.562243775597;4379.540148284448;4390.407295015196;4392.978035109868;4580.725156490621;4581.931271030937;4582.977085114553;4601.976990115028;4643.976780116145;4773.785179666854;4781.880452988703;4824.879378015507;4833.105875412919;4833.830815921426;5153.149730294459;5177.326947496801;5198.038362902875;5201.115810312181;5246.658967167122;4873.4639189689815;4886.755662216804;4903.60771138301;4904.4605093440405;4949.257611358325;4884.511548845087;5038.319826823332;5084.1102807009365;5112.74436278192;5114.156164233009;5166.225066240094;5180.378354597472;5185.9222111669105;5188;5219.2953951216095;5033.6476446648385;5035.899282014412;5047.192449208256;5047.2429135629945;5101.668391554537;4888.828890988798;4962.156433406258;4984.825531106394;5018.84566549703;5032.6980381177245;4943.110240156806;4952.158133117451;4965.925511117408;5004.84985450437;5014.52362025607;5059.848204553869;5060.063888180698;5065.898682026413;5095.592352611856;5106.540411362995;4776.880577985439;4810.783514741775;4825.155597770306;4837.395325584302;4866.1727506323305 13:09:23 INFO - PROCESS | 31398 | |1;ext.html;546.3967947356202;584.1121495327101;588.9911651325231;604.0154548086618;610.4048552661156;27307.180784576445;40391.59608403915;40641.187176256455;40648.79675601625;40734.79632601833;41704.58295417045;42384.78807605965;42385.78807105968;42434.36348454776;42499;7634.923650763477;7836.451448398614;7839.686412543491;7842.137364889858;7846.176151504067;7626.08486981563;7781.688732450695;7804.960975195116;7805.102413222467;7811.843763124734;7804.063512378522;7854.332381747558;7858;7860.606969651494;7866.6460009299435;7758.340541054017;7793.2596403341595;7806.1413244543055;7817.882731758971;7819.022622172229;7651.081870175614;7751.379889608817;7751.496152750054;7754.457187996843;7763;38591.22817543661;38647;39005.41491877624;39035;39116;2900.7099290071037;2995.775316851223;3264.8041117533025;3613.837377318027;3733.5893051764283;29289.56065659017;29523.704762952526;29605.555916661266;29952.25119372033;30647.620857061487;3251.581180482589;3308.553345298402;3320.96679033209;3332.9333413331597;3413.607435144965;251613.99999999817;252670;253398.73300633562;254299;255621;31809.363812723615;32462.67537324644;51533;51914;51935.74032129815;34338.48492272618;34450.82774586111;34461.31077378438;34559.30881382358;34564.48153277703;12588.685282868002;12709.93645031769;12711.427985740664;12713.872861271453;12727.109102362745;10153.441560714084;10198.133158681447;10199.9490002551;10201.74495637615;10202.234832387601;7905.644246008828;7963.761087167279;7969.960150199212;8012.839743205103;8033.1163572007035;3078.7998780079224;3088;3115.1589070950718;3140.4347217501067;3181.5545823584716;824.9257566819015;853.2619284319144;916.1434059154711;948.137195152408;1018.2464975917916;27852.303692407448;28131.156065318075;28252.15243542697;28666.42667146687;28836.279093022422;723.565860483716;885.2386947225381;921.4931787516973;950.4487397309543;962.5379817687549;14267.143971361751;14410.42358305656;14713;14818;15260;400184;401721;404218;404865;405919;51475;51506.48493515092;51976.740116299174;52075;52108;1016.5120742043861;1133.2690414682484;1144.9427528623535;1149.1955631058293;1166.854143232096;26811.463770724087;28207.153785386472;28528.714712852605;28666.42667146687;28842.711572884004;41206.793966029974;41902.37146442867;41925.58074419339;41970.160596788504;42175.57824421716;321629;323724;324374;325266;393494;23949.28152155438;24211.031558737453;24380;25502.362440939123;25512;40312.1937561253;40504.59495405126;40750.59249407468;41405.79297103495;41438;34933;35093.82453087718;35143;35157.12107197341;35918.8204058978;34057.829710852275;34670;35350;35449.82275088711;35508.112297192776;34415.31169376648;34845;35253.64746352606;35487.467687984186;36092;29493.705062949954;33988.83005584956;34051.489227661106;34115.82942085274;34365.48451773275;25129.623055654545;25755.742442576084;25878.66243777068;25925.481490370465;26103.738962610132 13:09:23 INFO - PROCESS | 31398 | |2;jquery.html;351.9612842587313;357.47629722456594;357.6441440766438;362.48708078069535;372.37255224945966;15676.372945082197;16692.165391730425;16754.83245167548;17121.486355409357;17329.56676083097;15936.681266374666;16901.239444225008;16965.745513817303;16975.745363819522;17051.57371065721;4822.300766388871;4994;5027.271045698371;5038.269450929613;5039.017391608638;3738.214974855284;3911.9608803912024;4940.5306495883015;5649.322081350244;5929.051351783715;5971.044632858743;5987.22166118404;6011.489023433013;6013.849653758669;6014.4286292802335;5810.070388737781;5886.293644762634;5936.7328470218945;5941.079132734433;5963.373845746221;3373.983130084334;4766.404199475066;4996.400431948153;5008;5156;19384.224631014742;20029;20073.297434589866;20271.189152433886;20291.89854050735;1786.1605045628535;1839.4389711138097;1852.19429548147;1862.9906850465798;1896.1656870976865;12557.309347985856;12850.485980560767;12882.420291086924;13206.735865282737;13357.666058348523;1736.4530172995592;1771.5925337172523;1779.8487128593956;1780.4836597386743;1786.767720196379;66563.3343666562;68259.3174068258;68417.65791171062;69183;69228.3077169232;8438.45150065256;8909.73270801877;9260.39807412516;9640.228781697448;9729.854052189223;11874.34691091981;11885.108616853771;11919.344436055926;11941.462634181482;11958.40207989597;6824.931750682529;6976.441884649216;7005.474589405815;7127.82180445493;7129.500934934505;6803.2856550062525;6850.4862135340045;6921;6943.340382663639;6944.51388402807;5849.941500585025;5861.912071318934;5864.354920958691;6010.729517171738;6020.969895150496;1515.8181018277878;1581.7706432567443;1611.379618846729;1628.9837101629068;1633.150761603983;707.2255879811598;711.6655172069119;815.7511958852489;819.7417813388763;829.875518672204;16057.518274451784;16192.352305907632;17219.913900430416;17240.568985775204;17522.737158942626;767.4359345880773;812.1472453923357;821.6179476543437;846.2510678049847;863.8056437301557;9729.4648794317;9755.609775609038;9970.601175953027;10004.299699021;10146.239032072624;373717;373721;380518;382026;383814;67370.66314668395;69389.65305173442;69489;69613.3038669617;71069.64465177641;913.2602591900582;921.7741653294852;923.1507013547553;927.1007123090591;929.8512238042016;14960.625984350043;15036.548903532912;15135.243237837843;15354.616134596725;15507.379704811681;30043.699563004964;31236.28200448997;31771;33068;33881.83059084689;41654.45937095381;43604.56395436005;43615.56384436242;43742.343864841416;44077.016534256676;6531;6558.967205163944;6625.403713665601;6717.16035495563;6751.831204219934;9555.474448905377;10078.79842403133;10202.489875506344;10317.432541210306;10400;8601.483910965362;8896.243819275176;8928.330375221754;8953.104689530996;9130.223930965942;8822.779430514032;8909.109089091038;8985.730428087169;9009.504477253813;9017.864732029157;8859.44959632049;8932.910670893209;9096.545172741204;9260.907390926273;9335.299852510952;6665.866682666417;6694.397504224643;6733.764318248838;6862.862742745217;6903.585784852925;8744.169303916118;8745.650173992968;8804.207621314112;8931.955340223258;8965.551722413984 13:09:23 INFO - PROCESS | 31398 | |3;mootools.html;1259.338847105269;1377.7037936843576;1435.9856401435984;1477.7487827069397;1726.5856194513312;6591.143151390319;7479.700811967522;7709.498882572643;7773.2615401536905;7871.409644276673;7604.277593628596;7727.768166955;7729.806754831118;7734.961325193366;7739.342155916754;1862.0131330394845;1914.5309399197217;1916.3867562380044;2172.7935846094597;2203.724534433196;1943.815337542931;2089.059923034633;2169.837262205333;2170.6309927312395;2171.3703026122407;2106.610277098742;2124.681297805334;2129.808317251447;2129.882856442895;2131.041031535807;1827.9817201827946;2168.447046003259;2169.5986242545177;2175.195177784214;2179.1283486605325;2092.058573641852;2152.4726442021806;2153.633882240023;2158.0612433591436;2158.136745301876;7791.805204869867;7815.140334563193;7817;7817;7827.060752709711;4503.076869241798;4620.19146649335;4624.838130665411;4626.745528995903;4635.0729854029;2734.5214587447317;2811.4517669054544;2857.985710071436;2894.276430892277;2898.7101289871057;821.6795449774593;831.6631764135474;847.6736456464243;847.7414388611471;853.1553761775859;10305.484725763681;10382.169426445866;10388.428636424993;10389;10408.219383546264;4179.080602267496;4184.225918205142;4255.659547236213;4256.872293831128;4298.441202643637;8992.730218093468;9026;9032.8645070324;9047.502387368626;9048.457092574467;4729.290606409066;4732.763361831963;4745.217039188496;4747.620190384761;4749.881252968635;3576.2668652926086;3608.1520842601967;4235.97882010588;4292.5063617683745;4297.376880352332;3579.8926032219074;3651.8904432867057;3732.5147730794824;3749.812509374575;3751.437284407306;1162.5640384855678;1180.4805885410392;1190.1014733875868;1205.427421974555;1205.6081773423673;697.6476879175983;819.5001049359886;830.5141492226994;843.6498852976069;849.2144766091341;4995.275685025651;5093.261477085802;5237.764300606405;5245.737713114329;5282.4717528246865;372.9627037296249;373.8355123745543;379.247194319276;885.3359980014989;923.9953800230955;3429.9485507717404;3437.8968630941113;3438.381091403571;3491.458823882302;3499.5975462822103;9295.256379489625;9514.19129374011;9527.571259293349;9528.428294302365;9569.234461243084;9305.441673499612;9423.151916327564;9434.292428067785;9439.811203775886;9470.384425012353;6969.825754356181;7221.8555628887125;7241.167265764505;7425.368843648243;7426.5915374654915;5130.230465430066;5368.651037682538;5383.650062745909;5396.433374495621;5440.075187218262;8733.781655458664;8892;8900.688475903313;8935.642574296955;8993.14565116313;8707.390482666153;8732.257758090633;8736.388452808496;8880.378373513791;8977;5818.534517238526;6464.967675161594;6606.141201643755;6757.93242067573;6898.551594146365;7520.8495830082;7571.621418929141;7590.0891892973195;7597.810054748676;7600.695972161052;6541.771038013647;6752.324767523209;6768.661566921536;6814.386705196556;6886.896696549456;6671.733130674913;6680.265170831108;6720.361565651256;6785.89821152693;6787.457003439614;6037.486813620892;6093.086037094471;6122.816315510542;6146.78486252979;6165.876682466236;4378.233809083461;4389.868303950887;4414.337849322627;4425.114977004676;4457.643388528974;4547.590716835501;4570.611498022706;4638.420197475316;4647.047355292225;4676.251799712029 13:09:23 INFO - PROCESS | 31398 | |4;prototype.html;286.88524590163934;288.5743528295764;291.2195316551642;291.7257777688971;294.3010350417758;4790;4816.494268101847;4817.590504807091;4848.951510484894;4857.51424857514;4722.362481065055;4733.266343716729;4793.233082706767;4801.399825021872;4815.542523460274;3528.558930133733;3621.8551257949653;3623.6376362363685;3645.216278500122;3711.2206436648335;3615.566132064156;3708.128589781399;3717.8141092945243;3751.5685696144883;3769.6418840210135;3670.247599242149;3704.6105262105925;3709.8330575124182;3715.9628403715888;3731.141837377405;3634.8731893112954;3704.518412606371;3736.4955730976244;3744.1762812181278;3746.550413950343;3290.654481279479;3291.782040644977;3293.4236508610898;3293.604767427924;3304.339132173575;4524.185646583614;4528.977355113237;4533.773311334453;4563.612092972101;4586.587207151339;4222.408862759216;4238.173556156551;4238.321868501056;4245.87262382129;4259.488861336628;4691.991221887277;4950.801967921278;4957.82647607332;4958.975205123951;5025.793809485697;3537.398642230827;3547.651892280917;3557.2174121693447;3560.964390356089;3570;5208.479152084799;5213.556847667953;5223.425423203483;5240.240165176028;5243.426971908412;3314.751393645486;3505.631908649606;3650.580183278904;3653.780773153619;3658.0671928658553;3576.8926932192076;3578.4453409721013;3583.605803361628;3592.6407359263862;3605.747597668138;4146.37804329347;4156.771377574202;4160.1471698301775;4162.438070860456;4165.604267594574;4937.925931111036;4961.70229786214;4972.502749725071;5015.598752099823;5026.899462010812;1211.9456073216359;1248.1263115818963;1254.1534464236604;1258.8867001969866;1260.8297879786294;773.89552410425;785.642532647644;790.8457850719054;795.2643804480832;800.1838125112353;4197.538270790211;4323.762193079411;4389.814750017477;4402.273624851928;4409.294512877924;5127.102757017507;5136.948630513722;5145.202493613496;5145.4854514549;5161.638685291993;4382.649388048949;4385.342198670161;4413.7351758894565;4414.359917811899;4442.378067070613;2641.379275870169;2705.5535836587137;2729.703390889312;2745.5607102863446;2754.5454999924787;4820.6143508519235;4854.543636908984;4857.344258525054;4903.166461701519;4908.680935739166;5126.743662816844;5248.711320877312;5255.868603284948;5255.948810237967;5313.203019547099;4849.224124140192;4876.268559716071;4884.4871288514905;4896.4124305083615;4947.925781113287;5102.923456148086;5118.206677964921;5121.231815227746;5133.845984620468;5163.225516172604;4800.66395352336;5003.724795136302;5032.220005899091;5054.74726263678;5066.417362003417;4857.271409288635;4884.804607815648;4886.975565122151;4887.144749668722;4913.43495498008;3514.3674138655288;3555.5733312002726;3565.554305711786;3567.304375646724;3568.4120566347724;5150.304708864255;5184.714840683799;5194.714290714047;5224.216367544898;5232.215167724872;4791.952080479151;4906.95093049065;4944.15949288629;4991.226359914219;5006.6495345325475;4936.3829521309835;4939.740366206738;4973.502649734997;4977.178765503651;5020.42265139499;4929.950700493093;4939.851804445872;4943.3573635427165;4951.554360107463;4969.503049695146;4774.21225497789;4835.20219163834;4931.950680493149;5015.1975683890405;5095.974520127524;4898.24077268024;4922.384701912261;4923.606111511142;4932.30947667334;4937.5556199942175 13:09:23 INFO - PROCESS | 31398 | |5;yui.html;732.534840376361;747.7382915979408;752.3905636434492;770.183605378299;771.6450432800912;11526.596569120082;11917.106217033725;12135.514579416813;12147.817782733255;12151.088668349865;11412.31526108434;11423.428828558559;11483.25358851674;11489.425528723572;11536.365499897502;619.2599843187393;758.525921299188;779.2129948751744;788.7002938883245;791.3708601661692;784;785.446260386429;787;787.2953706432739;787.7321710618388;840.0255703384075;840.844443777903;841.3353450773911;843.5065486690294;850.5492089192707;649.3960616626536;790.474334567512;816.6406781016334;816.873384625384;843.9915600844005;601.173386593434;601.2064075420446;601.6239850093691;601.9578629495937;602.9065494848305;11135.610253641084;11282.323060616389;11311.547538098466;11324.660260192126;11350.432478376131;11846;12103.697407564794;12213.755724885452;12367.196132251374;12630.052746043992;10846.566137354497;10942.288751231225;10982.835257471144;11024.44877756109;11309.660710178709;3999.8204121541135;4063;4097.927842123186;4108.239975604522;4172.144710334374;44142.33786493205;45019.77490112528;45098.32352514715;45246.54753452489;45382.77308613436;9668.323217374716;9900.752481187883;9933.552990115462;10008.349457285252;10045.69862904114;16314.102724350038;17674.646507069785;17777.111144442726;17853.821461785217;17867.553311167325;6149.292831324455;6455.580387274812;6466.64433456155;6650.434713049445;6951;3584.1039740064984;3601.513795637555;3608.783472991629;3677.8712745053795;3826;2747.32690490831;2835.7306055924655;2848.7720982321366;2856.5429531274895;2858.814177078483;521.7339157029942;527.862755683525;538.5718353908652;539.1939051118525;541.1098742568453;529.1692043491757;551.1292158389734;558.9133684278943;560.3192121572309;575.2148317546519;6993.510454268152;7011.649417529103;7091.9290807091265;7221.8555628887125;7287.453440991947;455.2056661126356;480.15732389656625;509.5134146889711;543.2882923370397;567.2087438024016;3272.036648405611;3310.1228174533767;3312.2381852173653;3413.095529684586;3436.329915666421;54884.13948256468;54929.45070549323;56745.43254567401;57486;57753.42246577564;49907.50092499029;50254.74872625687;50283.245751313756;51753.48246517562;51846.44460666186;46611.76694116508;46766.76616616963;47166;47471;47670.28494572515;6735.764248251287;6852.554583952027;6907.758228461979;6945;6983.546069505466;30729.846350768104;31078.844605776827;31997.520037199927;32259.516107258878;32435.675643243267;41075.794621026704;41991.580084198766;42071;42097.579024209364;42348.15303693971;8884.466931984101;8972.237359824489;10331.32846364984;10377.740556485845;10406.843897341394;11364.204505684524;11859;12290.262584244974;12382.318972456602;12555.246685198917;10645.627403041166;10742.409167495864;11066.114710823276;11147.609833655782;11226.775464490827;10637.574497020032;10744.409057501913;10934.945325273322;10978.725531861768;10983.725406864893;10335.431551264752;10422.895771042193;10586.100181484351;10589.894101058891;10952.835707464235;9237.307201960015;9244.121808428188;9481.66814161501;9722.951385243028;9888.31898577258;9002.774930626787;9218.26253899673;9332;9342.719718408458;9344.205742511962 13:09:23 INFO - PROCESS | 31398 | __end_tp_report 13:09:23 INFO - PROCESS | 31398 | __start_cc_report 13:09:23 INFO - PROCESS | 31398 | _x_x_mozilla_cycle_collect,991 13:09:23 INFO - PROCESS | 31398 | __end_cc_report 13:09:23 INFO - PROCESS | 31398 | __startTimestamp1464638963814__endTimestamp 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | ------- Summary: start ------- 13:09:23 INFO - PROCESS | 31398 | Number of tests: 6 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | [#0] dojo.html Cycles:165 Average:4730.34 Median:4833.83 stddev:502.16 (10.4%) stddev-sans-first:476.70 13:09:23 INFO - PROCESS | 31398 | Values: 2659.6 2679.8 2700.3 2714.8 2727.2 4668.3 4675.5 4730.3 4746.4 4756.0 4751.5 4766.0 4790.8 4824.8 4825.8 4289.6 4324.3 4328.9 4386.8 4425.9 4447.3 4475.6 4483.8 4523.0 4531.6 4308.7 4384.8 4419.9 4437.6 4445.4 4330.6 4334.2 4358.8 4390.0 4390.4 4381.4 4424.0 4448.3 4457.1 4490.3 4485.6 4769.0 4799.3 4802.5 4811.1 4992.2 5045.8 5050.8 5110.6 5129.7 5110.0 5136.4 5150.5 5158.0 5172.5 4641.6 4709.0 4722.4 4756.6 4772.4 5233.2 5276.4 5279.3 5308.8 5329.1 5023.6 5076.2 5079.3 5079.9 5081.9 4980.2 5054.7 5106.1 5186.4 5203.9 5075.6 5079.6 5094.4 5105.1 5110.7 5011.2 5015.9 5056.4 5066.9 5120.6 4217.9 4258.9 4260.1 4287.6 4332.4 3722.8 3753.8 3755.9 3775.2 3808.3 4398.8 4401.7 4412.1 4412.4 4458.3 5000.2 5053.4 5142.7 5148.3 5196.2 4328.3 4377.6 4379.5 4390.4 4393.0 4580.7 4581.9 4583.0 4602.0 4644.0 4773.8 4781.9 4824.9 4833.1 4833.8 5153.1 5177.3 5198.0 5201.1 5246.7 4873.5 4886.8 4903.6 4904.5 4949.3 4884.5 5038.3 5084.1 5112.7 5114.2 5166.2 5180.4 5185.9 5188.0 5219.3 5033.6 5035.9 5047.2 5047.2 5101.7 4888.8 4962.2 4984.8 5018.8 5032.7 4943.1 4952.2 4965.9 5004.8 5014.5 5059.8 5060.1 5065.9 5095.6 5106.5 4776.9 4810.8 4825.2 4837.4 4866.2 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | [#1] ext.html Cycles:180 Average:47220.14 Median:35399.91 stddev:89238.32 (252.1%) stddev-sans-first:89419.85 13:09:23 INFO - PROCESS | 31398 | Values: 546.4 584.1 589.0 604.0 610.4 27307.2 40391.6 40641.2 40648.8 40734.8 41704.6 42384.8 42385.8 42434.4 42499.0 7634.9 7836.5 7839.7 7842.1 7846.2 7626.1 7781.7 7805.0 7805.1 7811.8 7804.1 7854.3 7858.0 7860.6 7866.6 7758.3 7793.3 7806.1 7817.9 7819.0 7651.1 7751.4 7751.5 7754.5 7763.0 38591.2 38647.0 39005.4 39035.0 39116.0 2900.7 2995.8 3264.8 3613.8 3733.6 29289.6 29523.7 29605.6 29952.3 30647.6 3251.6 3308.6 3321.0 3332.9 3413.6 251614.0 252670.0 253398.7 254299.0 255621.0 31809.4 32462.7 51533.0 51914.0 51935.7 34338.5 34450.8 34461.3 34559.3 34564.5 12588.7 12709.9 12711.4 12713.9 12727.1 10153.4 10198.1 10199.9 10201.7 10202.2 7905.6 7963.8 7970.0 8012.8 8033.1 3078.8 3088.0 3115.2 3140.4 3181.6 824.9 853.3 916.1 948.1 1018.2 27852.3 28131.2 28252.2 28666.4 28836.3 723.6 885.2 921.5 950.4 962.5 14267.1 14410.4 14713.0 14818.0 15260.0 400184.0 401721.0 404218.0 404865.0 405919.0 51475.0 51506.5 51976.7 52075.0 52108.0 1016.5 1133.3 1144.9 1149.2 1166.9 26811.5 28207.2 28528.7 28666.4 28842.7 41206.8 41902.4 41925.6 41970.2 42175.6 321629.0 323724.0 324374.0 325266.0 393494.0 23949.3 24211.0 24380.0 25502.4 25512.0 40312.2 40504.6 40750.6 41405.8 41438.0 34933.0 35093.8 35143.0 35157.1 35918.8 34057.8 34670.0 35350.0 35449.8 35508.1 34415.3 34845.0 35253.6 35487.5 36092.0 29493.7 33988.8 34051.5 34115.8 34365.5 25129.6 25755.7 25878.7 25925.5 26103.7 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | [#2] jquery.html Cycles:180 Average:23193.57 Median:5830.01 stddev:62371.50 (1069.8%) stddev-sans-first:62522.89 13:09:23 INFO - PROCESS | 31398 | Values: 352.0 357.5 357.6 362.5 372.4 15676.4 16692.2 16754.8 17121.5 17329.6 15936.7 16901.2 16965.7 16975.7 17051.6 4822.3 4994.0 5027.3 5038.3 5039.0 3738.2 3912.0 4940.5 5649.3 5929.1 5971.0 5987.2 6011.5 6013.8 6014.4 5810.1 5886.3 5936.7 5941.1 5963.4 3374.0 4766.4 4996.4 5008.0 5156.0 19384.2 20029.0 20073.3 20271.2 20291.9 1786.2 1839.4 1852.2 1863.0 1896.2 12557.3 12850.5 12882.4 13206.7 13357.7 1736.5 1771.6 1779.8 1780.5 1786.8 66563.3 68259.3 68417.7 69183.0 69228.3 8438.5 8909.7 9260.4 9640.2 9729.9 11874.3 11885.1 11919.3 11941.5 11958.4 6824.9 6976.4 7005.5 7127.8 7129.5 6803.3 6850.5 6921.0 6943.3 6944.5 5849.9 5861.9 5864.4 6010.7 6021.0 1515.8 1581.8 1611.4 1629.0 1633.2 707.2 711.7 815.8 819.7 829.9 16057.5 16192.4 17219.9 17240.6 17522.7 767.4 812.1 821.6 846.3 863.8 9729.5 9755.6 9970.6 10004.3 10146.2 373717.0 373721.0 380518.0 382026.0 383814.0 67370.7 69389.7 69489.0 69613.3 71069.6 913.3 921.8 923.2 927.1 929.9 14960.6 15036.5 15135.2 15354.6 15507.4 30043.7 31236.3 31771.0 33068.0 33881.8 41654.5 43604.6 43615.6 43742.3 44077.0 6531.0 6559.0 6625.4 6717.2 6751.8 9555.5 10078.8 10202.5 10317.4 10400.0 8601.5 8896.2 8928.3 8953.1 9130.2 8822.8 8909.1 8985.7 9009.5 9017.9 8859.4 8932.9 9096.5 9260.9 9335.3 6665.9 6694.4 6733.8 6862.9 6903.6 8744.2 8745.7 8804.2 8932.0 8965.6 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | [#3] mootools.html Cycles:180 Average:5067.68 Median:5184.00 stddev:2857.92 (55.1%) stddev-sans-first:2851.61 13:09:23 INFO - PROCESS | 31398 | Values: 1259.3 1377.7 1436.0 1477.7 1726.6 6591.1 7479.7 7709.5 7773.3 7871.4 7604.3 7727.8 7729.8 7735.0 7739.3 1862.0 1914.5 1916.4 2172.8 2203.7 1943.8 2089.1 2169.8 2170.6 2171.4 2106.6 2124.7 2129.8 2129.9 2131.0 1828.0 2168.4 2169.6 2175.2 2179.1 2092.1 2152.5 2153.6 2158.1 2158.1 7791.8 7815.1 7817.0 7817.0 7827.1 4503.1 4620.2 4624.8 4626.7 4635.1 2734.5 2811.5 2858.0 2894.3 2898.7 821.7 831.7 847.7 847.7 853.2 10305.5 10382.2 10388.4 10389.0 10408.2 4179.1 4184.2 4255.7 4256.9 4298.4 8992.7 9026.0 9032.9 9047.5 9048.5 4729.3 4732.8 4745.2 4747.6 4749.9 3576.3 3608.2 4236.0 4292.5 4297.4 3579.9 3651.9 3732.5 3749.8 3751.4 1162.6 1180.5 1190.1 1205.4 1205.6 697.6 819.5 830.5 843.6 849.2 4995.3 5093.3 5237.8 5245.7 5282.5 373.0 373.8 379.2 885.3 924.0 3429.9 3437.9 3438.4 3491.5 3499.6 9295.3 9514.2 9527.6 9528.4 9569.2 9305.4 9423.2 9434.3 9439.8 9470.4 6969.8 7221.9 7241.2 7425.4 7426.6 5130.2 5368.7 5383.7 5396.4 5440.1 8733.8 8892.0 8900.7 8935.6 8993.1 8707.4 8732.3 8736.4 8880.4 8977.0 5818.5 6465.0 6606.1 6757.9 6898.6 7520.8 7571.6 7590.1 7597.8 7600.7 6541.8 6752.3 6768.7 6814.4 6886.9 6671.7 6680.3 6720.4 6785.9 6787.5 6037.5 6093.1 6122.8 6146.8 6165.9 4378.2 4389.9 4414.3 4425.1 4457.6 4547.6 4570.6 4638.4 4647.0 4676.3 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | [#4] prototype.html Cycles:180 Average:4133.76 Median:4792.59 stddev:1216.04 (25.4%) stddev-sans-first:1184.68 13:09:23 INFO - PROCESS | 31398 | Values: 286.9 288.6 291.2 291.7 294.3 4790.0 4816.5 4817.6 4849.0 4857.5 4722.4 4733.3 4793.2 4801.4 4815.5 3528.6 3621.9 3623.6 3645.2 3711.2 3615.6 3708.1 3717.8 3751.6 3769.6 3670.2 3704.6 3709.8 3716.0 3731.1 3634.9 3704.5 3736.5 3744.2 3746.6 3290.7 3291.8 3293.4 3293.6 3304.3 4524.2 4529.0 4533.8 4563.6 4586.6 4222.4 4238.2 4238.3 4245.9 4259.5 4692.0 4950.8 4957.8 4959.0 5025.8 3537.4 3547.7 3557.2 3561.0 3570.0 5208.5 5213.6 5223.4 5240.2 5243.4 3314.8 3505.6 3650.6 3653.8 3658.1 3576.9 3578.4 3583.6 3592.6 3605.7 4146.4 4156.8 4160.1 4162.4 4165.6 4937.9 4961.7 4972.5 5015.6 5026.9 1211.9 1248.1 1254.2 1258.9 1260.8 773.9 785.6 790.8 795.3 800.2 4197.5 4323.8 4389.8 4402.3 4409.3 5127.1 5136.9 5145.2 5145.5 5161.6 4382.6 4385.3 4413.7 4414.4 4442.4 2641.4 2705.6 2729.7 2745.6 2754.5 4820.6 4854.5 4857.3 4903.2 4908.7 5126.7 5248.7 5255.9 5255.9 5313.2 4849.2 4876.3 4884.5 4896.4 4947.9 5102.9 5118.2 5121.2 5133.8 5163.2 4800.7 5003.7 5032.2 5054.7 5066.4 4857.3 4884.8 4887.0 4887.1 4913.4 3514.4 3555.6 3565.6 3567.3 3568.4 5150.3 5184.7 5194.7 5224.2 5232.2 4792.0 4907.0 4944.2 4991.2 5006.6 4936.4 4939.7 4973.5 4977.2 5020.4 4930.0 4939.9 4943.4 4951.6 4969.5 4774.2 4835.2 4932.0 5015.2 5096.0 4898.2 4922.4 4923.6 4932.3 4937.6 13:09:23 INFO - PROCESS | 31398 | 13:09:23 INFO - PROCESS | 31398 | [#5] yui.html Cycles:180 Average:13108.86 Median:23533.49 stddev:15520.31 (65.9%) stddev-sans-first:15536.03 13:09:23 INFO - PROCESS | 31398 | Values: 732.5 747.7 752.4 770.2 771.6 11526.6 11917.1 12135.5 12147.8 12151.1 11412.3 11423.4 11483.3 11489.4 11536.4 619.3 758.5 779.2 788.7 791.4 784.0 785.4 787.0 787.3 787.7 840.0 840.8 841.3 843.5 850.5 649.4 790.5 816.6 816.9 844.0 601.2 601.2 601.6 602.0 602.9 11135.6 11282.3 11311.5 11324.7 11350.4 11846.0 12103.7 12213.8 12367.2 12630.1 10846.6 10942.3 10982.8 11024.4 11309.7 3999.8 4063.0 4097.9 4108.2 4172.1 44142.3 45019.8 45098.3 45246.5 45382.8 9668.3 9900.8 9933.6 10008.3 10045.7 16314.1 17674.6 17777.1 17853.8 17867.6 6149.3 6455.6 6466.6 6650.4 6951.0 3584.1 3601.5 3608.8 3677.9 3826.0 2747.3 2835.7 2848.8 2856.5 2858.8 521.7 527.9 538.6 539.2 541.1 529.2 551.1 558.9 560.3 575.2 6993.5 7011.6 7091.9 7221.9 7287.5 455.2 480.2 509.5 543.3 567.2 3272.0 3310.1 3312.2 3413.1 3436.3 54884.1 54929.5 56745.4 57486.0 57753.4 49907.5 50254.7 50283.2 51753.5 51846.4 46611.8 46766.8 47166.0 47471.0 47670.3 6735.8 6852.6 6907.8 6945.0 6983.5 30729.8 31078.8 31997.5 32259.5 32435.7 41075.8 41991.6 42071.0 42097.6 42348.2 8884.5 8972.2 10331.3 10377.7 10406.8 11364.2 11859.0 12290.3 12382.3 12555.2 10645.6 10742.4 11066.1 11147.6 11226.8 10637.6 10744.4 10934.9 10978.7 10983.7 10335.4 10422.9 10586.1 10589.9 10952.8 9237.3 9244.1 9481.7 9723.0 9888.3 9002.8 9218.3 9332.0 9342.7 9344.2 13:09:23 INFO - PROCESS | 31398 | -------- Summary: end -------- 13:09:23 INFO - PROCESS | 31398 | 13:09:24 INFO - TEST-INFO | 31398: exit 0 13:09:24 INFO - TEST-OK | dromaeo_css | took 1118657ms 13:09:24 INFO - TEST-START | kraken 13:09:24 INFO - operating with platform_type : linux_ 13:09:24 INFO - Initialising browser for kraken test... 13:09:24 INFO - TEST-INFO | started process 31578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5c0FX0/profile http://localhost:50622/getInfo.html) 13:09:28 INFO - PROCESS | 31578 | __metrics Screen width/height:1600/1200 13:09:28 INFO - PROCESS | 31578 | colorDepth:24 13:09:28 INFO - PROCESS | 31578 | Browser inner width/height: 1024/697 13:09:28 INFO - PROCESS | 31578 | __metrics 13:09:29 ERROR - PROCESS | 31578 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:09:30 INFO - TEST-INFO | 31578: exit 0 13:09:30 INFO - Browser initialized. 13:09:30 INFO - Running cycle 1/1 for kraken test... 13:09:30 INFO - TEST-INFO | started process 31660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5c0FX0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:42 INFO - PROCESS | 31660 | RSS: Main: 156430336 13:09:42 INFO - PROCESS | 31660 | 13:09:45 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50622/tests/kraken/driver.html?testName=audio-beat-detection) 13:09:46 INFO - PROCESS | 31660 | RSS: Main: 213893120 13:09:46 INFO - PROCESS | 31660 | 13:09:49 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50622/tests/kraken/driver.html?testName=audio-dft) 13:09:49 INFO - PROCESS | 31660 | RSS: Main: 202252288 13:09:49 INFO - PROCESS | 31660 | 13:09:53 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50622/tests/kraken/driver.html?testName=audio-fft) 13:09:53 INFO - PROCESS | 31660 | RSS: Main: 270336000 13:09:53 INFO - PROCESS | 31660 | 13:09:55 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50622/tests/kraken/driver.html?testName=audio-oscillator) 13:09:56 INFO - PROCESS | 31660 | RSS: Main: 180215808 13:09:56 INFO - PROCESS | 31660 | 13:09:58 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50622/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:09:59 INFO - PROCESS | 31660 | RSS: Main: 184745984 13:09:59 INFO - PROCESS | 31660 | 13:10:02 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50622/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:03 INFO - PROCESS | 31660 | RSS: Main: 220241920 13:10:03 INFO - PROCESS | 31660 | 13:10:06 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50622/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:07 INFO - PROCESS | 31660 | RSS: Main: 216203264 13:10:07 INFO - PROCESS | 31660 | 13:10:10 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50622/tests/kraken/driver.html?testName=json-parse-financial) 13:10:10 INFO - PROCESS | 31660 | RSS: Main: 219250688 13:10:10 INFO - PROCESS | 31660 | 13:10:12 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50622/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:12 INFO - PROCESS | 31660 | RSS: Main: 209747968 13:10:12 INFO - PROCESS | 31660 | 13:10:14 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:15 INFO - PROCESS | 31660 | RSS: Main: 211759104 13:10:15 INFO - PROCESS | 31660 | 13:10:17 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:18 INFO - PROCESS | 31660 | RSS: Main: 216862720 13:10:18 INFO - PROCESS | 31660 | 13:10:21 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:21 INFO - PROCESS | 31660 | RSS: Main: 221122560 13:10:21 INFO - PROCESS | 31660 | 13:10:24 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:10:25 INFO - PROCESS | 31660 | RSS: Main: 219889664 13:10:25 INFO - PROCESS | 31660 | 13:10:26 INFO - PROCESS | 31660 | Cycle 1(1): loaded http://localhost:50622/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50622/tests/kraken/driver.html?testName=ai-astar) 13:10:27 INFO - PROCESS | 31660 | RSS: Main: 262311936 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | __start_tp_report 13:10:27 INFO - PROCESS | 31660 | _x_x_mozilla_page_load 13:10:27 INFO - PROCESS | 31660 | _x_x_mozilla_page_load_details 13:10:27 INFO - PROCESS | 31660 | |i|pagename|runs| 13:10:27 INFO - PROCESS | 31660 | |0;ai-astar;112;109;113;113;113;112;114;113;113;112 13:10:27 INFO - PROCESS | 31660 | |1;audio-beat-detection;163;133;132;186;130;134;153;131;186;130 13:10:27 INFO - PROCESS | 31660 | |2;audio-dft;163;161;160;162;161;160;161;161;161;161 13:10:27 INFO - PROCESS | 31660 | |3;audio-fft;76;75;77;107;76;77;74;76;96;74 13:10:27 INFO - PROCESS | 31660 | |4;audio-oscillator;87;84;109;84;84;84;115;84;85;124 13:10:27 INFO - PROCESS | 31660 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;116;117 13:10:27 INFO - PROCESS | 31660 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 13:10:27 INFO - PROCESS | 31660 | |7;imaging-desaturate;94;95;95;95;94;94;94;96;95;95 13:10:27 INFO - PROCESS | 31660 | |8;json-parse-financial;61;61;60;62;61;62;62;62;62;62 13:10:27 INFO - PROCESS | 31660 | |9;json-stringify-tinderbox;65;66;65;65;65;66;65;66;65;66 13:10:27 INFO - PROCESS | 31660 | |10;stanford-crypto-aes;82;83;82;81;84;85;83;84;120;86 13:10:27 INFO - PROCESS | 31660 | |11;stanford-crypto-ccm;140;130;146;128;128;127;130;137;132;131 13:10:27 INFO - PROCESS | 31660 | |12;stanford-crypto-pbkdf2;170;168;170;168;169;172;172;172;169;170 13:10:27 INFO - PROCESS | 31660 | |13;stanford-crypto-sha256-iterative;67;68;66;67;65;66;65;65;68;65 13:10:27 INFO - PROCESS | 31660 | __end_tp_report 13:10:27 INFO - PROCESS | 31660 | __start_cc_report 13:10:27 INFO - PROCESS | 31660 | _x_x_mozilla_cycle_collect,1837 13:10:27 INFO - PROCESS | 31660 | __end_cc_report 13:10:27 INFO - PROCESS | 31660 | __startTimestamp1464639027209__endTimestamp 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | ------- Summary: start ------- 13:10:27 INFO - PROCESS | 31660 | Number of tests: 14 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 13:10:27 INFO - PROCESS | 31660 | Values: 112.0 109.0 113.0 113.0 113.0 112.0 114.0 113.0 113.0 112.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:143.50 stddev:22.98 (16.0%) stddev-sans-first:23.70 13:10:27 INFO - PROCESS | 31660 | Values: 163.0 133.0 132.0 186.0 130.0 134.0 153.0 131.0 186.0 130.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.60 13:10:27 INFO - PROCESS | 31660 | Values: 163.0 161.0 160.0 162.0 161.0 160.0 161.0 161.0 161.0 161.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.26 (14.8%) stddev-sans-first:11.81 13:10:27 INFO - PROCESS | 31660 | Values: 76.0 75.0 77.0 107.0 76.0 77.0 74.0 76.0 96.0 74.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:15.62 (18.6%) stddev-sans-first:16.36 13:10:27 INFO - PROCESS | 31660 | Values: 87.0 84.0 109.0 84.0 84.0 84.0 115.0 84.0 85.0 124.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:10:27 INFO - PROCESS | 31660 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 13:10:27 INFO - PROCESS | 31660 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 13:10:27 INFO - PROCESS | 31660 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 94.0 96.0 95.0 95.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 13:10:27 INFO - PROCESS | 31660 | Values: 61.0 61.0 60.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:10:27 INFO - PROCESS | 31660 | Values: 65.0 66.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:83.50 stddev:11.69 (14.0%) stddev-sans-first:12.26 13:10:27 INFO - PROCESS | 31660 | Values: 82.0 83.0 82.0 81.0 84.0 85.0 83.0 84.0 120.0 86.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:131.50 stddev:6.17 (4.7%) stddev-sans-first:5.99 13:10:27 INFO - PROCESS | 31660 | Values: 140.0 130.0 146.0 128.0 128.0 127.0 130.0 137.0 132.0 131.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.00 stddev:1.56 (0.9%) stddev-sans-first:1.66 13:10:27 INFO - PROCESS | 31660 | Values: 170.0 168.0 170.0 168.0 169.0 172.0 172.0 172.0 169.0 170.0 13:10:27 INFO - PROCESS | 31660 | 13:10:27 INFO - PROCESS | 31660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 13:10:27 INFO - PROCESS | 31660 | Values: 67.0 68.0 66.0 67.0 65.0 66.0 65.0 65.0 68.0 65.0 13:10:27 INFO - PROCESS | 31660 | -------- Summary: end -------- 13:10:27 INFO - PROCESS | 31660 | 13:10:28 INFO - TEST-INFO | 31660: exit 0 13:10:28 INFO - TEST-OK | kraken | took 63800ms 13:10:28 INFO - SUITE-END | took 1182s 13:10:28 INFO - Completed test suite (00:19:42) 13:10:28 INFO - javascript benchmark 13:10:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.574468085106, 2679.772219361354, 2700.2709268497506, 2714.8099633025695, 2727.1682136948225, 4668.346431499588, 4675.4856965733825, 4730.337752714623, 4746.382970213867, 4756.048790241953, 4751.548602882729, 4765.952340476594, 4790.808367665298, 4824.7587620618915, 4825.78283977221, 4289.571042895709, 4324.286492728696, 4328.935065974013, 4386.846460373888, 4425.867223983286, 4447.288433850585, 4475.619572336355, 4483.820647174109, 4522.954770452303, 4531.569500897426, 4308.74147551148, 4384.758838263894, 4419.867403977886, 4437.578430049172, 4445.377647129389, 4330.610245077958, 4334.1981733379425, 4358.760268185249, 4389.956100438987, 4390.385346051556, 4381.38660587518, 4423.977880110611, 4448.310511870633, 4457.130859482402, 4490.304002879526, 4485.573870482299, 4769.046190761862, 4799.2801079837955, 4802.471728109905, 4811.061842940628, 4992.201247800334, 5045.823396181153, 5050.772715227824, 5110.565601923841, 5129.743512824344, 5109.974450127763, 5136.357955255593, 5150.459201783834, 5157.974210128963, 5172.456892026321, 4641.605463535638, 4708.976455117702, 4722.433308003062, 4756.595689366408, 4772.427308722906, 5233.215017747369, 5276.445973172838, 5279.313689220377, 5308.761105750251, 5329.147336426153, 5023.623228257895, 5076.162433198481, 5079.31429257053, 5079.923801142986, 5081.8729531762, 4980.228064649985, 5054.721990290495, 5106.055379754757, 5186.429492755794, 5203.947960520422, 5075.56857667095, 5079.644424890296, 5094.414142373675, 5105.0810854045885, 5110.718910459886, 5011.223260394645, 5015.874603134951, 5056.418511871182, 5066.923996140061, 5120.61595380348, 4217.915641687149, 4258.893527661771, 4260.062786187033, 4287.592678695519, 4332.393464914914, 3722.7952462614817, 3753.756005859665, 3755.9436608450897, 3775.188334508039, 3808.257389808961, 4398.75806830621, 4401.6698747594055, 4412.0734645724115, 4412.426384569985, 4458.331250312414, 5000.199968005102, 5053.36832895888, 5142.665726727825, 5148.279240906276, 5196.246544251138, 4328.329108988112, 4377.562243775597, 4379.540148284448, 4390.407295015196, 4392.978035109868, 4580.725156490621, 4581.931271030937, 4582.977085114553, 4601.976990115028, 4643.976780116145, 4773.785179666854, 4781.880452988703, 4824.879378015507, 4833.105875412919, 4833.830815921426, 5153.149730294459, 5177.326947496801, 5198.038362902875, 5201.115810312181, 5246.658967167122, 4873.4639189689815, 4886.755662216804, 4903.60771138301, 4904.4605093440405, 4949.257611358325, 4884.511548845087, 5038.319826823332, 5084.1102807009365, 5112.74436278192, 5114.156164233009, 5166.225066240094, 5180.378354597472, 5185.9222111669105, 5188.0, 5219.2953951216095, 5033.6476446648385, 5035.899282014412, 5047.192449208256, 5047.2429135629945, 5101.668391554537, 4888.828890988798, 4962.156433406258, 4984.825531106394, 5018.84566549703, 5032.6980381177245, 4943.110240156806, 4952.158133117451, 4965.925511117408, 5004.84985450437, 5014.52362025607, 5059.848204553869, 5060.063888180698, 5065.898682026413, 5095.592352611856, 5106.540411362995, 4776.880577985439, 4810.783514741775, 4825.155597770306, 4837.395325584302, 4866.1727506323305], "value": 4698.198525786654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3967947356202, 584.1121495327101, 588.9911651325231, 604.0154548086618, 610.4048552661156, 27307.180784576445, 40391.59608403915, 40641.187176256455, 40648.79675601625, 40734.79632601833, 41704.58295417045, 42384.78807605965, 42385.78807105968, 42434.36348454776, 42499.0, 7634.923650763477, 7836.451448398614, 7839.686412543491, 7842.137364889858, 7846.176151504067, 7626.08486981563, 7781.688732450695, 7804.960975195116, 7805.102413222467, 7811.843763124734, 7804.063512378522, 7854.332381747558, 7858.0, 7860.606969651494, 7866.6460009299435, 7758.340541054017, 7793.2596403341595, 7806.1413244543055, 7817.882731758971, 7819.022622172229, 7651.081870175614, 7751.379889608817, 7751.496152750054, 7754.457187996843, 7763.0, 38591.22817543661, 38647.0, 39005.41491877624, 39035.0, 39116.0, 2900.7099290071037, 2995.775316851223, 3264.8041117533025, 3613.837377318027, 3733.5893051764283, 29289.56065659017, 29523.704762952526, 29605.555916661266, 29952.25119372033, 30647.620857061487, 3251.581180482589, 3308.553345298402, 3320.96679033209, 3332.9333413331597, 3413.607435144965, 251613.99999999817, 252670.0, 253398.73300633562, 254299.0, 255621.0, 31809.363812723615, 32462.67537324644, 51533.0, 51914.0, 51935.74032129815, 34338.48492272618, 34450.82774586111, 34461.31077378438, 34559.30881382358, 34564.48153277703, 12588.685282868002, 12709.93645031769, 12711.427985740664, 12713.872861271453, 12727.109102362745, 10153.441560714084, 10198.133158681447, 10199.9490002551, 10201.74495637615, 10202.234832387601, 7905.644246008828, 7963.761087167279, 7969.960150199212, 8012.839743205103, 8033.1163572007035, 3078.7998780079224, 3088.0, 3115.1589070950718, 3140.4347217501067, 3181.5545823584716, 824.9257566819015, 853.2619284319144, 916.1434059154711, 948.137195152408, 1018.2464975917916, 27852.303692407448, 28131.156065318075, 28252.15243542697, 28666.42667146687, 28836.279093022422, 723.565860483716, 885.2386947225381, 921.4931787516973, 950.4487397309543, 962.5379817687549, 14267.143971361751, 14410.42358305656, 14713.0, 14818.0, 15260.0, 400184.0, 401721.0, 404218.0, 404865.0, 405919.0, 51475.0, 51506.48493515092, 51976.740116299174, 52075.0, 52108.0, 1016.5120742043861, 1133.2690414682484, 1144.9427528623535, 1149.1955631058293, 1166.854143232096, 26811.463770724087, 28207.153785386472, 28528.714712852605, 28666.42667146687, 28842.711572884004, 41206.793966029974, 41902.37146442867, 41925.58074419339, 41970.160596788504, 42175.57824421716, 321629.0, 323724.0, 324374.0, 325266.0, 393494.0, 23949.28152155438, 24211.031558737453, 24380.0, 25502.362440939123, 25512.0, 40312.1937561253, 40504.59495405126, 40750.59249407468, 41405.79297103495, 41438.0, 34933.0, 35093.82453087718, 35143.0, 35157.12107197341, 35918.8204058978, 34057.829710852275, 34670.0, 35350.0, 35449.82275088711, 35508.112297192776, 34415.31169376648, 34845.0, 35253.64746352606, 35487.467687984186, 36092.0, 29493.705062949954, 33988.83005584956, 34051.489227661106, 34115.82942085274, 34365.48451773275, 25129.623055654545, 25755.742442576084, 25878.66243777068, 25925.481490370465, 26103.738962610132], "value": 16368.241116567346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9612842587313, 357.47629722456594, 357.6441440766438, 362.48708078069535, 372.37255224945966, 15676.372945082197, 16692.165391730425, 16754.83245167548, 17121.486355409357, 17329.56676083097, 15936.681266374666, 16901.239444225008, 16965.745513817303, 16975.745363819522, 17051.57371065721, 4822.300766388871, 4994.0, 5027.271045698371, 5038.269450929613, 5039.017391608638, 3738.214974855284, 3911.9608803912024, 4940.5306495883015, 5649.322081350244, 5929.051351783715, 5971.044632858743, 5987.22166118404, 6011.489023433013, 6013.849653758669, 6014.4286292802335, 5810.070388737781, 5886.293644762634, 5936.7328470218945, 5941.079132734433, 5963.373845746221, 3373.983130084334, 4766.404199475066, 4996.400431948153, 5008.0, 5156.0, 19384.224631014742, 20029.0, 20073.297434589866, 20271.189152433886, 20291.89854050735, 1786.1605045628535, 1839.4389711138097, 1852.19429548147, 1862.9906850465798, 1896.1656870976865, 12557.309347985856, 12850.485980560767, 12882.420291086924, 13206.735865282737, 13357.666058348523, 1736.4530172995592, 1771.5925337172523, 1779.8487128593956, 1780.4836597386743, 1786.767720196379, 66563.3343666562, 68259.3174068258, 68417.65791171062, 69183.0, 69228.3077169232, 8438.45150065256, 8909.73270801877, 9260.39807412516, 9640.228781697448, 9729.854052189223, 11874.34691091981, 11885.108616853771, 11919.344436055926, 11941.462634181482, 11958.40207989597, 6824.931750682529, 6976.441884649216, 7005.474589405815, 7127.82180445493, 7129.500934934505, 6803.2856550062525, 6850.4862135340045, 6921.0, 6943.340382663639, 6944.51388402807, 5849.941500585025, 5861.912071318934, 5864.354920958691, 6010.729517171738, 6020.969895150496, 1515.8181018277878, 1581.7706432567443, 1611.379618846729, 1628.9837101629068, 1633.150761603983, 707.2255879811598, 711.6655172069119, 815.7511958852489, 819.7417813388763, 829.875518672204, 16057.518274451784, 16192.352305907632, 17219.913900430416, 17240.568985775204, 17522.737158942626, 767.4359345880773, 812.1472453923357, 821.6179476543437, 846.2510678049847, 863.8056437301557, 9729.4648794317, 9755.609775609038, 9970.601175953027, 10004.299699021, 10146.239032072624, 373717.0, 373721.0, 380518.0, 382026.0, 383814.0, 67370.66314668395, 69389.65305173442, 69489.0, 69613.3038669617, 71069.64465177641, 913.2602591900582, 921.7741653294852, 923.1507013547553, 927.1007123090591, 929.8512238042016, 14960.625984350043, 15036.548903532912, 15135.243237837843, 15354.616134596725, 15507.379704811681, 30043.699563004964, 31236.28200448997, 31771.0, 33068.0, 33881.83059084689, 41654.45937095381, 43604.56395436005, 43615.56384436242, 43742.343864841416, 44077.016534256676, 6531.0, 6558.967205163944, 6625.403713665601, 6717.16035495563, 6751.831204219934, 9555.474448905377, 10078.79842403133, 10202.489875506344, 10317.432541210306, 10400.0, 8601.483910965362, 8896.243819275176, 8928.330375221754, 8953.104689530996, 9130.223930965942, 8822.779430514032, 8909.109089091038, 8985.730428087169, 9009.504477253813, 9017.864732029157, 8859.44959632049, 8932.910670893209, 9096.545172741204, 9260.907390926273, 9335.299852510952, 6665.866682666417, 6694.397504224643, 6733.764318248838, 6862.862742745217, 6903.585784852925, 8744.169303916118, 8745.650173992968, 8804.207621314112, 8931.955340223258, 8965.551722413984], "value": 7877.834736425917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.338847105269, 1377.7037936843576, 1435.9856401435984, 1477.7487827069397, 1726.5856194513312, 6591.143151390319, 7479.700811967522, 7709.498882572643, 7773.2615401536905, 7871.409644276673, 7604.277593628596, 7727.768166955, 7729.806754831118, 7734.961325193366, 7739.342155916754, 1862.0131330394845, 1914.5309399197217, 1916.3867562380044, 2172.7935846094597, 2203.724534433196, 1943.815337542931, 2089.059923034633, 2169.837262205333, 2170.6309927312395, 2171.3703026122407, 2106.610277098742, 2124.681297805334, 2129.808317251447, 2129.882856442895, 2131.041031535807, 1827.9817201827946, 2168.447046003259, 2169.5986242545177, 2175.195177784214, 2179.1283486605325, 2092.058573641852, 2152.4726442021806, 2153.633882240023, 2158.0612433591436, 2158.136745301876, 7791.805204869867, 7815.140334563193, 7817.0, 7817.0, 7827.060752709711, 4503.076869241798, 4620.19146649335, 4624.838130665411, 4626.745528995903, 4635.0729854029, 2734.5214587447317, 2811.4517669054544, 2857.985710071436, 2894.276430892277, 2898.7101289871057, 821.6795449774593, 831.6631764135474, 847.6736456464243, 847.7414388611471, 853.1553761775859, 10305.484725763681, 10382.169426445866, 10388.428636424993, 10389.0, 10408.219383546264, 4179.080602267496, 4184.225918205142, 4255.659547236213, 4256.872293831128, 4298.441202643637, 8992.730218093468, 9026.0, 9032.8645070324, 9047.502387368626, 9048.457092574467, 4729.290606409066, 4732.763361831963, 4745.217039188496, 4747.620190384761, 4749.881252968635, 3576.2668652926086, 3608.1520842601967, 4235.97882010588, 4292.5063617683745, 4297.376880352332, 3579.8926032219074, 3651.8904432867057, 3732.5147730794824, 3749.812509374575, 3751.437284407306, 1162.5640384855678, 1180.4805885410392, 1190.1014733875868, 1205.427421974555, 1205.6081773423673, 697.6476879175983, 819.5001049359886, 830.5141492226994, 843.6498852976069, 849.2144766091341, 4995.275685025651, 5093.261477085802, 5237.764300606405, 5245.737713114329, 5282.4717528246865, 372.9627037296249, 373.8355123745543, 379.247194319276, 885.3359980014989, 923.9953800230955, 3429.9485507717404, 3437.8968630941113, 3438.381091403571, 3491.458823882302, 3499.5975462822103, 9295.256379489625, 9514.19129374011, 9527.571259293349, 9528.428294302365, 9569.234461243084, 9305.441673499612, 9423.151916327564, 9434.292428067785, 9439.811203775886, 9470.384425012353, 6969.825754356181, 7221.8555628887125, 7241.167265764505, 7425.368843648243, 7426.5915374654915, 5130.230465430066, 5368.651037682538, 5383.650062745909, 5396.433374495621, 5440.075187218262, 8733.781655458664, 8892.0, 8900.688475903313, 8935.642574296955, 8993.14565116313, 8707.390482666153, 8732.257758090633, 8736.388452808496, 8880.378373513791, 8977.0, 5818.534517238526, 6464.967675161594, 6606.141201643755, 6757.93242067573, 6898.551594146365, 7520.8495830082, 7571.621418929141, 7590.0891892973195, 7597.810054748676, 7600.695972161052, 6541.771038013647, 6752.324767523209, 6768.661566921536, 6814.386705196556, 6886.896696549456, 6671.733130674913, 6680.265170831108, 6720.361565651256, 6785.89821152693, 6787.457003439614, 6037.486813620892, 6093.086037094471, 6122.816315510542, 6146.78486252979, 6165.876682466236, 4378.233809083461, 4389.868303950887, 4414.337849322627, 4425.114977004676, 4457.643388528974, 4547.590716835501, 4570.611498022706, 4638.420197475316, 4647.047355292225, 4676.251799712029], "value": 4031.1538708518456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.88524590163934, 288.5743528295764, 291.2195316551642, 291.7257777688971, 294.3010350417758, 4790.0, 4816.494268101847, 4817.590504807091, 4848.951510484894, 4857.51424857514, 4722.362481065055, 4733.266343716729, 4793.233082706767, 4801.399825021872, 4815.542523460274, 3528.558930133733, 3621.8551257949653, 3623.6376362363685, 3645.216278500122, 3711.2206436648335, 3615.566132064156, 3708.128589781399, 3717.8141092945243, 3751.5685696144883, 3769.6418840210135, 3670.247599242149, 3704.6105262105925, 3709.8330575124182, 3715.9628403715888, 3731.141837377405, 3634.8731893112954, 3704.518412606371, 3736.4955730976244, 3744.1762812181278, 3746.550413950343, 3290.654481279479, 3291.782040644977, 3293.4236508610898, 3293.604767427924, 3304.339132173575, 4524.185646583614, 4528.977355113237, 4533.773311334453, 4563.612092972101, 4586.587207151339, 4222.408862759216, 4238.173556156551, 4238.321868501056, 4245.87262382129, 4259.488861336628, 4691.991221887277, 4950.801967921278, 4957.82647607332, 4958.975205123951, 5025.793809485697, 3537.398642230827, 3547.651892280917, 3557.2174121693447, 3560.964390356089, 3570.0, 5208.479152084799, 5213.556847667953, 5223.425423203483, 5240.240165176028, 5243.426971908412, 3314.751393645486, 3505.631908649606, 3650.580183278904, 3653.780773153619, 3658.0671928658553, 3576.8926932192076, 3578.4453409721013, 3583.605803361628, 3592.6407359263862, 3605.747597668138, 4146.37804329347, 4156.771377574202, 4160.1471698301775, 4162.438070860456, 4165.604267594574, 4937.925931111036, 4961.70229786214, 4972.502749725071, 5015.598752099823, 5026.899462010812, 1211.9456073216359, 1248.1263115818963, 1254.1534464236604, 1258.8867001969866, 1260.8297879786294, 773.89552410425, 785.642532647644, 790.8457850719054, 795.2643804480832, 800.1838125112353, 4197.538270790211, 4323.762193079411, 4389.814750017477, 4402.273624851928, 4409.294512877924, 5127.102757017507, 5136.948630513722, 5145.202493613496, 5145.4854514549, 5161.638685291993, 4382.649388048949, 4385.342198670161, 4413.7351758894565, 4414.359917811899, 4442.378067070613, 2641.379275870169, 2705.5535836587137, 2729.703390889312, 2745.5607102863446, 2754.5454999924787, 4820.6143508519235, 4854.543636908984, 4857.344258525054, 4903.166461701519, 4908.680935739166, 5126.743662816844, 5248.711320877312, 5255.868603284948, 5255.948810237967, 5313.203019547099, 4849.224124140192, 4876.268559716071, 4884.4871288514905, 4896.4124305083615, 4947.925781113287, 5102.923456148086, 5118.206677964921, 5121.231815227746, 5133.845984620468, 5163.225516172604, 4800.66395352336, 5003.724795136302, 5032.220005899091, 5054.74726263678, 5066.417362003417, 4857.271409288635, 4884.804607815648, 4886.975565122151, 4887.144749668722, 4913.43495498008, 3514.3674138655288, 3555.5733312002726, 3565.554305711786, 3567.304375646724, 3568.4120566347724, 5150.304708864255, 5184.714840683799, 5194.714290714047, 5224.216367544898, 5232.215167724872, 4791.952080479151, 4906.95093049065, 4944.15949288629, 4991.226359914219, 5006.6495345325475, 4936.3829521309835, 4939.740366206738, 4973.502649734997, 4977.178765503651, 5020.42265139499, 4929.950700493093, 4939.851804445872, 4943.3573635427165, 4951.554360107463, 4969.503049695146, 4774.21225497789, 4835.20219163834, 4931.950680493149, 5015.1975683890405, 5095.974520127524, 4898.24077268024, 4922.384701912261, 4923.606111511142, 4932.30947667334, 4937.5556199942175], "value": 3741.4130785507114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.534840376361, 747.7382915979408, 752.3905636434492, 770.183605378299, 771.6450432800912, 11526.596569120082, 11917.106217033725, 12135.514579416813, 12147.817782733255, 12151.088668349865, 11412.31526108434, 11423.428828558559, 11483.25358851674, 11489.425528723572, 11536.365499897502, 619.2599843187393, 758.525921299188, 779.2129948751744, 788.7002938883245, 791.3708601661692, 784.0, 785.446260386429, 787.0, 787.2953706432739, 787.7321710618388, 840.0255703384075, 840.844443777903, 841.3353450773911, 843.5065486690294, 850.5492089192707, 649.3960616626536, 790.474334567512, 816.6406781016334, 816.873384625384, 843.9915600844005, 601.173386593434, 601.2064075420446, 601.6239850093691, 601.9578629495937, 602.9065494848305, 11135.610253641084, 11282.323060616389, 11311.547538098466, 11324.660260192126, 11350.432478376131, 11846.0, 12103.697407564794, 12213.755724885452, 12367.196132251374, 12630.052746043992, 10846.566137354497, 10942.288751231225, 10982.835257471144, 11024.44877756109, 11309.660710178709, 3999.8204121541135, 4063.0, 4097.927842123186, 4108.239975604522, 4172.144710334374, 44142.33786493205, 45019.77490112528, 45098.32352514715, 45246.54753452489, 45382.77308613436, 9668.323217374716, 9900.752481187883, 9933.552990115462, 10008.349457285252, 10045.69862904114, 16314.102724350038, 17674.646507069785, 17777.111144442726, 17853.821461785217, 17867.553311167325, 6149.292831324455, 6455.580387274812, 6466.64433456155, 6650.434713049445, 6951.0, 3584.1039740064984, 3601.513795637555, 3608.783472991629, 3677.8712745053795, 3826.0, 2747.32690490831, 2835.7306055924655, 2848.7720982321366, 2856.5429531274895, 2858.814177078483, 521.7339157029942, 527.862755683525, 538.5718353908652, 539.1939051118525, 541.1098742568453, 529.1692043491757, 551.1292158389734, 558.9133684278943, 560.3192121572309, 575.2148317546519, 6993.510454268152, 7011.649417529103, 7091.9290807091265, 7221.8555628887125, 7287.453440991947, 455.2056661126356, 480.15732389656625, 509.5134146889711, 543.2882923370397, 567.2087438024016, 3272.036648405611, 3310.1228174533767, 3312.2381852173653, 3413.095529684586, 3436.329915666421, 54884.13948256468, 54929.45070549323, 56745.43254567401, 57486.0, 57753.42246577564, 49907.50092499029, 50254.74872625687, 50283.245751313756, 51753.48246517562, 51846.44460666186, 46611.76694116508, 46766.76616616963, 47166.0, 47471.0, 47670.28494572515, 6735.764248251287, 6852.554583952027, 6907.758228461979, 6945.0, 6983.546069505466, 30729.846350768104, 31078.844605776827, 31997.520037199927, 32259.516107258878, 32435.675643243267, 41075.794621026704, 41991.580084198766, 42071.0, 42097.579024209364, 42348.15303693971, 8884.466931984101, 8972.237359824489, 10331.32846364984, 10377.740556485845, 10406.843897341394, 11364.204505684524, 11859.0, 12290.262584244974, 12382.318972456602, 12555.246685198917, 10645.627403041166, 10742.409167495864, 11066.114710823276, 11147.609833655782, 11226.775464490827, 10637.574497020032, 10744.409057501913, 10934.945325273322, 10978.725531861768, 10983.725406864893, 10335.431551264752, 10422.895771042193, 10586.100181484351, 10589.894101058891, 10952.835707464235, 9237.307201960015, 9244.121808428188, 9481.66814161501, 9722.951385243028, 9888.31898577258, 9002.774930626787, 9218.26253899673, 9332.0, 9342.719718408458, 9344.205742511962], "value": 5870.378227334349, "unit": "score"}], "name": "dromaeo_css", "value": 6141.198785557005, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 132.0, 186.0, 130.0, 134.0, 153.0, 131.0, 186.0, 130.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 107.0, 76.0, 77.0, 74.0, 76.0, 96.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 109.0, 84.0, 84.0, 84.0, 115.0, 84.0, 85.0, 124.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 81.0, 84.0, 85.0, 83.0, 84.0, 120.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 146.0, 128.0, 128.0, 127.0, 130.0, 137.0, 132.0, 131.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 170.0, 168.0, 169.0, 172.0, 172.0, 172.0, 169.0, 170.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 68.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1536.5000000000005, "alertThreshold": 2.0}]} 13:10:28 INFO - Return code: 0 13:10:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:10:28 ERROR - # TBPL SUCCESS # 13:10:28 INFO - Running post-action listener: _resource_record_post_action 13:10:28 INFO - ##### 13:10:28 INFO - ##### Finished run-tests step (success) 13:10:28 INFO - ##### 13:10:28 INFO - Running post-run listener: _resource_record_post_run 13:10:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 530935808; Read time: 0; Write time: 432580 13:10:28 INFO - TinderboxPrint: CPU usage
13.1% 13:10:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:10:28 INFO - TinderboxPrint: I/O write bytes / time
530,935,808 / 432,580 13:10:28 INFO - TinderboxPrint: CPU idle
8,315.9 (86.9%) 13:10:28 INFO - TinderboxPrint: CPU user
1,210.4 (12.6%) 13:10:28 INFO - TinderboxPrint: Swap in / out
0 / 0 13:10:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227446784; Read time: 0; Write time: 228040 13:10:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284540928; Read time: 0; Write time: 201488 13:10:29 INFO - Running post-run listener: _upload_blobber_files 13:10:29 INFO - Blob upload gear active. 13:10:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:10:29 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 13:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:10:29 INFO - (blobuploader) - INFO - Open directory for files ... 13:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:10:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:30 INFO - (blobuploader) - INFO - Done attempting. 13:10:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:10:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:10:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:35 INFO - (blobuploader) - INFO - Done attempting. 13:10:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:10:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:10:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:35 INFO - (blobuploader) - INFO - Done attempting. 13:10:35 INFO - (blobuploader) - INFO - Iteration through files over. 13:10:35 INFO - Return code: 0 13:10:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:10:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:10:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d944de6409ab6a859115f5b39e5796a6d5cfd7231e9de52ad363c8a5d03a017a28f252c3468903cb0ff3791f91c9684da2222836ad997fa8e3e902a157e2db70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84445df093074a2512d86538bfc86c599eb0f86ec43574802b0afbbaab6b82f635a2443e7b25e02216cd728da4ef830401fd29b07f7da122bb7d2c07910195ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed78b2bd3beb9acea8fdad258cfe9e72d7485cdd164f7f583e56d316187d659547346538a51cc7601a8b967d5c112bf753bfcbbb273c6f06a8835977b5557dd8"} 13:10:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:10:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:10:35 INFO - Contents: 13:10:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d944de6409ab6a859115f5b39e5796a6d5cfd7231e9de52ad363c8a5d03a017a28f252c3468903cb0ff3791f91c9684da2222836ad997fa8e3e902a157e2db70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84445df093074a2512d86538bfc86c599eb0f86ec43574802b0afbbaab6b82f635a2443e7b25e02216cd728da4ef830401fd29b07f7da122bb7d2c07910195ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed78b2bd3beb9acea8fdad258cfe9e72d7485cdd164f7f583e56d316187d659547346538a51cc7601a8b967d5c112bf753bfcbbb273c6f06a8835977b5557dd8"} 13:10:35 INFO - Running post-run listener: copy_logs_to_upload_dir 13:10:35 INFO - Copying logs to upload dir... 13:10:35 INFO - mkdir: /builds/slave/test/build/upload/logs 13:10:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.144794 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-30 13:10:35.617476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 13:10:35.622082) ========= 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=4300f881736b422476174874000001bc-1464630508.36670-87350152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d944de6409ab6a859115f5b39e5796a6d5cfd7231e9de52ad363c8a5d03a017a28f252c3468903cb0ff3791f91c9684da2222836ad997fa8e3e902a157e2db70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84445df093074a2512d86538bfc86c599eb0f86ec43574802b0afbbaab6b82f635a2443e7b25e02216cd728da4ef830401fd29b07f7da122bb7d2c07910195ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed78b2bd3beb9acea8fdad258cfe9e72d7485cdd164f7f583e56d316187d659547346538a51cc7601a8b967d5c112bf753bfcbbb273c6f06a8835977b5557dd8"} build_url:https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/L95xscyyT-KYFFiUJNLHRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d944de6409ab6a859115f5b39e5796a6d5cfd7231e9de52ad363c8a5d03a017a28f252c3468903cb0ff3791f91c9684da2222836ad997fa8e3e902a157e2db70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84445df093074a2512d86538bfc86c599eb0f86ec43574802b0afbbaab6b82f635a2443e7b25e02216cd728da4ef830401fd29b07f7da122bb7d2c07910195ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed78b2bd3beb9acea8fdad258cfe9e72d7485cdd164f7f583e56d316187d659547346538a51cc7601a8b967d5c112bf753bfcbbb273c6f06a8835977b5557dd8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 13:10:35.650080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 13:10:35.650404) ========= 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=4300f881736b422476174874000001bc-1464630508.36670-87350152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 13:10:35.969649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 13:10:35.969978) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 13:10:35.970266) ========= ========= Total master_lag: 0.42 =========