builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0261 starttime: 1464611412.68 results: success (0) buildid: 20160530030222 builduid: de919baeb673425787a2c9a3cab47b2c revision: cad514ad49c199e823a92e8c8d27e16c22c3cac7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:12.677332) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:12.677772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:12.678144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:12.745448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:12.745773) ========= 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.opjJlAhcAn/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.mxnJV0XVqp/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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-30 05:30:12-- 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% 17.2M=0.001s 2016-05-30 05:30:13 (17.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.490568 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:13.268818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:13.269153) ========= 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.opjJlAhcAn/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.mxnJV0XVqp/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.024774 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:13.342428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-30 05:30:13.342763) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cad514ad49c199e823a92e8c8d27e16c22c3cac7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cad514ad49c199e823a92e8c8d27e16c22c3cac7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.opjJlAhcAn/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.mxnJV0XVqp/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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-30 05:30:13,409 truncating revision to first 12 chars 2016-05-30 05:30:13,409 Setting DEBUG logging. 2016-05-30 05:30:13,409 attempt 1/10 2016-05-30 05:30:13,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cad514ad49c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 05:30:14,578 unpacking tar archive at: mozilla-central-cad514ad49c1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.336666 ========= master_lag: 0.76 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-30 05:30:16.436360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:16.436696) ========= script_repo_revision: cad514ad49c199e823a92e8c8d27e16c22c3cac7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 05:30:16.437111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-05-30 05:30:16.437386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-05-30 05:30:21.320896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 29 secs) (at 2016-05-30 05:30:21.321182) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.opjJlAhcAn/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.mxnJV0XVqp/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:30:21 INFO - MultiFileLogger online at 20160530 05:30:21 in /builds/slave/test 05:30:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:30:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:30:21 INFO - {'append_to_log': False, 05:30:21 INFO - 'base_work_dir': '/builds/slave/test', 05:30:21 INFO - 'blob_upload_branch': 'Firefox', 05:30:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:30:21 INFO - 'branch': 'Firefox', 05:30:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:21 INFO - 'config_files': ('talos/mac_config.py',), 05:30:21 INFO - 'default_actions': ('clobber', 05:30:21 INFO - 'read-buildbot-config', 05:30:21 INFO - 'download-and-extract', 05:30:21 INFO - 'populate-webroot', 05:30:21 INFO - 'create-virtualenv', 05:30:21 INFO - 'install', 05:30:21 INFO - 'run-tests'), 05:30:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:21 INFO - 'download_minidump_stackwalk': True, 05:30:21 INFO - 'download_symbols': 'ondemand', 05:30:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:21 INFO - 'installer_path': 'installer.exe', 05:30:21 INFO - 'log_level': 'info', 05:30:21 INFO - 'log_name': 'talos', 05:30:21 INFO - 'log_to_console': True, 05:30:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:30:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:30:21 INFO - 'opt_config_files': (), 05:30:21 INFO - 'pip_index': False, 05:30:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:21 INFO - 'cmd': ('bash', 05:30:21 INFO - '-c', 05:30:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:21 INFO - 'enabled': True, 05:30:21 INFO - 'halt_on_failure': False, 05:30:21 INFO - 'name': 'check_screen_resolution'},), 05:30:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:21 INFO - 'cmd': ('bash', 05:30:21 INFO - '-c', 05:30:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:21 INFO - 'enabled': True, 05:30:21 INFO - 'halt_on_failure': False, 05:30:21 INFO - 'name': 'check_screen_resolution'},), 05:30:21 INFO - 'run_cmd_checks_enabled': True, 05:30:21 INFO - 'sps_profile': False, 05:30:21 INFO - 'sps_profile_interval': 0, 05:30:21 INFO - 'suite': 'dromaeojs-e10s', 05:30:21 INFO - 'system_bits': '32', 05:30:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:21 INFO - 'title': 't-yosemite-r7-0261', 05:30:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:21 INFO - 'use_talos_json': True, 05:30:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:30:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:21 INFO - 'work_dir': 'build'} 05:30:21 INFO - ##### 05:30:21 INFO - ##### Running clobber step. 05:30:21 INFO - ##### 05:30:21 INFO - Running pre-action listener: _resource_record_pre_action 05:30:21 INFO - Running main action method: clobber 05:30:21 INFO - rmtree: /builds/slave/test/build 05:30:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:30:23 INFO - Running post-action listener: _resource_record_post_action 05:30:23 INFO - ##### 05:30:23 INFO - ##### Finished clobber step (success) 05:30:23 INFO - ##### 05:30:23 INFO - ##### 05:30:23 INFO - ##### Running read-buildbot-config step. 05:30:23 INFO - ##### 05:30:23 INFO - Running pre-action listener: _resource_record_pre_action 05:30:23 INFO - Running main action method: read_buildbot_config 05:30:23 INFO - Using buildbot properties: 05:30:23 INFO - { 05:30:23 INFO - "project": "", 05:30:23 INFO - "product": "firefox", 05:30:23 INFO - "script_repo_revision": "production", 05:30:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:30:23 INFO - "repository": "", 05:30:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:30:23 INFO - "buildid": "20160530030222", 05:30:23 INFO - "stage_platform": "macosx64", 05:30:23 INFO - "basedir": "/builds/slave/test", 05:30:23 INFO - "nightly_build": "True", 05:30:23 INFO - "buildnumber": 17, 05:30:23 INFO - "slavename": "t-yosemite-r7-0261", 05:30:23 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:30:23 INFO - "platform": "yosemite_r7", 05:30:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:30:23 INFO - "branch": "mozilla-central", 05:30:23 INFO - "repo_path": "mozilla-central", 05:30:23 INFO - "revision": "cad514ad49c199e823a92e8c8d27e16c22c3cac7", 05:30:23 INFO - "pgo_build": "False", 05:30:23 INFO - "builduid": "de919baeb673425787a2c9a3cab47b2c", 05:30:23 INFO - "slavebuilddir": "test" 05:30:23 INFO - } 05:30:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:30:23 INFO - Running post-action listener: _resource_record_post_action 05:30:23 INFO - ##### 05:30:23 INFO - ##### Finished read-buildbot-config step (success) 05:30:23 INFO - ##### 05:30:23 INFO - ##### 05:30:23 INFO - ##### Running download-and-extract step. 05:30:23 INFO - ##### 05:30:23 INFO - Running pre-action listener: _resource_record_pre_action 05:30:23 INFO - Running main action method: download_and_extract 05:30:23 INFO - mkdir: /builds/slave/test/build/tests 05:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:23 INFO - https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:30:53 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 05:30:53 INFO - retry: attempt #1 caught exception: timed out 05:30:53 INFO - retry: Failed, sleeping 30 seconds before retrying 05:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 #2 05:31:41 INFO - Downloaded 1199 bytes. 05:31:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:31:41 INFO - Using the following test package requirements: 05:31:41 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:31:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:31:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'jsshell-mac.zip'], 05:31:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:31:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:31:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:31:41 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:31:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:31:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:31:41 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:41 INFO - https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:46 INFO - Downloaded 18684832 bytes. 05:31:46 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'] 05:31:46 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 05:31:49 INFO - Return code: 0 05:31:49 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 05:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:49 INFO - https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:31:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:31:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:50 INFO - Downloaded 18684832 bytes. 05:31:50 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'] 05:31:50 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 05:31:54 INFO - Return code: 0 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:54 INFO - https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:31:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:31:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:31:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:55 INFO - Downloaded 10834034 bytes. 05:31:55 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'] 05:31:55 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 05:31:56 INFO - Return code: 0 05:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:56 INFO - https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:31:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:31:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:31:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNtmLL7sTFq_zV6YdGdR1A/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 05:31:59 INFO - Downloaded 110611948 bytes. 05:31:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:31:59 INFO - mkdir: /builds/slave/test/properties 05:31:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:59 INFO - Contents: 05:31:59 INFO - build_url:https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:32:00 INFO - Running post-action listener: _resource_record_post_action 05:32:00 INFO - Running post-action listener: set_extra_try_arguments 05:32:00 INFO - ##### 05:32:00 INFO - ##### Finished download-and-extract step (success) 05:32:00 INFO - ##### 05:32:00 INFO - ##### 05:32:00 INFO - ##### Running populate-webroot step. 05:32:00 INFO - ##### 05:32:00 INFO - Running pre-action listener: _resource_record_pre_action 05:32:00 INFO - Running main action method: populate_webroot 05:32:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:00 INFO - '--tppagecycles', 05:32:00 INFO - '7'], 05:32:00 INFO - 'tests': ['tsvgm']}}, 05:32:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['damp', 'tps']}, 05:32:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'tests': ['damp', 'tps']}, 05:32:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['dromaeo_dom']}, 05:32:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore', 05:32:00 INFO - 'tabpaint']}, 05:32:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore', 05:32:00 INFO - 'tabpaint']}, 05:32:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore', 05:32:00 INFO - 'tabpaint']}, 05:32:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore', 05:32:00 INFO - 'tabpaint']}, 05:32:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore', 05:32:00 INFO - 'tabpaint']}, 05:32:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['a11yr', 05:32:00 INFO - 'ts_paint', 05:32:00 INFO - 'tpaint', 05:32:00 INFO - 'sessionrestore', 05:32:00 INFO - 'sessionrestore_no_auto_restore', 05:32:00 INFO - 'tabpaint']}, 05:32:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['tsvgx', 05:32:00 INFO - 'tsvgr_opacity', 05:32:00 INFO - 'tart', 05:32:00 INFO - 'tscrollx', 05:32:00 INFO - 'cart']}, 05:32:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:00 INFO - 'tsvgr_opacity', 05:32:00 INFO - 'tart', 05:32:00 INFO - 'tscrollx', 05:32:00 INFO - 'cart']}, 05:32:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--disable-e10s'], 05:32:00 INFO - 'tests': ['tp5o']}, 05:32:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'tests': ['tp5o']}, 05:32:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--disable-e10s', 05:32:00 INFO - '--xperf_path', 05:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:00 INFO - 'tests': ['tp5n']}, 05:32:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:00 INFO - 'talos_options': ['--xperf_path', 05:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:00 INFO - 'tests': ['tp5n']}}, 05:32:00 INFO - 'talos.zip': {'path': '', 05:32:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:00 INFO - Running post-action listener: _resource_record_post_action 05:32:00 INFO - ##### 05:32:00 INFO - ##### Finished populate-webroot step (success) 05:32:00 INFO - ##### 05:32:00 INFO - ##### 05:32:00 INFO - ##### Running create-virtualenv step. 05:32:00 INFO - ##### 05:32:00 INFO - Running pre-action listener: _resource_record_pre_action 05:32:00 INFO - Running main action method: create_virtualenv 05:32:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:32:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:00 INFO - Using real prefix '/tools/python27' 05:32:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:04 INFO - Installing pip.................done. 05:32:04 INFO - Return code: 0 05:32:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:04 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 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:04 INFO - 'HOME': '/Users/cltbld', 05:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:04 INFO - 'LOGNAME': 'cltbld', 05:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:04 INFO - 'MOZ_NO_REMOTE': '1', 05:32:04 INFO - 'NO_EM_RESTART': '1', 05:32:04 INFO - 'PAGER': '/bin/cat', 05:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:04 INFO - 'PWD': '/builds/slave/test', 05:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:04 INFO - 'SHELL': '/bin/bash', 05:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:04 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:04 INFO - 'USER': 'cltbld', 05:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:04 INFO - 'XPC_FLAGS': '0x0', 05:32:04 INFO - 'XPC_SERVICE_NAME': '0', 05:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:32:04 INFO - Cleaning up... 05:32:04 INFO - Return code: 0 05:32:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:04 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 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:04 INFO - 'HOME': '/Users/cltbld', 05:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:04 INFO - 'LOGNAME': 'cltbld', 05:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:04 INFO - 'MOZ_NO_REMOTE': '1', 05:32:04 INFO - 'NO_EM_RESTART': '1', 05:32:04 INFO - 'PAGER': '/bin/cat', 05:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:04 INFO - 'PWD': '/builds/slave/test', 05:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:04 INFO - 'SHELL': '/bin/bash', 05:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:04 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:04 INFO - 'USER': 'cltbld', 05:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:04 INFO - 'XPC_FLAGS': '0x0', 05:32:04 INFO - 'XPC_SERVICE_NAME': '0', 05:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:04 INFO - Downloading/unpacking psutil>=3.1.1 05:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:08 INFO - Installing collected packages: psutil 05:32:08 INFO - Running setup.py install for psutil 05:32:08 INFO - building 'psutil._psutil_osx' extension 05:32:08 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 05:32:09 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 05:32:09 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 05:32:09 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 05:32:09 INFO - building 'psutil._psutil_posix' extension 05:32:09 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 05:32:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:09 INFO - ^ 05:32:09 INFO - 1 warning generated. 05:32:09 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 05:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:09 INFO - Successfully installed psutil 05:32:09 INFO - Cleaning up... 05:32:09 INFO - Return code: 0 05:32:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:09 INFO - 'HOME': '/Users/cltbld', 05:32:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:09 INFO - 'LOGNAME': 'cltbld', 05:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:09 INFO - 'MOZ_NO_REMOTE': '1', 05:32:09 INFO - 'NO_EM_RESTART': '1', 05:32:09 INFO - 'PAGER': '/bin/cat', 05:32:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:09 INFO - 'PWD': '/builds/slave/test', 05:32:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:09 INFO - 'SHELL': '/bin/bash', 05:32:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:09 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:09 INFO - 'USER': 'cltbld', 05:32:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:09 INFO - 'XPC_FLAGS': '0x0', 05:32:09 INFO - 'XPC_SERVICE_NAME': '0', 05:32:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:12 INFO - Installing collected packages: mozsystemmonitor 05:32:12 INFO - Running setup.py install for mozsystemmonitor 05:32:12 INFO - Successfully installed mozsystemmonitor 05:32:12 INFO - Cleaning up... 05:32:12 INFO - Return code: 0 05:32:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:12 INFO - 'HOME': '/Users/cltbld', 05:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:12 INFO - 'LOGNAME': 'cltbld', 05:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:12 INFO - 'MOZ_NO_REMOTE': '1', 05:32:12 INFO - 'NO_EM_RESTART': '1', 05:32:12 INFO - 'PAGER': '/bin/cat', 05:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:12 INFO - 'PWD': '/builds/slave/test', 05:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:12 INFO - 'SHELL': '/bin/bash', 05:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:12 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:12 INFO - 'USER': 'cltbld', 05:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:12 INFO - 'XPC_FLAGS': '0x0', 05:32:12 INFO - 'XPC_SERVICE_NAME': '0', 05:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:16 INFO - Downloading docopt-0.6.1.tar.gz 05:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:16 INFO - Running setup.py install for blobuploader 05:32:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:16 INFO - Running setup.py install for requests 05:32:17 INFO - Running setup.py install for docopt 05:32:17 INFO - Successfully installed blobuploader requests docopt 05:32:17 INFO - Cleaning up... 05:32:17 INFO - Return code: 0 05:32:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:17 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 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:17 INFO - 'HOME': '/Users/cltbld', 05:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:17 INFO - 'LOGNAME': 'cltbld', 05:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:17 INFO - 'MOZ_NO_REMOTE': '1', 05:32:17 INFO - 'NO_EM_RESTART': '1', 05:32:17 INFO - 'PAGER': '/bin/cat', 05:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:17 INFO - 'PWD': '/builds/slave/test', 05:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:17 INFO - 'SHELL': '/bin/bash', 05:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:17 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:17 INFO - 'USER': 'cltbld', 05:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:17 INFO - 'XPC_FLAGS': '0x0', 05:32:17 INFO - 'XPC_SERVICE_NAME': '0', 05:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:17 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-pLqidw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:17 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-AZxIoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:17 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-tBfN72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:17 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-MxXcvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2kVNuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-01iDFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-__rCsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-kELNfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-tdEtGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Twfm4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-aH2Bqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-rPG06d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:18 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-oM3fY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:19 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-f7PAZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:19 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-7enIXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:19 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-0X4wmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:19 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-qfstDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:19 INFO - Running setup.py install for manifestparser 05:32:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:19 INFO - Running setup.py install for mozcrash 05:32:19 INFO - Running setup.py install for mozdebug 05:32:19 INFO - Running setup.py install for mozdevice 05:32:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Running setup.py install for mozfile 05:32:20 INFO - Running setup.py install for mozhttpd 05:32:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Running setup.py install for mozinfo 05:32:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Running setup.py install for mozInstall 05:32:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Running setup.py install for mozleak 05:32:20 INFO - Running setup.py install for mozlog 05:32:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:20 INFO - Running setup.py install for moznetwork 05:32:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:21 INFO - Running setup.py install for mozprocess 05:32:21 INFO - Running setup.py install for mozprofile 05:32:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:21 INFO - Running setup.py install for mozrunner 05:32:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:21 INFO - Running setup.py install for mozscreenshot 05:32:21 INFO - Running setup.py install for moztest 05:32:21 INFO - Running setup.py install for mozversion 05:32:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:22 INFO - Cleaning up... 05:32:22 INFO - Return code: 0 05:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:22 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 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:22 INFO - 'HOME': '/Users/cltbld', 05:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:22 INFO - 'LOGNAME': 'cltbld', 05:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:22 INFO - 'MOZ_NO_REMOTE': '1', 05:32:22 INFO - 'NO_EM_RESTART': '1', 05:32:22 INFO - 'PAGER': '/bin/cat', 05:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:22 INFO - 'PWD': '/builds/slave/test', 05:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:22 INFO - 'SHELL': '/bin/bash', 05:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:22 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:22 INFO - 'USER': 'cltbld', 05:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:22 INFO - 'XPC_FLAGS': '0x0', 05:32:22 INFO - 'XPC_SERVICE_NAME': '0', 05:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-P0VfpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-PxOBsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2CwOLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-9zZr62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-fk4o34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2U1Vqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:22 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-npkCsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-nBTLYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-hdnLen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-E2B0hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-33VKRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-der8G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-OSvJTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-oMbaTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-XYreVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:23 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-tAsqr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:24 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-y6c_xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:26 INFO - Downloading blessings-1.6.tar.gz 05:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:26 INFO - Installing collected packages: blessings 05:32:26 INFO - Running setup.py install for blessings 05:32:27 INFO - Successfully installed blessings 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:27 INFO - Reading from file tmpfile_stdout 05:32:27 INFO - Current package versions: 05:32:27 INFO - blessings == 1.6 05:32:27 INFO - blobuploader == 1.2.4 05:32:27 INFO - docopt == 0.6.1 05:32:27 INFO - manifestparser == 1.1 05:32:27 INFO - mozInstall == 1.12 05:32:27 INFO - mozcrash == 0.17 05:32:27 INFO - mozdebug == 0.1 05:32:27 INFO - mozdevice == 0.48 05:32:27 INFO - mozfile == 1.2 05:32:27 INFO - mozhttpd == 0.7 05:32:27 INFO - mozinfo == 0.9 05:32:27 INFO - mozleak == 0.1 05:32:27 INFO - mozlog == 3.2 05:32:27 INFO - moznetwork == 0.27 05:32:27 INFO - mozprocess == 0.22 05:32:27 INFO - mozprofile == 0.28 05:32:27 INFO - mozrunner == 6.11 05:32:27 INFO - mozscreenshot == 0.1 05:32:27 INFO - mozsystemmonitor == 0.3 05:32:27 INFO - moztest == 0.7 05:32:27 INFO - mozversion == 1.4 05:32:27 INFO - psutil == 3.1.1 05:32:27 INFO - requests == 1.2.3 05:32:27 INFO - wsgiref == 0.1.2 05:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 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 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32: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', 'jsonschema'] in /builds/slave/test/build 05:32: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 jsonschema 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking jsonschema 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:30 INFO - Downloading/unpacking functools32 (from jsonschema) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:30 INFO - warning: no files found matching '*.txt' 05:32:30 INFO - no previously-included directories found matching 'build' 05:32:30 INFO - no previously-included directories found matching 'dist' 05:32:30 INFO - no previously-included directories found matching '.git*' 05:32:30 INFO - Installing collected packages: jsonschema, functools32 05:32:30 INFO - Running setup.py install for functools32 05:32:31 INFO - warning: no files found matching '*.txt' 05:32:31 INFO - no previously-included directories found matching 'build' 05:32:31 INFO - no previously-included directories found matching 'dist' 05:32:31 INFO - no previously-included directories found matching '.git*' 05:32:31 INFO - Successfully installed jsonschema functools32 05:32:31 INFO - Cleaning up... 05:32:31 INFO - Return code: 0 05:32:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 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 0x1105a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885b4e1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, '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.opjJlAhcAn/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.mxnJV0XVqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 05:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:31 INFO - 'HOME': '/Users/cltbld', 05:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:31 INFO - 'LOGNAME': 'cltbld', 05:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:31 INFO - 'MOZ_NO_REMOTE': '1', 05:32:31 INFO - 'NO_EM_RESTART': '1', 05:32:31 INFO - 'PAGER': '/bin/cat', 05:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:31 INFO - 'PWD': '/builds/slave/test', 05:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:31 INFO - 'SHELL': '/bin/bash', 05:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:32:31 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:31 INFO - 'USER': 'cltbld', 05:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:31 INFO - 'XPC_FLAGS': '0x0', 05:32:31 INFO - 'XPC_SERVICE_NAME': '0', 05:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:31 INFO - Downloading/unpacking flake8 05:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:32:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:32:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:35 INFO - no previously-included directories found matching 'docs/_build' 05:32:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:32:35 INFO - Running setup.py install for pep8 05:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:35 INFO - no previously-included directories found matching 'docs/_build' 05:32:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:32:35 INFO - Cleaning up... 05:32:35 INFO - Return code: 0 05:32:35 INFO - Running post-action listener: _resource_record_post_action 05:32:35 INFO - Running post-action listener: _start_resource_monitoring 05:32:35 INFO - Starting resource monitoring. 05:32:35 INFO - ##### 05:32:35 INFO - ##### Finished create-virtualenv step (success) 05:32:35 INFO - ##### 05:32:35 INFO - ##### 05:32:35 INFO - ##### Running install step. 05:32:35 INFO - ##### 05:32:35 INFO - Running pre-action listener: _resource_record_pre_action 05:32:35 INFO - Running main action method: install 05:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:35 INFO - Reading from file tmpfile_stdout 05:32:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:35 INFO - Reading from file tmpfile_stdout 05:32:35 INFO - Output received: 05:32:35 INFO - Usage: mozinstall [options] installer 05:32:35 INFO - Options: 05:32:35 INFO - -h, --help show this help message and exit 05:32:35 INFO - -d DEST, --destination=DEST 05:32:35 INFO - Directory to install application into. [default: 05:32:35 INFO - "/builds/slave/test"] 05:32:35 INFO - --app=APP Application being installed. [default: firefox] 05:32:35 INFO - mkdir: /builds/slave/test/build/application 05:32:35 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'] 05:32:35 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 05:33:09 INFO - Reading from file tmpfile_stdout 05:33:09 INFO - Output received: 05:33:09 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:09 INFO - Running post-action listener: _resource_record_post_action 05:33:09 INFO - ##### 05:33:09 INFO - ##### Finished install step (success) 05:33:09 INFO - ##### 05:33:09 INFO - ##### 05:33:09 INFO - ##### Running run-tests step. 05:33:09 INFO - ##### 05:33:09 INFO - Running pre-action listener: _resource_record_pre_action 05:33:09 INFO - Running main action method: run_tests 05:33:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:09 INFO - 2016-05-30 05:33:09.512 screenresolution[1642:8467] starting screenresolution argv=screenresolution get 05:33:09 INFO - 2016-05-30 05:33:09.515 screenresolution[1642:8467] Display 0: 1600x1200x32@60 05:33:09 INFO - 2016-05-30 05:33:09.520 screenresolution[1643:8469] starting screenresolution argv=screenresolution list 05:33:09 INFO - Available Modes on Display 0 05:33:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:09 INFO - Intel Iris: 05:33:09 INFO - Chipset Model: Intel Iris 05:33:09 INFO - Type: GPU 05:33:09 INFO - Bus: Built-In 05:33:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:09 INFO - Vendor: Intel (0x8086) 05:33:09 INFO - Device ID: 0x0a2e 05:33:09 INFO - Revision ID: 0x0009 05:33:09 INFO - Displays: 05:33:09 INFO - Display: 05:33:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:09 INFO - Display Serial Number: 1600x1200 60 05:33:09 INFO - Main Display: Yes 05:33:09 INFO - Mirror: Off 05:33:09 INFO - Online: Yes 05:33:09 INFO - Rotation: Supported 05:33:09 INFO - Return code: 0 05:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:09 INFO - Python 2.7.3 05:33:09 INFO - Return code: 0 05:33:09 INFO - grabbing minidump binary from tooltool 05:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:09 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 0x11044bd30>, '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 0x11026fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110442b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:09 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 05:33:09 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 05:33:09 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 05:33:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:09 INFO - Return code: 0 05:33:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:33:10 INFO - Return code: 0 05:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 05:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0261 --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 05:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.opjJlAhcAn/Render', 05:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:10 INFO - 'HOME': '/Users/cltbld', 05:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:10 INFO - 'LOGNAME': 'cltbld', 05:33:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:10 INFO - 'MOZ_NO_REMOTE': '1', 05:33:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:10 INFO - 'NO_EM_RESTART': '1', 05:33:10 INFO - 'PAGER': '/bin/cat', 05:33:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:10 INFO - 'PWD': '/builds/slave/test', 05:33:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:10 INFO - 'SHELL': '/bin/bash', 05:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mxnJV0XVqp/Listeners', 05:33:10 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 05:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:10 INFO - 'USER': 'cltbld', 05:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:10 INFO - 'XPC_FLAGS': '0x0', 05:33:10 INFO - 'XPC_SERVICE_NAME': '0', 05:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 05:33:11 INFO - mozversion application_buildid: 20160530030222 05:33:11 INFO - mozversion application_changeset: cad514ad49c199e823a92e8c8d27e16c22c3cac7 05:33:11 INFO - mozversion application_display_name: Nightly 05:33:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:11 INFO - mozversion application_name: Firefox 05:33:11 INFO - mozversion application_remotingname: firefox 05:33:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:11 INFO - mozversion application_vendor: Mozilla 05:33:11 INFO - mozversion application_version: 49.0a1 05:33:11 INFO - mozversion platform_buildid: 20160530030222 05:33:11 INFO - mozversion platform_changeset: cad514ad49c199e823a92e8c8d27e16c22c3cac7 05:33:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:11 INFO - mozversion platform_version: 49.0a1 05:33:11 INFO - using testdate: 1464611591 05:33:11 INFO - actual date: 1464611591 05:33:11 INFO - starting webserver on 'localhost:49274' 05:33:11 INFO - SUITE-START | Running 2 tests 05:33:11 INFO - TEST-START | dromaeo_css 05:33:11 INFO - operating with platform_type : mac_ 05:33:11 INFO - Initialising browser for dromaeo_css test... 05:33:11 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpMB6uOs/profile http://localhost:49274/getInfo.html) 05:33:14 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:33:14 INFO - PROCESS | 1661 | colorDepth:24 05:33:14 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:33:14 INFO - PROCESS | 1661 | __metrics 05:33:14 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:33:15 INFO - TEST-INFO | 1661: exit 0 05:33:15 INFO - Browser initialized. 05:33:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:15 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpMB6uOs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:27 INFO - PROCESS | 1666 | RSS: Main: 252547072 05:33:27 INFO - PROCESS | 1666 | 05:34:16 INFO - PROCESS | 1666 | 1464611656954 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:36:28 INFO - PROCESS | 1666 | RSS: Main: 265166848 05:36:28 INFO - PROCESS | 1666 | 05:39:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:39:31 INFO - PROCESS | 1666 | RSS: Main: 276799488 05:39:31 INFO - PROCESS | 1666 | 05:42:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:42:34 INFO - PROCESS | 1666 | RSS: Main: 278274048 05:42:34 INFO - PROCESS | 1666 | 05:45:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:45:36 INFO - PROCESS | 1666 | RSS: Main: 279928832 05:45:36 INFO - PROCESS | 1666 | 05:48:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:48:39 INFO - PROCESS | 1666 | RSS: Main: 283525120 05:48:39 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:51:42 INFO - PROCESS | 1666 | RSS: Main: 283381760 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | __start_tp_report 05:51:42 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:51:42 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:51:42 INFO - PROCESS | 1666 | |i|pagename|runs| 05:51:42 INFO - PROCESS | 1666 | |0;dojo.html;3136.686331366863;3492.5110484532156;3506.772059816112;3515.7363197760174;3536.628653991331;5733.397993210715;5802.506786923117;5825.8252252432385;5830.679312637803;5843.123531470282;4888.68223565468;5424.213489044087;5656.830295091144;5796.449337312959;5892.528597712183;5195.06488832011;5221.477852214786;5321.627486075976;5385.515303622673;5413.756380962846;406.24971662268666;5324.988252232083;5330.573554115681;5357.116075847481;5384.40771515135;5247.790088396459;5257.106291930362;5277.393099793515;5311.575073994071;5324.068288049614;5196.506331898464;5307.230451584537;5326.973365133188;5345.251664766935;5366.570674346043;5176.767045482962;5199.090159222159;5236.371635403776;5253.290805741214;5272.393674727378;5694.088945768699;5773.39379365169;5823.359430462688;5824.504917082053;5837.387074357216;6143.539234557381;6153.969230153865;6235.158253635746;6248.562600617958;6265.498760099181;6172.07418887166;6297.622142671455;6301.747930082791;6312.558120931537;6331.461825744817;5985.880282394328;5996;6000.764112513163;6010.879782404371;6013.849653758647;6220.222472190976;6291.1192433059405;6345.555811093179;6482.513811464159;6495.805125846137;6173.506119510428;6243.594166379171;6243.875122497616;6265.122882796412;6272.937270627235;6266.68666566679;6284.057391391237;6303.936960630427;6310.5267104967315;6314.305426403092;4537.38745269391;4879.975600122048;6048.546359023091;6184.783532576338;6217.067439883963;6148.1699970504305;6170.938290617126;6213.068039793977;6226.128342032119;6230.719617617218;4955.4796746341835;5034.974825125851;5035.496450354935;5037.471065538139;5046.520580544842;4417.668674849399;4421.624161946206;4464.4865840428765;4521;4537.38745269391;5922.970385148046;5979.880402392015;6023.247094113236;6025.096235564701;6069.36271691466;6328.11406403104;6333.366663333722;6336.429721325103;6347.143135676717;6363.713632886531;5833.329167145747;5946.762129514771;5969.701514924236;6016.217891674142;6030.216071910623;5458.699771512525;5481.342238931274;5505.724713764296;5519.172124181405;5520.06158952979;6593.637349945703;6619.0733297339375;6619.172603424572;6621.039949207338;6622.304658010936;5171.560417364566;6150.446459818638;6217.906731398942;6239.968800156152;6300.401461861299;6536.379043990813;6578.144841170617;6585.111010013587;6598.8350291243105;6599.835004124935;6109.34393638171;6204.937950620436;6212.161358216583;6246.250449946036;6289.213848268966;6174.475169610633;6187.969060154851;6223.533235007483;6299.118123462627;6322.557420980487;5556.472135147154;6065.2418447694035;6214.8135555933395;6222.222222222223;6249.593776404519;6104.17593624855;6117.096718007379;6238.594491358229;6243.063540468785;6279;5735.11105778605;6103.640733310809;6111.205543279345;6119.326874043941;6160.815175544741;5561.499465048165;6155.1382806406245;6201.131841542097;6225.221847269091;6236.656983865931;4983.426905905867;5936.257967754031;6089.025755879038;6141.355157708376;6153.107799369156 05:51:42 INFO - PROCESS | 1666 | |1;ext.html;498.785522225443;510.41047590033503;512.5105524224364;544.8501662042937;545.920841477986;38803.83588492343;41577.58422415775;41708.791456042716;41716.79141604295;41732.16535669292;42544.57455425445;43013.35479967803;43152.568474315325;43201.783991080076;43366.783166084206;9394.436333819976;9479.905200947971;9521.381110227847;9643.324967252294;9648.421094734304;9433.292503062263;9453.33826632136;9494.335396522247;9623.085806848338;9651.324407291493;9461.101195386462;9576.755021847184;9578.185854202366;9623.84513858338;9625.759356016086;9529.904700953006;9630.374025688308;9652.517374131301;9657.985911479334;9663.082007209305;8009.67961281548;9440.858387124199;9465.432074075508;9556.187724043464;9596.040395960417;31959.041228763173;33872.661273387195;40917.79541102305;41074;41161;3043.8478076096326;3045.604071470717;3207.935841283161;3423.400904841643;3456.1186897341267;29225.415491690048;29452.70547294521;30172.849135754182;30541.93103241376;30898.53652195219;2777.291790593406;3149.4331020416316;3160.415323165199;3189.122991177445;3246.9675303247136;353696;433041;437549;440360;441050.79474602744;33603;33928.32143357119;33949.83025084859;33953.49069763956;33976.660233397844;35324.47013294802;36160.73437429677;36584.268314633555;37835.62164378376;37869.43195852065;16820.990740555604;16890.98654080759;17001.829981700273;17041.062741549085;17073.31706731717;12625.242485450719;12759.362031898369;12911.483540658268;12943.870561294267;12950.093493455368;19691.9169445679;19716.60566788656;19814.90092549528;19814.90092549528;19918.90040549817;8043.793430985399;8051.597420129087;8062.516249025077;8067.717629882926;8092.2716955473115;884.8672699095058;973;1026.0201507560262;1077.671310250381;1157.65270418874;30734.385312294075;30780.92266770697;31144.53283200754;31219.531707024413;31396.843015784776;924.3852837862746;1073.7745073534488;1116.2799994003822;1135.6990397544657;1175.4122938530734;15764.68470630581;15903.52289431319;15985.760213596805;16109.27508262131;16124.859533025347;688085;691593;695971;697019;701795;59751.80496390048;59911.400885991454;60542.39457605367;60591.69704151451;60925.39074609286;1358.8437329707012;1377.5178687459309;1395.665040390299;1400.7338605665095;1402.2287741742;30040.849795751754;30282.87019489755;30497.390052199276;30599.08202753921;30723.692763072082;51078;51487;51844.740776295876;51860.48139518557;51985.96028079493;510169;515319;516386;518182;518704;26899.924003039658;27014;27090;27494.587581185897;27750;49106.75446622744;49634.255486167014;50267;50363.496365035884;50446;41457.58542414658;41487.792561037;41588.37617435801;41927.58072419359;42256.57743422526;39678.801605991786;39900;40571.7971410141;41078;41361.58638413698;32433.675663243066;34687.82656086703;38809;39525.01187470221;39595;32757.34485310328;32819;34831.65168348284;34980.65019349774;36587.45118823273;26011.73988260093;26083.217503474927;26507.11333651254;26562.46875062449;27217.86391068032 05:51:42 INFO - PROCESS | 1666 | |2;jquery.html;381.91597848473333;384.5423945504849;386.64042440530295;397.22338875027805;411.48975270664386;14378.712425751479;19619.822810631373;19735.901320493394;21079.99999999998;21115.894420527897;20397.184112635514;20686.27598034069;20746.792532074676;21539.56920861582;21672.34982950514;5570.359408667994;5853.678047707385;5932.703364831763;5943.375945525722;6044;5780.53755699543;5924.318703349106;6104.847378815521;6617.3382661733685;6813.659317034128;6668.533202675814;6759.290274521154;6765.05289259504;6771.424428923548;6774.220964589062;6060.272767267934;6109.938900611026;6113.113598528233;6124.112003759475;6132.540059495555;5576.553875689935;5872.618279811842;5889.116632505158;5912.201852749867;5925.170476133345;13052.412641431158;13258.801117983237;13260.668483287898;13263.137896036824;17667.55831104233;1682.6718789835986;2227.175944900381;2229.7547269800307;2288.2677543186187;2375.619900815861;7496.175420703718;10035.896051434336;10059.647912323033;10224.182065434747;10419.010194031554;1487.4868170481166;1837.255911355903;1844.8247416495412;1868.9252429902788;1890.2816929566814;115810;121384.39307803493;123596.76403235942;123961.38019309936;124378.37810810888;11143.219974601861;11436.31382117059;11600.071994240441;11714.88285117138;11790.823137652942;14437.278136093364;14519.128852268897;14523.201223932785;14592.197429141499;14616.415343386145;8354.958225208835;8566.27186689126;8571.057183709787;8632.827343453097;8659.263962563127;8364.414490985573;8431.451955622864;8433.620487078097;8540.017897941816;8547.700830471029;4411.647068234533;4585.037142200175;4588.518205588432;4633.86098417048;4643.489216186217;1890.3383815664408;1914.818092281231;1935.158206180316;1937.1379736017336;1975.9802401975796;882.7042940614966;900.684760333891;947.9905200947902;952.642758965388;1024.9494268374976;20291.492712682008;21607.56784864294;21666.24168154107;21864.89067554652;21944.561108777736;898.4699027573632;950.078423928788;955.3312681123102;971.2715463402449;1002.9218590015616;11037;11549.307041577533;11552.6534203974;11580.76838463226;11582.942085289687;567886.7662278614;573704;575863;595737.0213148993;596435;83796;137189;142825.28587357205;147483.2625836864;149852;904.1726819959663;1004.3672486333709;1047.0524175621076;1051.5583454948787;1052.7789164275434;18298.725519116957;18859.434216973514;18998.715019274445;19147.329843455413;19312.71030934509;54492.727536362065;55217;55461.7226913879;56235.43764562302;57012.71493642505;63245;76599.3190238339;80770;80887.19112808797;81654.59172704098;5808.9543882101625;7919.9604001981925;8012.759617211493;8152.918470815216;8345.998480182418;12273.570425035081;13284.136531125447;13446.798298025733;13599.456021759019;13743.931280343535;10276.17790576737;10280.364553342637;11483.62196536421;11610.593629222936;11752.58865939688;11427.200095993201;11477.885221147682;11490.67857196433;11557.422128893353;11675.941620291844;10560.788784224425;11054.060404865677;11757.706057348634;11829.34938578352;11961.222520536137;8253.298469629908;8289.58552072406;8438.620262088343;8462.365322600952;8613.65545378178;11322.037626801484;11665.35840528779;11669.241499302518;11830.290182589073;11898.167128300936 05:51:42 INFO - PROCESS | 1666 | |3;mootools.html;1555.9533214003577;1576.1173742704084;1779.2971776148422;1868.8318051375375;1926.5472613935715;7899.328557072641;8526.53104079277;8532.189442003015;8995.685151019723;9015.323850711198;8675.219230269275;8732.388732788691;8851.601677924493;8860.734177974655;8884.33367497437;2089.9791002090014;2285.7085746553225;2337.8129749620034;2395.077895010416;2395.3053614451787;2269.8978545965388;2281;2389.390705370128;2395.940101497468;2416.1664225842055;2373.6558199061124;2375.0262392419113;2376.5246950609862;2398.9880050599722;2403.194929698553;2303.3550605830396;2320.443093657527;2326.0695721711368;2335.2643917166038;2338.953220935589;2297.1959814065112;2349.659299401594;2354.4702441950594;2356.1164563288767;2361.480474295652;7434.628268586604;8811.295096392338;8892.377533572653;8897.377183597151;8897.955510222473;5151.5106064923775;5168.664036837594;5298.92051619226;5301.913107812889;5355;3383.729301655886;3483.2685136121445;3553.200529880782;3561.394562924283;3578.1233597768455;1072.2922870905243;1084.9783004339947;1085.2891356161726;1099.4942326529806;1102.2669924500199;11360.772784544262;11468.541258349656;11477.426128693616;11502.309861408343;11503.137264705181;4633.698809577367;4669.929951050737;4762.333273341735;4772.5943294819635;4790.568848803624;9779.559919803625;9841.360311579725;9847.852282215772;9851.50742462874;9865.260105492116;5248.396434410015;5264.5525130363585;5306.363236411656;5350.010248104113;5365.08793505105;4402.229609818269;4754.5007774183905;4916.213405855046;4928;4938.9012219755405;3709.740318177756;3731.2910546995986;4001;4042.6361627453084;4134.462519872397;1106.5297248669444;1292.468424916477;1302.7785276503016;1315.3489022933709;1317.571789168524;824.9546274954935;852.1606217875387;893.8257039877292;925.4169872980115;967.3035414501547;5237.371515418098;5809.8547536311935;5946.43508866657;5948.315943666447;6123.234595675541;378.3605706356249;431.5921454225726;436.57215928390355;448.70385545539784;449.11076069382807;3314.4199765041503;3958.6239307265764;4037.1118353962083;4062.451569038142;4065.6340929316502;10195.541200645988;10500.842487362695;10557.683269501927;10571.682849514527;10583.94708026455;10340.638077667396;10440.63457778974;10492.370457772406;10525.84211236832;10535.736606584896;7700.075990881131;8094.83810323802;8145.999999999882;8170.959145204355;8173;5181.53366197044;5990.640561566146;6026.216591843032;6058.4244496772735;6079.635221886701;9748.9025109748;9974.750631233986;9980.550875210487;9980.850287245843;10109.797804044025;9703.12671859536;10120.746981325527;10120.746981325527;10137.695869123938;10155.847662284923;7026.8945965809535;7252.311030452099;7301.342879140902;7412.925870741439;7679.2704693054075;8296.585170741559;8330;8377.371697122862;8381.706640267805;8387.119352467904;7286.599237042014;7420.109586849612;7462.067241594801;7511.586862722603;7590.658420371207;7264.128304603481;7360.668769905475;7415.629218538944;7471.925280747123;7512.173660897406;7021.508494405342;7033.824154396181;7069.01033855271;7103.431725462054;7109.253528379446;4924.532169443897;5086.726961138693;5104;5132.640715149903;5178.97410512945;4983.4518202996915;5093.719845408538;5103.464136265638;5127.102757017582;5159.484051594811 05:51:42 INFO - PROCESS | 1666 | |4;prototype.html;251.55725922376618;302.47520551842547;316.66908081055294;319.21791610554135;319.8113113263174;5286.3392075990505;5467.371252305986;5542.334919809618;5585.218069470272;5589.692566908819;5564.749586268617;5564.968786392968;5568.248286481324;5569.554435645149;5649.180868774036;4186.623203911655;4200.4539409876825;4201.91596168078;4232.3228283474655;4243.575642435747;3582.444721068239;3813.31360355136;3838.7696738195796;3925.6663183629285;4199.6220340169375;3260.9347813043723;3507.964920350802;4174;4204.2222188895;4212.852550160745;3431.005008547518;3616.150204701893;4176.477940257468;4207.747535147901;4214.704970652056;3619.3304238715923;3659.499605161871;3667;3673.559172899269;3682.7294583368694;5141.820036298749;5213.921791173136;5219.42586315505;5223.537409525339;5232.843014709565;4101.200265948141;4781.952180478185;4782.856514304576;4816.373871396696;4816.710997340136;4967.552920237196;5456.427075157091;5871.882562348772;5879.79420720277;5927.436893495111;3492.6158122606494;3610.9778524026365;3913.5303763548554;3925.960740392588;3928.3714605663245;4925.581325587294;5303.575713942875;6072.483838873701;6117.174181485487;6135.913789311656;3517.982410087933;3675.5589329280656;3892.6107389261415;3942.4677668514955;3974.1058261890844;3858.823058967042;3870.013146647587;4020.6582440492302;4037.9394309085387;4058.289799285113;4652.302154676826;4687.648426368036;4713.740744259098;4738.360321356642;4785;4973.925391119136;5316.73416329182;5565.107863326489;5687.431256874363;5893.939090963668;1224.650974472289;1245.7134858982486;1273.5478904988781;1356.9687037851106;1380.178793617816;787.3661702329565;802.2218448105328;809.1988930958427;819.9549024803694;824.7299159294739;4030.266985196335;4138.668906487474;4692.272697731857;4694.342792009122;4694.36626055485;4401.009772801158;4750.8337208197545;4758.405199350082;4809.398825146856;5183.0304484296485;4395.824167033346;4441.400410944546;4596.816127354935;4686.226772582554;4735.715857048588;2055.1882006607307;2400.7719266669637;2584.741525847438;2663.720309367527;2780.88876444944;4525;4744.478107408182;4893.363862697897;4911.61786533531;5343.919841202385;4497.763115143296;4778.713277203379;4964.007198560303;5237.046030247215;5352.330958630171;5045.862607338003;5256.842294731241;5445;6330.778422755181;6451.774187903495;6107.106796892977;6134.78528251509;6183.227096612924;6187.474064704551;6196.132541444292;5066.847994560169;6020.337762845996;6048.546359023003;6052.394760523913;6080.452759251511;6002.549808764447;6085.300190478151;6310.274318453253;6327.145835312174;6362.809115726535;3121.4381411346176;3665.303592317451;3964.06844391562;4004.1991601679197;4024.75851448914;5303.337082864642;5712.743196496764;5912.5861189718025;6057.666828324484;6080.969595152173;5000.499950004971;5775.364709881994;5837.0676778122415;5895.852603684943;5913.669424379652;4866.829660961849;5888.263967004124;5913.733881975408;5924.733386997509;5946.07835785454;5086.440491545853;5163.9413920147035;5330.880515091874;5727.596738799021;5788.118861370156;5026.497350265091;5335.759890804846;5818.82543523678;5898.528117750656;5923.985844812784;4943.555080042814;5725.112607545837;5762.971185144215;5784.623999440023;5828.300603927556 05:51:42 INFO - PROCESS | 1666 | |5;yui.html;746.1158527145329;779.2285637219151;819.9508029518229;820.1798201798206;843.6414523827372;13053.151545149558;14770;14855.628609284773;15153;15334;13866.890648748102;13948.163110213394;13966.511172108978;13989.860101399008;13992.860071399284;676.5737585321241;865.1996902864825;865.7186414415308;865.9567021648892;871.9738407847759;870.3907264914585;883.1609970527992;894.5259012723267;896.4262871762045;897.7845317123908;943.9197668198211;948.3503799897093;948.7580666929957;951.6954574536152;953.0136308920269;924.7087167542203;939.1922946266205;940.05994005994;942.9528523573794;948.1940350701883;701.698269744015;701.891206862932;702.6065403374075;702.9402500787439;705.3792662457005;14620.049696769676;14629.92685036568;14644.12135271887;14703.411863525445;14721.337539810735;11613;13989;14074.507392241325;14095.929520352434;14214.289285535786;11497.482613282422;11498.42507874603;11507.309561426342;11531.308121512653;11809.94369330057;3344.8662053518074;3812;3857.0550215197177;3875;3975.840966361371;78724.60637696774;78962.99999999943;79629.60185199037;79641.20358796396;79672;10194.949025254826;10718.785624287471;10790.460476976119;10891.83662245067;10951.890481095086;22024.779752202594;22030.559388812453;22048.007839647253;22052.11791528353;22092.889535552218;6827.48793840454;7857.724979625686;8153.470024448392;8175.305099066527;8186.918130818734;4379.562043795595;4460.477538167196;4470.396496472999;4472.195432355292;4478.362380959516;3381.7970921744773;3427.622961474236;3471.1669199391963;3488.2674638326234;3506.2111025019167;639.5459223950954;647.1263793878227;650.7397041183565;690.2510775808204;700.3451772592642;572.4933433911019;615.4153554123601;620.882032413849;670.128832517725;710.4830889192333;9541.18899893503;9589.089036541518;9667.35084223509;9701.70894873155;9730.36752611078;602.4306333487679;608.528390497368;651.3649192037725;666.4435196610884;690.7893092606803;4299.419578356944;4332.090261045153;4498.797554110073;4500.572445617727;4566.657500687462;91789.54105229431;92786.53606731923;94252.52873735725;94678;95277.52361238288;79056.41887162339;79085.20914790778;79892.20107798847;80630;84290.52111612726;74052.62973685097;74119;74745;75075;75104.11823231472;8098.068722097034;8265.83468330642;8838.646454141763;8881.955590222007;8953.462792232487;47622.76188619035;47624.761876191784;47950.520494794604;48208;48925.5107448921;55581.61045973883;64480.67759661172;66790;67071;67564.32435675581;10557.841632375366;11086.556537738401;11138.10895128404;11544.653660390202;11894.34581098048;12050.819237711617;12242.326672032767;12322.383880805744;12390.256584604953;12436.81344779811;11593.420328983348;11832;11985.820212696643;12093.81859272094;12192.085593580694;11564.074874009892;11720.120990925545;11854.407279636156;11929.463174157358;12197.695057623276;11175.776484470103;11339.206255562032;11597.536098555964;11974.281543107441;11989.580364687194;9226.35415520907;9252.814943701223;9306.953465232631;9513.191378732885;9531.952340238255;7111.644417779194;8502.702405415781;9249.861252081359;9449.48027858447;9554 05:51:42 INFO - PROCESS | 1666 | __end_tp_report 05:51:42 INFO - PROCESS | 1666 | __start_cc_report 05:51:42 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,411 05:51:42 INFO - PROCESS | 1666 | __end_cc_report 05:51:42 INFO - PROCESS | 1666 | __startTimestamp1464612702658__endTimestamp 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:51:42 INFO - PROCESS | 1666 | Number of tests: 6 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5770.45 Median:6048.55 stddev:785.36 (13.0%) stddev-sans-first:760.10 05:51:42 INFO - PROCESS | 1666 | Values: 3136.7 3492.5 3506.8 3515.7 3536.6 5733.4 5802.5 5825.8 5830.7 5843.1 4888.7 5424.2 5656.8 5796.4 5892.5 5195.1 5221.5 5321.6 5385.5 5413.8 406.2 5325.0 5330.6 5357.1 5384.4 5247.8 5257.1 5277.4 5311.6 5324.1 5196.5 5307.2 5327.0 5345.3 5366.6 5176.8 5199.1 5236.4 5253.3 5272.4 5694.1 5773.4 5823.4 5824.5 5837.4 6143.5 6154.0 6235.2 6248.6 6265.5 6172.1 6297.6 6301.7 6312.6 6331.5 5985.9 5996.0 6000.8 6010.9 6013.8 6220.2 6291.1 6345.6 6482.5 6495.8 6173.5 6243.6 6243.9 6265.1 6272.9 6266.7 6284.1 6303.9 6310.5 6314.3 4537.4 4880.0 6048.5 6184.8 6217.1 6148.2 6170.9 6213.1 6226.1 6230.7 4955.5 5035.0 5035.5 5037.5 5046.5 4417.7 4421.6 4464.5 4521.0 4537.4 5923.0 5979.9 6023.2 6025.1 6069.4 6328.1 6333.4 6336.4 6347.1 6363.7 5833.3 5946.8 5969.7 6016.2 6030.2 5458.7 5481.3 5505.7 5519.2 5520.1 6593.6 6619.1 6619.2 6621.0 6622.3 5171.6 6150.4 6217.9 6240.0 6300.4 6536.4 6578.1 6585.1 6598.8 6599.8 6109.3 6204.9 6212.2 6246.3 6289.2 6174.5 6188.0 6223.5 6299.1 6322.6 5556.5 6065.2 6214.8 6222.2 6249.6 6104.2 6117.1 6238.6 6243.1 6279.0 5735.1 6103.6 6111.2 6119.3 6160.8 5561.5 6155.1 6201.1 6225.2 6236.7 4983.4 5936.3 6089.0 6141.4 6153.1 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:67132.03 Median:39636.90 stddev:148859.00 (375.6%) stddev-sans-first:149192.52 05:51:42 INFO - PROCESS | 1666 | Values: 498.8 510.4 512.5 544.9 545.9 38803.8 41577.6 41708.8 41716.8 41732.2 42544.6 43013.4 43152.6 43201.8 43366.8 9394.4 9479.9 9521.4 9643.3 9648.4 9433.3 9453.3 9494.3 9623.1 9651.3 9461.1 9576.8 9578.2 9623.8 9625.8 9529.9 9630.4 9652.5 9658.0 9663.1 8009.7 9440.9 9465.4 9556.2 9596.0 31959.0 33872.7 40917.8 41074.0 41161.0 3043.8 3045.6 3207.9 3423.4 3456.1 29225.4 29452.7 30172.8 30541.9 30898.5 2777.3 3149.4 3160.4 3189.1 3247.0 353696.0 433041.0 437549.0 440360.0 441050.8 33603.0 33928.3 33949.8 33953.5 33976.7 35324.5 36160.7 36584.3 37835.6 37869.4 16821.0 16891.0 17001.8 17041.1 17073.3 12625.2 12759.4 12911.5 12943.9 12950.1 19691.9 19716.6 19814.9 19814.9 19918.9 8043.8 8051.6 8062.5 8067.7 8092.3 884.9 973.0 1026.0 1077.7 1157.7 30734.4 30780.9 31144.5 31219.5 31396.8 924.4 1073.8 1116.3 1135.7 1175.4 15764.7 15903.5 15985.8 16109.3 16124.9 688085.0 691593.0 695971.0 697019.0 701795.0 59751.8 59911.4 60542.4 60591.7 60925.4 1358.8 1377.5 1395.7 1400.7 1402.2 30040.8 30282.9 30497.4 30599.1 30723.7 51078.0 51487.0 51844.7 51860.5 51986.0 510169.0 515319.0 516386.0 518182.0 518704.0 26899.9 27014.0 27090.0 27494.6 27750.0 49106.8 49634.3 50267.0 50363.5 50446.0 41457.6 41487.8 41588.4 41927.6 42256.6 39678.8 39900.0 40571.8 41078.0 41361.6 32433.7 34687.8 38809.0 39525.0 39595.0 32757.3 32819.0 34831.7 34980.7 36587.5 26011.7 26083.2 26507.1 26562.5 27217.9 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34633.22 Median:21636.90 stddev:97620.97 (451.2%) stddev-sans-first:97860.95 05:51:42 INFO - PROCESS | 1666 | Values: 381.9 384.5 386.6 397.2 411.5 14378.7 19619.8 19735.9 21080.0 21115.9 20397.2 20686.3 20746.8 21539.6 21672.3 5570.4 5853.7 5932.7 5943.4 6044.0 5780.5 5924.3 6104.8 6617.3 6813.7 6668.5 6759.3 6765.1 6771.4 6774.2 6060.3 6109.9 6113.1 6124.1 6132.5 5576.6 5872.6 5889.1 5912.2 5925.2 13052.4 13258.8 13260.7 13263.1 17667.6 1682.7 2227.2 2229.8 2288.3 2375.6 7496.2 10035.9 10059.6 10224.2 10419.0 1487.5 1837.3 1844.8 1868.9 1890.3 115810.0 121384.4 123596.8 123961.4 124378.4 11143.2 11436.3 11600.1 11714.9 11790.8 14437.3 14519.1 14523.2 14592.2 14616.4 8355.0 8566.3 8571.1 8632.8 8659.3 8364.4 8431.5 8433.6 8540.0 8547.7 4411.6 4585.0 4588.5 4633.9 4643.5 1890.3 1914.8 1935.2 1937.1 1976.0 882.7 900.7 948.0 952.6 1024.9 20291.5 21607.6 21666.2 21864.9 21944.6 898.5 950.1 955.3 971.3 1002.9 11037.0 11549.3 11552.7 11580.8 11582.9 567886.8 573704.0 575863.0 595737.0 596435.0 83796.0 137189.0 142825.3 147483.3 149852.0 904.2 1004.4 1047.1 1051.6 1052.8 18298.7 18859.4 18998.7 19147.3 19312.7 54492.7 55217.0 55461.7 56235.4 57012.7 63245.0 76599.3 80770.0 80887.2 81654.6 5809.0 7920.0 8012.8 8152.9 8346.0 12273.6 13284.1 13446.8 13599.5 13743.9 10276.2 10280.4 11483.6 11610.6 11752.6 11427.2 11477.9 11490.7 11557.4 11675.9 10560.8 11054.1 11757.7 11829.3 11961.2 8253.3 8289.6 8438.6 8462.4 8613.7 11322.0 11665.4 11669.2 11830.3 11898.2 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5674.77 Median:4961.18 stddev:3177.90 (64.1%) stddev-sans-first:3171.74 05:51:42 INFO - PROCESS | 1666 | Values: 1556.0 1576.1 1779.3 1868.8 1926.5 7899.3 8526.5 8532.2 8995.7 9015.3 8675.2 8732.4 8851.6 8860.7 8884.3 2090.0 2285.7 2337.8 2395.1 2395.3 2269.9 2281.0 2389.4 2395.9 2416.2 2373.7 2375.0 2376.5 2399.0 2403.2 2303.4 2320.4 2326.1 2335.3 2339.0 2297.2 2349.7 2354.5 2356.1 2361.5 7434.6 8811.3 8892.4 8897.4 8898.0 5151.5 5168.7 5298.9 5301.9 5355.0 3383.7 3483.3 3553.2 3561.4 3578.1 1072.3 1085.0 1085.3 1099.5 1102.3 11360.8 11468.5 11477.4 11502.3 11503.1 4633.7 4669.9 4762.3 4772.6 4790.6 9779.6 9841.4 9847.9 9851.5 9865.3 5248.4 5264.6 5306.4 5350.0 5365.1 4402.2 4754.5 4916.2 4928.0 4938.9 3709.7 3731.3 4001.0 4042.6 4134.5 1106.5 1292.5 1302.8 1315.3 1317.6 825.0 852.2 893.8 925.4 967.3 5237.4 5809.9 5946.4 5948.3 6123.2 378.4 431.6 436.6 448.7 449.1 3314.4 3958.6 4037.1 4062.5 4065.6 10195.5 10500.8 10557.7 10571.7 10583.9 10340.6 10440.6 10492.4 10525.8 10535.7 7700.1 8094.8 8146.0 8171.0 8173.0 5181.5 5990.6 6026.2 6058.4 6079.6 9748.9 9974.8 9980.6 9980.9 10109.8 9703.1 10120.7 10120.7 10137.7 10155.8 7026.9 7252.3 7301.3 7412.9 7679.3 8296.6 8330.0 8377.4 8381.7 8387.1 7286.6 7420.1 7462.1 7511.6 7590.7 7264.1 7360.7 7415.6 7471.9 7512.2 7021.5 7033.8 7069.0 7103.4 7109.3 4924.5 5086.7 5104.0 5132.6 5179.0 4983.5 5093.7 5103.5 5127.1 5159.5 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4545.94 Median:4918.60 stddev:1453.79 (29.6%) stddev-sans-first:1421.69 05:51:42 INFO - PROCESS | 1666 | Values: 251.6 302.5 316.7 319.2 319.8 5286.3 5467.4 5542.3 5585.2 5589.7 5564.7 5565.0 5568.2 5569.6 5649.2 4186.6 4200.5 4201.9 4232.3 4243.6 3582.4 3813.3 3838.8 3925.7 4199.6 3260.9 3508.0 4174.0 4204.2 4212.9 3431.0 3616.2 4176.5 4207.7 4214.7 3619.3 3659.5 3667.0 3673.6 3682.7 5141.8 5213.9 5219.4 5223.5 5232.8 4101.2 4782.0 4782.9 4816.4 4816.7 4967.6 5456.4 5871.9 5879.8 5927.4 3492.6 3611.0 3913.5 3926.0 3928.4 4925.6 5303.6 6072.5 6117.2 6135.9 3518.0 3675.6 3892.6 3942.5 3974.1 3858.8 3870.0 4020.7 4037.9 4058.3 4652.3 4687.6 4713.7 4738.4 4785.0 4973.9 5316.7 5565.1 5687.4 5893.9 1224.7 1245.7 1273.5 1357.0 1380.2 787.4 802.2 809.2 820.0 824.7 4030.3 4138.7 4692.3 4694.3 4694.4 4401.0 4750.8 4758.4 4809.4 5183.0 4395.8 4441.4 4596.8 4686.2 4735.7 2055.2 2400.8 2584.7 2663.7 2780.9 4525.0 4744.5 4893.4 4911.6 5343.9 4497.8 4778.7 4964.0 5237.0 5352.3 5045.9 5256.8 5445.0 6330.8 6451.8 6107.1 6134.8 6183.2 6187.5 6196.1 5066.8 6020.3 6048.5 6052.4 6080.5 6002.5 6085.3 6310.3 6327.1 6362.8 3121.4 3665.3 3964.1 4004.2 4024.8 5303.3 5712.7 5912.6 6057.7 6081.0 5000.5 5775.4 5837.1 5895.9 5913.7 4866.8 5888.3 5913.7 5924.7 5946.1 5086.4 5163.9 5330.9 5727.6 5788.1 5026.5 5335.8 5818.8 5898.5 5924.0 4943.6 5725.1 5763.0 5784.6 5828.3 05:51:42 INFO - PROCESS | 1666 | 05:51:42 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18560.66 Median:630.21 stddev:25849.59 (4101.7%) stddev-sans-first:25887.50 05:51:42 INFO - PROCESS | 1666 | Values: 746.1 779.2 820.0 820.2 843.6 13053.2 14770.0 14855.6 15153.0 15334.0 13866.9 13948.2 13966.5 13989.9 13992.9 676.6 865.2 865.7 866.0 872.0 870.4 883.2 894.5 896.4 897.8 943.9 948.4 948.8 951.7 953.0 924.7 939.2 940.1 943.0 948.2 701.7 701.9 702.6 702.9 705.4 14620.0 14629.9 14644.1 14703.4 14721.3 11613.0 13989.0 14074.5 14095.9 14214.3 11497.5 11498.4 11507.3 11531.3 11809.9 3344.9 3812.0 3857.1 3875.0 3975.8 78724.6 78963.0 79629.6 79641.2 79672.0 10194.9 10718.8 10790.5 10891.8 10951.9 22024.8 22030.6 22048.0 22052.1 22092.9 6827.5 7857.7 8153.5 8175.3 8186.9 4379.6 4460.5 4470.4 4472.2 4478.4 3381.8 3427.6 3471.2 3488.3 3506.2 639.5 647.1 650.7 690.3 700.3 572.5 615.4 620.9 670.1 710.5 9541.2 9589.1 9667.4 9701.7 9730.4 602.4 608.5 651.4 666.4 690.8 4299.4 4332.1 4498.8 4500.6 4566.7 91789.5 92786.5 94252.5 94678.0 95277.5 79056.4 79085.2 79892.2 80630.0 84290.5 74052.6 74119.0 74745.0 75075.0 75104.1 8098.1 8265.8 8838.6 8882.0 8953.5 47622.8 47624.8 47950.5 48208.0 48925.5 55581.6 64480.7 66790.0 67071.0 67564.3 10557.8 11086.6 11138.1 11544.7 11894.3 12050.8 12242.3 12322.4 12390.3 12436.8 11593.4 11832.0 11985.8 12093.8 12192.1 11564.1 11720.1 11854.4 11929.5 12197.7 11175.8 11339.2 11597.5 11974.3 11989.6 9226.4 9252.8 9307.0 9513.2 9532.0 7111.6 8502.7 9249.9 9449.5 9554.0 05:51:42 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:51:42 INFO - PROCESS | 1666 | 05:51:43 INFO - TEST-INFO | 1666: exit 0 05:51:43 INFO - TEST-OK | dromaeo_css | took 1112008ms 05:51:43 INFO - TEST-START | kraken 05:51:43 INFO - operating with platform_type : mac_ 05:51:43 INFO - Initialising browser for kraken test... 05:51:43 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpFu8eg3/profile http://localhost:49274/getInfo.html) 05:51:46 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 05:51:46 INFO - PROCESS | 1674 | colorDepth:24 05:51:46 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 05:51:46 INFO - PROCESS | 1674 | __metrics 05:51:46 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:51:46 INFO - TEST-INFO | 1674: exit 0 05:51:46 INFO - Browser initialized. 05:51:46 INFO - Running cycle 1/1 for kraken test... 05:51:46 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpFu8eg3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:58 INFO - PROCESS | 1677 | RSS: Main: 252563456 05:51:58 INFO - PROCESS | 1677 | 05:52:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:02 INFO - PROCESS | 1677 | RSS: Main: 265416704 05:52:02 INFO - PROCESS | 1677 | 05:52:05 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:52:05 INFO - PROCESS | 1677 | RSS: Main: 269697024 05:52:05 INFO - PROCESS | 1677 | 05:52:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:52:09 INFO - PROCESS | 1677 | RSS: Main: 270323712 05:52:09 INFO - PROCESS | 1677 | 05:52:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:52:12 INFO - PROCESS | 1677 | RSS: Main: 271134720 05:52:12 INFO - PROCESS | 1677 | 05:52:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:15 INFO - PROCESS | 1677 | RSS: Main: 271712256 05:52:15 INFO - PROCESS | 1677 | 05:52:17 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:18 INFO - PROCESS | 1677 | RSS: Main: 271454208 05:52:18 INFO - PROCESS | 1677 | 05:52:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:22 INFO - PROCESS | 1677 | RSS: Main: 271945728 05:52:22 INFO - PROCESS | 1677 | 05:52:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:52:26 INFO - PROCESS | 1677 | RSS: Main: 272314368 05:52:26 INFO - PROCESS | 1677 | 05:52:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:28 INFO - PROCESS | 1677 | RSS: Main: 271437824 05:52:28 INFO - PROCESS | 1677 | 05:52:30 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:30 INFO - PROCESS | 1677 | RSS: Main: 271716352 05:52:30 INFO - PROCESS | 1677 | 05:52:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:33 INFO - PROCESS | 1677 | RSS: Main: 272154624 05:52:33 INFO - PROCESS | 1677 | 05:52:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:37 INFO - PROCESS | 1677 | RSS: Main: 272052224 05:52:37 INFO - PROCESS | 1677 | 05:52:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:40 INFO - PROCESS | 1677 | RSS: Main: 271949824 05:52:40 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:52:42 INFO - PROCESS | 1677 | RSS: Main: 272769024 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | __start_tp_report 05:52:42 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 05:52:42 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 05:52:42 INFO - PROCESS | 1677 | |i|pagename|runs| 05:52:42 INFO - PROCESS | 1677 | |0;ai-astar;126;108;116;121;119;116;113;116;131;172 05:52:42 INFO - PROCESS | 1677 | |1;audio-beat-detection;154;134;160;188;150;136;136;136;164;117 05:52:42 INFO - PROCESS | 1677 | |2;audio-dft;196;197;202;213;246;195;198;200;232;282 05:52:42 INFO - PROCESS | 1677 | |3;audio-fft;68;81;76;183;50;81;82;78;128;81 05:52:42 INFO - PROCESS | 1677 | |4;audio-oscillator;69;72;112;69;70;79;112;69;72;112 05:52:42 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;89;86;89;85;88;86;88;86;88;85 05:52:42 INFO - PROCESS | 1677 | |6;imaging-darkroom;144;95;104;140;95;95;95;105;124;120 05:52:42 INFO - PROCESS | 1677 | |7;imaging-desaturate;146;124;120;133;128;143;99;146;109;145 05:52:42 INFO - PROCESS | 1677 | |8;json-parse-financial;55;58;56;58;58;58;56;58;57;62 05:52:42 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;66;71;66;72;68;70;70;69;70;79 05:52:42 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;87;75;106;77;97;110;106;105;148;87 05:52:42 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;139;134;136;139;136;141;140;138;149;146 05:52:42 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;167;166;174;166;166;166;169;165;166;164 05:52:42 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;65;67;67;66;66;64;68;64;67;67 05:52:42 INFO - PROCESS | 1677 | __end_tp_report 05:52:42 INFO - PROCESS | 1677 | __start_cc_report 05:52:42 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1067 05:52:42 INFO - PROCESS | 1677 | __end_cc_report 05:52:42 INFO - PROCESS | 1677 | __startTimestamp1464612762379__endTimestamp 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | ------- Summary: start ------- 05:52:42 INFO - PROCESS | 1677 | Number of tests: 14 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:123.80 Median:120.00 stddev:18.13 (15.1%) stddev-sans-first:19.22 05:52:42 INFO - PROCESS | 1677 | Values: 126.0 108.0 116.0 121.0 119.0 116.0 113.0 116.0 131.0 172.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:152.00 stddev:20.07 (13.2%) stddev-sans-first:21.15 05:52:42 INFO - PROCESS | 1677 | Values: 154.0 134.0 160.0 188.0 150.0 136.0 136.0 136.0 164.0 117.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:216.10 Median:207.50 stddev:28.87 (13.9%) stddev-sans-first:29.69 05:52:42 INFO - PROCESS | 1677 | Values: 196.0 197.0 202.0 213.0 246.0 195.0 198.0 200.0 232.0 282.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:90.80 Median:79.50 stddev:37.74 (47.5%) stddev-sans-first:39.12 05:52:42 INFO - PROCESS | 1677 | Values: 68.0 81.0 76.0 183.0 50.0 81.0 82.0 78.0 128.0 81.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:69.50 stddev:19.82 (28.5%) stddev-sans-first:20.30 05:52:42 INFO - PROCESS | 1677 | Values: 69.0 72.0 112.0 69.0 70.0 79.0 112.0 69.0 72.0 112.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.56 (1.8%) stddev-sans-first:1.48 05:52:42 INFO - PROCESS | 1677 | Values: 89.0 86.0 89.0 85.0 88.0 86.0 88.0 86.0 88.0 85.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:111.70 Median:119.50 stddev:19.10 (16.0%) stddev-sans-first:16.30 05:52:42 INFO - PROCESS | 1677 | Values: 144.0 95.0 104.0 140.0 95.0 95.0 95.0 105.0 124.0 120.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:129.30 Median:144.00 stddev:16.51 (11.5%) stddev-sans-first:16.36 05:52:42 INFO - PROCESS | 1677 | Values: 146.0 124.0 120.0 133.0 128.0 143.0 99.0 146.0 109.0 145.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.90 (3.3%) stddev-sans-first:1.76 05:52:42 INFO - PROCESS | 1677 | Values: 55.0 58.0 56.0 58.0 58.0 58.0 56.0 58.0 57.0 62.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:3.70 (5.3%) stddev-sans-first:3.61 05:52:42 INFO - PROCESS | 1677 | Values: 66.0 71.0 66.0 72.0 68.0 70.0 70.0 69.0 70.0 79.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:99.80 Median:76.00 stddev:21.09 (27.7%) stddev-sans-first:21.85 05:52:42 INFO - PROCESS | 1677 | Values: 87.0 75.0 106.0 77.0 97.0 110.0 106.0 105.0 148.0 87.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.50 stddev:4.61 (3.3%) stddev-sans-first:4.88 05:52:42 INFO - PROCESS | 1677 | Values: 139.0 134.0 136.0 139.0 136.0 141.0 140.0 138.0 149.0 146.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.00 stddev:2.81 (1.7%) stddev-sans-first:2.98 05:52:42 INFO - PROCESS | 1677 | Values: 167.0 166.0 174.0 166.0 166.0 166.0 169.0 165.0 166.0 164.0 05:52:42 INFO - PROCESS | 1677 | 05:52:42 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.39 05:52:42 INFO - PROCESS | 1677 | Values: 65.0 67.0 67.0 66.0 66.0 64.0 68.0 64.0 67.0 67.0 05:52:42 INFO - PROCESS | 1677 | -------- Summary: end -------- 05:52:42 INFO - PROCESS | 1677 | 05:52:43 INFO - TEST-INFO | 1677: exit 0 05:52:43 INFO - TEST-OK | kraken | took 59952ms 05:52:43 INFO - SUITE-END | took 1171s 05:52:43 INFO - Completed test suite (00:19:32) 05:52:43 INFO - javascript benchmark 05:52:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7199.820073901869, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.686331366863, 3492.5110484532156, 3506.772059816112, 3515.7363197760174, 3536.628653991331, 5733.397993210715, 5802.506786923117, 5825.8252252432385, 5830.679312637803, 5843.123531470282, 4888.68223565468, 5424.213489044087, 5656.830295091144, 5796.449337312959, 5892.528597712183, 5195.06488832011, 5221.477852214786, 5321.627486075976, 5385.515303622673, 5413.756380962846, 406.24971662268666, 5324.988252232083, 5330.573554115681, 5357.116075847481, 5384.40771515135, 5247.790088396459, 5257.106291930362, 5277.393099793515, 5311.575073994071, 5324.068288049614, 5196.506331898464, 5307.230451584537, 5326.973365133188, 5345.251664766935, 5366.570674346043, 5176.767045482962, 5199.090159222159, 5236.371635403776, 5253.290805741214, 5272.393674727378, 5694.088945768699, 5773.39379365169, 5823.359430462688, 5824.504917082053, 5837.387074357216, 6143.539234557381, 6153.969230153865, 6235.158253635746, 6248.562600617958, 6265.498760099181, 6172.07418887166, 6297.622142671455, 6301.747930082791, 6312.558120931537, 6331.461825744817, 5985.880282394328, 5996.0, 6000.764112513163, 6010.879782404371, 6013.849653758647, 6220.222472190976, 6291.1192433059405, 6345.555811093179, 6482.513811464159, 6495.805125846137, 6173.506119510428, 6243.594166379171, 6243.875122497616, 6265.122882796412, 6272.937270627235, 6266.68666566679, 6284.057391391237, 6303.936960630427, 6310.5267104967315, 6314.305426403092, 4537.38745269391, 4879.975600122048, 6048.546359023091, 6184.783532576338, 6217.067439883963, 6148.1699970504305, 6170.938290617126, 6213.068039793977, 6226.128342032119, 6230.719617617218, 4955.4796746341835, 5034.974825125851, 5035.496450354935, 5037.471065538139, 5046.520580544842, 4417.668674849399, 4421.624161946206, 4464.4865840428765, 4521.0, 4537.38745269391, 5922.970385148046, 5979.880402392015, 6023.247094113236, 6025.096235564701, 6069.36271691466, 6328.11406403104, 6333.366663333722, 6336.429721325103, 6347.143135676717, 6363.713632886531, 5833.329167145747, 5946.762129514771, 5969.701514924236, 6016.217891674142, 6030.216071910623, 5458.699771512525, 5481.342238931274, 5505.724713764296, 5519.172124181405, 5520.06158952979, 6593.637349945703, 6619.0733297339375, 6619.172603424572, 6621.039949207338, 6622.304658010936, 5171.560417364566, 6150.446459818638, 6217.906731398942, 6239.968800156152, 6300.401461861299, 6536.379043990813, 6578.144841170617, 6585.111010013587, 6598.8350291243105, 6599.835004124935, 6109.34393638171, 6204.937950620436, 6212.161358216583, 6246.250449946036, 6289.213848268966, 6174.475169610633, 6187.969060154851, 6223.533235007483, 6299.118123462627, 6322.557420980487, 5556.472135147154, 6065.2418447694035, 6214.8135555933395, 6222.222222222223, 6249.593776404519, 6104.17593624855, 6117.096718007379, 6238.594491358229, 6243.063540468785, 6279.0, 5735.11105778605, 6103.640733310809, 6111.205543279345, 6119.326874043941, 6160.815175544741, 5561.499465048165, 6155.1382806406245, 6201.131841542097, 6225.221847269091, 6236.656983865931, 4983.426905905867, 5936.257967754031, 6089.025755879038, 6141.355157708376, 6153.107799369156], "value": 5724.059842151869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.785522225443, 510.41047590033503, 512.5105524224364, 544.8501662042937, 545.920841477986, 38803.83588492343, 41577.58422415775, 41708.791456042716, 41716.79141604295, 41732.16535669292, 42544.57455425445, 43013.35479967803, 43152.568474315325, 43201.783991080076, 43366.783166084206, 9394.436333819976, 9479.905200947971, 9521.381110227847, 9643.324967252294, 9648.421094734304, 9433.292503062263, 9453.33826632136, 9494.335396522247, 9623.085806848338, 9651.324407291493, 9461.101195386462, 9576.755021847184, 9578.185854202366, 9623.84513858338, 9625.759356016086, 9529.904700953006, 9630.374025688308, 9652.517374131301, 9657.985911479334, 9663.082007209305, 8009.67961281548, 9440.858387124199, 9465.432074075508, 9556.187724043464, 9596.040395960417, 31959.041228763173, 33872.661273387195, 40917.79541102305, 41074.0, 41161.0, 3043.8478076096326, 3045.604071470717, 3207.935841283161, 3423.400904841643, 3456.1186897341267, 29225.415491690048, 29452.70547294521, 30172.849135754182, 30541.93103241376, 30898.53652195219, 2777.291790593406, 3149.4331020416316, 3160.415323165199, 3189.122991177445, 3246.9675303247136, 353696.0, 433041.0, 437549.0, 440360.0, 441050.79474602744, 33603.0, 33928.32143357119, 33949.83025084859, 33953.49069763956, 33976.660233397844, 35324.47013294802, 36160.73437429677, 36584.268314633555, 37835.62164378376, 37869.43195852065, 16820.990740555604, 16890.98654080759, 17001.829981700273, 17041.062741549085, 17073.31706731717, 12625.242485450719, 12759.362031898369, 12911.483540658268, 12943.870561294267, 12950.093493455368, 19691.9169445679, 19716.60566788656, 19814.90092549528, 19814.90092549528, 19918.90040549817, 8043.793430985399, 8051.597420129087, 8062.516249025077, 8067.717629882926, 8092.2716955473115, 884.8672699095058, 973.0, 1026.0201507560262, 1077.671310250381, 1157.65270418874, 30734.385312294075, 30780.92266770697, 31144.53283200754, 31219.531707024413, 31396.843015784776, 924.3852837862746, 1073.7745073534488, 1116.2799994003822, 1135.6990397544657, 1175.4122938530734, 15764.68470630581, 15903.52289431319, 15985.760213596805, 16109.27508262131, 16124.859533025347, 688085.0, 691593.0, 695971.0, 697019.0, 701795.0, 59751.80496390048, 59911.400885991454, 60542.39457605367, 60591.69704151451, 60925.39074609286, 1358.8437329707012, 1377.5178687459309, 1395.665040390299, 1400.7338605665095, 1402.2287741742, 30040.849795751754, 30282.87019489755, 30497.390052199276, 30599.08202753921, 30723.692763072082, 51078.0, 51487.0, 51844.740776295876, 51860.48139518557, 51985.96028079493, 510169.0, 515319.0, 516386.0, 518182.0, 518704.0, 26899.924003039658, 27014.0, 27090.0, 27494.587581185897, 27750.0, 49106.75446622744, 49634.255486167014, 50267.0, 50363.496365035884, 50446.0, 41457.58542414658, 41487.792561037, 41588.37617435801, 41927.58072419359, 42256.57743422526, 39678.801605991786, 39900.0, 40571.7971410141, 41078.0, 41361.58638413698, 32433.675663243066, 34687.82656086703, 38809.0, 39525.01187470221, 39595.0, 32757.34485310328, 32819.0, 34831.65168348284, 34980.65019349774, 36587.45118823273, 26011.73988260093, 26083.217503474927, 26507.11333651254, 26562.46875062449, 27217.86391068032], "value": 19546.50176943898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.91597848473333, 384.5423945504849, 386.64042440530295, 397.22338875027805, 411.48975270664386, 14378.712425751479, 19619.822810631373, 19735.901320493394, 21079.99999999998, 21115.894420527897, 20397.184112635514, 20686.27598034069, 20746.792532074676, 21539.56920861582, 21672.34982950514, 5570.359408667994, 5853.678047707385, 5932.703364831763, 5943.375945525722, 6044.0, 5780.53755699543, 5924.318703349106, 6104.847378815521, 6617.3382661733685, 6813.659317034128, 6668.533202675814, 6759.290274521154, 6765.05289259504, 6771.424428923548, 6774.220964589062, 6060.272767267934, 6109.938900611026, 6113.113598528233, 6124.112003759475, 6132.540059495555, 5576.553875689935, 5872.618279811842, 5889.116632505158, 5912.201852749867, 5925.170476133345, 13052.412641431158, 13258.801117983237, 13260.668483287898, 13263.137896036824, 17667.55831104233, 1682.6718789835986, 2227.175944900381, 2229.7547269800307, 2288.2677543186187, 2375.619900815861, 7496.175420703718, 10035.896051434336, 10059.647912323033, 10224.182065434747, 10419.010194031554, 1487.4868170481166, 1837.255911355903, 1844.8247416495412, 1868.9252429902788, 1890.2816929566814, 115810.0, 121384.39307803493, 123596.76403235942, 123961.38019309936, 124378.37810810888, 11143.219974601861, 11436.31382117059, 11600.071994240441, 11714.88285117138, 11790.823137652942, 14437.278136093364, 14519.128852268897, 14523.201223932785, 14592.197429141499, 14616.415343386145, 8354.958225208835, 8566.27186689126, 8571.057183709787, 8632.827343453097, 8659.263962563127, 8364.414490985573, 8431.451955622864, 8433.620487078097, 8540.017897941816, 8547.700830471029, 4411.647068234533, 4585.037142200175, 4588.518205588432, 4633.86098417048, 4643.489216186217, 1890.3383815664408, 1914.818092281231, 1935.158206180316, 1937.1379736017336, 1975.9802401975796, 882.7042940614966, 900.684760333891, 947.9905200947902, 952.642758965388, 1024.9494268374976, 20291.492712682008, 21607.56784864294, 21666.24168154107, 21864.89067554652, 21944.561108777736, 898.4699027573632, 950.078423928788, 955.3312681123102, 971.2715463402449, 1002.9218590015616, 11037.0, 11549.307041577533, 11552.6534203974, 11580.76838463226, 11582.942085289687, 567886.7662278614, 573704.0, 575863.0, 595737.0213148993, 596435.0, 83796.0, 137189.0, 142825.28587357205, 147483.2625836864, 149852.0, 904.1726819959663, 1004.3672486333709, 1047.0524175621076, 1051.5583454948787, 1052.7789164275434, 18298.725519116957, 18859.434216973514, 18998.715019274445, 19147.329843455413, 19312.71030934509, 54492.727536362065, 55217.0, 55461.7226913879, 56235.43764562302, 57012.71493642505, 63245.0, 76599.3190238339, 80770.0, 80887.19112808797, 81654.59172704098, 5808.9543882101625, 7919.9604001981925, 8012.759617211493, 8152.918470815216, 8345.998480182418, 12273.570425035081, 13284.136531125447, 13446.798298025733, 13599.456021759019, 13743.931280343535, 10276.17790576737, 10280.364553342637, 11483.62196536421, 11610.593629222936, 11752.58865939688, 11427.200095993201, 11477.885221147682, 11490.67857196433, 11557.422128893353, 11675.941620291844, 10560.788784224425, 11054.060404865677, 11757.706057348634, 11829.34938578352, 11961.222520536137, 8253.298469629908, 8289.58552072406, 8438.620262088343, 8462.365322600952, 8613.65545378178, 11322.037626801484, 11665.35840528779, 11669.241499302518, 11830.290182589073, 11898.167128300936], "value": 9556.079058781246, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.9533214003577, 1576.1173742704084, 1779.2971776148422, 1868.8318051375375, 1926.5472613935715, 7899.328557072641, 8526.53104079277, 8532.189442003015, 8995.685151019723, 9015.323850711198, 8675.219230269275, 8732.388732788691, 8851.601677924493, 8860.734177974655, 8884.33367497437, 2089.9791002090014, 2285.7085746553225, 2337.8129749620034, 2395.077895010416, 2395.3053614451787, 2269.8978545965388, 2281.0, 2389.390705370128, 2395.940101497468, 2416.1664225842055, 2373.6558199061124, 2375.0262392419113, 2376.5246950609862, 2398.9880050599722, 2403.194929698553, 2303.3550605830396, 2320.443093657527, 2326.0695721711368, 2335.2643917166038, 2338.953220935589, 2297.1959814065112, 2349.659299401594, 2354.4702441950594, 2356.1164563288767, 2361.480474295652, 7434.628268586604, 8811.295096392338, 8892.377533572653, 8897.377183597151, 8897.955510222473, 5151.5106064923775, 5168.664036837594, 5298.92051619226, 5301.913107812889, 5355.0, 3383.729301655886, 3483.2685136121445, 3553.200529880782, 3561.394562924283, 3578.1233597768455, 1072.2922870905243, 1084.9783004339947, 1085.2891356161726, 1099.4942326529806, 1102.2669924500199, 11360.772784544262, 11468.541258349656, 11477.426128693616, 11502.309861408343, 11503.137264705181, 4633.698809577367, 4669.929951050737, 4762.333273341735, 4772.5943294819635, 4790.568848803624, 9779.559919803625, 9841.360311579725, 9847.852282215772, 9851.50742462874, 9865.260105492116, 5248.396434410015, 5264.5525130363585, 5306.363236411656, 5350.010248104113, 5365.08793505105, 4402.229609818269, 4754.5007774183905, 4916.213405855046, 4928.0, 4938.9012219755405, 3709.740318177756, 3731.2910546995986, 4001.0, 4042.6361627453084, 4134.462519872397, 1106.5297248669444, 1292.468424916477, 1302.7785276503016, 1315.3489022933709, 1317.571789168524, 824.9546274954935, 852.1606217875387, 893.8257039877292, 925.4169872980115, 967.3035414501547, 5237.371515418098, 5809.8547536311935, 5946.43508866657, 5948.315943666447, 6123.234595675541, 378.3605706356249, 431.5921454225726, 436.57215928390355, 448.70385545539784, 449.11076069382807, 3314.4199765041503, 3958.6239307265764, 4037.1118353962083, 4062.451569038142, 4065.6340929316502, 10195.541200645988, 10500.842487362695, 10557.683269501927, 10571.682849514527, 10583.94708026455, 10340.638077667396, 10440.63457778974, 10492.370457772406, 10525.84211236832, 10535.736606584896, 7700.075990881131, 8094.83810323802, 8145.999999999882, 8170.959145204355, 8173.0, 5181.53366197044, 5990.640561566146, 6026.216591843032, 6058.4244496772735, 6079.635221886701, 9748.9025109748, 9974.750631233986, 9980.550875210487, 9980.850287245843, 10109.797804044025, 9703.12671859536, 10120.746981325527, 10120.746981325527, 10137.695869123938, 10155.847662284923, 7026.8945965809535, 7252.311030452099, 7301.342879140902, 7412.925870741439, 7679.2704693054075, 8296.585170741559, 8330.0, 8377.371697122862, 8381.706640267805, 8387.119352467904, 7286.599237042014, 7420.109586849612, 7462.067241594801, 7511.586862722603, 7590.658420371207, 7264.128304603481, 7360.668769905475, 7415.629218538944, 7471.925280747123, 7512.173660897406, 7021.508494405342, 7033.824154396181, 7069.01033855271, 7103.431725462054, 7109.253528379446, 4924.532169443897, 5086.726961138693, 5104.0, 5132.640715149903, 5178.97410512945, 4983.4518202996915, 5093.719845408538, 5103.464136265638, 5127.102757017582, 5159.484051594811], "value": 4488.980628735825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.55725922376618, 302.47520551842547, 316.66908081055294, 319.21791610554135, 319.8113113263174, 5286.3392075990505, 5467.371252305986, 5542.334919809618, 5585.218069470272, 5589.692566908819, 5564.749586268617, 5564.968786392968, 5568.248286481324, 5569.554435645149, 5649.180868774036, 4186.623203911655, 4200.4539409876825, 4201.91596168078, 4232.3228283474655, 4243.575642435747, 3582.444721068239, 3813.31360355136, 3838.7696738195796, 3925.6663183629285, 4199.6220340169375, 3260.9347813043723, 3507.964920350802, 4174.0, 4204.2222188895, 4212.852550160745, 3431.005008547518, 3616.150204701893, 4176.477940257468, 4207.747535147901, 4214.704970652056, 3619.3304238715923, 3659.499605161871, 3667.0, 3673.559172899269, 3682.7294583368694, 5141.820036298749, 5213.921791173136, 5219.42586315505, 5223.537409525339, 5232.843014709565, 4101.200265948141, 4781.952180478185, 4782.856514304576, 4816.373871396696, 4816.710997340136, 4967.552920237196, 5456.427075157091, 5871.882562348772, 5879.79420720277, 5927.436893495111, 3492.6158122606494, 3610.9778524026365, 3913.5303763548554, 3925.960740392588, 3928.3714605663245, 4925.581325587294, 5303.575713942875, 6072.483838873701, 6117.174181485487, 6135.913789311656, 3517.982410087933, 3675.5589329280656, 3892.6107389261415, 3942.4677668514955, 3974.1058261890844, 3858.823058967042, 3870.013146647587, 4020.6582440492302, 4037.9394309085387, 4058.289799285113, 4652.302154676826, 4687.648426368036, 4713.740744259098, 4738.360321356642, 4785.0, 4973.925391119136, 5316.73416329182, 5565.107863326489, 5687.431256874363, 5893.939090963668, 1224.650974472289, 1245.7134858982486, 1273.5478904988781, 1356.9687037851106, 1380.178793617816, 787.3661702329565, 802.2218448105328, 809.1988930958427, 819.9549024803694, 824.7299159294739, 4030.266985196335, 4138.668906487474, 4692.272697731857, 4694.342792009122, 4694.36626055485, 4401.009772801158, 4750.8337208197545, 4758.405199350082, 4809.398825146856, 5183.0304484296485, 4395.824167033346, 4441.400410944546, 4596.816127354935, 4686.226772582554, 4735.715857048588, 2055.1882006607307, 2400.7719266669637, 2584.741525847438, 2663.720309367527, 2780.88876444944, 4525.0, 4744.478107408182, 4893.363862697897, 4911.61786533531, 5343.919841202385, 4497.763115143296, 4778.713277203379, 4964.007198560303, 5237.046030247215, 5352.330958630171, 5045.862607338003, 5256.842294731241, 5445.0, 6330.778422755181, 6451.774187903495, 6107.106796892977, 6134.78528251509, 6183.227096612924, 6187.474064704551, 6196.132541444292, 5066.847994560169, 6020.337762845996, 6048.546359023003, 6052.394760523913, 6080.452759251511, 6002.549808764447, 6085.300190478151, 6310.274318453253, 6327.145835312174, 6362.809115726535, 3121.4381411346176, 3665.303592317451, 3964.06844391562, 4004.1991601679197, 4024.75851448914, 5303.337082864642, 5712.743196496764, 5912.5861189718025, 6057.666828324484, 6080.969595152173, 5000.499950004971, 5775.364709881994, 5837.0676778122415, 5895.852603684943, 5913.669424379652, 4866.829660961849, 5888.263967004124, 5913.733881975408, 5924.733386997509, 5946.07835785454, 5086.440491545853, 5163.9413920147035, 5330.880515091874, 5727.596738799021, 5788.118861370156, 5026.497350265091, 5335.759890804846, 5818.82543523678, 5898.528117750656, 5923.985844812784, 4943.555080042814, 5725.112607545837, 5762.971185144215, 5784.623999440023, 5828.300603927556], "value": 4075.1588579176105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.1158527145329, 779.2285637219151, 819.9508029518229, 820.1798201798206, 843.6414523827372, 13053.151545149558, 14770.0, 14855.628609284773, 15153.0, 15334.0, 13866.890648748102, 13948.163110213394, 13966.511172108978, 13989.860101399008, 13992.860071399284, 676.5737585321241, 865.1996902864825, 865.7186414415308, 865.9567021648892, 871.9738407847759, 870.3907264914585, 883.1609970527992, 894.5259012723267, 896.4262871762045, 897.7845317123908, 943.9197668198211, 948.3503799897093, 948.7580666929957, 951.6954574536152, 953.0136308920269, 924.7087167542203, 939.1922946266205, 940.05994005994, 942.9528523573794, 948.1940350701883, 701.698269744015, 701.891206862932, 702.6065403374075, 702.9402500787439, 705.3792662457005, 14620.049696769676, 14629.92685036568, 14644.12135271887, 14703.411863525445, 14721.337539810735, 11613.0, 13989.0, 14074.507392241325, 14095.929520352434, 14214.289285535786, 11497.482613282422, 11498.42507874603, 11507.309561426342, 11531.308121512653, 11809.94369330057, 3344.8662053518074, 3812.0, 3857.0550215197177, 3875.0, 3975.840966361371, 78724.60637696774, 78962.99999999943, 79629.60185199037, 79641.20358796396, 79672.0, 10194.949025254826, 10718.785624287471, 10790.460476976119, 10891.83662245067, 10951.890481095086, 22024.779752202594, 22030.559388812453, 22048.007839647253, 22052.11791528353, 22092.889535552218, 6827.48793840454, 7857.724979625686, 8153.470024448392, 8175.305099066527, 8186.918130818734, 4379.562043795595, 4460.477538167196, 4470.396496472999, 4472.195432355292, 4478.362380959516, 3381.7970921744773, 3427.622961474236, 3471.1669199391963, 3488.2674638326234, 3506.2111025019167, 639.5459223950954, 647.1263793878227, 650.7397041183565, 690.2510775808204, 700.3451772592642, 572.4933433911019, 615.4153554123601, 620.882032413849, 670.128832517725, 710.4830889192333, 9541.18899893503, 9589.089036541518, 9667.35084223509, 9701.70894873155, 9730.36752611078, 602.4306333487679, 608.528390497368, 651.3649192037725, 666.4435196610884, 690.7893092606803, 4299.419578356944, 4332.090261045153, 4498.797554110073, 4500.572445617727, 4566.657500687462, 91789.54105229431, 92786.53606731923, 94252.52873735725, 94678.0, 95277.52361238288, 79056.41887162339, 79085.20914790778, 79892.20107798847, 80630.0, 84290.52111612726, 74052.62973685097, 74119.0, 74745.0, 75075.0, 75104.11823231472, 8098.068722097034, 8265.83468330642, 8838.646454141763, 8881.955590222007, 8953.462792232487, 47622.76188619035, 47624.761876191784, 47950.520494794604, 48208.0, 48925.5107448921, 55581.61045973883, 64480.67759661172, 66790.0, 67071.0, 67564.32435675581, 10557.841632375366, 11086.556537738401, 11138.10895128404, 11544.653660390202, 11894.34581098048, 12050.819237711617, 12242.326672032767, 12322.383880805744, 12390.256584604953, 12436.81344779811, 11593.420328983348, 11832.0, 11985.820212696643, 12093.81859272094, 12192.085593580694, 11564.074874009892, 11720.120990925545, 11854.407279636156, 11929.463174157358, 12197.695057623276, 11175.776484470103, 11339.206255562032, 11597.536098555964, 11974.281543107441, 11989.580364687194, 9226.35415520907, 9252.814943701223, 9306.953465232631, 9513.191378732885, 9531.952340238255, 7111.644417779194, 8502.702405415781, 9249.861252081359, 9449.48027858447, 9554.0], "value": 7120.963072376512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 108.0, 116.0, 121.0, 119.0, 116.0, 113.0, 116.0, 131.0, 172.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 134.0, 160.0, 188.0, 150.0, 136.0, 136.0, 136.0, 164.0, 117.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 202.0, 213.0, 246.0, 195.0, 198.0, 200.0, 232.0, 282.0], "value": 216.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 81.0, 76.0, 183.0, 50.0, 81.0, 82.0, 78.0, 128.0, 81.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 112.0, 69.0, 70.0, 79.0, 112.0, 69.0, 72.0, 112.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 88.0, 86.0, 88.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 95.0, 104.0, 140.0, 95.0, 95.0, 95.0, 105.0, 124.0, 120.0], "value": 111.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 120.0, 133.0, 128.0, 143.0, 99.0, 146.0, 109.0, 145.0], "value": 129.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 58.0, 58.0, 58.0, 56.0, 58.0, 57.0, 62.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 66.0, 72.0, 68.0, 70.0, 70.0, 69.0, 70.0, 79.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 106.0, 77.0, 97.0, 110.0, 106.0, 105.0, 148.0, 87.0], "value": 99.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 136.0, 139.0, 136.0, 141.0, 140.0, 138.0, 149.0, 146.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 174.0, 166.0, 166.0, 166.0, 169.0, 165.0, 166.0, 164.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 66.0, 66.0, 64.0, 68.0, 64.0, 67.0, 67.0], "value": 66.1, "unit": "score"}]}]} 05:52:43 INFO - Return code: 0 05:52:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:52:43 ERROR - # TBPL SUCCESS # 05:52:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:43 INFO - 2016-05-30 05:52:43.677 screenresolution[1682:11130] starting screenresolution argv=screenresolution get 05:52:43 INFO - 2016-05-30 05:52:43.680 screenresolution[1682:11130] Display 0: 1600x1200x32@60 05:52:43 INFO - 2016-05-30 05:52:43.686 screenresolution[1683:11133] starting screenresolution argv=screenresolution list 05:52:43 INFO - Available Modes on Display 0 05:52:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:43 INFO - Intel Iris: 05:52:43 INFO - Chipset Model: Intel Iris 05:52:43 INFO - Type: GPU 05:52:43 INFO - Bus: Built-In 05:52:43 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:43 INFO - Vendor: Intel (0x8086) 05:52:43 INFO - Device ID: 0x0a2e 05:52:43 INFO - Revision ID: 0x0009 05:52:43 INFO - Displays: 05:52:43 INFO - Display: 05:52:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:43 INFO - Display Serial Number: 1600x1200 60 05:52:43 INFO - Main Display: Yes 05:52:43 INFO - Mirror: Off 05:52:43 INFO - Online: Yes 05:52:43 INFO - Rotation: Supported 05:52:43 INFO - Return code: 0 05:52:43 INFO - Running post-action listener: _resource_record_post_action 05:52:43 INFO - ##### 05:52:43 INFO - ##### Finished run-tests step (success) 05:52:43 INFO - ##### 05:52:43 INFO - Running post-run listener: _resource_record_post_run 05:52:43 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 32574976; Write bytes: 699938304; Read time: 204; Write time: 1912 05:52:43 INFO - TinderboxPrint: CPU usage
54.4% 05:52:43 INFO - TinderboxPrint: I/O read bytes / time
32,574,976 / 204 05:52:43 INFO - TinderboxPrint: I/O write bytes / time
699,938,304 / 1,912 05:52:43 INFO - TinderboxPrint: CPU idle
2,201.4 (45.6%) 05:52:43 INFO - TinderboxPrint: CPU system
965.0 (20.0%) 05:52:43 INFO - TinderboxPrint: CPU user
1,663.2 (34.4%) 05:52:43 INFO - TinderboxPrint: Swap in / out
426,835,968 / 0 05:52:43 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379222528; Write bytes: 372795392; Read time: 28077; Write time: 748 05:52:43 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 31645184; Write bytes: 299949568; Read time: 192; Write time: 1102 05:52:44 INFO - Running post-run listener: _upload_blobber_files 05:52:44 INFO - Blob upload gear active. 05:52:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:52:44 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:44 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:46 INFO - (blobuploader) - INFO - Done attempting. 05:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:46 INFO - (blobuploader) - INFO - Done attempting. 05:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:49 INFO - (blobuploader) - INFO - Done attempting. 05:52:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:49 INFO - Return code: 0 05:52:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d393874dbc24aae7795063d62779ac9db1f880b12edc9e2a22fcd84e029b16b3ef10436fcffb29206e4d83d1a2d40d80c3b3a1fb6cafa522d8344a66e5b208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0f77d6d8dc0bdf93a29b63561cc011c87f367c82d7cc369562e93fef68637a0cf0135a9a989e1e53e7a18ee1503465b82427980b17109970a7c9c1004a8a148", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6cafc9f365bbbec456313ea403ed756b4514656c5a844d119a3380137625651c839120c5fb6bfaa294ab366221d7c5fa730bfe71c9909268b2bf3506cf1272"} 05:52:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:49 INFO - Contents: 05:52:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d393874dbc24aae7795063d62779ac9db1f880b12edc9e2a22fcd84e029b16b3ef10436fcffb29206e4d83d1a2d40d80c3b3a1fb6cafa522d8344a66e5b208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0f77d6d8dc0bdf93a29b63561cc011c87f367c82d7cc369562e93fef68637a0cf0135a9a989e1e53e7a18ee1503465b82427980b17109970a7c9c1004a8a148", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6cafc9f365bbbec456313ea403ed756b4514656c5a844d119a3380137625651c839120c5fb6bfaa294ab366221d7c5fa730bfe71c9909268b2bf3506cf1272"} 05:52:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:49 INFO - Copying logs to upload dir... 05:52:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1347.947977 ========= master_lag: 1.84 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 29 secs) (at 2016-05-30 05:52:51.111012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 05:52:51.115933) ========= 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.opjJlAhcAn/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.mxnJV0XVqp/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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/Firefox/sha512/d1d393874dbc24aae7795063d62779ac9db1f880b12edc9e2a22fcd84e029b16b3ef10436fcffb29206e4d83d1a2d40d80c3b3a1fb6cafa522d8344a66e5b208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0f77d6d8dc0bdf93a29b63561cc011c87f367c82d7cc369562e93fef68637a0cf0135a9a989e1e53e7a18ee1503465b82427980b17109970a7c9c1004a8a148", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6cafc9f365bbbec456313ea403ed756b4514656c5a844d119a3380137625651c839120c5fb6bfaa294ab366221d7c5fa730bfe71c9909268b2bf3506cf1272"} build_url:https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/FNtmLL7sTFq_zV6YdGdR1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d393874dbc24aae7795063d62779ac9db1f880b12edc9e2a22fcd84e029b16b3ef10436fcffb29206e4d83d1a2d40d80c3b3a1fb6cafa522d8344a66e5b208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0f77d6d8dc0bdf93a29b63561cc011c87f367c82d7cc369562e93fef68637a0cf0135a9a989e1e53e7a18ee1503465b82427980b17109970a7c9c1004a8a148", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6cafc9f365bbbec456313ea403ed756b4514656c5a844d119a3380137625651c839120c5fb6bfaa294ab366221d7c5fa730bfe71c9909268b2bf3506cf1272"}' ========= master_lag: 0.68 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 05:52:51.812334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:52:51.812899) ========= 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.opjJlAhcAn/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.mxnJV0XVqp/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.005179 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:52:51.845431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 05:52:51.845814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 05:52:51.851401) ========= ========= Total master_lag: 3.39 =========