builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0267 starttime: 1464296810.21 results: success (0) buildid: 20160526082448 builduid: 163abf2ca9d847deaa352c2e281ae048 revision: 5fdfce654062b471415a82f1a2c07200fc463dcf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.209106) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.209519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.209794) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.249118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.249484) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypbtOsYKZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-26 14:06:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 18.3M=0.001s 2016-05-26 14:06:50 (18.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.396628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.397003) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypbtOsYKZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.024517 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:50.444590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 14:06:50.444923) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fdfce654062b471415a82f1a2c07200fc463dcf --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 5fdfce654062b471415a82f1a2c07200fc463dcf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypbtOsYKZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-26 14:06:50,528 truncating revision to first 12 chars 2016-05-26 14:06:50,528 Setting DEBUG logging. 2016-05-26 14:06:50,528 attempt 1/10 2016-05-26 14:06:50,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fdfce654062?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 14:06:51,263 unpacking tar archive at: fx-team-5fdfce654062/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 14:06:51.473701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:51.474049) ========= script_repo_revision: 5fdfce654062b471415a82f1a2c07200fc463dcf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:51.474434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:51.474699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 14:06:51.491042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-05-26 14:06:51.491338) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypbtOsYKZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:06:51 INFO - MultiFileLogger online at 20160526 14:06:51 in /builds/slave/test 14:06:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:06:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:06:51 INFO - {'append_to_log': False, 14:06:51 INFO - 'base_work_dir': '/builds/slave/test', 14:06:51 INFO - 'blob_upload_branch': 'Fx-Team', 14:06:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:06:51 INFO - 'branch': 'Fx-Team', 14:06:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:51 INFO - 'config_files': ('talos/mac_config.py',), 14:06:51 INFO - 'default_actions': ('clobber', 14:06:51 INFO - 'read-buildbot-config', 14:06:51 INFO - 'download-and-extract', 14:06:51 INFO - 'populate-webroot', 14:06:51 INFO - 'create-virtualenv', 14:06:51 INFO - 'install', 14:06:51 INFO - 'run-tests'), 14:06:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:51 INFO - 'download_minidump_stackwalk': True, 14:06:51 INFO - 'download_symbols': 'ondemand', 14:06:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:51 INFO - 'installer_path': 'installer.exe', 14:06:51 INFO - 'log_level': 'info', 14:06:51 INFO - 'log_name': 'talos', 14:06:51 INFO - 'log_to_console': True, 14:06:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:06:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:06:51 INFO - 'opt_config_files': (), 14:06:51 INFO - 'pip_index': False, 14:06:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:06:51 INFO - 'cmd': ('bash', 14:06:51 INFO - '-c', 14:06:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:06:51 INFO - 'enabled': True, 14:06:51 INFO - 'halt_on_failure': False, 14:06:51 INFO - 'name': 'check_screen_resolution'},), 14:06:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:06:51 INFO - 'cmd': ('bash', 14:06:51 INFO - '-c', 14:06:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:06:51 INFO - 'enabled': True, 14:06:51 INFO - 'halt_on_failure': False, 14:06:51 INFO - 'name': 'check_screen_resolution'},), 14:06:51 INFO - 'run_cmd_checks_enabled': True, 14:06:51 INFO - 'sps_profile': False, 14:06:51 INFO - 'sps_profile_interval': 0, 14:06:51 INFO - 'suite': 'dromaeojs-e10s', 14:06:51 INFO - 'system_bits': '32', 14:06:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:51 INFO - 'title': 't-yosemite-r7-0267', 14:06:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:51 INFO - 'use_talos_json': True, 14:06:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:06:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:51 INFO - 'work_dir': 'build'} 14:06:51 INFO - ##### 14:06:51 INFO - ##### Running clobber step. 14:06:51 INFO - ##### 14:06:51 INFO - Running pre-action listener: _resource_record_pre_action 14:06:51 INFO - Running main action method: clobber 14:06:51 INFO - rmtree: /builds/slave/test/build 14:06:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:06:53 INFO - Running post-action listener: _resource_record_post_action 14:06:53 INFO - ##### 14:06:53 INFO - ##### Finished clobber step (success) 14:06:53 INFO - ##### 14:06:53 INFO - ##### 14:06:53 INFO - ##### Running read-buildbot-config step. 14:06:53 INFO - ##### 14:06:53 INFO - Running pre-action listener: _resource_record_pre_action 14:06:53 INFO - Running main action method: read_buildbot_config 14:06:53 INFO - Using buildbot properties: 14:06:53 INFO - { 14:06:53 INFO - "project": "", 14:06:53 INFO - "product": "firefox", 14:06:53 INFO - "script_repo_revision": "production", 14:06:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:06:53 INFO - "repository": "", 14:06:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:06:53 INFO - "buildid": "20160526082448", 14:06:53 INFO - "pgo_build": "False", 14:06:53 INFO - "basedir": "/builds/slave/test", 14:06:53 INFO - "buildnumber": 15, 14:06:53 INFO - "slavename": "t-yosemite-r7-0267", 14:06:53 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:06:53 INFO - "platform": "yosemite_r7", 14:06:53 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 14:06:53 INFO - "branch": "fx-team", 14:06:53 INFO - "repo_path": "integration/fx-team", 14:06:53 INFO - "revision": "5fdfce654062b471415a82f1a2c07200fc463dcf", 14:06:53 INFO - "stage_platform": "macosx64", 14:06:53 INFO - "builduid": "163abf2ca9d847deaa352c2e281ae048", 14:06:53 INFO - "slavebuilddir": "test" 14:06:53 INFO - } 14:06:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 14:06:53 INFO - Running post-action listener: _resource_record_post_action 14:06:53 INFO - ##### 14:06:53 INFO - ##### Finished read-buildbot-config step (success) 14:06:53 INFO - ##### 14:06:53 INFO - ##### 14:06:53 INFO - ##### Running download-and-extract step. 14:06:53 INFO - ##### 14:06:53 INFO - Running pre-action listener: _resource_record_pre_action 14:06:53 INFO - Running main action method: download_and_extract 14:06:53 INFO - mkdir: /builds/slave/test/build/tests 14: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')]} 14:06:53 INFO - https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 14:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 14:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 14:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 14:06:55 INFO - Downloaded 1199 bytes. 14:06:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 14:06:55 INFO - Using the following test package requirements: 14:06:55 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 14:06:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 14:06:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 14:06:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'jsshell-mac.zip'], 14:06:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 14:06:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 14:06:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 14:06:55 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 14:06:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 14:06:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:06:55 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 14:06:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:55 INFO - https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:06:57 INFO - Downloaded 18622109 bytes. 14:06:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:06:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:07:00 INFO - Return code: 0 14:07:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:00 INFO - https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:07:01 INFO - Downloaded 18622109 bytes. 14:07:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:07:05 INFO - Return code: 0 14:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:05 INFO - https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:07:10 INFO - Downloaded 10834034 bytes. 14:07:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:07:11 INFO - Return code: 0 14:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:11 INFO - https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 14:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 14:07:14 INFO - Downloaded 110491763 bytes. 14:07:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:07:14 INFO - mkdir: /builds/slave/test/properties 14:07:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:14 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:14 INFO - Contents: 14:07:14 INFO - build_url:https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:07:15 INFO - Running post-action listener: _resource_record_post_action 14:07:15 INFO - Running post-action listener: set_extra_try_arguments 14:07:15 INFO - ##### 14:07:15 INFO - ##### Finished download-and-extract step (success) 14:07:15 INFO - ##### 14:07:15 INFO - ##### 14:07:15 INFO - ##### Running populate-webroot step. 14:07:15 INFO - ##### 14:07:15 INFO - Running pre-action listener: _resource_record_pre_action 14:07:15 INFO - Running main action method: populate_webroot 14:07:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:15 INFO - '--tppagecycles', 14:07:15 INFO - '7'], 14:07:15 INFO - 'tests': ['tsvgm']}}, 14:07:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['damp', 'tps']}, 14:07:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'tests': ['damp', 'tps']}, 14:07:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['dromaeo_dom']}, 14:07:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['a11yr', 14:07:15 INFO - 'ts_paint', 14:07:15 INFO - 'tpaint', 14:07:15 INFO - 'sessionrestore', 14:07:15 INFO - 'sessionrestore_no_auto_restore', 14:07:15 INFO - 'tabpaint']}, 14:07:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:15 INFO - 'ts_paint', 14:07:15 INFO - 'tpaint', 14:07:15 INFO - 'sessionrestore', 14:07:15 INFO - 'sessionrestore_no_auto_restore', 14:07:15 INFO - 'tabpaint']}, 14:07:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:15 INFO - 'ts_paint', 14:07:15 INFO - 'tpaint', 14:07:15 INFO - 'sessionrestore', 14:07:15 INFO - 'sessionrestore_no_auto_restore', 14:07:15 INFO - 'tabpaint']}, 14:07:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:15 INFO - 'ts_paint', 14:07:15 INFO - 'tpaint', 14:07:15 INFO - 'sessionrestore', 14:07:15 INFO - 'sessionrestore_no_auto_restore', 14:07:15 INFO - 'tabpaint']}, 14:07:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['a11yr', 14:07:15 INFO - 'ts_paint', 14:07:15 INFO - 'tpaint', 14:07:15 INFO - 'sessionrestore', 14:07:15 INFO - 'sessionrestore_no_auto_restore', 14:07:15 INFO - 'tabpaint']}, 14:07:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['a11yr', 14:07:15 INFO - 'ts_paint', 14:07:15 INFO - 'tpaint', 14:07:15 INFO - 'sessionrestore', 14:07:15 INFO - 'sessionrestore_no_auto_restore', 14:07:15 INFO - 'tabpaint']}, 14:07:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['tsvgx', 14:07:15 INFO - 'tsvgr_opacity', 14:07:15 INFO - 'tart', 14:07:15 INFO - 'tscrollx', 14:07:15 INFO - 'cart']}, 14:07:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:15 INFO - 'tsvgr_opacity', 14:07:15 INFO - 'tart', 14:07:15 INFO - 'tscrollx', 14:07:15 INFO - 'cart']}, 14:07:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'talos_options': ['--disable-e10s'], 14:07:15 INFO - 'tests': ['tp5o']}, 14:07:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'tests': ['tp5o']}, 14:07:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'talos_options': ['--disable-e10s', 14:07:15 INFO - '--xperf_path', 14:07:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:15 INFO - 'tests': ['tp5n']}, 14:07:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:15 INFO - 'talos_options': ['--xperf_path', 14:07:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:15 INFO - 'tests': ['tp5n']}}, 14:07:15 INFO - 'talos.zip': {'path': '', 14:07:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:15 INFO - Running post-action listener: _resource_record_post_action 14:07:15 INFO - ##### 14:07:15 INFO - ##### Finished populate-webroot step (success) 14:07:15 INFO - ##### 14:07:15 INFO - ##### 14:07:15 INFO - ##### Running create-virtualenv step. 14:07:15 INFO - ##### 14:07:15 INFO - Running pre-action listener: _resource_record_pre_action 14:07:15 INFO - Running main action method: create_virtualenv 14:07:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:15 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 14:07:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:15 INFO - Using real prefix '/tools/python27' 14:07:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:19 INFO - Installing pip.................done. 14:07:19 INFO - Return code: 0 14:07:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:19 INFO - 'HOME': '/Users/cltbld', 14:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:19 INFO - 'LOGNAME': 'cltbld', 14:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:19 INFO - 'MOZ_NO_REMOTE': '1', 14:07:19 INFO - 'NO_EM_RESTART': '1', 14:07:19 INFO - 'PAGER': '/bin/cat', 14:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:19 INFO - 'PWD': '/builds/slave/test', 14:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:19 INFO - 'SHELL': '/bin/bash', 14:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:19 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:19 INFO - 'USER': 'cltbld', 14:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:19 INFO - 'XPC_FLAGS': '0x0', 14:07:19 INFO - 'XPC_SERVICE_NAME': '0', 14:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:07:19 INFO - Cleaning up... 14:07:20 INFO - Return code: 0 14:07:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:20 INFO - 'HOME': '/Users/cltbld', 14:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:20 INFO - 'LOGNAME': 'cltbld', 14:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:20 INFO - 'MOZ_NO_REMOTE': '1', 14:07:20 INFO - 'NO_EM_RESTART': '1', 14:07:20 INFO - 'PAGER': '/bin/cat', 14:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:20 INFO - 'PWD': '/builds/slave/test', 14:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:20 INFO - 'SHELL': '/bin/bash', 14:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:20 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:20 INFO - 'USER': 'cltbld', 14:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:20 INFO - 'XPC_FLAGS': '0x0', 14:07:20 INFO - 'XPC_SERVICE_NAME': '0', 14:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:20 INFO - Downloading/unpacking psutil>=3.1.1 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:23 INFO - Installing collected packages: psutil 14:07:23 INFO - Running setup.py install for psutil 14:07:23 INFO - building 'psutil._psutil_osx' extension 14:07:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:07:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:07:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:07:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:07:24 INFO - building 'psutil._psutil_posix' extension 14:07:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:07:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:07:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:07:24 INFO - ^ 14:07:24 INFO - 1 warning generated. 14:07:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:24 INFO - Successfully installed psutil 14:07:24 INFO - Cleaning up... 14:07:24 INFO - Return code: 0 14:07:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:24 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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:24 INFO - 'HOME': '/Users/cltbld', 14:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:24 INFO - 'LOGNAME': 'cltbld', 14:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:24 INFO - 'MOZ_NO_REMOTE': '1', 14:07:24 INFO - 'NO_EM_RESTART': '1', 14:07:24 INFO - 'PAGER': '/bin/cat', 14:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:24 INFO - 'PWD': '/builds/slave/test', 14:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:24 INFO - 'SHELL': '/bin/bash', 14:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:24 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:24 INFO - 'USER': 'cltbld', 14:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:24 INFO - 'XPC_FLAGS': '0x0', 14:07:24 INFO - 'XPC_SERVICE_NAME': '0', 14:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:07:27 INFO - Installing collected packages: mozsystemmonitor 14:07:27 INFO - Running setup.py install for mozsystemmonitor 14:07:27 INFO - Successfully installed mozsystemmonitor 14:07:27 INFO - Cleaning up... 14:07:27 INFO - Return code: 0 14:07:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:07:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:27 INFO - 'HOME': '/Users/cltbld', 14:07:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:27 INFO - 'LOGNAME': 'cltbld', 14:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:27 INFO - 'MOZ_NO_REMOTE': '1', 14:07:27 INFO - 'NO_EM_RESTART': '1', 14:07:27 INFO - 'PAGER': '/bin/cat', 14:07:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:27 INFO - 'PWD': '/builds/slave/test', 14:07:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:27 INFO - 'SHELL': '/bin/bash', 14:07:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:27 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:27 INFO - 'USER': 'cltbld', 14:07:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:27 INFO - 'XPC_FLAGS': '0x0', 14:07:27 INFO - 'XPC_SERVICE_NAME': '0', 14:07:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:27 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Downloading docopt-0.6.1.tar.gz 14:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:31 INFO - Running setup.py install for blobuploader 14:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:31 INFO - Running setup.py install for requests 14:07:32 INFO - Running setup.py install for docopt 14:07:32 INFO - Successfully installed blobuploader requests docopt 14:07:32 INFO - Cleaning up... 14:07:32 INFO - Return code: 0 14:07:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:32 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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:32 INFO - 'HOME': '/Users/cltbld', 14:07:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:32 INFO - 'LOGNAME': 'cltbld', 14:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:32 INFO - 'MOZ_NO_REMOTE': '1', 14:07:32 INFO - 'NO_EM_RESTART': '1', 14:07:32 INFO - 'PAGER': '/bin/cat', 14:07:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:32 INFO - 'PWD': '/builds/slave/test', 14:07:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:32 INFO - 'SHELL': '/bin/bash', 14:07:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:32 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:32 INFO - 'USER': 'cltbld', 14:07:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:32 INFO - 'XPC_FLAGS': '0x0', 14:07:32 INFO - 'XPC_SERVICE_NAME': '0', 14:07:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-PcESO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-jSA4ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-HE3yiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-rGmD1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-HKj33U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-uwxHJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-lWwfnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-4_FFTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-CGnJBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-6j2HwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-1ucdPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-9GNchu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-W874CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-JZ72t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-SttPgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-cFiifL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:34 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-p98U58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:34 INFO - Running setup.py install for manifestparser 14:07:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:34 INFO - Running setup.py install for mozcrash 14:07:34 INFO - Running setup.py install for mozdebug 14:07:34 INFO - Running setup.py install for mozdevice 14:07:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:34 INFO - Running setup.py install for mozfile 14:07:35 INFO - Running setup.py install for mozhttpd 14:07:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Running setup.py install for mozinfo 14:07:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Running setup.py install for mozInstall 14:07:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Running setup.py install for mozleak 14:07:35 INFO - Running setup.py install for mozlog 14:07:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Running setup.py install for moznetwork 14:07:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:35 INFO - Running setup.py install for mozprocess 14:07:36 INFO - Running setup.py install for mozprofile 14:07:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozrunner 14:07:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozscreenshot 14:07:36 INFO - Running setup.py install for moztest 14:07:36 INFO - Running setup.py install for mozversion 14:07:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:36 INFO - Cleaning up... 14:07:36 INFO - Return code: 0 14:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:36 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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:36 INFO - 'HOME': '/Users/cltbld', 14:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:36 INFO - 'LOGNAME': 'cltbld', 14:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:36 INFO - 'MOZ_NO_REMOTE': '1', 14:07:36 INFO - 'NO_EM_RESTART': '1', 14:07:36 INFO - 'PAGER': '/bin/cat', 14:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:36 INFO - 'PWD': '/builds/slave/test', 14:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:36 INFO - 'SHELL': '/bin/bash', 14:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:36 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:36 INFO - 'USER': 'cltbld', 14:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:36 INFO - 'XPC_FLAGS': '0x0', 14:07:36 INFO - 'XPC_SERVICE_NAME': '0', 14:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-zbx51Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-y2c5As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-PzAY5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-0G8K8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Mp5lp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-MJvxsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-LS3QhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-OUfFcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-O5fDk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-WY1ug9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-lPCmZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-mOgP4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-iWtjkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-1rMD9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-fDWNVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-dGVAzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-uEmmWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:41 INFO - Downloading blessings-1.6.tar.gz 14:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:41 INFO - Installing collected packages: blessings 14:07:41 INFO - Running setup.py install for blessings 14:07:41 INFO - Successfully installed blessings 14:07:41 INFO - Cleaning up... 14:07:41 INFO - Return code: 0 14:07:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:41 INFO - Reading from file tmpfile_stdout 14:07:41 INFO - Current package versions: 14:07:41 INFO - blessings == 1.6 14:07:41 INFO - blobuploader == 1.2.4 14:07:41 INFO - docopt == 0.6.1 14:07:41 INFO - manifestparser == 1.1 14:07:41 INFO - mozInstall == 1.12 14:07:41 INFO - mozcrash == 0.17 14:07:41 INFO - mozdebug == 0.1 14:07:41 INFO - mozdevice == 0.48 14:07:41 INFO - mozfile == 1.2 14:07:41 INFO - mozhttpd == 0.7 14:07:41 INFO - mozinfo == 0.9 14:07:41 INFO - mozleak == 0.1 14:07:41 INFO - mozlog == 3.2 14:07:41 INFO - moznetwork == 0.27 14:07:41 INFO - mozprocess == 0.22 14:07:41 INFO - mozprofile == 0.28 14:07:41 INFO - mozrunner == 6.11 14:07:41 INFO - mozscreenshot == 0.1 14:07:41 INFO - mozsystemmonitor == 0.3 14:07:41 INFO - moztest == 0.7 14:07:41 INFO - mozversion == 1.4 14:07:41 INFO - psutil == 3.1.1 14:07:41 INFO - requests == 1.2.3 14:07:41 INFO - wsgiref == 0.1.2 14:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:41 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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:41 INFO - 'HOME': '/Users/cltbld', 14:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:41 INFO - 'LOGNAME': 'cltbld', 14:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:42 INFO - 'MOZ_NO_REMOTE': '1', 14:07:42 INFO - 'NO_EM_RESTART': '1', 14:07:42 INFO - 'PAGER': '/bin/cat', 14:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:42 INFO - 'PWD': '/builds/slave/test', 14:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:42 INFO - 'SHELL': '/bin/bash', 14:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:42 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:42 INFO - 'USER': 'cltbld', 14:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:42 INFO - 'XPC_FLAGS': '0x0', 14:07:42 INFO - 'XPC_SERVICE_NAME': '0', 14:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:42 INFO - Cleaning up... 14:07:42 INFO - Return code: 0 14:07:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:42 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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:42 INFO - 'HOME': '/Users/cltbld', 14:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:42 INFO - 'LOGNAME': 'cltbld', 14:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:42 INFO - 'MOZ_NO_REMOTE': '1', 14:07:42 INFO - 'NO_EM_RESTART': '1', 14:07:42 INFO - 'PAGER': '/bin/cat', 14:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:42 INFO - 'PWD': '/builds/slave/test', 14:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:42 INFO - 'SHELL': '/bin/bash', 14:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:42 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:42 INFO - 'USER': 'cltbld', 14:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:42 INFO - 'XPC_FLAGS': '0x0', 14:07:42 INFO - 'XPC_SERVICE_NAME': '0', 14:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:42 INFO - Downloading/unpacking jsonschema 14:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:44 INFO - Downloading/unpacking functools32 (from jsonschema) 14:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:45 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:45 INFO - warning: no files found matching '*.txt' 14:07:45 INFO - no previously-included directories found matching 'build' 14:07:45 INFO - no previously-included directories found matching 'dist' 14:07:45 INFO - no previously-included directories found matching '.git*' 14:07:45 INFO - Installing collected packages: jsonschema, functools32 14:07:45 INFO - Running setup.py install for functools32 14:07:45 INFO - warning: no files found matching '*.txt' 14:07:45 INFO - no previously-included directories found matching 'build' 14:07:45 INFO - no previously-included directories found matching 'dist' 14:07:45 INFO - no previously-included directories found matching '.git*' 14:07:45 INFO - Successfully installed jsonschema functools32 14:07:45 INFO - Cleaning up... 14:07:45 INFO - Return code: 0 14:07:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:46 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 0x106e17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e1d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88f0e051f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:46 INFO - 'HOME': '/Users/cltbld', 14:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:46 INFO - 'LOGNAME': 'cltbld', 14:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:46 INFO - 'MOZ_NO_REMOTE': '1', 14:07:46 INFO - 'NO_EM_RESTART': '1', 14:07:46 INFO - 'PAGER': '/bin/cat', 14:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:46 INFO - 'PWD': '/builds/slave/test', 14:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:46 INFO - 'SHELL': '/bin/bash', 14:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:07:46 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:46 INFO - 'USER': 'cltbld', 14:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:46 INFO - 'XPC_FLAGS': '0x0', 14:07:46 INFO - 'XPC_SERVICE_NAME': '0', 14:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:46 INFO - Downloading/unpacking flake8 14:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:07:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:07:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:51 INFO - no previously-included directories found matching 'docs/_build' 14:07:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:07:51 INFO - Running setup.py install for pep8 14:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:51 INFO - no previously-included directories found matching 'docs/_build' 14:07:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:07:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:07:51 INFO - Cleaning up... 14:07:51 INFO - Return code: 0 14:07:51 INFO - Running post-action listener: _resource_record_post_action 14:07:51 INFO - Running post-action listener: _start_resource_monitoring 14:07:51 INFO - Starting resource monitoring. 14:07:51 INFO - ##### 14:07:51 INFO - ##### Finished create-virtualenv step (success) 14:07:51 INFO - ##### 14:07:51 INFO - ##### 14:07:51 INFO - ##### Running install step. 14:07:51 INFO - ##### 14:07:51 INFO - Running pre-action listener: _resource_record_pre_action 14:07:51 INFO - Running main action method: install 14:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:51 INFO - Reading from file tmpfile_stdout 14:07:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:52 INFO - Reading from file tmpfile_stdout 14:07:52 INFO - Output received: 14:07:52 INFO - Usage: mozinstall [options] installer 14:07:52 INFO - Options: 14:07:52 INFO - -h, --help show this help message and exit 14:07:52 INFO - -d DEST, --destination=DEST 14:07:52 INFO - Directory to install application into. [default: 14:07:52 INFO - "/builds/slave/test"] 14:07:52 INFO - --app=APP Application being installed. [default: firefox] 14:07:52 INFO - mkdir: /builds/slave/test/build/application 14:07:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:08:25 INFO - Reading from file tmpfile_stdout 14:08:25 INFO - Output received: 14:08:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:08:25 INFO - Running post-action listener: _resource_record_post_action 14:08:25 INFO - ##### 14:08:25 INFO - ##### Finished install step (success) 14:08:25 INFO - ##### 14:08:25 INFO - ##### 14:08:25 INFO - ##### Running run-tests step. 14:08:25 INFO - ##### 14:08:25 INFO - Running pre-action listener: _resource_record_pre_action 14:08:25 INFO - Running main action method: run_tests 14:08:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:08:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:08:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:08:25 INFO - 2016-05-26 14:08:25.923 screenresolution[1649:7644] starting screenresolution argv=screenresolution get 14:08:25 INFO - 2016-05-26 14:08:25.925 screenresolution[1649:7644] Display 0: 1600x1200x32@60 14:08:25 INFO - 2016-05-26 14:08:25.931 screenresolution[1650:7646] starting screenresolution argv=screenresolution list 14:08:25 INFO - Available Modes on Display 0 14:08:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:08:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:08:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:08:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:08:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:08:26 INFO - Intel Iris: 14:08:26 INFO - Chipset Model: Intel Iris 14:08:26 INFO - Type: GPU 14:08:26 INFO - Bus: Built-In 14:08:26 INFO - VRAM (Dynamic, Max): 1536 MB 14:08:26 INFO - Vendor: Intel (0x8086) 14:08:26 INFO - Device ID: 0x0a2e 14:08:26 INFO - Revision ID: 0x0009 14:08:26 INFO - Displays: 14:08:26 INFO - Display: 14:08:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:08:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:08:26 INFO - Display Serial Number: 1600x1200 60 14:08:26 INFO - Main Display: Yes 14:08:26 INFO - Mirror: Off 14:08:26 INFO - Online: Yes 14:08:26 INFO - Rotation: Supported 14:08:26 INFO - Return code: 0 14:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:26 INFO - Python 2.7.3 14:08:26 INFO - Return code: 0 14:08:26 INFO - grabbing minidump binary from tooltool 14:08: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')]} 14:08: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/macosx64/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 0x106cbbd30>, '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 0x106adfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cb2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08: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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:08: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/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:08: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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:08:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:26 INFO - Return code: 0 14:08:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:08:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:08:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:08:27 INFO - Return code: 0 14:08: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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:08: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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0267 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:08:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypbtOsYKZS/Render', 14:08:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:27 INFO - 'HOME': '/Users/cltbld', 14:08:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:27 INFO - 'LOGNAME': 'cltbld', 14:08:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:27 INFO - 'MOZ_NO_REMOTE': '1', 14:08:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:27 INFO - 'NO_EM_RESTART': '1', 14:08:27 INFO - 'PAGER': '/bin/cat', 14:08:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:27 INFO - 'PWD': '/builds/slave/test', 14:08:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:27 INFO - 'SHELL': '/bin/bash', 14:08:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners', 14:08:27 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 14:08:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:27 INFO - 'USER': 'cltbld', 14:08:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:27 INFO - 'XPC_FLAGS': '0x0', 14:08:27 INFO - 'XPC_SERVICE_NAME': '0', 14:08:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08: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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:08:27 INFO - mozversion application_buildid: 20160526082448 14:08:27 INFO - mozversion application_changeset: 5fdfce654062b471415a82f1a2c07200fc463dcf 14:08:27 INFO - mozversion application_display_name: Nightly 14:08:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:27 INFO - mozversion application_name: Firefox 14:08:27 INFO - mozversion application_remotingname: firefox 14:08:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:08:27 INFO - mozversion application_vendor: Mozilla 14:08:27 INFO - mozversion application_version: 49.0a1 14:08:27 INFO - mozversion platform_buildid: 20160526082448 14:08:27 INFO - mozversion platform_changeset: 5fdfce654062b471415a82f1a2c07200fc463dcf 14:08:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:08:27 INFO - mozversion platform_version: 49.0a1 14:08:27 INFO - using testdate: 1464296907 14:08:27 INFO - actual date: 1464296907 14:08:27 INFO - starting webserver on 'localhost:49275' 14:08:27 INFO - SUITE-START | Running 2 tests 14:08:27 INFO - TEST-START | dromaeo_css 14:08:27 INFO - operating with platform_type : mac_ 14:08:27 INFO - Initialising browser for dromaeo_css test... 14:08:27 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpGfF0ie/profile http://localhost:49275/getInfo.html) 14:08:30 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 14:08:30 INFO - PROCESS | 1668 | colorDepth:24 14:08:30 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 14:08:30 INFO - PROCESS | 1668 | __metrics 14:08:30 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:08:31 INFO - TEST-INFO | 1668: exit 0 14:08:31 INFO - Browser initialized. 14:08:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:31 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpGfF0ie/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:43 INFO - PROCESS | 1671 | RSS: Main: 252264448 14:08:43 INFO - PROCESS | 1671 | 14:09:33 INFO - PROCESS | 1671 | 1464296973222 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:11:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 14:11:44 INFO - PROCESS | 1671 | RSS: Main: 264245248 14:11:44 INFO - PROCESS | 1671 | 14:14:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 14:14:47 INFO - PROCESS | 1671 | RSS: Main: 275783680 14:14:47 INFO - PROCESS | 1671 | 14:17:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 14:17:49 INFO - PROCESS | 1671 | RSS: Main: 277553152 14:17:49 INFO - PROCESS | 1671 | 14:20:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 14:20:52 INFO - PROCESS | 1671 | RSS: Main: 278945792 14:20:52 INFO - PROCESS | 1671 | 14:23:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 14:23:55 INFO - PROCESS | 1671 | RSS: Main: 282357760 14:23:55 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 14:26:58 INFO - PROCESS | 1671 | RSS: Main: 283176960 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | __start_tp_report 14:26:58 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 14:26:58 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 14:26:58 INFO - PROCESS | 1671 | |i|pagename|runs| 14:26:58 INFO - PROCESS | 1671 | |0;dojo.html;3102.8519447804315;3235.6764323567645;3461.6365281645435;3500.0899766060834;3522.8414721337535;4752.786124624392;5800.825975220745;5838.182654428379;5870.26621672291;5889.116632505126;5073.985202959414;5645.266115405002;5681.52853508723;5735.741891614877;5813.157092221625;5120.103981803198;5188.429272779991;5258.474152584749;5281.419043905167;5300.708461034642;67.72653641943954;5238.109521381355;5301.416844147141;5311.707856067915;5382;4352.455943007124;4624.768761561909;4954.752262386903;5265.815696450625;5311.123664595318;5154.355705536808;5315.920261196085;5321.2284218788445;5342.759575819097;5363.249145119687;5156.639035267533;5185.066687996159;5250.448702886219;5262.631615786897;5295.364556253236;5458.099413596752;5550.69471179085;5791.21818554494;5796.739146738365;5796.97101514494;6108.267007959073;6236.220472440945;6312.936870631281;6322.778702745381;6331.715072821734;6274.874502509924;6305.3379395163765;6307.27466341372;6309.589876658002;6316.873662526724;6014.2181516403025;6016.639001659871;6031.577789554733;6040.093985902062;6041.335453100155;6210.596311239755;6285.402886725754;6292.087647291117;6420.0690899819265;6438.806835794933;6212;6327.525435592257;6329.588576742497;6330.050492426173;6332.841678958063;6309.589876658002;6312.274088479791;6315.905261421082;6349.2698339690605;6367.235931688227;6104.459155447136;6221.502279817694;6237.844053898598;6325.620462772248;6326;6135.01831721223;6255.030470277115;6281.654509001957;6314.336994615591;6322.304546499881;5018.422881368616;5068.391792984866;5079.669821461667;5091.287219789232;5102.642815002914;4434.068845542408;4449.310356894686;4512.187806194916;4560.726356418625;4584.312353147055;5835.737391817378;5906.616069955439;5917.852053698606;5987.401259874065;6003.21958145447;6287.811365659038;6293.30773614902;6294.370562943669;6302.243730752248;6315.494760419156;4947.975260123676;5745.569082318842;5903.734331955073;5952.672603006789;5996.400359963969;5523.226748255248;5529.806456774074;5530.253415788898;5533.114701647717;5538.446155384429;6262.655553944577;6501.544891857525;6515.446187074057;6517.967410162919;6533.18335208099;6247.750089996349;6272.090546870587;6296.905546416899;6310.842228944313;6319.24169099711;6491.285958544462;6511.837204069936;6523.804285871432;6529.542931994714;6562.146920900253;6103.03463616155;6189.5048396129105;6317.305096439296;6337.003843789192;6355.300916899045;6247.468965138014;6296.181496405438;6309.652969086745;6310.6844657766005;6350.142730731477;5411.756470958895;6101.542384321105;6240.719167637377;6259.906101408392;6294.181756371826;5548.611597188319;6019.398060194121;6108.099244189703;6244.843878902882;6274.905876411949;5046.520580544842;5062.443131255633;5982.252218472691;6004.849878753066;6140.355262697352;6089.817305480843;6305.085762564311;6308.589941653778;6310.242770867341;6344.841378965562;4925.950740492549;5997.13041608973;6071.787487438095;6114.847128821815;6159.5688301818445 14:26:58 INFO - PROCESS | 1671 | |1;ext.html;498.76306759237093;503.9017391608636;505.41119595671046;521.7313083761866;532.0237364436259;38010.80994595026;40953;41035.179296414055;41118.58881411185;41206.38190427146;41824.790876045576;41877.58122418775;42419.78790106053;42669.573304266945;42672.35991460123;7905.486143400675;9648.90351096487;9667.613295468173;9677.322587418883;10015.74960625983;9595.616175353012;9671.323007389485;9701.70894873155;9703.029697030312;9744.269179811507;9640.084192001748;9690.854637180448;9715.417074975489;9720.611175553006;9733.805323893517;9623.759406014835;9690.224782017422;9701.90298097017;9704.223662107015;9716.368436051634;9466.479343636098;9514.28642851789;9553.1402173804;9599.664011759625;9612.231021518262;39316.606833931866;39771.80114099411;39775.00562485961;39892.60107398918;39935.602253921264;2613.372790530278;2877.8992735254164;2897;3033.8634761435787;3181.586393768818;26693.332666683487;27248.04631837876;27340.58989115165;28057.456839873797;28727.13818585446;2621.397078671897;2628.6057091436246;2668.9332766680986;2725.591161325817;2800.558714955594;404218;467260;470835;474111;474902;28256;31662.51712311644;33624.831875840464;33727.662723372945;33958.66041339555;31966.680333196837;35401.64598354035;35969.64030359715;36103.458448123296;36169.457458138146;13130;13898.096623719628;14913.328900199516;14978.251087445584;14991.850081499264;12684.556040538537;12745.745085098246;12778.61664150077;12791.680207994874;12813.743725125632;7881.448298619041;7885.1326354101;7914.960425197953;7937.007874015748;7939.325157361689;3271.754618403582;3283.310504793972;3296.3901678189613;3303.3228188221356;3340.983295083509;772.3705180278056;933.0669330669331;945.4421891084294;1009.6920439265947;1099.780043991205;29139.980100696375;29490.410191796043;29672.800514505398;29905.401891962472;29921.700782992328;922.432703887118;1025.8358662614096;1119.6081371519904;1162.8255761635821;1163.4357336691698;14531.143120557592;15047.247637618075;15085.252188907518;15195.012324198891;15340.079595224322;537598;654704;665436;670705;671946;57383.13925291124;59383.10925336123;59437.405625944055;59569.702151488964;59644.70177649084;1403.5719105672663;1420.2969530082469;1436.7485690004207;1440.9783853242209;1445.8409574946747;28338.574921376607;28689.995850145144;28965.565516516846;28988.275293116996;29427.558586621646;54704.45295547153;58077;59003.40996590151;59040.40959590349;59199;639824;643846;644246;645733;646587;40198.79900600478;42354.152916942105;42705.57294427016;42750.71747847569;43123.137537249706;45993;46600.53399465962;46894.29658555056;47028.29457558208;47166.76416617895;38090.0477488065;38475;39014.219715606094;39189;39727.80816575507;37592.43611345887;37766.43350349692;37920.81039594785;38606;38981.80509097436;37071.258574827814;37543.87368378953;37659.87020389393;37986.810065949496;38703.22593548057;30741.692583073884;32513.733585927897;32995;33719.831400842835;33967.83016084904;24631.261062168163;24895.62656560189;24907.879145438863;25180.370490737878;25232.36522816725 14:26:58 INFO - PROCESS | 1671 | |2;jquery.html;376.069228659069;382.6785500179849;384.4867102418272;395.4286056648145;405.2502869691072;19396;20483.385498435033;21031.053602587883;21251.14995400184;21278.042488088016;17519.12404379779;20746;21148.682769758427;21575.029123689434;21621.567568648657;5345.599080068991;5650.406707295737;5805.622634528763;5849.239598852143;5853.64878107315;4802.97598512007;5798.2172406725185;5801.245838041049;5830.096335068071;5838.095095260242;5521.475459831309;5738.454846789569;5753.741081651336;5757.68332741699;5766.452187042224;5596.188552659842;5624.128260119688;5716.256886604757;5746.138079288098;5757.337906140785;4900.926486102711;5019.974900125512;5042.621803364726;5047.772850221712;5053.444121146671;20684.276050338318;22049.669254961187;22315.10739570415;26040;26156.86921565399;2010.58782949495;2072.626927153112;2084.713264772532;2102.5374417628095;2211.1155537784853;9166.495842728647;10096.596136154545;12857.842794148479;14952.177630230333;15356.539303820904;1571.2222449887265;1752.5969027123706;1761.6740902932997;1791.0596936608254;1821.7176337667684;94975.0502494973;122024;129067.35466322608;129234;129570;9605.519724013771;11253.156013299036;11702.414879256003;11835.230710003822;11988.940055299669;14588.270586470633;14812.555623331318;14903.627409314853;14951.850481495263;14979.700405992036;8757.386982911263;8789.97830498976;8806.955965220133;8830.955845220862;8849.51327676984;8710.564471776512;8813.074627164184;8839.071897450804;8901.73294801157;8946.776330591787;4060.7766572838777;4476.7090139140855;4622.653301002439;4635.3742244797195;4648.070385922829;1710.598009467774;1730.5154556724137;1804.83588085684;2000.2898970865133;2009.1661960286317;839.9836198200246;841.772721365228;881.6693739847557;912.9726108216764;1025.917926565873;15435.691286174213;19398.127084280957;20225.79774202239;20487.4878128048;20646.483837903874;793.9603019848985;912.7216199059218;922.2529750901791;981.1365997921926;1011.2112552209288;10552.15582753378;10775.461226938622;10840.837387439195;10865.511052002521;10869.967353101443;596847;601591;610687;611121;615502;87850;132394;137565;143289.28355358157;147504.52495475122;437.5602519467978;455.10344621096385;456.6301295950291;458.8898664320539;459.34772622875596;10747.677569672922;10813.405262710627;10961.725956851142;11022.50398732043;11327.037201837606;54376;54417.45582544282;54722.726386367816;55948.6012849682;57342.426575733705;51644;83432.33135337381;85283.57358213418;85774.14225857912;86850.56574717085;7810.531368117931;8206.179382061746;8246.847394460792;8298.502089874626;8314.168583141638;7062.081929349151;11308.83036754433;11461.942690286829;12757.298348590917;13079.607611771662;10781.946090269812;11025.897410258909;11157;11178.27341222818;11206;10691.251612387057;10876.945615271872;10883.891161088604;11098.2786118902;11212.215144939775;8450.957745211235;10497.9475102624;11045.779084418427;11276.985071343619;11383.943080284545;8125.4718443301;8167.387445941697;8195.877061843958;8210.178982101743;8212;10451.790964180826;11091.50088246047;11349.319040857576;11377.601783937522;11400.258983166068 14:26:58 INFO - PROCESS | 1671 | |3;mootools.html;1501.3769285746412;1562.7343351630225;1608.2843134805003;1806.304572739495;1933.8452923766108;7989.081255655601;8498.872516912235;8513.489190648557;9017.954910225448;9037.322200834938;7401.444891633122;8667.479951202933;8737.563121843914;8754;8845.115488451152;2352.329586067971;2361.598528250193;2368.609179485383;2393.3537944754908;2403.627437747152;2367.917122900699;2390.0917651292484;2406;2417.5648383291;2419.395151212197;2385.3440303916477;2414.8913298901593;2422.39440139965;2432.963505547418;2437.9512409751796;2373.8338316317863;2382.297222319411;2396.7962723168466;2400.4958958618713;2408.5303365843665;1953.8827670339683;2327.511222643247;2357.2574638988663;2381.4165529445395;2384.403899025244;8783.60473778675;8798.648054077828;8859.202671759509;8897.79879716243;8903.421277616999;5236.371635403738;5303.310569625924;5396.298481197458;5410.48600382963;5410.756515956752;2903.896519322665;2985.268609190762;3549.361114999299;3592.7305452091196;3667.578228503703;1010.2069875148047;1033.829418146005;1036.5180191211123;1037.387941114746;1048.0619845238468;11539.307641541534;11630.360330181837;11666.533338666442;11685.357305348203;11691.240069395462;4561.771911404417;4575.336576196433;4619.514950930104;4668.159731248408;4696.694714843524;9238.67664631748;9239.168474837297;9252.95373523128;9254.722358329262;9255.02822203659;5229.633925625246;5235.188545775411;5273.472652734773;5285.973570132125;5290.1800220965815;3952.4861767970556;4413.249747542925;4903.01939612079;4916.06594746997;4917.188663870493;3773.415120656303;3821.885343439701;3844.058205739612;3860.7876566788536;3935.4883865097354;1186.6768553063446;1204.127007919269;1205.6021512900722;1206.6018213989362;1212.6422705301957;778.2528772378466;882.761654353321;885.93798434109;906.977325566866;916.6699988004314;5171.560417364491;5765.4522820332;5806.767729290781;5975.880482390327;6051;434.4374035623875;434.7391565060938;437.28285611597005;449.8785327961432;452.34410105347376;3934.8622798201927;3982.3429134192534;3987.9202415951518;4053.310937140693;4062.6343629072935;10375.948120259502;10547.472626368652;10801.135909127252;10801.405922674172;10806.243562950518;10668.786624267472;10702.571897124184;10708.518116684769;10713.464326783629;10769.83845242322;8066.31436327907;8146.511209327341;8175.509469431853;8289.0467596226;8308.421399933994;5472.398036216093;5812.651240925558;5880.970595146997;5906.114082887601;5946.851328716817;8357.707480238163;9939.950300248453;10026.398416095057;10054.396736195558;10087.142592879687;9461.574229159567;9915;9971.850422243817;9993.950030249802;10349.223808214263;6467.320931302145;6961.512694111364;7530.134034585873;7616.69533218665;7658.502197357154;8387.245147936716;8435.873461897954;8446.986361636644;8503.787405314917;8529.87205191935;7208.783736487913;7335.7432489862595;7482.401407887465;7572.242775722384;7580.810479738051;6106.542009349228;6432.742690292336;6524.956007038851;7023.894641580278;7358.0434543509;6806.115205023315;6945.617991010543;6972.163340398982;6976.5814051157095;6987.231404545394;4888.511148885225;4907.116718990616;4925.507449255046;5006.69959802413;5125.1799712045895;4346.760928148982;4843.104025755106;4958.107540642719;4996.225585034325;5212.713300768342 14:26:58 INFO - PROCESS | 1671 | |4;prototype.html;271.706556918528;275.374898979317;311.7116667082949;316.6010826358788;317.9173414912122;4611.4466264048315;5061.84814455566;5189.6506908203855;5413.83758487246;5589.7205139743055;4617.492075871652;5316.548093412064;5463;5519.558435325174;5528.170774383844;3631.7094632429344;3967.0479085019606;4057.7768222747736;4154.6676265898805;4166.854160104382;3512.910997590742;3728.384816505273;4058.6347228749405;4146.357314616239;4178.874633760992;3957.267905437489;4015.217032678614;4057.1885622875543;4154.359028183865;4175.66594672427;3454.464557993515;3789.4315852622053;3865.594112618177;4133.586641335843;4181.937270940938;3165.841707914618;3430.6740859618294;3503.7722548034294;3507.8947631571095;3530.293941211742;4165.91668166638;5254.789808407659;5284.6564973277;5325.094733895247;5335.306410166653;4076.714629975903;4380.496242932072;4711.835085772016;4751.643626727975;4762.28565715142;4704.553067458586;5028.4971502849785;5547.5007249347755;5714.799712161203;5816.941830581683;3471.583409990792;3864.5460132815583;3908.5895980922164;3924.1955399143108;3933.409988501719;5637.46444087811;5706.315242170925;5848.3274423441;5859.267591551056;6056.636601803906;3930.9803450982563;3936.3505021671676;3960.7029472789654;3964.6431821136234;3967.78177200251;3849.4225866119746;4011.13760541485;4018.276710192135;4053.6959728020515;4067.535687152623;4204.540343898792;4695.436547614308;4713.882152946135;4726.243800991825;4763.2140696784645;5219.869503262373;5267.3152490176035;5679.949209396275;5811.970940145272;5829.94170058294;1220.9816852747215;1357.2535105692027;1364.6588352911772;1369.3700897587023;1374.2510331869155;790.7825348029338;829.2957971368895;851.3912552524974;853.7524118005833;882.0782282514659;4741.245739076564;5332.33345831771;5391.7034563099405;5409.755756176101;5418.756155972991;5045.823396181116;5065.884481044205;5152.381714194321;5318.138651471954;5667.603267771299;4630.53694630541;4969.329140566049;5061.861081256688;5304.443033481429;5370.9731451342495;2660.5876089206204;2763.935884684411;2879.8848046077924;2923.2837954701236;3170.8573114209917;5317.388500322512;6278.968605156945;6303;6303.653299068504;6310.245403984622;5300.602454815904;6129.701361989254;6193.659348735772;6255.374462553708;6258.968705156536;5326.866828329245;5761.625494342854;6238.781642642486;6266.624002559861;6288.5598008138995;5044.167712327571;5336.866578335573;5567.832965011056;5822.3304320003745;6100.603460775035;5706.087026075808;5873.737146513349;5946.732397042057;5958.851028724316;5962.2249107615735;5226.555742761908;6037.245344331958;6249.3751624578845;6284.685765711788;6297.716602752978;3574.982125089358;3951.920961580695;3953.545342285559;3955.663768579703;3987;4805.831795887128;5210.947890521198;5590.413006634408;6086.817395478142;6096.420840020191;5080.898382032413;5636.4927156556105;5890.022930623616;5901.498372638373;5904.3210030847;5358.196270559447;5540.695261760642;5770.480656740913;5821.875015619184;5880.794172203952;4644.790984405778;5410.458954104558;5703.857403564944;5706.059939620549;5716.456936591017;4727.432708075053;4970.652054356305;5598.048331783688;5845.736941837543;5886.3525012247765;5231.3199284092825;5334.039872822929;5672;5707.203470299606;5707.743151558107 14:26:58 INFO - PROCESS | 1671 | |5;yui.html;696.7039008421422;726.3208899678798;739.4121673269751;758.78374663221;767.7428061599364;14545.781813272795;15179.013364131324;15320.69358612827;15355.232238388078;15441.459548915791;13638.863611363884;13721.45114195431;14876.181810000446;15580.766288505682;15583.532494025168;895.1048951048951;902.571278642646;903.9231665308457;905.4612505559181;905.483874191711;712.5368510468211;891.9375643704943;903.5075883643398;911.3939230411768;918.9724308270762;959.6976952260015;961.3943215774087;962.0139357158898;964.4454438697742;967.3470407474962;911.8267529169436;917.7797328641145;932.1005229953093;941.5433514745343;956.1872408452829;703.4302215205648;703.7536862098225;713.254648891904;713.5005496152662;714.7105422303976;11606.419679016015;13854.445822167101;14634.707305853823;14809.185494797783;15057.623559410993;12173.513059477611;12200.633980980585;12306.384680766016;12342.691432714164;12693.04802139834;7998.600069996477;9148.908510914938;9394.778678771716;9726.36778609388;9881.90118098817;3395.4567269236804;3401.370746411897;3406.267652454709;3439.9656003439895;3448.5689288838894;80259;81063.59468202622;81662.59168704179;82393;82651.76022359669;9054.954725226331;9150.908490915139;9226.815463690822;9348.859767103499;9487.908890477545;17985;20285.898570507346;21257;21260;21311.36065918025;6098.664573448415;7034.472414568825;7323.267673232741;7341.155767086747;7421.851562968711;4001.6598589119667;4085.71400001997;4097.8975525612095;4102.5692302307825;4106.67146628269;3372.37611041958;3476.8261586921058;3477.043812951408;3477.565304336958;3484.0244731475227;565.8698499345173;606.5352174498624;628.4815027602247;634.9746010159635;637.2066776862836;505.38529398571944;552.259971638007;584.1967294969417;585.5169485174748;600.9278886533557;7935.56354400502;7956.283934445928;8002.239787220205;8059.314958228499;8254.8349033019;577.6187716107349;588.7821506042706;597.3667912013279;601.6239850093691;605.5557495373566;3665.541807274091;3818.503594532693;3833.865814696472;3866.3620502617314;3948.802559871995;85057;85159.14840851635;85522.14477855267;85935.57032214924;89459.65810512847;62376.688116560035;74666.6266668674;76802.61598692082;78681;79790.60104699439;65461.67269163719;66564.6671766638;66930.32674183184;67103.65137220174;68262.31737682658;6391.296957334783;7196.316349946746;7196.784096477114;7221.9901744337885;7228;40086;41724;42246.57753422549;42693.78653106715;43251.78374108109;51630.74184629203;54928;60005;60092.69953650204;61088;8220.424570280262;8370.958145209235;9054.683086091954;9190.724278271662;9988.950055249677;8771.210591046582;10641.94679026631;10821.242513024014;10920.18098642589;11542.076633869438;10121;10568.947155264175;10728.624498142528;11118.319079713005;11245.493952772309;7758.650860711395;10183.84724229152;10191.592336306465;10306.33008854452;10505.15958723285;10150.54322555472;10202.438865862448;10430.68707938763;10508.737281568023;10544.998225168596;8798.120187981407;8806.91193088061;8836.160564746338;9035.995444867998;9175.816483670156;8631;8870.290376769972;8922.843238165646;8964.910350896407;9042.457452552604 14:26:58 INFO - PROCESS | 1671 | __end_tp_report 14:26:58 INFO - PROCESS | 1671 | __start_cc_report 14:26:58 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,418 14:26:58 INFO - PROCESS | 1671 | __end_cc_report 14:26:58 INFO - PROCESS | 1671 | __startTimestamp1464298018577__endTimestamp 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | ------- Summary: start ------- 14:26:58 INFO - PROCESS | 1671 | Number of tests: 6 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5758.05 Median:6041.34 stddev:820.62 (13.6%) stddev-sans-first:796.26 14:26:58 INFO - PROCESS | 1671 | Values: 3102.9 3235.7 3461.6 3500.1 3522.8 4752.8 5800.8 5838.2 5870.3 5889.1 5074.0 5645.3 5681.5 5735.7 5813.2 5120.1 5188.4 5258.5 5281.4 5300.7 67.7 5238.1 5301.4 5311.7 5382.0 4352.5 4624.8 4954.8 5265.8 5311.1 5154.4 5315.9 5321.2 5342.8 5363.2 5156.6 5185.1 5250.4 5262.6 5295.4 5458.1 5550.7 5791.2 5796.7 5797.0 6108.3 6236.2 6312.9 6322.8 6331.7 6274.9 6305.3 6307.3 6309.6 6316.9 6014.2 6016.6 6031.6 6040.1 6041.3 6210.6 6285.4 6292.1 6420.1 6438.8 6212.0 6327.5 6329.6 6330.1 6332.8 6309.6 6312.3 6315.9 6349.3 6367.2 6104.5 6221.5 6237.8 6325.6 6326.0 6135.0 6255.0 6281.7 6314.3 6322.3 5018.4 5068.4 5079.7 5091.3 5102.6 4434.1 4449.3 4512.2 4560.7 4584.3 5835.7 5906.6 5917.9 5987.4 6003.2 6287.8 6293.3 6294.4 6302.2 6315.5 4948.0 5745.6 5903.7 5952.7 5996.4 5523.2 5529.8 5530.3 5533.1 5538.4 6262.7 6501.5 6515.4 6518.0 6533.2 6247.8 6272.1 6296.9 6310.8 6319.2 6491.3 6511.8 6523.8 6529.5 6562.1 6103.0 6189.5 6317.3 6337.0 6355.3 6247.5 6296.2 6309.7 6310.7 6350.1 5411.8 6101.5 6240.7 6259.9 6294.2 5548.6 6019.4 6108.1 6244.8 6274.9 5046.5 5062.4 5982.3 6004.8 6140.4 6089.8 6305.1 6308.6 6310.2 6344.8 4926.0 5997.1 6071.8 6114.8 6159.6 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:69667.53 Median:39101.61 stddev:157762.12 (403.5%) stddev-sans-first:158119.20 14:26:58 INFO - PROCESS | 1671 | Values: 498.8 503.9 505.4 521.7 532.0 38010.8 40953.0 41035.2 41118.6 41206.4 41824.8 41877.6 42419.8 42669.6 42672.4 7905.5 9648.9 9667.6 9677.3 10015.7 9595.6 9671.3 9701.7 9703.0 9744.3 9640.1 9690.9 9715.4 9720.6 9733.8 9623.8 9690.2 9701.9 9704.2 9716.4 9466.5 9514.3 9553.1 9599.7 9612.2 39316.6 39771.8 39775.0 39892.6 39935.6 2613.4 2877.9 2897.0 3033.9 3181.6 26693.3 27248.0 27340.6 28057.5 28727.1 2621.4 2628.6 2668.9 2725.6 2800.6 404218.0 467260.0 470835.0 474111.0 474902.0 28256.0 31662.5 33624.8 33727.7 33958.7 31966.7 35401.6 35969.6 36103.5 36169.5 13130.0 13898.1 14913.3 14978.3 14991.9 12684.6 12745.7 12778.6 12791.7 12813.7 7881.4 7885.1 7915.0 7937.0 7939.3 3271.8 3283.3 3296.4 3303.3 3341.0 772.4 933.1 945.4 1009.7 1099.8 29140.0 29490.4 29672.8 29905.4 29921.7 922.4 1025.8 1119.6 1162.8 1163.4 14531.1 15047.2 15085.3 15195.0 15340.1 537598.0 654704.0 665436.0 670705.0 671946.0 57383.1 59383.1 59437.4 59569.7 59644.7 1403.6 1420.3 1436.7 1441.0 1445.8 28338.6 28690.0 28965.6 28988.3 29427.6 54704.5 58077.0 59003.4 59040.4 59199.0 639824.0 643846.0 644246.0 645733.0 646587.0 40198.8 42354.2 42705.6 42750.7 43123.1 45993.0 46600.5 46894.3 47028.3 47166.8 38090.0 38475.0 39014.2 39189.0 39727.8 37592.4 37766.4 37920.8 38606.0 38981.8 37071.3 37543.9 37659.9 37986.8 38703.2 30741.7 32513.7 32995.0 33719.8 33967.8 24631.3 24895.6 24907.9 25180.4 25232.4 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:35151.68 Median:13266.47 stddev:101571.03 (765.6%) stddev-sans-first:101822.40 14:26:58 INFO - PROCESS | 1671 | Values: 376.1 382.7 384.5 395.4 405.3 19396.0 20483.4 21031.1 21251.1 21278.0 17519.1 20746.0 21148.7 21575.0 21621.6 5345.6 5650.4 5805.6 5849.2 5853.6 4803.0 5798.2 5801.2 5830.1 5838.1 5521.5 5738.5 5753.7 5757.7 5766.5 5596.2 5624.1 5716.3 5746.1 5757.3 4900.9 5020.0 5042.6 5047.8 5053.4 20684.3 22049.7 22315.1 26040.0 26156.9 2010.6 2072.6 2084.7 2102.5 2211.1 9166.5 10096.6 12857.8 14952.2 15356.5 1571.2 1752.6 1761.7 1791.1 1821.7 94975.1 122024.0 129067.4 129234.0 129570.0 9605.5 11253.2 11702.4 11835.2 11988.9 14588.3 14812.6 14903.6 14951.9 14979.7 8757.4 8790.0 8807.0 8831.0 8849.5 8710.6 8813.1 8839.1 8901.7 8946.8 4060.8 4476.7 4622.7 4635.4 4648.1 1710.6 1730.5 1804.8 2000.3 2009.2 840.0 841.8 881.7 913.0 1025.9 15435.7 19398.1 20225.8 20487.5 20646.5 794.0 912.7 922.3 981.1 1011.2 10552.2 10775.5 10840.8 10865.5 10870.0 596847.0 601591.0 610687.0 611121.0 615502.0 87850.0 132394.0 137565.0 143289.3 147504.5 437.6 455.1 456.6 458.9 459.3 10747.7 10813.4 10961.7 11022.5 11327.0 54376.0 54417.5 54722.7 55948.6 57342.4 51644.0 83432.3 85283.6 85774.1 86850.6 7810.5 8206.2 8246.8 8298.5 8314.2 7062.1 11308.8 11461.9 12757.3 13079.6 10781.9 11025.9 11157.0 11178.3 11206.0 10691.3 10876.9 10883.9 11098.3 11212.2 8451.0 10497.9 11045.8 11277.0 11383.9 8125.5 8167.4 8195.9 8210.2 8212.0 10451.8 11091.5 11349.3 11377.6 11400.3 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5621.18 Median:4911.59 stddev:3177.45 (64.7%) stddev-sans-first:3171.28 14:26:58 INFO - PROCESS | 1671 | Values: 1501.4 1562.7 1608.3 1806.3 1933.8 7989.1 8498.9 8513.5 9018.0 9037.3 7401.4 8667.5 8737.6 8754.0 8845.1 2352.3 2361.6 2368.6 2393.4 2403.6 2367.9 2390.1 2406.0 2417.6 2419.4 2385.3 2414.9 2422.4 2433.0 2438.0 2373.8 2382.3 2396.8 2400.5 2408.5 1953.9 2327.5 2357.3 2381.4 2384.4 8783.6 8798.6 8859.2 8897.8 8903.4 5236.4 5303.3 5396.3 5410.5 5410.8 2903.9 2985.3 3549.4 3592.7 3667.6 1010.2 1033.8 1036.5 1037.4 1048.1 11539.3 11630.4 11666.5 11685.4 11691.2 4561.8 4575.3 4619.5 4668.2 4696.7 9238.7 9239.2 9253.0 9254.7 9255.0 5229.6 5235.2 5273.5 5286.0 5290.2 3952.5 4413.2 4903.0 4916.1 4917.2 3773.4 3821.9 3844.1 3860.8 3935.5 1186.7 1204.1 1205.6 1206.6 1212.6 778.3 882.8 885.9 907.0 916.7 5171.6 5765.5 5806.8 5975.9 6051.0 434.4 434.7 437.3 449.9 452.3 3934.9 3982.3 3987.9 4053.3 4062.6 10375.9 10547.5 10801.1 10801.4 10806.2 10668.8 10702.6 10708.5 10713.5 10769.8 8066.3 8146.5 8175.5 8289.0 8308.4 5472.4 5812.7 5881.0 5906.1 5946.9 8357.7 9940.0 10026.4 10054.4 10087.1 9461.6 9915.0 9971.9 9994.0 10349.2 6467.3 6961.5 7530.1 7616.7 7658.5 8387.2 8435.9 8447.0 8503.8 8529.9 7208.8 7335.7 7482.4 7572.2 7580.8 6106.5 6432.7 6525.0 7023.9 7358.0 6806.1 6945.6 6972.2 6976.6 6987.2 4888.5 4907.1 4925.5 5006.7 5125.2 4346.8 4843.1 4958.1 4996.2 5212.7 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4616.99 Median:5215.41 stddev:1450.96 (27.8%) stddev-sans-first:1417.90 14:26:58 INFO - PROCESS | 1671 | Values: 271.7 275.4 311.7 316.6 317.9 4611.4 5061.8 5189.7 5413.8 5589.7 4617.5 5316.5 5463.0 5519.6 5528.2 3631.7 3967.0 4057.8 4154.7 4166.9 3512.9 3728.4 4058.6 4146.4 4178.9 3957.3 4015.2 4057.2 4154.4 4175.7 3454.5 3789.4 3865.6 4133.6 4181.9 3165.8 3430.7 3503.8 3507.9 3530.3 4165.9 5254.8 5284.7 5325.1 5335.3 4076.7 4380.5 4711.8 4751.6 4762.3 4704.6 5028.5 5547.5 5714.8 5816.9 3471.6 3864.5 3908.6 3924.2 3933.4 5637.5 5706.3 5848.3 5859.3 6056.6 3931.0 3936.4 3960.7 3964.6 3967.8 3849.4 4011.1 4018.3 4053.7 4067.5 4204.5 4695.4 4713.9 4726.2 4763.2 5219.9 5267.3 5679.9 5812.0 5829.9 1221.0 1357.3 1364.7 1369.4 1374.3 790.8 829.3 851.4 853.8 882.1 4741.2 5332.3 5391.7 5409.8 5418.8 5045.8 5065.9 5152.4 5318.1 5667.6 4630.5 4969.3 5061.9 5304.4 5371.0 2660.6 2763.9 2879.9 2923.3 3170.9 5317.4 6279.0 6303.0 6303.7 6310.2 5300.6 6129.7 6193.7 6255.4 6259.0 5326.9 5761.6 6238.8 6266.6 6288.6 5044.2 5336.9 5567.8 5822.3 6100.6 5706.1 5873.7 5946.7 5958.9 5962.2 5226.6 6037.2 6249.4 6284.7 6297.7 3575.0 3951.9 3953.5 3955.7 3987.0 4805.8 5210.9 5590.4 6086.8 6096.4 5080.9 5636.5 5890.0 5901.5 5904.3 5358.2 5540.7 5770.5 5821.9 5880.8 4644.8 5410.5 5703.9 5706.1 5716.5 4727.4 4970.7 5598.0 5845.7 5886.4 5231.3 5334.0 5672.0 5707.2 5707.7 14:26:58 INFO - PROCESS | 1671 | 14:26:58 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:17106.49 Median:35926.48 stddev:24215.25 (67.4%) stddev-sans-first:24251.84 14:26:58 INFO - PROCESS | 1671 | Values: 696.7 726.3 739.4 758.8 767.7 14545.8 15179.0 15320.7 15355.2 15441.5 13638.9 13721.5 14876.2 15580.8 15583.5 895.1 902.6 903.9 905.5 905.5 712.5 891.9 903.5 911.4 919.0 959.7 961.4 962.0 964.4 967.3 911.8 917.8 932.1 941.5 956.2 703.4 703.8 713.3 713.5 714.7 11606.4 13854.4 14634.7 14809.2 15057.6 12173.5 12200.6 12306.4 12342.7 12693.0 7998.6 9148.9 9394.8 9726.4 9881.9 3395.5 3401.4 3406.3 3440.0 3448.6 80259.0 81063.6 81662.6 82393.0 82651.8 9055.0 9150.9 9226.8 9348.9 9487.9 17985.0 20285.9 21257.0 21260.0 21311.4 6098.7 7034.5 7323.3 7341.2 7421.9 4001.7 4085.7 4097.9 4102.6 4106.7 3372.4 3476.8 3477.0 3477.6 3484.0 565.9 606.5 628.5 635.0 637.2 505.4 552.3 584.2 585.5 600.9 7935.6 7956.3 8002.2 8059.3 8254.8 577.6 588.8 597.4 601.6 605.6 3665.5 3818.5 3833.9 3866.4 3948.8 85057.0 85159.1 85522.1 85935.6 89459.7 62376.7 74666.6 76802.6 78681.0 79790.6 65461.7 66564.7 66930.3 67103.7 68262.3 6391.3 7196.3 7196.8 7222.0 7228.0 40086.0 41724.0 42246.6 42693.8 43251.8 51630.7 54928.0 60005.0 60092.7 61088.0 8220.4 8371.0 9054.7 9190.7 9989.0 8771.2 10641.9 10821.2 10920.2 11542.1 10121.0 10568.9 10728.6 11118.3 11245.5 7758.7 10183.8 10191.6 10306.3 10505.2 10150.5 10202.4 10430.7 10508.7 10545.0 8798.1 8806.9 8836.2 9036.0 9175.8 8631.0 8870.3 8922.8 8964.9 9042.5 14:26:58 INFO - PROCESS | 1671 | -------- Summary: end -------- 14:26:58 INFO - PROCESS | 1671 | 14:26:59 INFO - TEST-INFO | 1671: exit 0 14:26:59 INFO - TEST-OK | dromaeo_css | took 1111584ms 14:26:59 INFO - TEST-START | kraken 14:26:59 INFO - operating with platform_type : mac_ 14:26:59 INFO - Initialising browser for kraken test... 14:26:59 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpsCyyLh/profile http://localhost:49275/getInfo.html) 14:27:02 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 14:27:02 INFO - PROCESS | 1679 | colorDepth:24 14:27:02 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 14:27:02 INFO - PROCESS | 1679 | __metrics 14:27:02 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:27:02 INFO - TEST-INFO | 1679: exit 0 14:27:02 INFO - Browser initialized. 14:27:02 INFO - Running cycle 1/1 for kraken test... 14:27:02 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpsCyyLh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:14 INFO - PROCESS | 1681 | RSS: Main: 252387328 14:27:14 INFO - PROCESS | 1681 | 14:27:17 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:18 INFO - PROCESS | 1681 | RSS: Main: 264200192 14:27:18 INFO - PROCESS | 1681 | 14:27:21 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 14:27:21 INFO - PROCESS | 1681 | RSS: Main: 269000704 14:27:21 INFO - PROCESS | 1681 | 14:27:24 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 14:27:25 INFO - PROCESS | 1681 | RSS: Main: 269172736 14:27:25 INFO - PROCESS | 1681 | 14:27:27 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 14:27:28 INFO - PROCESS | 1681 | RSS: Main: 269844480 14:27:28 INFO - PROCESS | 1681 | 14:27:30 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:30 INFO - PROCESS | 1681 | RSS: Main: 270389248 14:27:30 INFO - PROCESS | 1681 | 14:27:33 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:34 INFO - PROCESS | 1681 | RSS: Main: 271237120 14:27:34 INFO - PROCESS | 1681 | 14:27:37 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:38 INFO - PROCESS | 1681 | RSS: Main: 271302656 14:27:38 INFO - PROCESS | 1681 | 14:27:41 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 14:27:41 INFO - PROCESS | 1681 | RSS: Main: 271667200 14:27:41 INFO - PROCESS | 1681 | 14:27:43 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:43 INFO - PROCESS | 1681 | RSS: Main: 270651392 14:27:43 INFO - PROCESS | 1681 | 14:27:45 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:46 INFO - PROCESS | 1681 | RSS: Main: 270700544 14:27:46 INFO - PROCESS | 1681 | 14:27:48 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:49 INFO - PROCESS | 1681 | RSS: Main: 271032320 14:27:49 INFO - PROCESS | 1681 | 14:27:52 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:53 INFO - PROCESS | 1681 | RSS: Main: 271106048 14:27:53 INFO - PROCESS | 1681 | 14:27:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:56 INFO - PROCESS | 1681 | RSS: Main: 271429632 14:27:56 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 14:27:58 INFO - PROCESS | 1681 | RSS: Main: 273059840 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | __start_tp_report 14:27:58 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 14:27:58 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 14:27:58 INFO - PROCESS | 1681 | |i|pagename|runs| 14:27:58 INFO - PROCESS | 1681 | |0;ai-astar;116;107;117;115;133;142;114;115;114;118 14:27:58 INFO - PROCESS | 1681 | |1;audio-beat-detection;150;118;163;195;151;136;136;120;168;121 14:27:58 INFO - PROCESS | 1681 | |2;audio-dft;193;189;202;204;226;194;196;193;195;191 14:27:58 INFO - PROCESS | 1681 | |3;audio-fft;76;83;75;142;58;58;58;60;126;71 14:27:58 INFO - PROCESS | 1681 | |4;audio-oscillator;70;74;130;70;72;77;113;68;72;116 14:27:58 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;137;131;89;87;90;85;90;87;90;105 14:27:58 INFO - PROCESS | 1681 | |6;imaging-darkroom;95;97;102;100;100;112;119;111;152;152 14:27:58 INFO - PROCESS | 1681 | |7;imaging-desaturate;89;132;130;106;79;145;142;127;132;89 14:27:58 INFO - PROCESS | 1681 | |8;json-parse-financial;56;61;56;58;57;59;59;73;60;61 14:27:58 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;67;71;67;67;94;110;99;92;71;72 14:27:58 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;89;106;113;83;84;76;81;95;107;75 14:27:58 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;152;150;149;147;139;137;138;142;175;141 14:27:58 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;184;230;170;168;162;166;168;164;164;167 14:27:58 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;64;78;88;88;82;75;67;67;66;67 14:27:58 INFO - PROCESS | 1681 | __end_tp_report 14:27:58 INFO - PROCESS | 1681 | __start_cc_report 14:27:58 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1078 14:27:58 INFO - PROCESS | 1681 | __end_cc_report 14:27:58 INFO - PROCESS | 1681 | __startTimestamp1464298078542__endTimestamp 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | ------- Summary: start ------- 14:27:58 INFO - PROCESS | 1681 | Number of tests: 14 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:119.10 Median:116.50 stddev:10.35 (8.9%) stddev-sans-first:10.92 14:27:58 INFO - PROCESS | 1681 | Values: 116.0 107.0 117.0 115.0 133.0 142.0 114.0 115.0 114.0 118.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:150.50 stddev:24.72 (16.4%) stddev-sans-first:26.17 14:27:58 INFO - PROCESS | 1681 | Values: 150.0 118.0 163.0 195.0 151.0 136.0 136.0 120.0 168.0 121.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:198.30 Median:195.50 stddev:10.77 (5.5%) stddev-sans-first:11.25 14:27:58 INFO - PROCESS | 1681 | Values: 193.0 189.0 202.0 204.0 226.0 194.0 196.0 193.0 195.0 191.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:80.70 Median:65.50 stddev:29.70 (45.3%) stddev-sans-first:31.45 14:27:58 INFO - PROCESS | 1681 | Values: 76.0 83.0 75.0 142.0 58.0 58.0 58.0 60.0 126.0 71.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:71.00 stddev:23.61 (33.3%) stddev-sans-first:24.31 14:27:58 INFO - PROCESS | 1681 | Values: 70.0 74.0 130.0 70.0 72.0 77.0 113.0 68.0 72.0 116.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:99.10 Median:88.00 stddev:19.24 (21.9%) stddev-sans-first:14.73 14:27:58 INFO - PROCESS | 1681 | Values: 137.0 131.0 89.0 87.0 90.0 85.0 90.0 87.0 90.0 105.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:114.00 Median:135.50 stddev:21.37 (15.8%) stddev-sans-first:21.54 14:27:58 INFO - PROCESS | 1681 | Values: 95.0 97.0 102.0 100.0 100.0 112.0 119.0 111.0 152.0 152.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:117.10 Median:143.50 stddev:24.18 (16.8%) stddev-sans-first:23.41 14:27:58 INFO - PROCESS | 1681 | Values: 89.0 132.0 130.0 106.0 79.0 145.0 142.0 127.0 132.0 89.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.50 stddev:4.92 (8.3%) stddev-sans-first:5.00 14:27:58 INFO - PROCESS | 1681 | Values: 56.0 61.0 56.0 58.0 57.0 59.0 59.0 73.0 60.0 61.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:71.50 stddev:16.07 (22.5%) stddev-sans-first:16.23 14:27:58 INFO - PROCESS | 1681 | Values: 67.0 71.0 67.0 67.0 94.0 110.0 99.0 92.0 71.0 72.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:82.00 stddev:13.66 (16.7%) stddev-sans-first:14.47 14:27:58 INFO - PROCESS | 1681 | Values: 89.0 106.0 113.0 83.0 84.0 76.0 81.0 95.0 107.0 75.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:148.00 stddev:11.20 (7.6%) stddev-sans-first:11.73 14:27:58 INFO - PROCESS | 1681 | Values: 152.0 150.0 149.0 147.0 139.0 137.0 138.0 142.0 175.0 141.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:168.00 stddev:20.49 (12.2%) stddev-sans-first:21.43 14:27:58 INFO - PROCESS | 1681 | Values: 184.0 230.0 170.0 168.0 162.0 166.0 168.0 164.0 164.0 167.0 14:27:58 INFO - PROCESS | 1681 | 14:27:58 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:76.50 stddev:9.33 (12.2%) stddev-sans-first:9.14 14:27:58 INFO - PROCESS | 1681 | Values: 64.0 78.0 88.0 88.0 82.0 75.0 67.0 67.0 66.0 67.0 14:27:58 INFO - PROCESS | 1681 | -------- Summary: end -------- 14:27:58 INFO - PROCESS | 1681 | 14:27:59 INFO - TEST-INFO | 1681: exit 0 14:27:59 INFO - TEST-OK | kraken | took 60222ms 14:27:59 INFO - SUITE-END | took 1171s 14:27:59 INFO - Completed test suite (00:19:32) 14:27:59 INFO - javascript benchmark 14:27:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6985.568157375037, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.8519447804315, 3235.6764323567645, 3461.6365281645435, 3500.0899766060834, 3522.8414721337535, 4752.786124624392, 5800.825975220745, 5838.182654428379, 5870.26621672291, 5889.116632505126, 5073.985202959414, 5645.266115405002, 5681.52853508723, 5735.741891614877, 5813.157092221625, 5120.103981803198, 5188.429272779991, 5258.474152584749, 5281.419043905167, 5300.708461034642, 67.72653641943954, 5238.109521381355, 5301.416844147141, 5311.707856067915, 5382.0, 4352.455943007124, 4624.768761561909, 4954.752262386903, 5265.815696450625, 5311.123664595318, 5154.355705536808, 5315.920261196085, 5321.2284218788445, 5342.759575819097, 5363.249145119687, 5156.639035267533, 5185.066687996159, 5250.448702886219, 5262.631615786897, 5295.364556253236, 5458.099413596752, 5550.69471179085, 5791.21818554494, 5796.739146738365, 5796.97101514494, 6108.267007959073, 6236.220472440945, 6312.936870631281, 6322.778702745381, 6331.715072821734, 6274.874502509924, 6305.3379395163765, 6307.27466341372, 6309.589876658002, 6316.873662526724, 6014.2181516403025, 6016.639001659871, 6031.577789554733, 6040.093985902062, 6041.335453100155, 6210.596311239755, 6285.402886725754, 6292.087647291117, 6420.0690899819265, 6438.806835794933, 6212.0, 6327.525435592257, 6329.588576742497, 6330.050492426173, 6332.841678958063, 6309.589876658002, 6312.274088479791, 6315.905261421082, 6349.2698339690605, 6367.235931688227, 6104.459155447136, 6221.502279817694, 6237.844053898598, 6325.620462772248, 6326.0, 6135.01831721223, 6255.030470277115, 6281.654509001957, 6314.336994615591, 6322.304546499881, 5018.422881368616, 5068.391792984866, 5079.669821461667, 5091.287219789232, 5102.642815002914, 4434.068845542408, 4449.310356894686, 4512.187806194916, 4560.726356418625, 4584.312353147055, 5835.737391817378, 5906.616069955439, 5917.852053698606, 5987.401259874065, 6003.21958145447, 6287.811365659038, 6293.30773614902, 6294.370562943669, 6302.243730752248, 6315.494760419156, 4947.975260123676, 5745.569082318842, 5903.734331955073, 5952.672603006789, 5996.400359963969, 5523.226748255248, 5529.806456774074, 5530.253415788898, 5533.114701647717, 5538.446155384429, 6262.655553944577, 6501.544891857525, 6515.446187074057, 6517.967410162919, 6533.18335208099, 6247.750089996349, 6272.090546870587, 6296.905546416899, 6310.842228944313, 6319.24169099711, 6491.285958544462, 6511.837204069936, 6523.804285871432, 6529.542931994714, 6562.146920900253, 6103.03463616155, 6189.5048396129105, 6317.305096439296, 6337.003843789192, 6355.300916899045, 6247.468965138014, 6296.181496405438, 6309.652969086745, 6310.6844657766005, 6350.142730731477, 5411.756470958895, 6101.542384321105, 6240.719167637377, 6259.906101408392, 6294.181756371826, 5548.611597188319, 6019.398060194121, 6108.099244189703, 6244.843878902882, 6274.905876411949, 5046.520580544842, 5062.443131255633, 5982.252218472691, 6004.849878753066, 6140.355262697352, 6089.817305480843, 6305.085762564311, 6308.589941653778, 6310.242770867341, 6344.841378965562, 4925.950740492549, 5997.13041608973, 6071.787487438095, 6114.847128821815, 6159.5688301818445], "value": 5707.356698744632, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.76306759237093, 503.9017391608636, 505.41119595671046, 521.7313083761866, 532.0237364436259, 38010.80994595026, 40953.0, 41035.179296414055, 41118.58881411185, 41206.38190427146, 41824.790876045576, 41877.58122418775, 42419.78790106053, 42669.573304266945, 42672.35991460123, 7905.486143400675, 9648.90351096487, 9667.613295468173, 9677.322587418883, 10015.74960625983, 9595.616175353012, 9671.323007389485, 9701.70894873155, 9703.029697030312, 9744.269179811507, 9640.084192001748, 9690.854637180448, 9715.417074975489, 9720.611175553006, 9733.805323893517, 9623.759406014835, 9690.224782017422, 9701.90298097017, 9704.223662107015, 9716.368436051634, 9466.479343636098, 9514.28642851789, 9553.1402173804, 9599.664011759625, 9612.231021518262, 39316.606833931866, 39771.80114099411, 39775.00562485961, 39892.60107398918, 39935.602253921264, 2613.372790530278, 2877.8992735254164, 2897.0, 3033.8634761435787, 3181.586393768818, 26693.332666683487, 27248.04631837876, 27340.58989115165, 28057.456839873797, 28727.13818585446, 2621.397078671897, 2628.6057091436246, 2668.9332766680986, 2725.591161325817, 2800.558714955594, 404218.0, 467260.0, 470835.0, 474111.0, 474902.0, 28256.0, 31662.51712311644, 33624.831875840464, 33727.662723372945, 33958.66041339555, 31966.680333196837, 35401.64598354035, 35969.64030359715, 36103.458448123296, 36169.457458138146, 13130.0, 13898.096623719628, 14913.328900199516, 14978.251087445584, 14991.850081499264, 12684.556040538537, 12745.745085098246, 12778.61664150077, 12791.680207994874, 12813.743725125632, 7881.448298619041, 7885.1326354101, 7914.960425197953, 7937.007874015748, 7939.325157361689, 3271.754618403582, 3283.310504793972, 3296.3901678189613, 3303.3228188221356, 3340.983295083509, 772.3705180278056, 933.0669330669331, 945.4421891084294, 1009.6920439265947, 1099.780043991205, 29139.980100696375, 29490.410191796043, 29672.800514505398, 29905.401891962472, 29921.700782992328, 922.432703887118, 1025.8358662614096, 1119.6081371519904, 1162.8255761635821, 1163.4357336691698, 14531.143120557592, 15047.247637618075, 15085.252188907518, 15195.012324198891, 15340.079595224322, 537598.0, 654704.0, 665436.0, 670705.0, 671946.0, 57383.13925291124, 59383.10925336123, 59437.405625944055, 59569.702151488964, 59644.70177649084, 1403.5719105672663, 1420.2969530082469, 1436.7485690004207, 1440.9783853242209, 1445.8409574946747, 28338.574921376607, 28689.995850145144, 28965.565516516846, 28988.275293116996, 29427.558586621646, 54704.45295547153, 58077.0, 59003.40996590151, 59040.40959590349, 59199.0, 639824.0, 643846.0, 644246.0, 645733.0, 646587.0, 40198.79900600478, 42354.152916942105, 42705.57294427016, 42750.71747847569, 43123.137537249706, 45993.0, 46600.53399465962, 46894.29658555056, 47028.29457558208, 47166.76416617895, 38090.0477488065, 38475.0, 39014.219715606094, 39189.0, 39727.80816575507, 37592.43611345887, 37766.43350349692, 37920.81039594785, 38606.0, 38981.80509097436, 37071.258574827814, 37543.87368378953, 37659.87020389393, 37986.810065949496, 38703.22593548057, 30741.692583073884, 32513.733585927897, 32995.0, 33719.831400842835, 33967.83016084904, 24631.261062168163, 24895.62656560189, 24907.879145438863, 25180.370490737878, 25232.36522816725], "value": 18444.66104556635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.069228659069, 382.6785500179849, 384.4867102418272, 395.4286056648145, 405.2502869691072, 19396.0, 20483.385498435033, 21031.053602587883, 21251.14995400184, 21278.042488088016, 17519.12404379779, 20746.0, 21148.682769758427, 21575.029123689434, 21621.567568648657, 5345.599080068991, 5650.406707295737, 5805.622634528763, 5849.239598852143, 5853.64878107315, 4802.97598512007, 5798.2172406725185, 5801.245838041049, 5830.096335068071, 5838.095095260242, 5521.475459831309, 5738.454846789569, 5753.741081651336, 5757.68332741699, 5766.452187042224, 5596.188552659842, 5624.128260119688, 5716.256886604757, 5746.138079288098, 5757.337906140785, 4900.926486102711, 5019.974900125512, 5042.621803364726, 5047.772850221712, 5053.444121146671, 20684.276050338318, 22049.669254961187, 22315.10739570415, 26040.0, 26156.86921565399, 2010.58782949495, 2072.626927153112, 2084.713264772532, 2102.5374417628095, 2211.1155537784853, 9166.495842728647, 10096.596136154545, 12857.842794148479, 14952.177630230333, 15356.539303820904, 1571.2222449887265, 1752.5969027123706, 1761.6740902932997, 1791.0596936608254, 1821.7176337667684, 94975.0502494973, 122024.0, 129067.35466322608, 129234.0, 129570.0, 9605.519724013771, 11253.156013299036, 11702.414879256003, 11835.230710003822, 11988.940055299669, 14588.270586470633, 14812.555623331318, 14903.627409314853, 14951.850481495263, 14979.700405992036, 8757.386982911263, 8789.97830498976, 8806.955965220133, 8830.955845220862, 8849.51327676984, 8710.564471776512, 8813.074627164184, 8839.071897450804, 8901.73294801157, 8946.776330591787, 4060.7766572838777, 4476.7090139140855, 4622.653301002439, 4635.3742244797195, 4648.070385922829, 1710.598009467774, 1730.5154556724137, 1804.83588085684, 2000.2898970865133, 2009.1661960286317, 839.9836198200246, 841.772721365228, 881.6693739847557, 912.9726108216764, 1025.917926565873, 15435.691286174213, 19398.127084280957, 20225.79774202239, 20487.4878128048, 20646.483837903874, 793.9603019848985, 912.7216199059218, 922.2529750901791, 981.1365997921926, 1011.2112552209288, 10552.15582753378, 10775.461226938622, 10840.837387439195, 10865.511052002521, 10869.967353101443, 596847.0, 601591.0, 610687.0, 611121.0, 615502.0, 87850.0, 132394.0, 137565.0, 143289.28355358157, 147504.52495475122, 437.5602519467978, 455.10344621096385, 456.6301295950291, 458.8898664320539, 459.34772622875596, 10747.677569672922, 10813.405262710627, 10961.725956851142, 11022.50398732043, 11327.037201837606, 54376.0, 54417.45582544282, 54722.726386367816, 55948.6012849682, 57342.426575733705, 51644.0, 83432.33135337381, 85283.57358213418, 85774.14225857912, 86850.56574717085, 7810.531368117931, 8206.179382061746, 8246.847394460792, 8298.502089874626, 8314.168583141638, 7062.081929349151, 11308.83036754433, 11461.942690286829, 12757.298348590917, 13079.607611771662, 10781.946090269812, 11025.897410258909, 11157.0, 11178.27341222818, 11206.0, 10691.251612387057, 10876.945615271872, 10883.891161088604, 11098.2786118902, 11212.215144939775, 8450.957745211235, 10497.9475102624, 11045.779084418427, 11276.985071343619, 11383.943080284545, 8125.4718443301, 8167.387445941697, 8195.877061843958, 8210.178982101743, 8212.0, 10451.790964180826, 11091.50088246047, 11349.319040857576, 11377.601783937522, 11400.258983166068], "value": 9130.186095101228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.3769285746412, 1562.7343351630225, 1608.2843134805003, 1806.304572739495, 1933.8452923766108, 7989.081255655601, 8498.872516912235, 8513.489190648557, 9017.954910225448, 9037.322200834938, 7401.444891633122, 8667.479951202933, 8737.563121843914, 8754.0, 8845.115488451152, 2352.329586067971, 2361.598528250193, 2368.609179485383, 2393.3537944754908, 2403.627437747152, 2367.917122900699, 2390.0917651292484, 2406.0, 2417.5648383291, 2419.395151212197, 2385.3440303916477, 2414.8913298901593, 2422.39440139965, 2432.963505547418, 2437.9512409751796, 2373.8338316317863, 2382.297222319411, 2396.7962723168466, 2400.4958958618713, 2408.5303365843665, 1953.8827670339683, 2327.511222643247, 2357.2574638988663, 2381.4165529445395, 2384.403899025244, 8783.60473778675, 8798.648054077828, 8859.202671759509, 8897.79879716243, 8903.421277616999, 5236.371635403738, 5303.310569625924, 5396.298481197458, 5410.48600382963, 5410.756515956752, 2903.896519322665, 2985.268609190762, 3549.361114999299, 3592.7305452091196, 3667.578228503703, 1010.2069875148047, 1033.829418146005, 1036.5180191211123, 1037.387941114746, 1048.0619845238468, 11539.307641541534, 11630.360330181837, 11666.533338666442, 11685.357305348203, 11691.240069395462, 4561.771911404417, 4575.336576196433, 4619.514950930104, 4668.159731248408, 4696.694714843524, 9238.67664631748, 9239.168474837297, 9252.95373523128, 9254.722358329262, 9255.02822203659, 5229.633925625246, 5235.188545775411, 5273.472652734773, 5285.973570132125, 5290.1800220965815, 3952.4861767970556, 4413.249747542925, 4903.01939612079, 4916.06594746997, 4917.188663870493, 3773.415120656303, 3821.885343439701, 3844.058205739612, 3860.7876566788536, 3935.4883865097354, 1186.6768553063446, 1204.127007919269, 1205.6021512900722, 1206.6018213989362, 1212.6422705301957, 778.2528772378466, 882.761654353321, 885.93798434109, 906.977325566866, 916.6699988004314, 5171.560417364491, 5765.4522820332, 5806.767729290781, 5975.880482390327, 6051.0, 434.4374035623875, 434.7391565060938, 437.28285611597005, 449.8785327961432, 452.34410105347376, 3934.8622798201927, 3982.3429134192534, 3987.9202415951518, 4053.310937140693, 4062.6343629072935, 10375.948120259502, 10547.472626368652, 10801.135909127252, 10801.405922674172, 10806.243562950518, 10668.786624267472, 10702.571897124184, 10708.518116684769, 10713.464326783629, 10769.83845242322, 8066.31436327907, 8146.511209327341, 8175.509469431853, 8289.0467596226, 8308.421399933994, 5472.398036216093, 5812.651240925558, 5880.970595146997, 5906.114082887601, 5946.851328716817, 8357.707480238163, 9939.950300248453, 10026.398416095057, 10054.396736195558, 10087.142592879687, 9461.574229159567, 9915.0, 9971.850422243817, 9993.950030249802, 10349.223808214263, 6467.320931302145, 6961.512694111364, 7530.134034585873, 7616.69533218665, 7658.502197357154, 8387.245147936716, 8435.873461897954, 8446.986361636644, 8503.787405314917, 8529.87205191935, 7208.783736487913, 7335.7432489862595, 7482.401407887465, 7572.242775722384, 7580.810479738051, 6106.542009349228, 6432.742690292336, 6524.956007038851, 7023.894641580278, 7358.0434543509, 6806.115205023315, 6945.617991010543, 6972.163340398982, 6976.5814051157095, 6987.231404545394, 4888.511148885225, 4907.116718990616, 4925.507449255046, 5006.69959802413, 5125.1799712045895, 4346.760928148982, 4843.104025755106, 4958.107540642719, 4996.225585034325, 5212.713300768342], "value": 4440.4459103620065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.706556918528, 275.374898979317, 311.7116667082949, 316.6010826358788, 317.9173414912122, 4611.4466264048315, 5061.84814455566, 5189.6506908203855, 5413.83758487246, 5589.7205139743055, 4617.492075871652, 5316.548093412064, 5463.0, 5519.558435325174, 5528.170774383844, 3631.7094632429344, 3967.0479085019606, 4057.7768222747736, 4154.6676265898805, 4166.854160104382, 3512.910997590742, 3728.384816505273, 4058.6347228749405, 4146.357314616239, 4178.874633760992, 3957.267905437489, 4015.217032678614, 4057.1885622875543, 4154.359028183865, 4175.66594672427, 3454.464557993515, 3789.4315852622053, 3865.594112618177, 4133.586641335843, 4181.937270940938, 3165.841707914618, 3430.6740859618294, 3503.7722548034294, 3507.8947631571095, 3530.293941211742, 4165.91668166638, 5254.789808407659, 5284.6564973277, 5325.094733895247, 5335.306410166653, 4076.714629975903, 4380.496242932072, 4711.835085772016, 4751.643626727975, 4762.28565715142, 4704.553067458586, 5028.4971502849785, 5547.5007249347755, 5714.799712161203, 5816.941830581683, 3471.583409990792, 3864.5460132815583, 3908.5895980922164, 3924.1955399143108, 3933.409988501719, 5637.46444087811, 5706.315242170925, 5848.3274423441, 5859.267591551056, 6056.636601803906, 3930.9803450982563, 3936.3505021671676, 3960.7029472789654, 3964.6431821136234, 3967.78177200251, 3849.4225866119746, 4011.13760541485, 4018.276710192135, 4053.6959728020515, 4067.535687152623, 4204.540343898792, 4695.436547614308, 4713.882152946135, 4726.243800991825, 4763.2140696784645, 5219.869503262373, 5267.3152490176035, 5679.949209396275, 5811.970940145272, 5829.94170058294, 1220.9816852747215, 1357.2535105692027, 1364.6588352911772, 1369.3700897587023, 1374.2510331869155, 790.7825348029338, 829.2957971368895, 851.3912552524974, 853.7524118005833, 882.0782282514659, 4741.245739076564, 5332.33345831771, 5391.7034563099405, 5409.755756176101, 5418.756155972991, 5045.823396181116, 5065.884481044205, 5152.381714194321, 5318.138651471954, 5667.603267771299, 4630.53694630541, 4969.329140566049, 5061.861081256688, 5304.443033481429, 5370.9731451342495, 2660.5876089206204, 2763.935884684411, 2879.8848046077924, 2923.2837954701236, 3170.8573114209917, 5317.388500322512, 6278.968605156945, 6303.0, 6303.653299068504, 6310.245403984622, 5300.602454815904, 6129.701361989254, 6193.659348735772, 6255.374462553708, 6258.968705156536, 5326.866828329245, 5761.625494342854, 6238.781642642486, 6266.624002559861, 6288.5598008138995, 5044.167712327571, 5336.866578335573, 5567.832965011056, 5822.3304320003745, 6100.603460775035, 5706.087026075808, 5873.737146513349, 5946.732397042057, 5958.851028724316, 5962.2249107615735, 5226.555742761908, 6037.245344331958, 6249.3751624578845, 6284.685765711788, 6297.716602752978, 3574.982125089358, 3951.920961580695, 3953.545342285559, 3955.663768579703, 3987.0, 4805.831795887128, 5210.947890521198, 5590.413006634408, 6086.817395478142, 6096.420840020191, 5080.898382032413, 5636.4927156556105, 5890.022930623616, 5901.498372638373, 5904.3210030847, 5358.196270559447, 5540.695261760642, 5770.480656740913, 5821.875015619184, 5880.794172203952, 4644.790984405778, 5410.458954104558, 5703.857403564944, 5706.059939620549, 5716.456936591017, 4727.432708075053, 4970.652054356305, 5598.048331783688, 5845.736941837543, 5886.3525012247765, 5231.3199284092825, 5334.039872822929, 5672.0, 5707.203470299606, 5707.743151558107], "value": 4147.103861552268, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.7039008421422, 726.3208899678798, 739.4121673269751, 758.78374663221, 767.7428061599364, 14545.781813272795, 15179.013364131324, 15320.69358612827, 15355.232238388078, 15441.459548915791, 13638.863611363884, 13721.45114195431, 14876.181810000446, 15580.766288505682, 15583.532494025168, 895.1048951048951, 902.571278642646, 903.9231665308457, 905.4612505559181, 905.483874191711, 712.5368510468211, 891.9375643704943, 903.5075883643398, 911.3939230411768, 918.9724308270762, 959.6976952260015, 961.3943215774087, 962.0139357158898, 964.4454438697742, 967.3470407474962, 911.8267529169436, 917.7797328641145, 932.1005229953093, 941.5433514745343, 956.1872408452829, 703.4302215205648, 703.7536862098225, 713.254648891904, 713.5005496152662, 714.7105422303976, 11606.419679016015, 13854.445822167101, 14634.707305853823, 14809.185494797783, 15057.623559410993, 12173.513059477611, 12200.633980980585, 12306.384680766016, 12342.691432714164, 12693.04802139834, 7998.600069996477, 9148.908510914938, 9394.778678771716, 9726.36778609388, 9881.90118098817, 3395.4567269236804, 3401.370746411897, 3406.267652454709, 3439.9656003439895, 3448.5689288838894, 80259.0, 81063.59468202622, 81662.59168704179, 82393.0, 82651.76022359669, 9054.954725226331, 9150.908490915139, 9226.815463690822, 9348.859767103499, 9487.908890477545, 17985.0, 20285.898570507346, 21257.0, 21260.0, 21311.36065918025, 6098.664573448415, 7034.472414568825, 7323.267673232741, 7341.155767086747, 7421.851562968711, 4001.6598589119667, 4085.71400001997, 4097.8975525612095, 4102.5692302307825, 4106.67146628269, 3372.37611041958, 3476.8261586921058, 3477.043812951408, 3477.565304336958, 3484.0244731475227, 565.8698499345173, 606.5352174498624, 628.4815027602247, 634.9746010159635, 637.2066776862836, 505.38529398571944, 552.259971638007, 584.1967294969417, 585.5169485174748, 600.9278886533557, 7935.56354400502, 7956.283934445928, 8002.239787220205, 8059.314958228499, 8254.8349033019, 577.6187716107349, 588.7821506042706, 597.3667912013279, 601.6239850093691, 605.5557495373566, 3665.541807274091, 3818.503594532693, 3833.865814696472, 3866.3620502617314, 3948.802559871995, 85057.0, 85159.14840851635, 85522.14477855267, 85935.57032214924, 89459.65810512847, 62376.688116560035, 74666.6266668674, 76802.61598692082, 78681.0, 79790.60104699439, 65461.67269163719, 66564.6671766638, 66930.32674183184, 67103.65137220174, 68262.31737682658, 6391.296957334783, 7196.316349946746, 7196.784096477114, 7221.9901744337885, 7228.0, 40086.0, 41724.0, 42246.57753422549, 42693.78653106715, 43251.78374108109, 51630.74184629203, 54928.0, 60005.0, 60092.69953650204, 61088.0, 8220.424570280262, 8370.958145209235, 9054.683086091954, 9190.724278271662, 9988.950055249677, 8771.210591046582, 10641.94679026631, 10821.242513024014, 10920.18098642589, 11542.076633869438, 10121.0, 10568.947155264175, 10728.624498142528, 11118.319079713005, 11245.493952772309, 7758.650860711395, 10183.84724229152, 10191.592336306465, 10306.33008854452, 10505.15958723285, 10150.54322555472, 10202.438865862448, 10430.68707938763, 10508.737281568023, 10544.998225168596, 8798.120187981407, 8806.91193088061, 8836.160564746338, 9035.995444867998, 9175.816483670156, 8631.0, 8870.290376769972, 8922.843238165646, 8964.910350896407, 9042.457452552604], "value": 6564.637196515468, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 117.0, 115.0, 133.0, 142.0, 114.0, 115.0, 114.0, 118.0], "value": 119.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 163.0, 195.0, 151.0, 136.0, 136.0, 120.0, 168.0, 121.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 189.0, 202.0, 204.0, 226.0, 194.0, 196.0, 193.0, 195.0, 191.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 75.0, 142.0, 58.0, 58.0, 58.0, 60.0, 126.0, 71.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 130.0, 70.0, 72.0, 77.0, 113.0, 68.0, 72.0, 116.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 89.0, 87.0, 90.0, 85.0, 90.0, 87.0, 90.0, 105.0], "value": 99.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 102.0, 100.0, 100.0, 112.0, 119.0, 111.0, 152.0, 152.0], "value": 114.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 132.0, 130.0, 106.0, 79.0, 145.0, 142.0, 127.0, 132.0, 89.0], "value": 117.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 56.0, 58.0, 57.0, 59.0, 59.0, 73.0, 60.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 67.0, 94.0, 110.0, 99.0, 92.0, 71.0, 72.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 106.0, 113.0, 83.0, 84.0, 76.0, 81.0, 95.0, 107.0, 75.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 149.0, 147.0, 139.0, 137.0, 138.0, 142.0, 175.0, 141.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 230.0, 170.0, 168.0, 162.0, 166.0, 168.0, 164.0, 164.0, 167.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 78.0, 88.0, 88.0, 82.0, 75.0, 67.0, 67.0, 66.0, 67.0], "value": 74.2, "unit": "score"}]}]} 14:27:59 INFO - Return code: 0 14:27:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:27:59 ERROR - # TBPL SUCCESS # 14:27:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:27:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:27:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:27:59 INFO - 2016-05-26 14:27:59.887 screenresolution[1686:10277] starting screenresolution argv=screenresolution get 14:27:59 INFO - 2016-05-26 14:27:59.890 screenresolution[1686:10277] Display 0: 1600x1200x32@60 14:27:59 INFO - 2016-05-26 14:27:59.896 screenresolution[1687:10281] starting screenresolution argv=screenresolution list 14:27:59 INFO - Available Modes on Display 0 14:27:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:27:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:27:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:27:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:00 INFO - Intel Iris: 14:28:00 INFO - Chipset Model: Intel Iris 14:28:00 INFO - Type: GPU 14:28:00 INFO - Bus: Built-In 14:28:00 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:00 INFO - Vendor: Intel (0x8086) 14:28:00 INFO - Device ID: 0x0a2e 14:28:00 INFO - Revision ID: 0x0009 14:28:00 INFO - Displays: 14:28:00 INFO - Display: 14:28:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:00 INFO - Display Serial Number: 1600x1200 60 14:28:00 INFO - Main Display: Yes 14:28:00 INFO - Mirror: Off 14:28:00 INFO - Online: Yes 14:28:00 INFO - Rotation: Supported 14:28:00 INFO - Return code: 0 14:28:00 INFO - Running post-action listener: _resource_record_post_action 14:28:00 INFO - ##### 14:28:00 INFO - ##### Finished run-tests step (success) 14:28:00 INFO - ##### 14:28:00 INFO - Running post-run listener: _resource_record_post_run 14:28:00 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 36759040; Write bytes: 693731328; Read time: 245; Write time: 1946 14:28:00 INFO - TinderboxPrint: CPU usage
54.4% 14:28:00 INFO - TinderboxPrint: I/O read bytes / time
36,759,040 / 245 14:28:00 INFO - TinderboxPrint: I/O write bytes / time
693,731,328 / 1,946 14:28:00 INFO - TinderboxPrint: CPU idle
2,200.5 (45.6%) 14:28:00 INFO - TinderboxPrint: CPU system
973.0 (20.1%) 14:28:00 INFO - TinderboxPrint: CPU user
1,656.1 (34.3%) 14:28:00 INFO - TinderboxPrint: Swap in / out
433,315,840 / 0 14:28:00 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402983424; Write bytes: 398775808; Read time: 29823; Write time: 851 14:28:00 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29715968; Write bytes: 293939712; Read time: 179; Write time: 1092 14:28:00 INFO - Running post-run listener: _upload_blobber_files 14:28:00 INFO - Blob upload gear active. 14:28:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:28:00 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'] 14:28:00 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 14:28:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:02 INFO - (blobuploader) - INFO - Done attempting. 14:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:03 INFO - (blobuploader) - INFO - Done attempting. 14:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:06 INFO - (blobuploader) - INFO - Done attempting. 14:28:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:06 INFO - Return code: 0 14:28:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2c4fac9320d0a3186a7cf764b64bb8d9e791a955f96fc16a4ea9eb3b6598eb853b95faa83ef2a8c13ce51cfea2c5ecd1d5e2f172012865481552f299a446ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81553ee0972c4dbf34e809573b30dadcdbb844f1e470caa3360c0ea5878b5b9101dd01d0082ab7fba5d7e3af803a574f5dd7cd72b7c7a58c6263105df6fc2f3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdbded687c4bfb20e32b617e3587c362ddc189ecbb6ed61c9b32e2eb8e1f8bc7446eab037c2887b881af62ab7d2d73a9228f842cf4661afe7711f4afad65907b"} 14:28:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:06 INFO - Contents: 14:28:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2c4fac9320d0a3186a7cf764b64bb8d9e791a955f96fc16a4ea9eb3b6598eb853b95faa83ef2a8c13ce51cfea2c5ecd1d5e2f172012865481552f299a446ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81553ee0972c4dbf34e809573b30dadcdbb844f1e470caa3360c0ea5878b5b9101dd01d0082ab7fba5d7e3af803a574f5dd7cd72b7c7a58c6263105df6fc2f3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdbded687c4bfb20e32b617e3587c362ddc189ecbb6ed61c9b32e2eb8e1f8bc7446eab037c2887b881af62ab7d2d73a9228f842cf4661afe7711f4afad65907b"} 14:28:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:06 INFO - Copying logs to upload dir... 14:28:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.653821 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-05-26 14:28:06.195527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 14:28:06.200000) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypbtOsYKZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2c4fac9320d0a3186a7cf764b64bb8d9e791a955f96fc16a4ea9eb3b6598eb853b95faa83ef2a8c13ce51cfea2c5ecd1d5e2f172012865481552f299a446ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81553ee0972c4dbf34e809573b30dadcdbb844f1e470caa3360c0ea5878b5b9101dd01d0082ab7fba5d7e3af803a574f5dd7cd72b7c7a58c6263105df6fc2f3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdbded687c4bfb20e32b617e3587c362ddc189ecbb6ed61c9b32e2eb8e1f8bc7446eab037c2887b881af62ab7d2d73a9228f842cf4661afe7711f4afad65907b"} build_url:https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010669 build_url: 'https://queue.taskcluster.net/v1/task/VpaoSCIZQ2GjFbd7R2zEOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2c4fac9320d0a3186a7cf764b64bb8d9e791a955f96fc16a4ea9eb3b6598eb853b95faa83ef2a8c13ce51cfea2c5ecd1d5e2f172012865481552f299a446ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81553ee0972c4dbf34e809573b30dadcdbb844f1e470caa3360c0ea5878b5b9101dd01d0082ab7fba5d7e3af803a574f5dd7cd72b7c7a58c6263105df6fc2f3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdbded687c4bfb20e32b617e3587c362ddc189ecbb6ed61c9b32e2eb8e1f8bc7446eab037c2887b881af62ab7d2d73a9228f842cf4661afe7711f4afad65907b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 14:28:06.238306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:28:06.239088) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypbtOsYKZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.c2nESHcfZR/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005005 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:28:06.291618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 14:28:06.292351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 14:28:06.293058) ========= ========= Total master_lag: 0.19 =========