builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1463659592.82 results: success (0) buildid: 20160519023015 builduid: 4fc76e07790b44b195bc5181182268a4 revision: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.825316) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.825892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.826181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.843627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.844186) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 05:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.7M=0.001s 2016-05-19 05:06:33 (12.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.953968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:32.954480) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015719 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:33.008410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 05:06:33.008838) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 --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 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 05:06:33,681 truncating revision to first 12 chars 2016-05-19 05:06:33,681 Setting DEBUG logging. 2016-05-19 05:06:33,681 attempt 1/10 2016-05-19 05:06:33,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a4cdb6dfb19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 05:06:34,739 unpacking tar archive at: fx-team-5a4cdb6dfb19/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346508 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 05:06:34.370725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:34.371377) ========= script_repo_revision: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:34.372127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:34.372622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 05:06:34.385606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-19 05:06:34.386227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:35 INFO - MultiFileLogger online at 20160519 05:06:35 in /builds/slave/test 05:06:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:35 INFO - {'append_to_log': False, 05:06:35 INFO - 'base_work_dir': '/builds/slave/test', 05:06:35 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:35 INFO - 'branch': 'Fx-Team', 05:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:35 INFO - 'config_files': ('talos/linux_config.py',), 05:06:35 INFO - 'default_actions': ('clobber', 05:06:35 INFO - 'read-buildbot-config', 05:06:35 INFO - 'download-and-extract', 05:06:35 INFO - 'populate-webroot', 05:06:35 INFO - 'create-virtualenv', 05:06:35 INFO - 'install', 05:06:35 INFO - 'run-tests'), 05:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:35 INFO - 'download_minidump_stackwalk': True, 05:06:35 INFO - 'download_symbols': 'ondemand', 05:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:35 INFO - 'installer_path': 'installer.exe', 05:06:35 INFO - 'log_level': 'info', 05:06:35 INFO - 'log_name': 'talos', 05:06:35 INFO - 'log_to_console': True, 05:06:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:35 INFO - 'opt_config_files': (), 05:06:35 INFO - 'pip_index': False, 05:06:35 INFO - 'sps_profile': False, 05:06:35 INFO - 'sps_profile_interval': 0, 05:06:35 INFO - 'suite': 'dromaeojs', 05:06:35 INFO - 'system_bits': '32', 05:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:35 INFO - 'title': 'talos-linux64-ix-034', 05:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:35 INFO - 'use_talos_json': True, 05:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:35 INFO - 'work_dir': 'build'} 05:06:35 INFO - ##### 05:06:35 INFO - ##### Running clobber step. 05:06:35 INFO - ##### 05:06:35 INFO - Running pre-action listener: _resource_record_pre_action 05:06:35 INFO - Running main action method: clobber 05:06:35 INFO - rmtree: /builds/slave/test/build 05:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:36 INFO - Running post-action listener: _resource_record_post_action 05:06:36 INFO - ##### 05:06:36 INFO - ##### Finished clobber step (success) 05:06:36 INFO - ##### 05:06:36 INFO - ##### 05:06:36 INFO - ##### Running read-buildbot-config step. 05:06:36 INFO - ##### 05:06:36 INFO - Running pre-action listener: _resource_record_pre_action 05:06:36 INFO - Running main action method: read_buildbot_config 05:06:36 INFO - Using buildbot properties: 05:06:36 INFO - { 05:06:36 INFO - "project": "", 05:06:36 INFO - "product": "firefox", 05:06:36 INFO - "script_repo_revision": "production", 05:06:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:06:36 INFO - "repository": "", 05:06:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:06:36 INFO - "buildid": "20160519023015", 05:06:36 INFO - "pgo_build": "True", 05:06:36 INFO - "basedir": "/builds/slave/test", 05:06:36 INFO - "buildnumber": 700, 05:06:36 INFO - "slavename": "talos-linux64-ix-034", 05:06:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:06:36 INFO - "platform": "ubuntu64_hw", 05:06:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:06:36 INFO - "branch": "fx-team", 05:06:36 INFO - "repo_path": "integration/fx-team", 05:06:36 INFO - "revision": "5a4cdb6dfb19b458229c60e0e19f083ba83d0f58", 05:06:36 INFO - "stage_platform": "linux64-pgo", 05:06:36 INFO - "builduid": "4fc76e07790b44b195bc5181182268a4", 05:06:36 INFO - "slavebuilddir": "test" 05:06:36 INFO - } 05:06:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:06:36 INFO - Running post-action listener: _resource_record_post_action 05:06:36 INFO - ##### 05:06:36 INFO - ##### Finished read-buildbot-config step (success) 05:06:36 INFO - ##### 05:06:36 INFO - ##### 05:06:36 INFO - ##### Running download-and-extract step. 05:06:36 INFO - ##### 05:06:36 INFO - Running pre-action listener: _resource_record_pre_action 05:06:36 INFO - Running main action method: download_and_extract 05:06:36 INFO - mkdir: /builds/slave/test/build/tests 05:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:36 INFO - https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:36 INFO - Downloaded 1361 bytes. 05:06:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:36 INFO - Using the following test package requirements: 05:06:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'jsshell-linux-x86_64.zip'], 05:06:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:36 INFO - https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:37 INFO - Downloaded 24385714 bytes. 05:06:37 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'] 05:06:37 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 05:06:39 INFO - Return code: 0 05:06:39 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 05:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:39 INFO - https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:40 INFO - Downloaded 24385714 bytes. 05:06:40 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'] 05:06:40 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 05:06:41 INFO - Return code: 0 05:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:41 INFO - https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:42 INFO - Downloaded 10840194 bytes. 05:06:42 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'] 05:06:42 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 05:06:43 INFO - Return code: 0 05:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:43 INFO - https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqvk_neNRgK9Xks37UdzWA/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 05:06:44 INFO - Downloaded 58443694 bytes. 05:06:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:44 INFO - mkdir: /builds/slave/test/properties 05:06:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:44 INFO - Contents: 05:06:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:45 INFO - Running post-action listener: _resource_record_post_action 05:06:45 INFO - Running post-action listener: set_extra_try_arguments 05:06:45 INFO - ##### 05:06:45 INFO - ##### Finished download-and-extract step (success) 05:06:45 INFO - ##### 05:06:45 INFO - ##### 05:06:45 INFO - ##### Running populate-webroot step. 05:06:45 INFO - ##### 05:06:45 INFO - Running pre-action listener: _resource_record_pre_action 05:06:45 INFO - Running main action method: populate_webroot 05:06:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:45 INFO - '--tppagecycles', 05:06:45 INFO - '7'], 05:06:45 INFO - 'tests': ['tsvgm']}}, 05:06:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['damp', 'tps']}, 05:06:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'tests': ['damp', 'tps']}, 05:06:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['dromaeo_dom']}, 05:06:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['a11yr', 05:06:45 INFO - 'ts_paint', 05:06:45 INFO - 'tpaint', 05:06:45 INFO - 'sessionrestore', 05:06:45 INFO - 'sessionrestore_no_auto_restore', 05:06:45 INFO - 'tabpaint']}, 05:06:45 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:45 INFO - 'ts_paint', 05:06:45 INFO - 'tpaint', 05:06:45 INFO - 'sessionrestore', 05:06:45 INFO - 'sessionrestore_no_auto_restore', 05:06:45 INFO - 'tabpaint']}, 05:06:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:45 INFO - 'ts_paint', 05:06:45 INFO - 'tpaint', 05:06:45 INFO - 'sessionrestore', 05:06:45 INFO - 'sessionrestore_no_auto_restore', 05:06:45 INFO - 'tabpaint']}, 05:06:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:45 INFO - 'ts_paint', 05:06:45 INFO - 'tpaint', 05:06:45 INFO - 'sessionrestore', 05:06:45 INFO - 'sessionrestore_no_auto_restore', 05:06:45 INFO - 'tabpaint']}, 05:06:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['a11yr', 05:06:45 INFO - 'ts_paint', 05:06:45 INFO - 'tpaint', 05:06:45 INFO - 'sessionrestore', 05:06:45 INFO - 'sessionrestore_no_auto_restore', 05:06:45 INFO - 'tabpaint']}, 05:06:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['a11yr', 05:06:45 INFO - 'ts_paint', 05:06:45 INFO - 'tpaint', 05:06:45 INFO - 'sessionrestore', 05:06:45 INFO - 'sessionrestore_no_auto_restore', 05:06:45 INFO - 'tabpaint']}, 05:06:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['tsvgx', 05:06:45 INFO - 'tsvgr_opacity', 05:06:45 INFO - 'tart', 05:06:45 INFO - 'tscrollx', 05:06:45 INFO - 'cart']}, 05:06:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:45 INFO - 'tsvgr_opacity', 05:06:45 INFO - 'tart', 05:06:45 INFO - 'tscrollx', 05:06:45 INFO - 'cart']}, 05:06:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'talos_options': ['--disable-e10s'], 05:06:45 INFO - 'tests': ['tp5o']}, 05:06:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'tests': ['tp5o']}, 05:06:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'talos_options': ['--disable-e10s', 05:06:45 INFO - '--xperf_path', 05:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:45 INFO - 'tests': ['tp5n']}, 05:06:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:45 INFO - 'talos_options': ['--xperf_path', 05:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:45 INFO - 'tests': ['tp5n']}}, 05:06:45 INFO - 'talos.zip': {'path': '', 05:06:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:45 INFO - Running post-action listener: _resource_record_post_action 05:06:45 INFO - ##### 05:06:45 INFO - ##### Finished populate-webroot step (success) 05:06:45 INFO - ##### 05:06:45 INFO - ##### 05:06:45 INFO - ##### Running create-virtualenv step. 05:06:45 INFO - ##### 05:06:45 INFO - Running pre-action listener: _resource_record_pre_action 05:06:45 INFO - Running main action method: create_virtualenv 05:06:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:45 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 05:06:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:45 INFO - Using real prefix '/usr' 05:06:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:47 INFO - Installing pip.................done. 05:06:47 INFO - Return code: 0 05:06:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:47 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')]} 05:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:47 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')]} 05:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:47 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 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:06:47 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 05:06:47 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 05:06:47 INFO - Using env: {'DISPLAY': ':0', 05:06:47 INFO - 'HOME': '/home/cltbld', 05:06:47 INFO - 'LANG': 'en_US.UTF-8', 05:06:47 INFO - 'LANGUAGE': 'en_US:en', 05:06:47 INFO - 'LOGNAME': 'cltbld', 05:06:47 INFO - 'MAIL': '/var/mail/cltbld', 05:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:47 INFO - 'MOZ_NO_REMOTE': '1', 05:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:47 INFO - 'NO_EM_RESTART': '1', 05:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:47 INFO - 'PWD': '/builds/slave/test', 05:06:47 INFO - 'SHELL': '/bin/bash', 05:06:47 INFO - 'SHLVL': '1', 05:06:47 INFO - 'TERM': 'linux', 05:06:47 INFO - 'TMOUT': '86400', 05:06:47 INFO - 'USER': 'cltbld', 05:06:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:47 INFO - '_': '/tools/buildbot/bin/python'} 05:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:48 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 05:06:48 INFO - Cleaning up... 05:06:48 INFO - Return code: 0 05:06:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:06:48 INFO - Using env: {'DISPLAY': ':0', 05:06:48 INFO - 'HOME': '/home/cltbld', 05:06:48 INFO - 'LANG': 'en_US.UTF-8', 05:06:48 INFO - 'LANGUAGE': 'en_US:en', 05:06:48 INFO - 'LOGNAME': 'cltbld', 05:06:48 INFO - 'MAIL': '/var/mail/cltbld', 05:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:48 INFO - 'MOZ_NO_REMOTE': '1', 05:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:48 INFO - 'NO_EM_RESTART': '1', 05:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:48 INFO - 'PWD': '/builds/slave/test', 05:06:48 INFO - 'SHELL': '/bin/bash', 05:06:48 INFO - 'SHLVL': '1', 05:06:48 INFO - 'TERM': 'linux', 05:06:48 INFO - 'TMOUT': '86400', 05:06:48 INFO - 'USER': 'cltbld', 05:06:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:48 INFO - '_': '/tools/buildbot/bin/python'} 05:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:48 INFO - Downloading/unpacking psutil>=3.1.1 05:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:50 INFO - Installing collected packages: psutil 05:06:50 INFO - Running setup.py install for psutil 05:06:50 INFO - building 'psutil._psutil_linux' extension 05:06:50 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 05:06:50 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 05:06:50 INFO - building 'psutil._psutil_posix' extension 05:06:50 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 05:06:50 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 05:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:50 INFO - Successfully installed psutil 05:06:50 INFO - Cleaning up... 05:06:50 INFO - Return code: 0 05:06:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:06:50 INFO - Using env: {'DISPLAY': ':0', 05:06:50 INFO - 'HOME': '/home/cltbld', 05:06:50 INFO - 'LANG': 'en_US.UTF-8', 05:06:50 INFO - 'LANGUAGE': 'en_US:en', 05:06:50 INFO - 'LOGNAME': 'cltbld', 05:06:50 INFO - 'MAIL': '/var/mail/cltbld', 05:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:50 INFO - 'MOZ_NO_REMOTE': '1', 05:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:50 INFO - 'NO_EM_RESTART': '1', 05:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:50 INFO - 'PWD': '/builds/slave/test', 05:06:50 INFO - 'SHELL': '/bin/bash', 05:06:50 INFO - 'SHLVL': '1', 05:06:50 INFO - 'TERM': 'linux', 05:06:50 INFO - 'TMOUT': '86400', 05:06:50 INFO - 'USER': 'cltbld', 05:06:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:50 INFO - '_': '/tools/buildbot/bin/python'} 05:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:53 INFO - Installing collected packages: mozsystemmonitor 05:06:53 INFO - Running setup.py install for mozsystemmonitor 05:06:53 INFO - Successfully installed mozsystemmonitor 05:06:53 INFO - Cleaning up... 05:06:53 INFO - Return code: 0 05:06:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:53 INFO - Using env: {'DISPLAY': ':0', 05:06:53 INFO - 'HOME': '/home/cltbld', 05:06:53 INFO - 'LANG': 'en_US.UTF-8', 05:06:53 INFO - 'LANGUAGE': 'en_US:en', 05:06:53 INFO - 'LOGNAME': 'cltbld', 05:06:53 INFO - 'MAIL': '/var/mail/cltbld', 05:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:53 INFO - 'MOZ_NO_REMOTE': '1', 05:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:53 INFO - 'NO_EM_RESTART': '1', 05:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:53 INFO - 'PWD': '/builds/slave/test', 05:06:53 INFO - 'SHELL': '/bin/bash', 05:06:53 INFO - 'SHLVL': '1', 05:06:53 INFO - 'TERM': 'linux', 05:06:53 INFO - 'TMOUT': '86400', 05:06:53 INFO - 'USER': 'cltbld', 05:06:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:53 INFO - '_': '/tools/buildbot/bin/python'} 05:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - Downloading docopt-0.6.1.tar.gz 05:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:56 INFO - Running setup.py install for blobuploader 05:06:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:56 INFO - Running setup.py install for requests 05:06:56 INFO - Running setup.py install for docopt 05:06:56 INFO - Successfully installed blobuploader requests docopt 05:06:56 INFO - Cleaning up... 05:06:56 INFO - Return code: 0 05:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:56 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')]} 05:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:56 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')]} 05:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:56 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 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:06:56 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 05:06:56 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 05:06:56 INFO - Using env: {'DISPLAY': ':0', 05:06:56 INFO - 'HOME': '/home/cltbld', 05:06:56 INFO - 'LANG': 'en_US.UTF-8', 05:06:56 INFO - 'LANGUAGE': 'en_US:en', 05:06:56 INFO - 'LOGNAME': 'cltbld', 05:06:56 INFO - 'MAIL': '/var/mail/cltbld', 05:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:56 INFO - 'MOZ_NO_REMOTE': '1', 05:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:56 INFO - 'NO_EM_RESTART': '1', 05:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:56 INFO - 'PWD': '/builds/slave/test', 05:06:56 INFO - 'SHELL': '/bin/bash', 05:06:56 INFO - 'SHLVL': '1', 05:06:56 INFO - 'TERM': 'linux', 05:06:56 INFO - 'TMOUT': '86400', 05:06:56 INFO - 'USER': 'cltbld', 05:06:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:56 INFO - '_': '/tools/buildbot/bin/python'} 05:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:56 INFO - Running setup.py (path:/tmp/pip-1L8jqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:56 INFO - Running setup.py (path:/tmp/pip-orScpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:56 INFO - Running setup.py (path:/tmp/pip-ApK6HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:57 INFO - Running setup.py (path:/tmp/pip-17Hc5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:57 INFO - Running setup.py (path:/tmp/pip-IIEGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:57 INFO - Running setup.py (path:/tmp/pip-wMS9lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:57 INFO - Running setup.py (path:/tmp/pip-rwDVoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:57 INFO - Running setup.py (path:/tmp/pip-kMVnR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:57 INFO - Running setup.py (path:/tmp/pip-cFdXFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:57 INFO - Running setup.py (path:/tmp/pip-Vxoanz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:57 INFO - Running setup.py (path:/tmp/pip-55BA0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:57 INFO - Running setup.py (path:/tmp/pip-j7hy0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:57 INFO - Running setup.py (path:/tmp/pip-HPmBdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:57 INFO - Running setup.py (path:/tmp/pip-kVjL5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:57 INFO - Running setup.py (path:/tmp/pip-0gFNJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:57 INFO - Running setup.py (path:/tmp/pip-Hqqk9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:57 INFO - Running setup.py (path:/tmp/pip-KTxBqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:58 INFO - Running setup.py install for manifestparser 05:06:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Running setup.py install for mozcrash 05:06:58 INFO - Running setup.py install for mozdebug 05:06:58 INFO - Running setup.py install for mozdevice 05:06:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Running setup.py install for mozfile 05:06:58 INFO - Running setup.py install for mozhttpd 05:06:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Running setup.py install for mozinfo 05:06:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Running setup.py install for mozInstall 05:06:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Running setup.py install for mozleak 05:06:58 INFO - Running setup.py install for mozlog 05:06:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Running setup.py install for moznetwork 05:06:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Running setup.py install for mozprocess 05:06:59 INFO - Running setup.py install for mozprofile 05:06:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Running setup.py install for mozrunner 05:06:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Running setup.py install for mozscreenshot 05:06:59 INFO - Running setup.py install for moztest 05:06:59 INFO - Running setup.py install for mozversion 05:06:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:59 INFO - Cleaning up... 05:06:59 INFO - Return code: 0 05:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:59 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')]} 05:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:59 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')]} 05:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:59 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 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:06:59 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 05:06:59 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 05:06:59 INFO - Using env: {'DISPLAY': ':0', 05:06:59 INFO - 'HOME': '/home/cltbld', 05:06:59 INFO - 'LANG': 'en_US.UTF-8', 05:06:59 INFO - 'LANGUAGE': 'en_US:en', 05:06:59 INFO - 'LOGNAME': 'cltbld', 05:06:59 INFO - 'MAIL': '/var/mail/cltbld', 05:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:59 INFO - 'MOZ_NO_REMOTE': '1', 05:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:59 INFO - 'NO_EM_RESTART': '1', 05:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:59 INFO - 'PWD': '/builds/slave/test', 05:06:59 INFO - 'SHELL': '/bin/bash', 05:06:59 INFO - 'SHLVL': '1', 05:06:59 INFO - 'TERM': 'linux', 05:06:59 INFO - 'TMOUT': '86400', 05:06:59 INFO - 'USER': 'cltbld', 05:06:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:59 INFO - '_': '/tools/buildbot/bin/python'} 05:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:00 INFO - Running setup.py (path:/tmp/pip-vvMn46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:00 INFO - Running setup.py (path:/tmp/pip-JHK9vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:00 INFO - Running setup.py (path:/tmp/pip-Bjk8vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:00 INFO - Running setup.py (path:/tmp/pip-HtqkrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:00 INFO - Running setup.py (path:/tmp/pip-s4gffZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:00 INFO - Running setup.py (path:/tmp/pip-XkBcQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:00 INFO - Running setup.py (path:/tmp/pip-giclQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:00 INFO - Running setup.py (path:/tmp/pip-lNE605-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:00 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)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:00 INFO - Running setup.py (path:/tmp/pip-RqwY5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:00 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)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:00 INFO - Running setup.py (path:/tmp/pip-S5EMFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:00 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)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:00 INFO - Running setup.py (path:/tmp/pip-FWrTKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:00 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)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:00 INFO - Running setup.py (path:/tmp/pip-Cm49e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:00 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)) 05:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:00 INFO - Running setup.py (path:/tmp/pip-4nawd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:01 INFO - Running setup.py (path:/tmp/pip-hThzIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:01 INFO - Running setup.py (path:/tmp/pip-L8LMvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:01 INFO - Running setup.py (path:/tmp/pip-oza6lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:01 INFO - Running setup.py (path:/tmp/pip-ZI0arr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:03 INFO - Downloading blessings-1.6.tar.gz 05:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:03 INFO - Installing collected packages: blessings 05:07:03 INFO - Running setup.py install for blessings 05:07:03 INFO - Successfully installed blessings 05:07:03 INFO - Cleaning up... 05:07:03 INFO - Return code: 0 05:07:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:03 INFO - Reading from file tmpfile_stdout 05:07:03 INFO - Current package versions: 05:07:03 INFO - argparse == 1.2.1 05:07:03 INFO - blessings == 1.6 05:07:03 INFO - blobuploader == 1.2.4 05:07:03 INFO - docopt == 0.6.1 05:07:03 INFO - manifestparser == 1.1 05:07:03 INFO - mozInstall == 1.12 05:07:03 INFO - mozcrash == 0.17 05:07:03 INFO - mozdebug == 0.1 05:07:03 INFO - mozdevice == 0.48 05:07:03 INFO - mozfile == 1.2 05:07:03 INFO - mozhttpd == 0.7 05:07:03 INFO - mozinfo == 0.9 05:07:03 INFO - mozleak == 0.1 05:07:03 INFO - mozlog == 3.2 05:07:03 INFO - moznetwork == 0.27 05:07:03 INFO - mozprocess == 0.22 05:07:03 INFO - mozprofile == 0.28 05:07:03 INFO - mozrunner == 6.11 05:07:03 INFO - mozscreenshot == 0.1 05:07:03 INFO - mozsystemmonitor == 0.3 05:07:03 INFO - moztest == 0.7 05:07:03 INFO - mozversion == 1.4 05:07:03 INFO - psutil == 3.1.1 05:07:03 INFO - requests == 1.2.3 05:07:03 INFO - wsgiref == 0.1.2 05:07:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:03 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 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:07:03 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 05:07:03 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 05:07:03 INFO - Using env: {'DISPLAY': ':0', 05:07:03 INFO - 'HOME': '/home/cltbld', 05:07:03 INFO - 'LANG': 'en_US.UTF-8', 05:07:03 INFO - 'LANGUAGE': 'en_US:en', 05:07:03 INFO - 'LOGNAME': 'cltbld', 05:07:03 INFO - 'MAIL': '/var/mail/cltbld', 05:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:03 INFO - 'MOZ_NO_REMOTE': '1', 05:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:03 INFO - 'NO_EM_RESTART': '1', 05:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:03 INFO - 'PWD': '/builds/slave/test', 05:07:03 INFO - 'SHELL': '/bin/bash', 05:07:03 INFO - 'SHLVL': '1', 05:07:03 INFO - 'TERM': 'linux', 05:07:03 INFO - 'TMOUT': '86400', 05:07:03 INFO - 'USER': 'cltbld', 05:07:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:03 INFO - '_': '/tools/buildbot/bin/python'} 05:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 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)) 05:07:03 INFO - Cleaning up... 05:07:03 INFO - Return code: 0 05:07:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:07:03 INFO - Using env: {'DISPLAY': ':0', 05:07:03 INFO - 'HOME': '/home/cltbld', 05:07:03 INFO - 'LANG': 'en_US.UTF-8', 05:07:03 INFO - 'LANGUAGE': 'en_US:en', 05:07:03 INFO - 'LOGNAME': 'cltbld', 05:07:03 INFO - 'MAIL': '/var/mail/cltbld', 05:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:03 INFO - 'MOZ_NO_REMOTE': '1', 05:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:03 INFO - 'NO_EM_RESTART': '1', 05:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:03 INFO - 'PWD': '/builds/slave/test', 05:07:03 INFO - 'SHELL': '/bin/bash', 05:07:03 INFO - 'SHLVL': '1', 05:07:03 INFO - 'TERM': 'linux', 05:07:03 INFO - 'TMOUT': '86400', 05:07:03 INFO - 'USER': 'cltbld', 05:07:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:03 INFO - '_': '/tools/buildbot/bin/python'} 05:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:04 INFO - Downloading/unpacking jsonschema 05:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:05 INFO - Downloading/unpacking functools32 (from jsonschema) 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:06 INFO - warning: no files found matching '*.txt' 05:07:06 INFO - no previously-included directories found matching 'build' 05:07:06 INFO - no previously-included directories found matching 'dist' 05:07:06 INFO - no previously-included directories found matching '.git*' 05:07:06 INFO - Installing collected packages: jsonschema, functools32 05:07:06 INFO - Running setup.py install for functools32 05:07:06 INFO - warning: no files found matching '*.txt' 05:07:06 INFO - no previously-included directories found matching 'build' 05:07:06 INFO - no previously-included directories found matching 'dist' 05:07:06 INFO - no previously-included directories found matching '.git*' 05:07:06 INFO - Successfully installed jsonschema functools32 05:07:06 INFO - Cleaning up... 05:07:06 INFO - Return code: 0 05:07:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6316c3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', '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 05:07: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', 'flake8'] in /builds/slave/test/build 05:07: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 flake8 05:07:06 INFO - Using env: {'DISPLAY': ':0', 05:07:06 INFO - 'HOME': '/home/cltbld', 05:07:06 INFO - 'LANG': 'en_US.UTF-8', 05:07:06 INFO - 'LANGUAGE': 'en_US:en', 05:07:06 INFO - 'LOGNAME': 'cltbld', 05:07:06 INFO - 'MAIL': '/var/mail/cltbld', 05:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:06 INFO - 'MOZ_NO_REMOTE': '1', 05:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:06 INFO - 'NO_EM_RESTART': '1', 05:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:06 INFO - 'PWD': '/builds/slave/test', 05:07:06 INFO - 'SHELL': '/bin/bash', 05:07:06 INFO - 'SHLVL': '1', 05:07:06 INFO - 'TERM': 'linux', 05:07:06 INFO - 'TMOUT': '86400', 05:07:06 INFO - 'USER': 'cltbld', 05:07:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:06 INFO - '_': '/tools/buildbot/bin/python'} 05:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:06 INFO - Downloading/unpacking flake8 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:07:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:07:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:09 INFO - no previously-included directories found matching 'docs/_build' 05:07:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:07:09 INFO - Running setup.py install for pep8 05:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:09 INFO - no previously-included directories found matching 'docs/_build' 05:07:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:07:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:07:09 INFO - Cleaning up... 05:07:09 INFO - Return code: 0 05:07:09 INFO - Running post-action listener: _resource_record_post_action 05:07:09 INFO - Running post-action listener: _start_resource_monitoring 05:07:09 INFO - Starting resource monitoring. 05:07:09 INFO - ##### 05:07:09 INFO - ##### Finished create-virtualenv step (success) 05:07:09 INFO - ##### 05:07:09 INFO - ##### 05:07:09 INFO - ##### Running install step. 05:07:09 INFO - ##### 05:07:09 INFO - Running pre-action listener: _resource_record_pre_action 05:07:09 INFO - Running main action method: install 05:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:09 INFO - Reading from file tmpfile_stdout 05:07:09 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:09 INFO - Reading from file tmpfile_stdout 05:07:09 INFO - Output received: 05:07:09 INFO - Usage: mozinstall [options] installer 05:07:09 INFO - Options: 05:07:09 INFO - -h, --help show this help message and exit 05:07:09 INFO - -d DEST, --destination=DEST 05:07:09 INFO - Directory to install application into. [default: 05:07:09 INFO - "/builds/slave/test"] 05:07:09 INFO - --app=APP Application being installed. [default: firefox] 05:07:09 INFO - mkdir: /builds/slave/test/build/application 05:07:09 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'] 05:07:09 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 05:07:26 INFO - Reading from file tmpfile_stdout 05:07:26 INFO - Output received: 05:07:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:26 INFO - Running post-action listener: _resource_record_post_action 05:07:26 INFO - ##### 05:07:26 INFO - ##### Finished install step (success) 05:07:26 INFO - ##### 05:07:26 INFO - ##### 05:07:26 INFO - ##### Running run-tests step. 05:07:26 INFO - ##### 05:07:26 INFO - Running pre-action listener: _resource_record_pre_action 05:07:26 INFO - Running main action method: run_tests 05:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:26 INFO - Python 2.7.3 05:07:26 INFO - Return code: 0 05:07:26 INFO - grabbing minidump binary from tooltool 05:07:26 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')]} 05:07:26 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 0x11d39c0>, '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 0x11d48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:26 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 05:07:26 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 05:07:26 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 05:07:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:26 INFO - Return code: 0 05:07:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:27 INFO - Return code: 0 05:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:07:27 INFO - Using env: {'DISPLAY': ':0', 05:07:27 INFO - 'HOME': '/home/cltbld', 05:07:27 INFO - 'LANG': 'en_US.UTF-8', 05:07:27 INFO - 'LANGUAGE': 'en_US:en', 05:07:27 INFO - 'LOGNAME': 'cltbld', 05:07:27 INFO - 'MAIL': '/var/mail/cltbld', 05:07:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:27 INFO - 'MOZ_NO_REMOTE': '1', 05:07:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:27 INFO - 'NO_EM_RESTART': '1', 05:07:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:27 INFO - 'PWD': '/builds/slave/test', 05:07:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:27 INFO - 'SHELL': '/bin/bash', 05:07:27 INFO - 'SHLVL': '1', 05:07:27 INFO - 'TERM': 'linux', 05:07:27 INFO - 'TMOUT': '86400', 05:07:27 INFO - 'USER': 'cltbld', 05:07:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408', 05:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:27 INFO - '_': '/tools/buildbot/bin/python'} 05:07:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:07:27 INFO - mozversion application_buildid: 20160519023015 05:07:27 INFO - mozversion application_changeset: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 05:07:27 INFO - mozversion application_display_name: Nightly 05:07:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:27 INFO - mozversion application_name: Firefox 05:07:27 INFO - mozversion application_remotingname: firefox 05:07:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:27 INFO - mozversion application_vendor: Mozilla 05:07:27 INFO - mozversion application_version: 49.0a1 05:07:27 INFO - mozversion platform_buildid: 20160519023015 05:07:27 INFO - mozversion platform_changeset: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 05:07:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:27 INFO - mozversion platform_version: 49.0a1 05:07:27 INFO - using testdate: 1463659647 05:07:27 INFO - actual date: 1463659647 05:07:27 INFO - starting webserver on 'localhost:58240' 05:07:27 INFO - SUITE-START | Running 2 tests 05:07:27 INFO - TEST-START | dromaeo_css 05:07:27 INFO - operating with platform_type : linux_ 05:07:27 INFO - Initialising browser for dromaeo_css test... 05:07:27 INFO - TEST-INFO | started process 30203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuksx7K/profile http://localhost:58240/getInfo.html) 05:07:31 INFO - PROCESS | 30203 | __metrics Screen width/height:1600/1200 05:07:31 INFO - PROCESS | 30203 | colorDepth:24 05:07:31 INFO - PROCESS | 30203 | Browser inner width/height: 1024/697 05:07:31 INFO - PROCESS | 30203 | __metrics 05:07:32 ERROR - PROCESS | 30203 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:07:33 INFO - TEST-INFO | 30203: exit 0 05:07:33 INFO - Browser initialized. 05:07:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:33 INFO - TEST-INFO | started process 30283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuksx7K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:45 INFO - PROCESS | 30283 | RSS: Main: 152162304 05:07:45 INFO - PROCESS | 30283 | 05:08:36 INFO - PROCESS | 30283 | 1463659716980 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] 05:10:44 INFO - PROCESS | 30283 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58240/tests/dromaeo/cssquery-ext.html) 05:10:45 INFO - PROCESS | 30283 | RSS: Main: 261033984 05:10:45 INFO - PROCESS | 30283 | 05:13:48 INFO - PROCESS | 30283 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-ext.html (next: http://localhost:58240/tests/dromaeo/cssquery-jquery.html) 05:13:48 INFO - PROCESS | 30283 | RSS: Main: 241704960 05:13:48 INFO - PROCESS | 30283 | 05:16:50 INFO - PROCESS | 30283 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58240/tests/dromaeo/cssquery-mootools.html) 05:16:51 INFO - PROCESS | 30283 | RSS: Main: 240242688 05:16:51 INFO - PROCESS | 30283 | 05:19:53 INFO - PROCESS | 30283 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58240/tests/dromaeo/cssquery-prototype.html) 05:19:53 INFO - PROCESS | 30283 | RSS: Main: 235696128 05:19:53 INFO - PROCESS | 30283 | 05:22:56 INFO - PROCESS | 30283 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58240/tests/dromaeo/cssquery-yui.html) 05:22:57 INFO - PROCESS | 30283 | RSS: Main: 213553152 05:22:57 INFO - PROCESS | 30283 | 05:25:59 INFO - PROCESS | 30283 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-yui.html (next: http://localhost:58240/tests/dromaeo/cssquery-dojo.html) 05:26:00 INFO - PROCESS | 30283 | RSS: Main: 264175616 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | __start_tp_report 05:26:00 INFO - PROCESS | 30283 | _x_x_mozilla_page_load 05:26:00 INFO - PROCESS | 30283 | _x_x_mozilla_page_load_details 05:26:00 INFO - PROCESS | 30283 | |i|pagename|runs| 05:26:00 INFO - PROCESS | 30283 | |0;dojo.html;3144.701253380929;3150.527420886867;3161.889333873315;3195.568598239237;3212.164837142342;5408.810691625794;5415.106507426275;5449.482299181582;5500.312460942382;5539.861503462415;5463.426340234278;5504.80733174339;5514.779408823642;5521.033819081655;5529.281193444856;4874.97562512187;4991.126552853236;5010;5030.396352437694;5156.407013193474;5055.545000949914;5055.848324550269;5087.058894104584;5110.6422550421485;5126.359205099363;4822.97588512057;4894;4928.063667903105;4934.333864928225;5010.7995680172935;4921;4924.975375123137;4978.87552811179;4987.526185012418;5034.924476132861;4775.426948766136;4931.3589233399425;4956.6282528810125;4974.054929563371;5016.046951079284;5373.328333958255;5450.618456708032;5460.672359658433;5495.065838807413;5529.723513824292;5933.3473317934995;5945.078512830518;5951.791687290967;5972.850678733023;5977.8804423911715;5754.424557544212;5838.941610583882;5887.646741195499;5937.762489500415;6028.367021462727;5536.529395001429;5546.528545073674;5552.194931734956;5560.805371812007;5561.99999999996;6040.728023341186;6057.098957891561;6060.154113845389;6063.804890679235;6092.695365231721;5610.887782244332;5638.2670252866865;5664.631798933056;5684.062129748628;5851;5787.536997040227;5791.160281759121;5800.738966746507;5853.0635098384055;5859.062549991981;5755.453231942959;5767.509761670305;5770.394108618619;5771.307443106854;5775.5090817281;5703.315602127688;5765.884682306414;5809.564282678816;5842.5618078644275;5883.61756485827;4447.644188464915;4456.732596044248;4457.153140903218;4457.286834106528;4493.573110554557;3880.223955208913;3942;3982.3827306766916;3998.2603218404106;4031.91936161281;5551.195076713934;5595.300587426572;5596.944030559724;5603.887922241533;5629.634073785191;5914.260717410324;5924.466797988115;5933.3769954154195;5961;5970.194023806731;5370.838874833761;5459.962607104638;5565.693886836263;5608.887822243614;5614.382417934024;4991.176455884811;5028.773705183203;5030.496950305013;5034.546890779774;5073.847784566469;6045.667488288098;6055.7274922628585;6055.757769689163;6059.48494377974;6062.151298818169;5728.513076388554;5854.9121763174435;5882.941170588239;5887.735051922588;5904.232449781673;6112.108359148444;6126.700892189639;6131.3460828618745;6136.243373036893;6139.768135342541;5787.94212057874;5838.4453476919625;5842.912356314574;5844.12338149264;5888.087346461305;5740.253767010262;5804.5356371491025;5845.473907348359;5863.530917526673;5930.080837470199;5749.942500575108;5754.021816291324;5754.280714910637;5757.251557297524;5761.337446193741;5692.48767610917;5731.541476681939;5744.396838331915;5750.424957504216;5753.741081651252;5488.396276409512;5520.1443776214755;5576.247206627054;5598.580106492111;5616.887662246814;5742.913856292243;5793.102069179284;5806.042003069446;5813.447722466359;5813.593048486735;5505.697186654773;5585.636933599303;5628.718564071862;5639.928413601403;5641.379448260606 05:26:00 INFO - PROCESS | 30283 | |1;ext.html;599.3916175082293;646.954713170078;649.0880313160011;654.4175683641558;655.1221363373079;31921.361572768532;44455.33317000248;45115.32327015098;45180.32229516552;45252.999999999956;46468.53531464684;47012;47092.29361559571;47100;47106.293405598946;8811.77970550735;9025.684101056464;9028.232600228956;9032.638694452215;9040.457572545669;8843.646254149826;8962.32782541312;8965.32760042996;8965.775855603597;8971.910280897173;9034.86447703285;9083.318751093695;9084.273258139367;9084.454932704059;9087.636494540211;8938.597763100675;8984.820303593924;9020.503872287021;9025.864612030824;9036.096390360944;8914.064023277591;8982.10178982103;9001.144891235323;9011.819763604757;9013;42525.57474425247;42875.78562107169;42905.57094429078;42921.78539107316;42969;3774.792386418746;3847.3844184930276;3882.5535063467496;4063.96691843872;4072.348424252135;32602.510962335586;33171.6682833171;33276.33447331064;33429.83285083559;33465.33069338599;4285.507166675841;4358.193734159191;4388.934165987513;4400.977995110036;4423;319818;321421;322327;322667;323076.3846180778;59998.70000649969;60189.39810601925;60577.39422605806;60670;60710.69644651748;55798.442015580134;61012.89871012952;62958;62988.685056574424;63114.36885631085;15818.130002849954;16826.747598786027;16840.915795421188;16843.41048063312;16846.747298790528;13112.278824664545;13208;13219.272939988394;13220.272884991226;13222.404991775393;16199.271032803552;17456;17910.731339029924;17914.46256612304;18392.816071839112;6450.4839612830865;6562.80311590653;6579.4736421087155;6671.699773510204;6724.620303756975;1023.6314926626409;1129.6611016694958;1184.9927561572595;1226.5093962414926;1240.1257113734976;32879.83560082184;33507.49738753921;33873.32253354919;33970;34128.658713413046;1179.1274456902001;1180.2328486483855;1206.831043653889;1217.598192596441;1291.6770807298176;16916.32334706598;17892.10539473021;17894.55263618394;17907.37324193647;17925;520881;523814;524528;526310;526315;51258;51433.22850157251;51479.485205148216;51728.48271517312;51842;1415.1226239731432;1423.5586968039734;1440.0495672855866;1463.778939507095;1470.5735336752223;31092.378152437275;32382.83808580942;32712.83643581767;32987.505187422685;33371.499427509094;51830.48169518408;52550;52720;52769.736151319;52826.20760688516;418651;422362;423545;423966;425072;25318;27605.447891041666;28455.146345609664;28814.838887083133;28831.5675264867;43556.34665480084;43872.34191487194;48025.759871201815;48411.75794121007;48790.5120948786;40560.59439405568;40581.1883762329;40762.79618601888;41811.37282940697;42158.15683686248;40791.59208407878;40819;40880.79559602183;41066.1786764269;41566.37650435185;40824.38763418492;41528.377074343305;42476.362854557825;42518.14963700771;42558.361624576275;36032.27935441329;36211.81894090513;36553.63446365609;36684;37073.44389834101;28155.155345339674;28300.292492687848;28581.857090714413;28830.279243019093;29025.85487072551 05:26:00 INFO - PROCESS | 30283 | |2;jquery.html;404.5893418180547;404.81783197561106;410.35164440184514;412.14384316685357;422.7167797575624;14223.502177423792;18290;19799.109040093175;19805.108770105344;20006.799932000675;17559.209835557398;18105;18231;19342.613147737036;19598;5236.371635403747;5394.622376433651;5404.513593776559;5406.324209473816;5427.3215848019;3880.9223815523674;5339.332583427072;5375.247465354853;5376.731163441832;5382.569394448455;5613.494785469307;5886.499647529965;5890.440408161217;5979.431953964388;5987.760489580433;5912;5964.671943043131;6057.485113765335;6507.837304067436;6526.445252153572;5647.604667673265;5770.076787713946;5773.451522105393;5775.740091695884;5796.88406231873;14208;14235.50175743844;14238.928805355907;14239.857601423957;17453.56366090845;2340.33300509354;2480.441900572375;2518.106072344328;2570.8457492550506;2822.1251412062325;10231.283810133295;10303.227257955608;10339.327943683711;10810.67567972962;10814.297070690458;1769.5222289981632;1958.8628795984287;2025.4126303372152;2031.238285642884;2093.1522733292886;80124;81725;83035.5848220755;83424;83984.16015839824;10910.836337454944;11080.833787493195;11155.27490713101;11169.553217871357;12091.637250882488;15479.380824766884;15577.221138943007;15621.812946187543;15643.530694079196;15654.45209417665;7808.375329973588;7893.565853878092;7924.48490848093;8001.639926203218;8021.959890200512;7321.084864391951;7359.37445317154;7379.446541509408;7428.554286742705;7535.623218839036;4829.9275510867365;4858.222684370484;4866.902661946741;4915.65590408668;4934.753262336869;1964.8329891959343;1986.5629561496448;1987.7415935928525;2008.4275981345538;2041.9081141348674;900.9189172974333;964.8504481805331;1024.538957469127;1053.115383078218;1150.988490115105;18886.716699249522;19413;19770.60458790816;19957.452927962586;20176.39470815878;1022.2333250062453;1022.3967858963099;1032.767627283855;1084.3819023156725;1091.6888686724246;10796.622118225825;11307.604233851776;11451.713707157222;11474.254173478697;11514.884851151548;164988;166103;323632;328947;474435;74082.25917740862;84711.5764421174;85026.57486712527;93558;96801.515992421;1117.0616681987008;1135.2167004766684;1159.4202898550725;1180.2977228549;1181.3207405741732;17616.207270673105;17879.821201788334;17900.10499474995;18192.545186370447;18274.634507310046;41567.79216104021;41720.3741943865;42249.366259505514;42439.15121697487;43494.78252608717;58102;60304.09543856933;60741.69629151826;61017.389826102946;62041.37958620356;8746.518941458025;8951.686690965786;9052.683156089506;9069.818603627758;9419.952900235456;10403.58385664565;12667.556635517712;12973.870261297267;13837.308134593432;14141.646458838612;12275.815862762245;12325.322107284186;12493.875061249271;12495.891475184395;13006.739865202831;12080.275183489019;12108.455119519467;12357.814632780335;12427.875721242672;12522.937385313015;12536.811947820972;12602.55891043809;12633.115681902178;12711.237325760483;12814.55149069778;8958.238549723086;9007.189352958003;9061.546922653974;9096.954515227382;9279.304052195977;11917.76164476723;12444.502219911103;12534.059945504307;12558.623241302776;12592.685182870502 05:26:00 INFO - PROCESS | 30283 | |3;mootools.html;1390.5480718766403;1553.9300731467083;1584.0812328849265;1765.9051388139349;1849.963000739986;8651.351148663853;8998.145176208258;9002.279817614592;9238.81522369554;9245.352825302232;8894.066123057082;9132.086791320864;9137.497437640926;9138.954305228464;9150.679726209584;2151.365347222565;2222.8777417242045;2410.4214988402746;2469.802415806731;2493.0401795308844;2528.5954247320433;2547.821652484327;2549.0441084593276;2549.056848965876;2554.859482728449;2463.9753602463925;2475.344033831036;2477.801775857927;2478.429961108946;2478.925632231036;2110.7361579802523;2351.306364622432;2371.2530552875787;2443.4624382635793;2447.669564608773;2436.90252389906;2437;2443.0716327795503;2464.5687004774272;2466.161505088279;9212;9238.307126965505;9275.257979361635;9279.21126704231;9291.76770580734;5479.287692599976;5588.748506317185;5597.608167428281;5602.327720673546;5605.215269862222;3499.4051011328133;3521.1197200699826;3532.975437123231;3539.522164507784;3580.946285805715;1145.3872178384524;1175.6061719324036;1176.9764604707943;1184.24208506555;1233.1552886272932;12744.80882786759;12775.425105870258;12783;12783;12812.80780788289;4892.461829198785;4929.13740095489;4961.652684312064;4970.15507363749;5017.122003649347;10536.841947370796;10560.894391056145;10583.894161058292;10629.309094908805;10642.680719578426;5427.728613569306;5432.728363581805;5438.15708565173;5439.619226654097;5441.102218134043;4473.955260447419;5031.77357018935;5163.896722065538;5177.741112944338;5233.973830130901;4139.5653456387245;4171;4213.726107802983;4246.150769846043;4251.277282861921;1347.508159521787;1357.6741582020245;1359.2727890578492;1375.277979061001;1382.7165431086603;993.3692105512907;997.3317877022413;1009.4700282351824;1023.8771347438206;1030.5877648940484;6171.59884607499;6175.59858609189;6184.7249545533605;6266.24805023391;6311.400416960381;474.1157740813358;483.2678492084495;488.4041469407317;490.53644306130366;493.1640868727544;4251.319788833834;4278.44380230568;4285.6142947134285;4313.568643135724;4356.934645980313;11275.887241127648;11518.36648984297;11583.305001699924;11611.709707257387;11619.53521859133;11068.833967490495;11262.155338349656;11330.94334528322;11417.714557135972;11434.256773309708;8359.540225287668;8420.4947703138;8425.199606037417;8511;8516.914830851736;5985.221921150222;5998.280206375263;6152.0156774915795;6196.287426945959;6352.841178970562;10340.53467593975;10437.68686939393;10660.786784264426;10678.786424271315;10759.731006724895;10682.946585267335;10753.73115672083;10865.402402867918;10939.617113400993;10956.780864382827;7225.602591857288;7591.43064270193;7991.440599158003;8051.033875934925;8119.59402029908;8905.465672059698;8912.73261802147;8955.104489551253;8979.281657467518;8985.595648195978;7901.525908445512;8009.3192078673965;8019.03771547418;8161.387895907712;8246.917530824854;7934.166912474338;7978.162292959156;8009.359251259769;8162.224588664068;8199.303059240032;7008.0889484368745;7179.784606461814;7355.77932662021;7443.739469118555;7452.292032256927;5112.335396398593;5232.03207406631;5527.336719593674;5557.055300598989;5568.470995255444;5388.464287677993;5431.158170483582;5439.102548079681;5539.113741801292;5553.472420120243 05:26:00 INFO - PROCESS | 30283 | |4;prototype.html;323.4259189937861;333.09066249139863;335.68110295219543;340.48756621284963;341.05697745733045;5263.921041184385;5343.225232341309;5350.438203988583;5389.541888939435;5407.864803379917;5309.787608495655;5324.467553244684;5342.492463215998;5361.356637203531;5369.5167434930845;4186.665066794649;4203.327467605184;4215.768132752705;4235;4263.509696384909;3963.7621742695387;4065.166640838636;4192.916141677165;4213.873583792491;4216.831326746927;4166.145940082276;4178.623923846853;4179.811908464111;4191.7694526801015;4216.536181020086;3995.760254384717;4161.667066634662;4170.16596680662;4175.686823488235;4233.111046680186;3539.2744487380023;3614.8011859347725;3629.981850090759;3630.0198946284618;3637.381645120336;5127.948720512784;5172.948270517322;5173.068847607429;5173.146430838907;5203.635745497817;4628.143793398232;4716.3868697069165;4727.534464316039;4728.40894888139;4742.383490146293;5491.752871120809;5495.835124946258;5521.806736764194;5551.444855514416;5568.387477377485;4008.2985477541315;4022.597740225983;4027.496562929634;4041.4544036554985;4049.9392509112386;5599;5859.53123750099;5861.238039054895;5879.294484661825;5884.852878678024;4099.405586189986;4100.979495102505;4112.547619761824;4113.876583702494;4115.991582062414;4120;4173.478315210598;4176.832926682899;4181.686373521937;4198.85304014358;4724.196886529298;4733.266343716729;4740.317187398493;4747.287906813936;4785.856424307276;5474.178873169057;5597.776088956478;5599.348192283286;5622.7750889963945;5622.971885140548;1435.397133204057;1441.6467965348556;1447.65256338478;1456.4975083596141;1458.8978771486106;912.4023764434173;937.5640327247862;947.2611363136764;950.2920324358397;966.5312323523086;4869.6591238612955;5251.842444726664;5354.812581559627;5525.778968841281;5535.03136951032;5815.534757219412;5839.328477225174;5844.26946631671;5873.765049398062;5886.470217680429;5354.3842458117815;5543.196236545678;5545.833624991256;5556.527695145958;5563.5271001964475;3075.4617941860083;3080.4147212029643;3117.4388610049955;3127.9218019549694;3130.546070819764;5972.492338151305;5988.820335389945;5996.550258730613;6045.425684560048;6069.180660610849;5597.608167428241;5934.37689042653;5938.792142275;5952.166696662471;5953.404659534012;5902.848944455875;5929.822105336847;5987.9101813472835;5994.970025149846;5998.550108741862;5638.971805140948;5842.912356314744;5855.3266374365785;5874.882502350015;5886.6173698709445;5692.686902220417;5707.543396528351;5712.428757124254;5765.8558536036935;5773;6021.42796434338;6027.60820546663;6040.848978775566;6054.545909056927;6062.848428789315;3927.450156977968;4041.0705537727076;4106;4117.21772863155;4132.772697501546;5766.654000759968;5807.390224026416;5816.854578635568;5884.911291411103;5907;5558.666480011212;5654;5736.71316434185;5743.167240750151;5762.616971926791;5532.114861622121;5568.16477528374;5577.776888924398;5594;5610.158476228598;5488.890222195454;5515.338159420895;5517.944820551904;5567.830755541382;5583.469570390806;5398.4871437213405;5504.752286147213;5583.692896890548;5622.85942851432;5644.294463192101;5518.668879867221;5537.418571049981;5542.224088627676;5552.890381386436;5561.443855614406 05:26:00 INFO - PROCESS | 30283 | |5;yui.html;729.2088084428395;796.7092011415831;806.850732614466;835.3317346123101;871.1245198575431;14223.57329280122;14977.176255305954;14997.17515536645;15000;15021.774673379909;14010.22943738094;14031.368588413521;14064.64838379041;14071.577852664412;14074.22591757453;683.9247682754906;703.0543918429729;703.4372501998406;703.5778532880256;811.6753298680516;829.9211574900405;834.7996480844583;835.448603921412;837.2255663511258;837.9203975622306;871.1680345270252;879.6305551668314;882.3250213586612;883.567052144451;884.9159329863685;719.9208087110413;742.0909386002104;876.2639382918347;878.1218781218781;878.7934835313696;546.4835730234929;625.3746253746253;641.9325970773049;644.8839208942388;647.427027081032;14228;14241.643958901006;14247.501337453243;14282.3572939218;14282.857171428257;13536.593902182853;13893.374798134108;13899.513517026957;13929.303534823319;13987.860121398757;12539.686507837287;12591.496340146383;12618;12947.741045179138;13007.934960325232;4528.298113792367;4631;4650;4662.790174442158;4741.644376671729;55648.721756391365;55863.72068139674;56087.71956140234;57419.42580574183;58102.41897581012;11297.943510282561;11400.087992960543;11484.368359740294;11491.138164637685;11504.654860354203;20484.385468435972;20612.793872061087;20626.58746825055;20646.17415303371;20649.483762906046;8279.089300176976;8492.660293588311;8730.738077857675;8828.117188281249;8846.203841654282;4701.694389864716;4761.095391875532;4780.928286075712;4858.17411040124;4980.701157930535;3381.425157723193;3459.3081383723356;3465.3242617689307;3468.739844511672;3470.305938812248;619.0868469008177;635.9951276982357;637.4072112934922;637.5887552528593;649.3538928765909;631.8420394901275;688.683205725362;694.8193469697813;695.2248243208786;696.7456878239406;9242.630294788267;9246.95376523113;9349.719508414759;9534.713958581253;9852.605895764233;634.6763150793037;641.7016087519232;651.1827656291418;661.8047675935611;676.3270545806954;4318.35224716295;4422.425084738963;4439.089986552749;4505.189065968158;4631.073785242965;61789;62818;63045.684771576765;63209.68395158087;63338.366616333245;56314.43685563174;56373.7181314099;56538;58380;59042;49658.50341496611;49835.25247121296;50779.74610126999;53134.20298695523;54104.72947635315;9507.524623768923;9517.952410237904;9813.165880900204;9874.21006319507;9924.801503969737;35812.28375432529;35926.461103083995;36564.634353656125;36564.81717591395;37663;43429.782851086806;48282.758586206844;48704.51295487;49246.50753492419;50178.49821501738;13170.802437963246;13211.405486752927;13219.140755850838;13441.059125861097;13498.59504214875;14000.089994150349;14086.647833804236;14112.36494357777;14220.21788801626;14575.562733118024;10928.6721398355;13347.199168049949;13439.798403023768;13720.93139534296;13819.79270310926;12846;13156.541577846541;13374.799378009144;13500.459981600627;13789.724205515633;13307.66730831737;13609.319534023061;13669.179849209078;13677.658058548615;13718.245496497788;10746.247762656853;10821.945890270814;10905.890941090805;11022.283551569122;11076.39079850616;11330.490127944428;11353.881974388352;11603.767924641628;11649.88350116488;11674.182807203415 05:26:00 INFO - PROCESS | 30283 | __end_tp_report 05:26:00 INFO - PROCESS | 30283 | __start_cc_report 05:26:00 INFO - PROCESS | 30283 | _x_x_mozilla_cycle_collect,851 05:26:00 INFO - PROCESS | 30283 | __end_cc_report 05:26:00 INFO - PROCESS | 30283 | __startTimestamp1463660760086__endTimestamp 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | ------- Summary: start ------- 05:26:00 INFO - PROCESS | 30283 | Number of tests: 6 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | [#0] dojo.html Cycles:165 Average:5446.62 Median:5628.72 stddev:626.18 (11.1%) stddev-sans-first:601.50 05:26:00 INFO - PROCESS | 30283 | Values: 3144.7 3150.5 3161.9 3195.6 3212.2 5408.8 5415.1 5449.5 5500.3 5539.9 5463.4 5504.8 5514.8 5521.0 5529.3 4875.0 4991.1 5010.0 5030.4 5156.4 5055.5 5055.8 5087.1 5110.6 5126.4 4823.0 4894.0 4928.1 4934.3 5010.8 4921.0 4925.0 4978.9 4987.5 5034.9 4775.4 4931.4 4956.6 4974.1 5016.0 5373.3 5450.6 5460.7 5495.1 5529.7 5933.3 5945.1 5951.8 5972.9 5977.9 5754.4 5838.9 5887.6 5937.8 6028.4 5536.5 5546.5 5552.2 5560.8 5562.0 6040.7 6057.1 6060.2 6063.8 6092.7 5610.9 5638.3 5664.6 5684.1 5851.0 5787.5 5791.2 5800.7 5853.1 5859.1 5755.5 5767.5 5770.4 5771.3 5775.5 5703.3 5765.9 5809.6 5842.6 5883.6 4447.6 4456.7 4457.2 4457.3 4493.6 3880.2 3942.0 3982.4 3998.3 4031.9 5551.2 5595.3 5596.9 5603.9 5629.6 5914.3 5924.5 5933.4 5961.0 5970.2 5370.8 5460.0 5565.7 5608.9 5614.4 4991.2 5028.8 5030.5 5034.5 5073.8 6045.7 6055.7 6055.8 6059.5 6062.2 5728.5 5854.9 5882.9 5887.7 5904.2 6112.1 6126.7 6131.3 6136.2 6139.8 5787.9 5838.4 5842.9 5844.1 5888.1 5740.3 5804.5 5845.5 5863.5 5930.1 5749.9 5754.0 5754.3 5757.3 5761.3 5692.5 5731.5 5744.4 5750.4 5753.7 5488.4 5520.1 5576.2 5598.6 5616.9 5742.9 5793.1 5806.0 5813.4 5813.6 5505.7 5585.6 5628.7 5639.9 5641.4 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | [#1] ext.html Cycles:180 Average:58868.33 Median:423755.50 stddev:114125.23 (26.9%) stddev-sans-first:114361.53 05:26:00 INFO - PROCESS | 30283 | Values: 599.4 647.0 649.1 654.4 655.1 31921.4 44455.3 45115.3 45180.3 45253.0 46468.5 47012.0 47092.3 47100.0 47106.3 8811.8 9025.7 9028.2 9032.6 9040.5 8843.6 8962.3 8965.3 8965.8 8971.9 9034.9 9083.3 9084.3 9084.5 9087.6 8938.6 8984.8 9020.5 9025.9 9036.1 8914.1 8982.1 9001.1 9011.8 9013.0 42525.6 42875.8 42905.6 42921.8 42969.0 3774.8 3847.4 3882.6 4064.0 4072.3 32602.5 33171.7 33276.3 33429.8 33465.3 4285.5 4358.2 4388.9 4401.0 4423.0 319818.0 321421.0 322327.0 322667.0 323076.4 59998.7 60189.4 60577.4 60670.0 60710.7 55798.4 61012.9 62958.0 62988.7 63114.4 15818.1 16826.7 16840.9 16843.4 16846.7 13112.3 13208.0 13219.3 13220.3 13222.4 16199.3 17456.0 17910.7 17914.5 18392.8 6450.5 6562.8 6579.5 6671.7 6724.6 1023.6 1129.7 1185.0 1226.5 1240.1 32879.8 33507.5 33873.3 33970.0 34128.7 1179.1 1180.2 1206.8 1217.6 1291.7 16916.3 17892.1 17894.6 17907.4 17925.0 520881.0 523814.0 524528.0 526310.0 526315.0 51258.0 51433.2 51479.5 51728.5 51842.0 1415.1 1423.6 1440.0 1463.8 1470.6 31092.4 32382.8 32712.8 32987.5 33371.5 51830.5 52550.0 52720.0 52769.7 52826.2 418651.0 422362.0 423545.0 423966.0 425072.0 25318.0 27605.4 28455.1 28814.8 28831.6 43556.3 43872.3 48025.8 48411.8 48790.5 40560.6 40581.2 40762.8 41811.4 42158.2 40791.6 40819.0 40880.8 41066.2 41566.4 40824.4 41528.4 42476.4 42518.1 42558.4 36032.3 36211.8 36553.6 36684.0 37073.4 28155.2 28300.3 28581.9 28830.3 29025.9 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | [#2] jquery.html Cycles:180 Average:23368.70 Median:11100.90 stddev:53446.01 (481.5%) stddev-sans-first:53568.13 05:26:00 INFO - PROCESS | 30283 | Values: 404.6 404.8 410.4 412.1 422.7 14223.5 18290.0 19799.1 19805.1 20006.8 17559.2 18105.0 18231.0 19342.6 19598.0 5236.4 5394.6 5404.5 5406.3 5427.3 3880.9 5339.3 5375.2 5376.7 5382.6 5613.5 5886.5 5890.4 5979.4 5987.8 5912.0 5964.7 6057.5 6507.8 6526.4 5647.6 5770.1 5773.5 5775.7 5796.9 14208.0 14235.5 14238.9 14239.9 17453.6 2340.3 2480.4 2518.1 2570.8 2822.1 10231.3 10303.2 10339.3 10810.7 10814.3 1769.5 1958.9 2025.4 2031.2 2093.2 80124.0 81725.0 83035.6 83424.0 83984.2 10910.8 11080.8 11155.3 11169.6 12091.6 15479.4 15577.2 15621.8 15643.5 15654.5 7808.4 7893.6 7924.5 8001.6 8022.0 7321.1 7359.4 7379.4 7428.6 7535.6 4829.9 4858.2 4866.9 4915.7 4934.8 1964.8 1986.6 1987.7 2008.4 2041.9 900.9 964.9 1024.5 1053.1 1151.0 18886.7 19413.0 19770.6 19957.5 20176.4 1022.2 1022.4 1032.8 1084.4 1091.7 10796.6 11307.6 11451.7 11474.3 11514.9 164988.0 166103.0 323632.0 328947.0 474435.0 74082.3 84711.6 85026.6 93558.0 96801.5 1117.1 1135.2 1159.4 1180.3 1181.3 17616.2 17879.8 17900.1 18192.5 18274.6 41567.8 41720.4 42249.4 42439.2 43494.8 58102.0 60304.1 60741.7 61017.4 62041.4 8746.5 8951.7 9052.7 9069.8 9420.0 10403.6 12667.6 12973.9 13837.3 14141.6 12275.8 12325.3 12493.9 12495.9 13006.7 12080.3 12108.5 12357.8 12427.9 12522.9 12536.8 12602.6 12633.1 12711.2 12814.6 8958.2 9007.2 9061.5 9097.0 9279.3 11917.8 12444.5 12534.1 12558.6 12592.7 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | [#3] mootools.html Cycles:180 Average:6046.48 Median:485.84 stddev:3449.80 (710.1%) stddev-sans-first:3441.73 05:26:00 INFO - PROCESS | 30283 | Values: 1390.5 1553.9 1584.1 1765.9 1850.0 8651.4 8998.1 9002.3 9238.8 9245.4 8894.1 9132.1 9137.5 9139.0 9150.7 2151.4 2222.9 2410.4 2469.8 2493.0 2528.6 2547.8 2549.0 2549.1 2554.9 2464.0 2475.3 2477.8 2478.4 2478.9 2110.7 2351.3 2371.3 2443.5 2447.7 2436.9 2437.0 2443.1 2464.6 2466.2 9212.0 9238.3 9275.3 9279.2 9291.8 5479.3 5588.7 5597.6 5602.3 5605.2 3499.4 3521.1 3533.0 3539.5 3580.9 1145.4 1175.6 1177.0 1184.2 1233.2 12744.8 12775.4 12783.0 12783.0 12812.8 4892.5 4929.1 4961.7 4970.2 5017.1 10536.8 10560.9 10583.9 10629.3 10642.7 5427.7 5432.7 5438.2 5439.6 5441.1 4474.0 5031.8 5163.9 5177.7 5234.0 4139.6 4171.0 4213.7 4246.2 4251.3 1347.5 1357.7 1359.3 1375.3 1382.7 993.4 997.3 1009.5 1023.9 1030.6 6171.6 6175.6 6184.7 6266.2 6311.4 474.1 483.3 488.4 490.5 493.2 4251.3 4278.4 4285.6 4313.6 4356.9 11275.9 11518.4 11583.3 11611.7 11619.5 11068.8 11262.2 11330.9 11417.7 11434.3 8359.5 8420.5 8425.2 8511.0 8516.9 5985.2 5998.3 6152.0 6196.3 6352.8 10340.5 10437.7 10660.8 10678.8 10759.7 10682.9 10753.7 10865.4 10939.6 10956.8 7225.6 7591.4 7991.4 8051.0 8119.6 8905.5 8912.7 8955.1 8979.3 8985.6 7901.5 8009.3 8019.0 8161.4 8246.9 7934.2 7978.2 8009.4 8162.2 8199.3 7008.1 7179.8 7355.8 7443.7 7452.3 5112.3 5232.0 5527.3 5557.1 5568.5 5388.5 5431.2 5439.1 5539.1 5553.5 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | [#4] prototype.html Cycles:180 Average:4738.68 Median:5481.53 stddev:1401.39 (25.6%) stddev-sans-first:1365.57 05:26:00 INFO - PROCESS | 30283 | Values: 323.4 333.1 335.7 340.5 341.1 5263.9 5343.2 5350.4 5389.5 5407.9 5309.8 5324.5 5342.5 5361.4 5369.5 4186.7 4203.3 4215.8 4235.0 4263.5 3963.8 4065.2 4192.9 4213.9 4216.8 4166.1 4178.6 4179.8 4191.8 4216.5 3995.8 4161.7 4170.2 4175.7 4233.1 3539.3 3614.8 3630.0 3630.0 3637.4 5127.9 5172.9 5173.1 5173.1 5203.6 4628.1 4716.4 4727.5 4728.4 4742.4 5491.8 5495.8 5521.8 5551.4 5568.4 4008.3 4022.6 4027.5 4041.5 4049.9 5599.0 5859.5 5861.2 5879.3 5884.9 4099.4 4101.0 4112.5 4113.9 4116.0 4120.0 4173.5 4176.8 4181.7 4198.9 4724.2 4733.3 4740.3 4747.3 4785.9 5474.2 5597.8 5599.3 5622.8 5623.0 1435.4 1441.6 1447.7 1456.5 1458.9 912.4 937.6 947.3 950.3 966.5 4869.7 5251.8 5354.8 5525.8 5535.0 5815.5 5839.3 5844.3 5873.8 5886.5 5354.4 5543.2 5545.8 5556.5 5563.5 3075.5 3080.4 3117.4 3127.9 3130.5 5972.5 5988.8 5996.6 6045.4 6069.2 5597.6 5934.4 5938.8 5952.2 5953.4 5902.8 5929.8 5987.9 5995.0 5998.6 5639.0 5842.9 5855.3 5874.9 5886.6 5692.7 5707.5 5712.4 5765.9 5773.0 6021.4 6027.6 6040.8 6054.5 6062.8 3927.5 4041.1 4106.0 4117.2 4132.8 5766.7 5807.4 5816.9 5884.9 5907.0 5558.7 5654.0 5736.7 5743.2 5762.6 5532.1 5568.2 5577.8 5594.0 5610.2 5488.9 5515.3 5517.9 5567.8 5583.5 5398.5 5504.8 5583.7 5622.9 5644.3 5518.7 5537.4 5542.2 5552.9 5561.4 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - PROCESS | 30283 | [#5] yui.html Cycles:180 Average:15453.12 Median:4721.67 stddev:17670.80 (374.2%) stddev-sans-first:17685.77 05:26:00 INFO - PROCESS | 30283 | Values: 729.2 796.7 806.9 835.3 871.1 14223.6 14977.2 14997.2 15000.0 15021.8 14010.2 14031.4 14064.6 14071.6 14074.2 683.9 703.1 703.4 703.6 811.7 829.9 834.8 835.4 837.2 837.9 871.2 879.6 882.3 883.6 884.9 719.9 742.1 876.3 878.1 878.8 546.5 625.4 641.9 644.9 647.4 14228.0 14241.6 14247.5 14282.4 14282.9 13536.6 13893.4 13899.5 13929.3 13987.9 12539.7 12591.5 12618.0 12947.7 13007.9 4528.3 4631.0 4650.0 4662.8 4741.6 55648.7 55863.7 56087.7 57419.4 58102.4 11297.9 11400.1 11484.4 11491.1 11504.7 20484.4 20612.8 20626.6 20646.2 20649.5 8279.1 8492.7 8730.7 8828.1 8846.2 4701.7 4761.1 4780.9 4858.2 4980.7 3381.4 3459.3 3465.3 3468.7 3470.3 619.1 636.0 637.4 637.6 649.4 631.8 688.7 694.8 695.2 696.7 9242.6 9247.0 9349.7 9534.7 9852.6 634.7 641.7 651.2 661.8 676.3 4318.4 4422.4 4439.1 4505.2 4631.1 61789.0 62818.0 63045.7 63209.7 63338.4 56314.4 56373.7 56538.0 58380.0 59042.0 49658.5 49835.3 50779.7 53134.2 54104.7 9507.5 9518.0 9813.2 9874.2 9924.8 35812.3 35926.5 36564.6 36564.8 37663.0 43429.8 48282.8 48704.5 49246.5 50178.5 13170.8 13211.4 13219.1 13441.1 13498.6 14000.1 14086.6 14112.4 14220.2 14575.6 10928.7 13347.2 13439.8 13720.9 13819.8 12846.0 13156.5 13374.8 13500.5 13789.7 13307.7 13609.3 13669.2 13677.7 13718.2 10746.2 10821.9 10905.9 11022.3 11076.4 11330.5 11353.9 11603.8 11649.9 11674.2 05:26:00 INFO - PROCESS | 30283 | -------- Summary: end -------- 05:26:00 INFO - PROCESS | 30283 | 05:26:00 INFO - TEST-INFO | 30283: exit 0 05:26:00 INFO - TEST-OK | dromaeo_css | took 1113183ms 05:26:00 INFO - TEST-START | kraken 05:26:00 INFO - operating with platform_type : linux_ 05:26:00 INFO - Initialising browser for kraken test... 05:26:00 INFO - TEST-INFO | started process 30468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptO8S8d/profile http://localhost:58240/getInfo.html) 05:26:04 INFO - PROCESS | 30468 | __metrics Screen width/height:1600/1200 05:26:04 INFO - PROCESS | 30468 | colorDepth:24 05:26:04 INFO - PROCESS | 30468 | Browser inner width/height: 1024/697 05:26:04 INFO - PROCESS | 30468 | __metrics 05:26:06 ERROR - PROCESS | 30468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:26:06 INFO - TEST-INFO | 30468: exit 0 05:26:06 INFO - Browser initialized. 05:26:06 INFO - Running cycle 1/1 for kraken test... 05:26:06 INFO - TEST-INFO | started process 30550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptO8S8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:18 INFO - PROCESS | 30550 | RSS: Main: 152698880 05:26:18 INFO - PROCESS | 30550 | 05:26:21 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:22 INFO - PROCESS | 30550 | RSS: Main: 209117184 05:26:22 INFO - PROCESS | 30550 | 05:26:24 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-dft) 05:26:25 INFO - PROCESS | 30550 | RSS: Main: 197226496 05:26:25 INFO - PROCESS | 30550 | 05:26:28 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-fft) 05:26:29 INFO - PROCESS | 30550 | RSS: Main: 265900032 05:26:29 INFO - PROCESS | 30550 | 05:26:31 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-oscillator) 05:26:32 INFO - PROCESS | 30550 | RSS: Main: 175058944 05:26:32 INFO - PROCESS | 30550 | 05:26:34 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:34 INFO - PROCESS | 30550 | RSS: Main: 179367936 05:26:34 INFO - PROCESS | 30550 | 05:26:38 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:38 INFO - PROCESS | 30550 | RSS: Main: 214487040 05:26:38 INFO - PROCESS | 30550 | 05:26:42 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:42 INFO - PROCESS | 30550 | RSS: Main: 213073920 05:26:42 INFO - PROCESS | 30550 | 05:26:45 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58240/tests/kraken/driver.html?testName=json-parse-financial) 05:26:46 INFO - PROCESS | 30550 | RSS: Main: 214360064 05:26:46 INFO - PROCESS | 30550 | 05:26:48 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:48 INFO - PROCESS | 30550 | RSS: Main: 204865536 05:26:48 INFO - PROCESS | 30550 | 05:26:50 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:51 INFO - PROCESS | 30550 | RSS: Main: 208412672 05:26:51 INFO - PROCESS | 30550 | 05:26:53 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:53 INFO - PROCESS | 30550 | RSS: Main: 217669632 05:26:53 INFO - PROCESS | 30550 | 05:26:56 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:57 INFO - PROCESS | 30550 | RSS: Main: 223850496 05:26:57 INFO - PROCESS | 30550 | 05:27:00 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:00 INFO - PROCESS | 30550 | RSS: Main: 219598848 05:27:00 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58240/tests/kraken/driver.html?testName=ai-astar) 05:27:02 INFO - PROCESS | 30550 | RSS: Main: 266051584 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | __start_tp_report 05:27:02 INFO - PROCESS | 30550 | _x_x_mozilla_page_load 05:27:02 INFO - PROCESS | 30550 | _x_x_mozilla_page_load_details 05:27:02 INFO - PROCESS | 30550 | |i|pagename|runs| 05:27:02 INFO - PROCESS | 30550 | |0;ai-astar;112;107;110;113;113;113;111;111;112;111 05:27:02 INFO - PROCESS | 30550 | |1;audio-beat-detection;159;125;147;212;126;149;148;126;179;126 05:27:02 INFO - PROCESS | 30550 | |2;audio-dft;167;162;161;161;162;164;162;163;160;161 05:27:02 INFO - PROCESS | 30550 | |3;audio-fft;76;75;77;152;75;73;76;75;152;74 05:27:02 INFO - PROCESS | 30550 | |4;audio-oscillator;92;92;154;92;92;91;125;93;92;135 05:27:02 INFO - PROCESS | 30550 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;117;116;117 05:27:02 INFO - PROCESS | 30550 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 05:27:02 INFO - PROCESS | 30550 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;95 05:27:02 INFO - PROCESS | 30550 | |8;json-parse-financial;52;55;54;52;53;52;54;105;51;52 05:27:02 INFO - PROCESS | 30550 | |9;json-stringify-tinderbox;58;60;59;59;59;59;59;59;59;59 05:27:02 INFO - PROCESS | 30550 | |10;stanford-crypto-aes;79;79;83;81;82;79;79;79;83;78 05:27:02 INFO - PROCESS | 30550 | |11;stanford-crypto-ccm;122;122;121;119;120;125;126;128;197;137 05:27:02 INFO - PROCESS | 30550 | |12;stanford-crypto-pbkdf2;165;163;164;165;163;162;167;164;167;162 05:27:02 INFO - PROCESS | 30550 | |13;stanford-crypto-sha256-iterative;62;64;65;65;62;62;62;63;62;62 05:27:02 INFO - PROCESS | 30550 | __end_tp_report 05:27:02 INFO - PROCESS | 30550 | __start_cc_report 05:27:02 INFO - PROCESS | 30550 | _x_x_mozilla_cycle_collect,1862 05:27:02 INFO - PROCESS | 30550 | __end_cc_report 05:27:02 INFO - PROCESS | 30550 | __startTimestamp1463660822606__endTimestamp 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | ------- Summary: start ------- 05:27:02 INFO - PROCESS | 30550 | Number of tests: 14 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.83 (1.6%) stddev-sans-first:1.92 05:27:02 INFO - PROCESS | 30550 | Values: 112.0 107.0 110.0 113.0 113.0 113.0 111.0 111.0 112.0 111.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:148.50 stddev:28.15 (19.0%) stddev-sans-first:29.66 05:27:02 INFO - PROCESS | 30550 | Values: 159.0 125.0 147.0 212.0 126.0 149.0 148.0 126.0 179.0 126.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.00 (1.2%) stddev-sans-first:1.20 05:27:02 INFO - PROCESS | 30550 | Values: 167.0 162.0 161.0 161.0 162.0 164.0 162.0 163.0 160.0 161.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#3] audio-fft Cycles:10 Average:90.50 Median:75.00 stddev:32.43 (43.2%) stddev-sans-first:33.97 05:27:02 INFO - PROCESS | 30550 | Values: 76.0 75.0 77.0 152.0 75.0 73.0 76.0 75.0 152.0 74.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:92.00 stddev:23.28 (25.3%) stddev-sans-first:24.16 05:27:02 INFO - PROCESS | 30550 | Values: 92.0 92.0 154.0 92.0 92.0 91.0 125.0 93.0 92.0 135.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:27:02 INFO - PROCESS | 30550 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:27:02 INFO - PROCESS | 30550 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:27:02 INFO - PROCESS | 30550 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:52.50 stddev:16.56 (31.5%) stddev-sans-first:17.42 05:27:02 INFO - PROCESS | 30550 | Values: 52.0 55.0 54.0 52.0 53.0 52.0 54.0 105.0 51.0 52.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 05:27:02 INFO - PROCESS | 30550 | Values: 58.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:1.87 (2.3%) stddev-sans-first:1.94 05:27:02 INFO - PROCESS | 30550 | Values: 79.0 79.0 83.0 81.0 82.0 79.0 79.0 79.0 83.0 78.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:125.50 stddev:23.53 (18.8%) stddev-sans-first:24.70 05:27:02 INFO - PROCESS | 30550 | Values: 122.0 122.0 121.0 119.0 120.0 125.0 126.0 128.0 197.0 137.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 05:27:02 INFO - PROCESS | 30550 | Values: 165.0 163.0 164.0 165.0 163.0 162.0 167.0 164.0 167.0 162.0 05:27:02 INFO - PROCESS | 30550 | 05:27:02 INFO - PROCESS | 30550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:1.29 (2.1%) stddev-sans-first:1.32 05:27:02 INFO - PROCESS | 30550 | Values: 62.0 64.0 65.0 65.0 62.0 62.0 62.0 63.0 62.0 62.0 05:27:02 INFO - PROCESS | 30550 | -------- Summary: end -------- 05:27:02 INFO - PROCESS | 30550 | 05:27:03 INFO - TEST-INFO | 30550: exit 0 05:27:03 INFO - TEST-OK | kraken | took 62797ms 05:27:03 INFO - SUITE-END | took 1175s 05:27:03 INFO - Completed test suite (00:19:36) 05:27:03 INFO - javascript benchmark 05:27:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.701253380929, 3150.527420886867, 3161.889333873315, 3195.568598239237, 3212.164837142342, 5408.810691625794, 5415.106507426275, 5449.482299181582, 5500.312460942382, 5539.861503462415, 5463.426340234278, 5504.80733174339, 5514.779408823642, 5521.033819081655, 5529.281193444856, 4874.97562512187, 4991.126552853236, 5010.0, 5030.396352437694, 5156.407013193474, 5055.545000949914, 5055.848324550269, 5087.058894104584, 5110.6422550421485, 5126.359205099363, 4822.97588512057, 4894.0, 4928.063667903105, 4934.333864928225, 5010.7995680172935, 4921.0, 4924.975375123137, 4978.87552811179, 4987.526185012418, 5034.924476132861, 4775.426948766136, 4931.3589233399425, 4956.6282528810125, 4974.054929563371, 5016.046951079284, 5373.328333958255, 5450.618456708032, 5460.672359658433, 5495.065838807413, 5529.723513824292, 5933.3473317934995, 5945.078512830518, 5951.791687290967, 5972.850678733023, 5977.8804423911715, 5754.424557544212, 5838.941610583882, 5887.646741195499, 5937.762489500415, 6028.367021462727, 5536.529395001429, 5546.528545073674, 5552.194931734956, 5560.805371812007, 5561.99999999996, 6040.728023341186, 6057.098957891561, 6060.154113845389, 6063.804890679235, 6092.695365231721, 5610.887782244332, 5638.2670252866865, 5664.631798933056, 5684.062129748628, 5851.0, 5787.536997040227, 5791.160281759121, 5800.738966746507, 5853.0635098384055, 5859.062549991981, 5755.453231942959, 5767.509761670305, 5770.394108618619, 5771.307443106854, 5775.5090817281, 5703.315602127688, 5765.884682306414, 5809.564282678816, 5842.5618078644275, 5883.61756485827, 4447.644188464915, 4456.732596044248, 4457.153140903218, 4457.286834106528, 4493.573110554557, 3880.223955208913, 3942.0, 3982.3827306766916, 3998.2603218404106, 4031.91936161281, 5551.195076713934, 5595.300587426572, 5596.944030559724, 5603.887922241533, 5629.634073785191, 5914.260717410324, 5924.466797988115, 5933.3769954154195, 5961.0, 5970.194023806731, 5370.838874833761, 5459.962607104638, 5565.693886836263, 5608.887822243614, 5614.382417934024, 4991.176455884811, 5028.773705183203, 5030.496950305013, 5034.546890779774, 5073.847784566469, 6045.667488288098, 6055.7274922628585, 6055.757769689163, 6059.48494377974, 6062.151298818169, 5728.513076388554, 5854.9121763174435, 5882.941170588239, 5887.735051922588, 5904.232449781673, 6112.108359148444, 6126.700892189639, 6131.3460828618745, 6136.243373036893, 6139.768135342541, 5787.94212057874, 5838.4453476919625, 5842.912356314574, 5844.12338149264, 5888.087346461305, 5740.253767010262, 5804.5356371491025, 5845.473907348359, 5863.530917526673, 5930.080837470199, 5749.942500575108, 5754.021816291324, 5754.280714910637, 5757.251557297524, 5761.337446193741, 5692.48767610917, 5731.541476681939, 5744.396838331915, 5750.424957504216, 5753.741081651252, 5488.396276409512, 5520.1443776214755, 5576.247206627054, 5598.580106492111, 5616.887662246814, 5742.913856292243, 5793.102069179284, 5806.042003069446, 5813.447722466359, 5813.593048486735, 5505.697186654773, 5585.636933599303, 5628.718564071862, 5639.928413601403, 5641.379448260606], "value": 5403.842784536744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.3916175082293, 646.954713170078, 649.0880313160011, 654.4175683641558, 655.1221363373079, 31921.361572768532, 44455.33317000248, 45115.32327015098, 45180.32229516552, 45252.999999999956, 46468.53531464684, 47012.0, 47092.29361559571, 47100.0, 47106.293405598946, 8811.77970550735, 9025.684101056464, 9028.232600228956, 9032.638694452215, 9040.457572545669, 8843.646254149826, 8962.32782541312, 8965.32760042996, 8965.775855603597, 8971.910280897173, 9034.86447703285, 9083.318751093695, 9084.273258139367, 9084.454932704059, 9087.636494540211, 8938.597763100675, 8984.820303593924, 9020.503872287021, 9025.864612030824, 9036.096390360944, 8914.064023277591, 8982.10178982103, 9001.144891235323, 9011.819763604757, 9013.0, 42525.57474425247, 42875.78562107169, 42905.57094429078, 42921.78539107316, 42969.0, 3774.792386418746, 3847.3844184930276, 3882.5535063467496, 4063.96691843872, 4072.348424252135, 32602.510962335586, 33171.6682833171, 33276.33447331064, 33429.83285083559, 33465.33069338599, 4285.507166675841, 4358.193734159191, 4388.934165987513, 4400.977995110036, 4423.0, 319818.0, 321421.0, 322327.0, 322667.0, 323076.3846180778, 59998.70000649969, 60189.39810601925, 60577.39422605806, 60670.0, 60710.69644651748, 55798.442015580134, 61012.89871012952, 62958.0, 62988.685056574424, 63114.36885631085, 15818.130002849954, 16826.747598786027, 16840.915795421188, 16843.41048063312, 16846.747298790528, 13112.278824664545, 13208.0, 13219.272939988394, 13220.272884991226, 13222.404991775393, 16199.271032803552, 17456.0, 17910.731339029924, 17914.46256612304, 18392.816071839112, 6450.4839612830865, 6562.80311590653, 6579.4736421087155, 6671.699773510204, 6724.620303756975, 1023.6314926626409, 1129.6611016694958, 1184.9927561572595, 1226.5093962414926, 1240.1257113734976, 32879.83560082184, 33507.49738753921, 33873.32253354919, 33970.0, 34128.658713413046, 1179.1274456902001, 1180.2328486483855, 1206.831043653889, 1217.598192596441, 1291.6770807298176, 16916.32334706598, 17892.10539473021, 17894.55263618394, 17907.37324193647, 17925.0, 520881.0, 523814.0, 524528.0, 526310.0, 526315.0, 51258.0, 51433.22850157251, 51479.485205148216, 51728.48271517312, 51842.0, 1415.1226239731432, 1423.5586968039734, 1440.0495672855866, 1463.778939507095, 1470.5735336752223, 31092.378152437275, 32382.83808580942, 32712.83643581767, 32987.505187422685, 33371.499427509094, 51830.48169518408, 52550.0, 52720.0, 52769.736151319, 52826.20760688516, 418651.0, 422362.0, 423545.0, 423966.0, 425072.0, 25318.0, 27605.447891041666, 28455.146345609664, 28814.838887083133, 28831.5675264867, 43556.34665480084, 43872.34191487194, 48025.759871201815, 48411.75794121007, 48790.5120948786, 40560.59439405568, 40581.1883762329, 40762.79618601888, 41811.37282940697, 42158.15683686248, 40791.59208407878, 40819.0, 40880.79559602183, 41066.1786764269, 41566.37650435185, 40824.38763418492, 41528.377074343305, 42476.362854557825, 42518.14963700771, 42558.361624576275, 36032.27935441329, 36211.81894090513, 36553.63446365609, 36684.0, 37073.44389834101, 28155.155345339674, 28300.292492687848, 28581.857090714413, 28830.279243019093, 29025.85487072551], "value": 20342.543268268713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.5893418180547, 404.81783197561106, 410.35164440184514, 412.14384316685357, 422.7167797575624, 14223.502177423792, 18290.0, 19799.109040093175, 19805.108770105344, 20006.799932000675, 17559.209835557398, 18105.0, 18231.0, 19342.613147737036, 19598.0, 5236.371635403747, 5394.622376433651, 5404.513593776559, 5406.324209473816, 5427.3215848019, 3880.9223815523674, 5339.332583427072, 5375.247465354853, 5376.731163441832, 5382.569394448455, 5613.494785469307, 5886.499647529965, 5890.440408161217, 5979.431953964388, 5987.760489580433, 5912.0, 5964.671943043131, 6057.485113765335, 6507.837304067436, 6526.445252153572, 5647.604667673265, 5770.076787713946, 5773.451522105393, 5775.740091695884, 5796.88406231873, 14208.0, 14235.50175743844, 14238.928805355907, 14239.857601423957, 17453.56366090845, 2340.33300509354, 2480.441900572375, 2518.106072344328, 2570.8457492550506, 2822.1251412062325, 10231.283810133295, 10303.227257955608, 10339.327943683711, 10810.67567972962, 10814.297070690458, 1769.5222289981632, 1958.8628795984287, 2025.4126303372152, 2031.238285642884, 2093.1522733292886, 80124.0, 81725.0, 83035.5848220755, 83424.0, 83984.16015839824, 10910.836337454944, 11080.833787493195, 11155.27490713101, 11169.553217871357, 12091.637250882488, 15479.380824766884, 15577.221138943007, 15621.812946187543, 15643.530694079196, 15654.45209417665, 7808.375329973588, 7893.565853878092, 7924.48490848093, 8001.639926203218, 8021.959890200512, 7321.084864391951, 7359.37445317154, 7379.446541509408, 7428.554286742705, 7535.623218839036, 4829.9275510867365, 4858.222684370484, 4866.902661946741, 4915.65590408668, 4934.753262336869, 1964.8329891959343, 1986.5629561496448, 1987.7415935928525, 2008.4275981345538, 2041.9081141348674, 900.9189172974333, 964.8504481805331, 1024.538957469127, 1053.115383078218, 1150.988490115105, 18886.716699249522, 19413.0, 19770.60458790816, 19957.452927962586, 20176.39470815878, 1022.2333250062453, 1022.3967858963099, 1032.767627283855, 1084.3819023156725, 1091.6888686724246, 10796.622118225825, 11307.604233851776, 11451.713707157222, 11474.254173478697, 11514.884851151548, 164988.0, 166103.0, 323632.0, 328947.0, 474435.0, 74082.25917740862, 84711.5764421174, 85026.57486712527, 93558.0, 96801.515992421, 1117.0616681987008, 1135.2167004766684, 1159.4202898550725, 1180.2977228549, 1181.3207405741732, 17616.207270673105, 17879.821201788334, 17900.10499474995, 18192.545186370447, 18274.634507310046, 41567.79216104021, 41720.3741943865, 42249.366259505514, 42439.15121697487, 43494.78252608717, 58102.0, 60304.09543856933, 60741.69629151826, 61017.389826102946, 62041.37958620356, 8746.518941458025, 8951.686690965786, 9052.683156089506, 9069.818603627758, 9419.952900235456, 10403.58385664565, 12667.556635517712, 12973.870261297267, 13837.308134593432, 14141.646458838612, 12275.815862762245, 12325.322107284186, 12493.875061249271, 12495.891475184395, 13006.739865202831, 12080.275183489019, 12108.455119519467, 12357.814632780335, 12427.875721242672, 12522.937385313015, 12536.811947820972, 12602.55891043809, 12633.115681902178, 12711.237325760483, 12814.55149069778, 8958.238549723086, 9007.189352958003, 9061.546922653974, 9096.954515227382, 9279.304052195977, 11917.76164476723, 12444.502219911103, 12534.059945504307, 12558.623241302776, 12592.685182870502], "value": 9161.633188321588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.5480718766403, 1553.9300731467083, 1584.0812328849265, 1765.9051388139349, 1849.963000739986, 8651.351148663853, 8998.145176208258, 9002.279817614592, 9238.81522369554, 9245.352825302232, 8894.066123057082, 9132.086791320864, 9137.497437640926, 9138.954305228464, 9150.679726209584, 2151.365347222565, 2222.8777417242045, 2410.4214988402746, 2469.802415806731, 2493.0401795308844, 2528.5954247320433, 2547.821652484327, 2549.0441084593276, 2549.056848965876, 2554.859482728449, 2463.9753602463925, 2475.344033831036, 2477.801775857927, 2478.429961108946, 2478.925632231036, 2110.7361579802523, 2351.306364622432, 2371.2530552875787, 2443.4624382635793, 2447.669564608773, 2436.90252389906, 2437.0, 2443.0716327795503, 2464.5687004774272, 2466.161505088279, 9212.0, 9238.307126965505, 9275.257979361635, 9279.21126704231, 9291.76770580734, 5479.287692599976, 5588.748506317185, 5597.608167428281, 5602.327720673546, 5605.215269862222, 3499.4051011328133, 3521.1197200699826, 3532.975437123231, 3539.522164507784, 3580.946285805715, 1145.3872178384524, 1175.6061719324036, 1176.9764604707943, 1184.24208506555, 1233.1552886272932, 12744.80882786759, 12775.425105870258, 12783.0, 12783.0, 12812.80780788289, 4892.461829198785, 4929.13740095489, 4961.652684312064, 4970.15507363749, 5017.122003649347, 10536.841947370796, 10560.894391056145, 10583.894161058292, 10629.309094908805, 10642.680719578426, 5427.728613569306, 5432.728363581805, 5438.15708565173, 5439.619226654097, 5441.102218134043, 4473.955260447419, 5031.77357018935, 5163.896722065538, 5177.741112944338, 5233.973830130901, 4139.5653456387245, 4171.0, 4213.726107802983, 4246.150769846043, 4251.277282861921, 1347.508159521787, 1357.6741582020245, 1359.2727890578492, 1375.277979061001, 1382.7165431086603, 993.3692105512907, 997.3317877022413, 1009.4700282351824, 1023.8771347438206, 1030.5877648940484, 6171.59884607499, 6175.59858609189, 6184.7249545533605, 6266.24805023391, 6311.400416960381, 474.1157740813358, 483.2678492084495, 488.4041469407317, 490.53644306130366, 493.1640868727544, 4251.319788833834, 4278.44380230568, 4285.6142947134285, 4313.568643135724, 4356.934645980313, 11275.887241127648, 11518.36648984297, 11583.305001699924, 11611.709707257387, 11619.53521859133, 11068.833967490495, 11262.155338349656, 11330.94334528322, 11417.714557135972, 11434.256773309708, 8359.540225287668, 8420.4947703138, 8425.199606037417, 8511.0, 8516.914830851736, 5985.221921150222, 5998.280206375263, 6152.0156774915795, 6196.287426945959, 6352.841178970562, 10340.53467593975, 10437.68686939393, 10660.786784264426, 10678.786424271315, 10759.731006724895, 10682.946585267335, 10753.73115672083, 10865.402402867918, 10939.617113400993, 10956.780864382827, 7225.602591857288, 7591.43064270193, 7991.440599158003, 8051.033875934925, 8119.59402029908, 8905.465672059698, 8912.73261802147, 8955.104489551253, 8979.281657467518, 8985.595648195978, 7901.525908445512, 8009.3192078673965, 8019.03771547418, 8161.387895907712, 8246.917530824854, 7934.166912474338, 7978.162292959156, 8009.359251259769, 8162.224588664068, 8199.303059240032, 7008.0889484368745, 7179.784606461814, 7355.77932662021, 7443.739469118555, 7452.292032256927, 5112.335396398593, 5232.03207406631, 5527.336719593674, 5557.055300598989, 5568.470995255444, 5388.464287677993, 5431.158170483582, 5439.102548079681, 5539.113741801292, 5553.472420120243], "value": 4764.469467993318, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4259189937861, 333.09066249139863, 335.68110295219543, 340.48756621284963, 341.05697745733045, 5263.921041184385, 5343.225232341309, 5350.438203988583, 5389.541888939435, 5407.864803379917, 5309.787608495655, 5324.467553244684, 5342.492463215998, 5361.356637203531, 5369.5167434930845, 4186.665066794649, 4203.327467605184, 4215.768132752705, 4235.0, 4263.509696384909, 3963.7621742695387, 4065.166640838636, 4192.916141677165, 4213.873583792491, 4216.831326746927, 4166.145940082276, 4178.623923846853, 4179.811908464111, 4191.7694526801015, 4216.536181020086, 3995.760254384717, 4161.667066634662, 4170.16596680662, 4175.686823488235, 4233.111046680186, 3539.2744487380023, 3614.8011859347725, 3629.981850090759, 3630.0198946284618, 3637.381645120336, 5127.948720512784, 5172.948270517322, 5173.068847607429, 5173.146430838907, 5203.635745497817, 4628.143793398232, 4716.3868697069165, 4727.534464316039, 4728.40894888139, 4742.383490146293, 5491.752871120809, 5495.835124946258, 5521.806736764194, 5551.444855514416, 5568.387477377485, 4008.2985477541315, 4022.597740225983, 4027.496562929634, 4041.4544036554985, 4049.9392509112386, 5599.0, 5859.53123750099, 5861.238039054895, 5879.294484661825, 5884.852878678024, 4099.405586189986, 4100.979495102505, 4112.547619761824, 4113.876583702494, 4115.991582062414, 4120.0, 4173.478315210598, 4176.832926682899, 4181.686373521937, 4198.85304014358, 4724.196886529298, 4733.266343716729, 4740.317187398493, 4747.287906813936, 4785.856424307276, 5474.178873169057, 5597.776088956478, 5599.348192283286, 5622.7750889963945, 5622.971885140548, 1435.397133204057, 1441.6467965348556, 1447.65256338478, 1456.4975083596141, 1458.8978771486106, 912.4023764434173, 937.5640327247862, 947.2611363136764, 950.2920324358397, 966.5312323523086, 4869.6591238612955, 5251.842444726664, 5354.812581559627, 5525.778968841281, 5535.03136951032, 5815.534757219412, 5839.328477225174, 5844.26946631671, 5873.765049398062, 5886.470217680429, 5354.3842458117815, 5543.196236545678, 5545.833624991256, 5556.527695145958, 5563.5271001964475, 3075.4617941860083, 3080.4147212029643, 3117.4388610049955, 3127.9218019549694, 3130.546070819764, 5972.492338151305, 5988.820335389945, 5996.550258730613, 6045.425684560048, 6069.180660610849, 5597.608167428241, 5934.37689042653, 5938.792142275, 5952.166696662471, 5953.404659534012, 5902.848944455875, 5929.822105336847, 5987.9101813472835, 5994.970025149846, 5998.550108741862, 5638.971805140948, 5842.912356314744, 5855.3266374365785, 5874.882502350015, 5886.6173698709445, 5692.686902220417, 5707.543396528351, 5712.428757124254, 5765.8558536036935, 5773.0, 6021.42796434338, 6027.60820546663, 6040.848978775566, 6054.545909056927, 6062.848428789315, 3927.450156977968, 4041.0705537727076, 4106.0, 4117.21772863155, 4132.772697501546, 5766.654000759968, 5807.390224026416, 5816.854578635568, 5884.911291411103, 5907.0, 5558.666480011212, 5654.0, 5736.71316434185, 5743.167240750151, 5762.616971926791, 5532.114861622121, 5568.16477528374, 5577.776888924398, 5594.0, 5610.158476228598, 5488.890222195454, 5515.338159420895, 5517.944820551904, 5567.830755541382, 5583.469570390806, 5398.4871437213405, 5504.752286147213, 5583.692896890548, 5622.85942851432, 5644.294463192101, 5518.668879867221, 5537.418571049981, 5542.224088627676, 5552.890381386436, 5561.443855614406], "value": 4291.347244211844, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2088084428395, 796.7092011415831, 806.850732614466, 835.3317346123101, 871.1245198575431, 14223.57329280122, 14977.176255305954, 14997.17515536645, 15000.0, 15021.774673379909, 14010.22943738094, 14031.368588413521, 14064.64838379041, 14071.577852664412, 14074.22591757453, 683.9247682754906, 703.0543918429729, 703.4372501998406, 703.5778532880256, 811.6753298680516, 829.9211574900405, 834.7996480844583, 835.448603921412, 837.2255663511258, 837.9203975622306, 871.1680345270252, 879.6305551668314, 882.3250213586612, 883.567052144451, 884.9159329863685, 719.9208087110413, 742.0909386002104, 876.2639382918347, 878.1218781218781, 878.7934835313696, 546.4835730234929, 625.3746253746253, 641.9325970773049, 644.8839208942388, 647.427027081032, 14228.0, 14241.643958901006, 14247.501337453243, 14282.3572939218, 14282.857171428257, 13536.593902182853, 13893.374798134108, 13899.513517026957, 13929.303534823319, 13987.860121398757, 12539.686507837287, 12591.496340146383, 12618.0, 12947.741045179138, 13007.934960325232, 4528.298113792367, 4631.0, 4650.0, 4662.790174442158, 4741.644376671729, 55648.721756391365, 55863.72068139674, 56087.71956140234, 57419.42580574183, 58102.41897581012, 11297.943510282561, 11400.087992960543, 11484.368359740294, 11491.138164637685, 11504.654860354203, 20484.385468435972, 20612.793872061087, 20626.58746825055, 20646.17415303371, 20649.483762906046, 8279.089300176976, 8492.660293588311, 8730.738077857675, 8828.117188281249, 8846.203841654282, 4701.694389864716, 4761.095391875532, 4780.928286075712, 4858.17411040124, 4980.701157930535, 3381.425157723193, 3459.3081383723356, 3465.3242617689307, 3468.739844511672, 3470.305938812248, 619.0868469008177, 635.9951276982357, 637.4072112934922, 637.5887552528593, 649.3538928765909, 631.8420394901275, 688.683205725362, 694.8193469697813, 695.2248243208786, 696.7456878239406, 9242.630294788267, 9246.95376523113, 9349.719508414759, 9534.713958581253, 9852.605895764233, 634.6763150793037, 641.7016087519232, 651.1827656291418, 661.8047675935611, 676.3270545806954, 4318.35224716295, 4422.425084738963, 4439.089986552749, 4505.189065968158, 4631.073785242965, 61789.0, 62818.0, 63045.684771576765, 63209.68395158087, 63338.366616333245, 56314.43685563174, 56373.7181314099, 56538.0, 58380.0, 59042.0, 49658.50341496611, 49835.25247121296, 50779.74610126999, 53134.20298695523, 54104.72947635315, 9507.524623768923, 9517.952410237904, 9813.165880900204, 9874.21006319507, 9924.801503969737, 35812.28375432529, 35926.461103083995, 36564.634353656125, 36564.81717591395, 37663.0, 43429.782851086806, 48282.758586206844, 48704.51295487, 49246.50753492419, 50178.49821501738, 13170.802437963246, 13211.405486752927, 13219.140755850838, 13441.059125861097, 13498.59504214875, 14000.089994150349, 14086.647833804236, 14112.36494357777, 14220.21788801626, 14575.562733118024, 10928.6721398355, 13347.199168049949, 13439.798403023768, 13720.93139534296, 13819.79270310926, 12846.0, 13156.541577846541, 13374.799378009144, 13500.459981600627, 13789.724205515633, 13307.66730831737, 13609.319534023061, 13669.179849209078, 13677.658058548615, 13718.245496497788, 10746.247762656853, 10821.945890270814, 10905.890941090805, 11022.283551569122, 11076.39079850616, 11330.490127944428, 11353.881974388352, 11603.767924641628, 11649.88350116488, 11674.182807203415], "value": 6961.550808652573, "unit": "score"}], "name": "dromaeo_css", "value": 7234.465550544289, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 110.0, 113.0, 113.0, 113.0, 111.0, 111.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 147.0, 212.0, 126.0, 149.0, 148.0, 126.0, 179.0, 126.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 161.0, 161.0, 162.0, 164.0, 162.0, 163.0, 160.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 152.0, 75.0, 73.0, 76.0, 75.0, 152.0, 74.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 154.0, 92.0, 92.0, 91.0, 125.0, 93.0, 92.0, 135.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 52.0, 53.0, 52.0, 54.0, 105.0, 51.0, 52.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 81.0, 82.0, 79.0, 79.0, 79.0, 83.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 121.0, 119.0, 120.0, 125.0, 126.0, 128.0, 197.0, 137.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 165.0, 163.0, 162.0, 167.0, 164.0, 167.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 65.0, 65.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1532.0000000000002, "alertThreshold": 2.0}]} 05:27:03 INFO - Return code: 0 05:27:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:27:03 ERROR - # TBPL SUCCESS # 05:27:03 INFO - Running post-action listener: _resource_record_post_action 05:27:03 INFO - ##### 05:27:03 INFO - ##### Finished run-tests step (success) 05:27:03 INFO - ##### 05:27:03 INFO - Running post-run listener: _resource_record_post_run 05:27:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 549015552; Read time: 0; Write time: 752196 05:27:03 INFO - TinderboxPrint: CPU usage
13.1% 05:27:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:27:03 INFO - TinderboxPrint: I/O write bytes / time
549,015,552 / 752,196 05:27:03 INFO - TinderboxPrint: CPU idle
8,279.3 (86.9%) 05:27:03 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 05:27:03 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:03 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 259846144; Read time: 0; Write time: 455976 05:27:03 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289169408; Read time: 0; Write time: 296220 05:27:04 INFO - Running post-run listener: _upload_blobber_files 05:27:04 INFO - Blob upload gear active. 05:27:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:04 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 05:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:05 INFO - (blobuploader) - INFO - Done attempting. 05:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:06 INFO - (blobuploader) - INFO - Done attempting. 05:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:11 INFO - (blobuploader) - INFO - Done attempting. 05:27:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:11 INFO - Return code: 0 05:27:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae60a5657f83d402e172c1b464af34872521a90798645a6ab452f77f323dc8afb1a2087663d36cab7436e0a09af8295e80ea7b5d2f846f56883a5124b30d0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e884580da07300e9818ecfdf44cdae8e69763fd8ceddc69542bd06f7d06797ee333db5d65dbc51e080261bf895451e8858069324abbfd56f16cf968140b3a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08c0bcd6dfc6a3ca3e2b835f3136e400bcd0fd15ad85025b0cd5c21a382b783f50b5cda90458e92f08b6a3489c864935038d6134c2943483149f39abf1a96b5a"} 05:27:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:11 INFO - Contents: 05:27:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae60a5657f83d402e172c1b464af34872521a90798645a6ab452f77f323dc8afb1a2087663d36cab7436e0a09af8295e80ea7b5d2f846f56883a5124b30d0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e884580da07300e9818ecfdf44cdae8e69763fd8ceddc69542bd06f7d06797ee333db5d65dbc51e080261bf895451e8858069324abbfd56f16cf968140b3a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08c0bcd6dfc6a3ca3e2b835f3136e400bcd0fd15ad85025b0cd5c21a382b783f50b5cda90458e92f08b6a3489c864935038d6134c2943483149f39abf1a96b5a"} 05:27:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:11 INFO - Copying logs to upload dir... 05:27:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.622822 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-19 05:27:11.018960) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:27:11.022915) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae60a5657f83d402e172c1b464af34872521a90798645a6ab452f77f323dc8afb1a2087663d36cab7436e0a09af8295e80ea7b5d2f846f56883a5124b30d0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e884580da07300e9818ecfdf44cdae8e69763fd8ceddc69542bd06f7d06797ee333db5d65dbc51e080261bf895451e8858069324abbfd56f16cf968140b3a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08c0bcd6dfc6a3ca3e2b835f3136e400bcd0fd15ad85025b0cd5c21a382b783f50b5cda90458e92f08b6a3489c864935038d6134c2943483149f39abf1a96b5a"} build_url:https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/Aqvk_neNRgK9Xks37UdzWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae60a5657f83d402e172c1b464af34872521a90798645a6ab452f77f323dc8afb1a2087663d36cab7436e0a09af8295e80ea7b5d2f846f56883a5124b30d0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38e884580da07300e9818ecfdf44cdae8e69763fd8ceddc69542bd06f7d06797ee333db5d65dbc51e080261bf895451e8858069324abbfd56f16cf968140b3a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08c0bcd6dfc6a3ca3e2b835f3136e400bcd0fd15ad85025b0cd5c21a382b783f50b5cda90458e92f08b6a3489c864935038d6134c2943483149f39abf1a96b5a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:27:11.047549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:27:11.047891) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463659449.911933-2057177408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:27:11.132254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:27:11.132706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:27:11.133101) ========= ========= Total master_lag: 0.17 =========