builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0112 starttime: 1464320171.07 results: success (0) buildid: 20160526184452 builduid: af5b319b8ada4c61bbc831eeaeb525da revision: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.066019) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.066480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.066809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.093496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.093807) ========= 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.svH5oqClSo/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.nX9LaGhVHR/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-26 20:36:11-- 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% 150M=0s 2016-05-26 20:36:11 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.379666 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.501464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.501799) ========= 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.svH5oqClSo/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.nX9LaGhVHR/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.029867 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:11.551751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-26 20:36:11.552090) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 --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 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.svH5oqClSo/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.nX9LaGhVHR/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-26 20:36:11,623 truncating revision to first 12 chars 2016-05-26 20:36:11,624 Setting DEBUG logging. 2016-05-26 20:36:11,624 attempt 1/10 2016-05-26 20:36:11,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34ac60e5b29c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 20:36:13,371 unpacking tar archive at: mozilla-central-34ac60e5b29c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.020537 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-26 20:36:13.597900) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:13.598399) ========= script_repo_revision: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:13.599561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:13.600165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 20:36:13.617262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2016-05-26 20:36:13.617848) ========= /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.svH5oqClSo/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.nX9LaGhVHR/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:36:13 INFO - MultiFileLogger online at 20160526 20:36:13 in /builds/slave/test 20:36:13 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 20:36:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:36:13 INFO - {'append_to_log': False, 20:36:13 INFO - 'base_work_dir': '/builds/slave/test', 20:36:13 INFO - 'blob_upload_branch': 'Firefox', 20:36:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:36:13 INFO - 'branch': 'Firefox', 20:36:13 INFO - 'buildbot_json_path': 'buildprops.json', 20:36:13 INFO - 'config_files': ('talos/mac_config.py',), 20:36:13 INFO - 'default_actions': ('clobber', 20:36:13 INFO - 'read-buildbot-config', 20:36:13 INFO - 'download-and-extract', 20:36:13 INFO - 'populate-webroot', 20:36:13 INFO - 'create-virtualenv', 20:36:13 INFO - 'install', 20:36:13 INFO - 'run-tests'), 20:36:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:36:13 INFO - 'download_minidump_stackwalk': True, 20:36:13 INFO - 'download_symbols': 'ondemand', 20:36:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:36:13 INFO - 'tooltool.py': '/tools/tooltool.py', 20:36:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:36:13 INFO - '/tools/misc-python/virtualenv.py')}, 20:36:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:36:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:36:13 INFO - 'installer_path': 'installer.exe', 20:36:13 INFO - 'log_level': 'info', 20:36:13 INFO - 'log_name': 'talos', 20:36:13 INFO - 'log_to_console': True, 20:36:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:36:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:36:13 INFO - 'opt_config_files': (), 20:36:13 INFO - 'pip_index': False, 20:36:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:36:13 INFO - 'cmd': ('bash', 20:36:13 INFO - '-c', 20:36:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:36:13 INFO - 'enabled': True, 20:36:13 INFO - 'halt_on_failure': False, 20:36:13 INFO - 'name': 'check_screen_resolution'},), 20:36:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:36:13 INFO - 'cmd': ('bash', 20:36:13 INFO - '-c', 20:36:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:36:13 INFO - 'enabled': True, 20:36:13 INFO - 'halt_on_failure': False, 20:36:13 INFO - 'name': 'check_screen_resolution'},), 20:36:13 INFO - 'run_cmd_checks_enabled': True, 20:36:13 INFO - 'sps_profile': False, 20:36:13 INFO - 'sps_profile_interval': 0, 20:36:13 INFO - 'suite': 'dromaeojs-e10s', 20:36:13 INFO - 'system_bits': '32', 20:36:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:36:13 INFO - 'title': 't-yosemite-r7-0112', 20:36:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:36:13 INFO - 'use_talos_json': True, 20:36:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:36:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:36:13 INFO - 'work_dir': 'build'} 20:36:13 INFO - ##### 20:36:13 INFO - ##### Running clobber step. 20:36:13 INFO - ##### 20:36:13 INFO - Running pre-action listener: _resource_record_pre_action 20:36:13 INFO - Running main action method: clobber 20:36:13 INFO - rmtree: /builds/slave/test/build 20:36:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:36:15 INFO - Running post-action listener: _resource_record_post_action 20:36:15 INFO - ##### 20:36:15 INFO - ##### Finished clobber step (success) 20:36:15 INFO - ##### 20:36:15 INFO - ##### 20:36:15 INFO - ##### Running read-buildbot-config step. 20:36:15 INFO - ##### 20:36:15 INFO - Running pre-action listener: _resource_record_pre_action 20:36:15 INFO - Running main action method: read_buildbot_config 20:36:15 INFO - Using buildbot properties: 20:36:15 INFO - { 20:36:15 INFO - "project": "", 20:36:15 INFO - "product": "firefox", 20:36:15 INFO - "script_repo_revision": "production", 20:36:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:36:15 INFO - "repository": "", 20:36:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:36:15 INFO - "buildid": "20160526184452", 20:36:15 INFO - "pgo_build": "False", 20:36:15 INFO - "basedir": "/builds/slave/test", 20:36:15 INFO - "buildnumber": 233, 20:36:15 INFO - "slavename": "t-yosemite-r7-0112", 20:36:15 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:36:15 INFO - "platform": "yosemite_r7", 20:36:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:36:15 INFO - "branch": "mozilla-central", 20:36:15 INFO - "repo_path": "mozilla-central", 20:36:15 INFO - "revision": "34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321", 20:36:15 INFO - "stage_platform": "macosx64", 20:36:15 INFO - "builduid": "af5b319b8ada4c61bbc831eeaeb525da", 20:36:15 INFO - "slavebuilddir": "test" 20:36:15 INFO - } 20:36:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 20:36:15 INFO - Running post-action listener: _resource_record_post_action 20:36:15 INFO - ##### 20:36:15 INFO - ##### Finished read-buildbot-config step (success) 20:36:15 INFO - ##### 20:36:15 INFO - ##### 20:36:15 INFO - ##### Running download-and-extract step. 20:36:15 INFO - ##### 20:36:15 INFO - Running pre-action listener: _resource_record_pre_action 20:36:15 INFO - Running main action method: download_and_extract 20:36:15 INFO - mkdir: /builds/slave/test/build/tests 20:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:36:15 INFO - https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:36:46 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 20:36:46 INFO - retry: attempt #1 caught exception: timed out 20:36:46 INFO - retry: Failed, sleeping 30 seconds before retrying 20:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:17 INFO - Downloaded 1199 bytes. 20:37:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:37:17 INFO - Using the following test package requirements: 20:37:17 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:37:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 20:37:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 20:37:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'jsshell-mac.zip'], 20:37:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 20:37:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:37:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 20:37:17 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 20:37:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 20:37:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:37:17 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 20:37:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:37: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')]} 20:37:17 INFO - https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:19 INFO - Downloaded 18622070 bytes. 20:37:19 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'] 20:37:19 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 20:37:22 INFO - Return code: 0 20:37:22 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 20:37: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')]} 20:37:22 INFO - https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:37:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:37:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:37:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:32 INFO - Downloaded 18622070 bytes. 20:37:32 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'] 20:37:32 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 20:37:36 INFO - Return code: 0 20:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:36 INFO - https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:37 INFO - Downloaded 10834034 bytes. 20:37:37 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'] 20:37:37 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 20:37:37 INFO - Return code: 0 20:37:37 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')]} 20:37:37 INFO - https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 20:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4NI3j55TN2cPFIxO4sOaA/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 20:37:40 INFO - Downloaded 110447994 bytes. 20:37:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:37:40 INFO - mkdir: /builds/slave/test/properties 20:37:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:37:40 INFO - Writing to file /builds/slave/test/properties/build_url 20:37:40 INFO - Contents: 20:37:40 INFO - build_url:https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:37:41 INFO - Running post-action listener: _resource_record_post_action 20:37:41 INFO - Running post-action listener: set_extra_try_arguments 20:37:41 INFO - ##### 20:37:41 INFO - ##### Finished download-and-extract step (success) 20:37:41 INFO - ##### 20:37:41 INFO - ##### 20:37:41 INFO - ##### Running populate-webroot step. 20:37:41 INFO - ##### 20:37:41 INFO - Running pre-action listener: _resource_record_pre_action 20:37:41 INFO - Running main action method: populate_webroot 20:37:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:37:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:37:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:37:41 INFO - '--tppagecycles', 20:37:41 INFO - '7'], 20:37:41 INFO - 'tests': ['tsvgm']}}, 20:37:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:37:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:37:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:37:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:37:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:37:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:37:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['damp', 'tps']}, 20:37:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'tests': ['damp', 'tps']}, 20:37:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['dromaeo_dom']}, 20:37:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:37:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['a11yr', 20:37:41 INFO - 'ts_paint', 20:37:41 INFO - 'tpaint', 20:37:41 INFO - 'sessionrestore', 20:37:41 INFO - 'sessionrestore_no_auto_restore', 20:37:41 INFO - 'tabpaint']}, 20:37:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:37:41 INFO - 'ts_paint', 20:37:41 INFO - 'tpaint', 20:37:41 INFO - 'sessionrestore', 20:37:41 INFO - 'sessionrestore_no_auto_restore', 20:37:41 INFO - 'tabpaint']}, 20:37:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:37:41 INFO - 'ts_paint', 20:37:41 INFO - 'tpaint', 20:37:41 INFO - 'sessionrestore', 20:37:41 INFO - 'sessionrestore_no_auto_restore', 20:37:41 INFO - 'tabpaint']}, 20:37:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:37:41 INFO - 'ts_paint', 20:37:41 INFO - 'tpaint', 20:37:41 INFO - 'sessionrestore', 20:37:41 INFO - 'sessionrestore_no_auto_restore', 20:37:41 INFO - 'tabpaint']}, 20:37:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['a11yr', 20:37:41 INFO - 'ts_paint', 20:37:41 INFO - 'tpaint', 20:37:41 INFO - 'sessionrestore', 20:37:41 INFO - 'sessionrestore_no_auto_restore', 20:37:41 INFO - 'tabpaint']}, 20:37:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['a11yr', 20:37:41 INFO - 'ts_paint', 20:37:41 INFO - 'tpaint', 20:37:41 INFO - 'sessionrestore', 20:37:41 INFO - 'sessionrestore_no_auto_restore', 20:37:41 INFO - 'tabpaint']}, 20:37:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['tsvgx', 20:37:41 INFO - 'tsvgr_opacity', 20:37:41 INFO - 'tart', 20:37:41 INFO - 'tscrollx', 20:37:41 INFO - 'cart']}, 20:37:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:37:41 INFO - 'tsvgr_opacity', 20:37:41 INFO - 'tart', 20:37:41 INFO - 'tscrollx', 20:37:41 INFO - 'cart']}, 20:37:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'talos_options': ['--disable-e10s'], 20:37:41 INFO - 'tests': ['tp5o']}, 20:37:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'tests': ['tp5o']}, 20:37:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'talos_options': ['--disable-e10s', 20:37:41 INFO - '--xperf_path', 20:37:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:37:41 INFO - 'tests': ['tp5n']}, 20:37:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:41 INFO - 'talos_options': ['--xperf_path', 20:37:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:37:41 INFO - 'tests': ['tp5n']}}, 20:37:41 INFO - 'talos.zip': {'path': '', 20:37:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:37:41 INFO - Running post-action listener: _resource_record_post_action 20:37:41 INFO - ##### 20:37:41 INFO - ##### Finished populate-webroot step (success) 20:37:41 INFO - ##### 20:37:41 INFO - ##### 20:37:41 INFO - ##### Running create-virtualenv step. 20:37:41 INFO - ##### 20:37:41 INFO - Running pre-action listener: _resource_record_pre_action 20:37:41 INFO - Running main action method: create_virtualenv 20:37:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:37:41 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 20:37:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:37:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:37:42 INFO - Using real prefix '/tools/python27' 20:37:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:37:42 INFO - Installing distribute.............................................................................................................................................................................................done. 20:37:45 INFO - Installing pip.................done. 20:37:45 INFO - Return code: 0 20:37:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:45 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:37:45 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 20:37:45 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 20:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:45 INFO - 'HOME': '/Users/cltbld', 20:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:45 INFO - 'LOGNAME': 'cltbld', 20:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:45 INFO - 'MOZ_NO_REMOTE': '1', 20:37:45 INFO - 'NO_EM_RESTART': '1', 20:37:45 INFO - 'PAGER': '/bin/cat', 20:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:45 INFO - 'PWD': '/builds/slave/test', 20:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:45 INFO - 'SHELL': '/bin/bash', 20:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:37:45 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:45 INFO - 'USER': 'cltbld', 20:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:45 INFO - 'XPC_FLAGS': '0x0', 20:37:45 INFO - 'XPC_SERVICE_NAME': '0', 20:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:45 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 20:37:45 INFO - Cleaning up... 20:37:45 INFO - Return code: 0 20:37:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:45 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:37:45 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 20:37:45 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 20:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:45 INFO - 'HOME': '/Users/cltbld', 20:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:45 INFO - 'LOGNAME': 'cltbld', 20:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:45 INFO - 'MOZ_NO_REMOTE': '1', 20:37:45 INFO - 'NO_EM_RESTART': '1', 20:37:45 INFO - 'PAGER': '/bin/cat', 20:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:45 INFO - 'PWD': '/builds/slave/test', 20:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:45 INFO - 'SHELL': '/bin/bash', 20:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:37:45 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:45 INFO - 'USER': 'cltbld', 20:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:45 INFO - 'XPC_FLAGS': '0x0', 20:37:45 INFO - 'XPC_SERVICE_NAME': '0', 20:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:46 INFO - Downloading/unpacking psutil>=3.1.1 20:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:37:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:37:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:37:49 INFO - Installing collected packages: psutil 20:37:49 INFO - Running setup.py install for psutil 20:37:49 INFO - building 'psutil._psutil_osx' extension 20:37:49 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 20:37:50 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 20:37:50 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 20:37:50 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 20:37:50 INFO - building 'psutil._psutil_posix' extension 20:37:50 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 20:37:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:37:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:37:50 INFO - ^ 20:37:50 INFO - 1 warning generated. 20:37:50 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 20:37:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:37:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:37:50 INFO - Successfully installed psutil 20:37:50 INFO - Cleaning up... 20:37:50 INFO - Return code: 0 20:37:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:50 INFO - 'HOME': '/Users/cltbld', 20:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:50 INFO - 'LOGNAME': 'cltbld', 20:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:50 INFO - 'MOZ_NO_REMOTE': '1', 20:37:50 INFO - 'NO_EM_RESTART': '1', 20:37:50 INFO - 'PAGER': '/bin/cat', 20:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:50 INFO - 'PWD': '/builds/slave/test', 20:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:50 INFO - 'SHELL': '/bin/bash', 20:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:37:50 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:50 INFO - 'USER': 'cltbld', 20:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:50 INFO - 'XPC_FLAGS': '0x0', 20:37:50 INFO - 'XPC_SERVICE_NAME': '0', 20:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:37:53 INFO - Installing collected packages: mozsystemmonitor 20:37:53 INFO - Running setup.py install for mozsystemmonitor 20:37:53 INFO - Successfully installed mozsystemmonitor 20:37:53 INFO - Cleaning up... 20:37:53 INFO - Return code: 0 20:37:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:53 INFO - 'HOME': '/Users/cltbld', 20:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:53 INFO - 'LOGNAME': 'cltbld', 20:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:53 INFO - 'MOZ_NO_REMOTE': '1', 20:37:53 INFO - 'NO_EM_RESTART': '1', 20:37:53 INFO - 'PAGER': '/bin/cat', 20:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:53 INFO - 'PWD': '/builds/slave/test', 20:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:53 INFO - 'SHELL': '/bin/bash', 20:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:37:53 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:53 INFO - 'USER': 'cltbld', 20:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:53 INFO - 'XPC_FLAGS': '0x0', 20:37:53 INFO - 'XPC_SERVICE_NAME': '0', 20:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:53 INFO - Downloading/unpacking blobuploader==1.2.4 20:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:56 INFO - Downloading blobuploader-1.2.4.tar.gz 20:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:37:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:37:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 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 20:37:56 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 20:37:57 INFO - Downloading docopt-0.6.1.tar.gz 20:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:37:57 INFO - Installing collected packages: blobuploader, requests, docopt 20:37:57 INFO - Running setup.py install for blobuploader 20:37:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:37:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:37:57 INFO - Running setup.py install for requests 20:37:58 INFO - Running setup.py install for docopt 20:37:58 INFO - Successfully installed blobuploader requests docopt 20:37:58 INFO - Cleaning up... 20:37:58 INFO - Return code: 0 20:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:58 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')]} 20:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:58 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')]} 20:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:58 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:37:58 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 20:37:58 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 20:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:58 INFO - 'HOME': '/Users/cltbld', 20:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:58 INFO - 'LOGNAME': 'cltbld', 20:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:58 INFO - 'MOZ_NO_REMOTE': '1', 20:37:58 INFO - 'NO_EM_RESTART': '1', 20:37:58 INFO - 'PAGER': '/bin/cat', 20:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:58 INFO - 'PWD': '/builds/slave/test', 20:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:58 INFO - 'SHELL': '/bin/bash', 20:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:37:58 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:58 INFO - 'USER': 'cltbld', 20:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:58 INFO - 'XPC_FLAGS': '0x0', 20:37:58 INFO - 'XPC_SERVICE_NAME': '0', 20:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:37:58 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-nH8jsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:37:58 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-69Bh1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:37:58 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cMY03l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lL6dUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cpJUCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-IMsat4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qsANi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-nDXXRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gdBFyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qHYciJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-1UlzSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-seos47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:37:59 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cECywI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:38:00 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0BULCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:38:00 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-H4NS6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:38:00 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-W627mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:38:00 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dzAfrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:38:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:38:00 INFO - Running setup.py install for manifestparser 20:38:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:38:00 INFO - Running setup.py install for mozcrash 20:38:00 INFO - Running setup.py install for mozdebug 20:38:00 INFO - Running setup.py install for mozdevice 20:38:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Running setup.py install for mozfile 20:38:01 INFO - Running setup.py install for mozhttpd 20:38:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Running setup.py install for mozinfo 20:38:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Running setup.py install for mozInstall 20:38:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Running setup.py install for mozleak 20:38:01 INFO - Running setup.py install for mozlog 20:38:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:38:01 INFO - Running setup.py install for moznetwork 20:38:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:38:02 INFO - Running setup.py install for mozprocess 20:38:02 INFO - Running setup.py install for mozprofile 20:38:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:38:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:38:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:38:02 INFO - Running setup.py install for mozrunner 20:38:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:38:02 INFO - Running setup.py install for mozscreenshot 20:38:02 INFO - Running setup.py install for moztest 20:38:02 INFO - Running setup.py install for mozversion 20:38:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:38:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:38:02 INFO - Cleaning up... 20:38:03 INFO - Return code: 0 20:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:03 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:38:03 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 20:38:03 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 20:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:38:03 INFO - 'HOME': '/Users/cltbld', 20:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:38:03 INFO - 'LOGNAME': 'cltbld', 20:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:03 INFO - 'MOZ_NO_REMOTE': '1', 20:38:03 INFO - 'NO_EM_RESTART': '1', 20:38:03 INFO - 'PAGER': '/bin/cat', 20:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:03 INFO - 'PWD': '/builds/slave/test', 20:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:38:03 INFO - 'SHELL': '/bin/bash', 20:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:38:03 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:38:03 INFO - 'USER': 'cltbld', 20:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:03 INFO - 'XPC_FLAGS': '0x0', 20:38:03 INFO - 'XPC_SERVICE_NAME': '0', 20:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-f5WNwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:38:03 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)) 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-C0_ehB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:38:03 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)) 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-eVLevi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:38:03 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)) 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-SFQ_ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:38:03 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)) 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-q8QTA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:38:03 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)) 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-WnZn2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:38:03 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)) 20:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:38:03 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-LHOPf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wXyQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3LeZe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MABiWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PhJcuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-7VnzUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-A1dGmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-TUl1fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vhz9zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-FSPikU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:38:04 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)) 20:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:38:04 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MRZsm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:38:05 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)) 20:38:05 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)) 20:38:05 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)) 20:38:05 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)) 20:38:05 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)) 20:38:05 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)) 20:38:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:07 INFO - Downloading blessings-1.6.tar.gz 20:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:38:07 INFO - Installing collected packages: blessings 20:38:07 INFO - Running setup.py install for blessings 20:38:07 INFO - Successfully installed blessings 20:38:07 INFO - Cleaning up... 20:38:07 INFO - Return code: 0 20:38:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:38:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:38:08 INFO - Reading from file tmpfile_stdout 20:38:08 INFO - Current package versions: 20:38:08 INFO - blessings == 1.6 20:38:08 INFO - blobuploader == 1.2.4 20:38:08 INFO - docopt == 0.6.1 20:38:08 INFO - manifestparser == 1.1 20:38:08 INFO - mozInstall == 1.12 20:38:08 INFO - mozcrash == 0.17 20:38:08 INFO - mozdebug == 0.1 20:38:08 INFO - mozdevice == 0.48 20:38:08 INFO - mozfile == 1.2 20:38:08 INFO - mozhttpd == 0.7 20:38:08 INFO - mozinfo == 0.9 20:38:08 INFO - mozleak == 0.1 20:38:08 INFO - mozlog == 3.2 20:38:08 INFO - moznetwork == 0.27 20:38:08 INFO - mozprocess == 0.22 20:38:08 INFO - mozprofile == 0.28 20:38:08 INFO - mozrunner == 6.11 20:38:08 INFO - mozscreenshot == 0.1 20:38:08 INFO - mozsystemmonitor == 0.3 20:38:08 INFO - moztest == 0.7 20:38:08 INFO - mozversion == 1.4 20:38:08 INFO - psutil == 3.1.1 20:38:08 INFO - requests == 1.2.3 20:38:08 INFO - wsgiref == 0.1.2 20:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:38:08 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')]} 20:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:08 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')]} 20:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:08 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:38:08 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 20:38:08 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 20:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:38:08 INFO - 'HOME': '/Users/cltbld', 20:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:38:08 INFO - 'LOGNAME': 'cltbld', 20:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:08 INFO - 'MOZ_NO_REMOTE': '1', 20:38:08 INFO - 'NO_EM_RESTART': '1', 20:38:08 INFO - 'PAGER': '/bin/cat', 20:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:08 INFO - 'PWD': '/builds/slave/test', 20:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:38:08 INFO - 'SHELL': '/bin/bash', 20:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:38:08 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:38:08 INFO - 'USER': 'cltbld', 20:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:08 INFO - 'XPC_FLAGS': '0x0', 20:38:08 INFO - 'XPC_SERVICE_NAME': '0', 20:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 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)) 20:38:08 INFO - Cleaning up... 20:38:08 INFO - Return code: 0 20:38:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:38:08 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')]} 20:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:08 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')]} 20:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:08 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:38:08 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 20:38:08 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 20:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:38:08 INFO - 'HOME': '/Users/cltbld', 20:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:38:08 INFO - 'LOGNAME': 'cltbld', 20:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:08 INFO - 'MOZ_NO_REMOTE': '1', 20:38:08 INFO - 'NO_EM_RESTART': '1', 20:38:08 INFO - 'PAGER': '/bin/cat', 20:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:08 INFO - 'PWD': '/builds/slave/test', 20:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:38:08 INFO - 'SHELL': '/bin/bash', 20:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:38:08 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:38:08 INFO - 'USER': 'cltbld', 20:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:08 INFO - 'XPC_FLAGS': '0x0', 20:38:08 INFO - 'XPC_SERVICE_NAME': '0', 20:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:08 INFO - Downloading/unpacking jsonschema 20:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:38:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:38:11 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 20:38:11 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 20:38:11 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 20:38:11 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 20:38:11 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 20:38:11 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 20:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:38:11 INFO - warning: no files found matching '*.txt' 20:38:11 INFO - no previously-included directories found matching 'build' 20:38:11 INFO - no previously-included directories found matching 'dist' 20:38:11 INFO - no previously-included directories found matching '.git*' 20:38:11 INFO - Installing collected packages: jsonschema, functools32 20:38:11 INFO - Running setup.py install for functools32 20:38:11 INFO - warning: no files found matching '*.txt' 20:38:11 INFO - no previously-included directories found matching 'build' 20:38:11 INFO - no previously-included directories found matching 'dist' 20:38:11 INFO - no previously-included directories found matching '.git*' 20:38:11 INFO - Successfully installed jsonschema functools32 20:38:11 INFO - Cleaning up... 20:38:11 INFO - Return code: 0 20:38:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:11 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 0x11001ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110024570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301498350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, '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.svH5oqClSo/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.nX9LaGhVHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:38:11 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 20:38:11 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 20:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:38:11 INFO - 'HOME': '/Users/cltbld', 20:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:38:11 INFO - 'LOGNAME': 'cltbld', 20:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:11 INFO - 'MOZ_NO_REMOTE': '1', 20:38:11 INFO - 'NO_EM_RESTART': '1', 20:38:11 INFO - 'PAGER': '/bin/cat', 20:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:11 INFO - 'PWD': '/builds/slave/test', 20:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:38:11 INFO - 'SHELL': '/bin/bash', 20:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:38:11 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:38:11 INFO - 'USER': 'cltbld', 20:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:11 INFO - 'XPC_FLAGS': '0x0', 20:38:11 INFO - 'XPC_SERVICE_NAME': '0', 20:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:12 INFO - Downloading/unpacking flake8 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:38:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:38:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:38:15 INFO - no previously-included directories found matching 'docs/_build' 20:38:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:38:15 INFO - Running setup.py install for pep8 20:38:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:38:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:38:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:38:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:38:16 INFO - no previously-included directories found matching 'docs/_build' 20:38:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:38:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:38:16 INFO - Cleaning up... 20:38:16 INFO - Return code: 0 20:38:16 INFO - Running post-action listener: _resource_record_post_action 20:38:16 INFO - Running post-action listener: _start_resource_monitoring 20:38:16 INFO - Starting resource monitoring. 20:38:16 INFO - ##### 20:38:16 INFO - ##### Finished create-virtualenv step (success) 20:38:16 INFO - ##### 20:38:16 INFO - ##### 20:38:16 INFO - ##### Running install step. 20:38:16 INFO - ##### 20:38:16 INFO - Running pre-action listener: _resource_record_pre_action 20:38:16 INFO - Running main action method: install 20:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:38:16 INFO - Reading from file tmpfile_stdout 20:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:38:16 INFO - Reading from file tmpfile_stdout 20:38:16 INFO - Output received: 20:38:16 INFO - Usage: mozinstall [options] installer 20:38:16 INFO - Options: 20:38:16 INFO - -h, --help show this help message and exit 20:38:16 INFO - -d DEST, --destination=DEST 20:38:16 INFO - Directory to install application into. [default: 20:38:16 INFO - "/builds/slave/test"] 20:38:16 INFO - --app=APP Application being installed. [default: firefox] 20:38:16 INFO - mkdir: /builds/slave/test/build/application 20:38:16 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'] 20:38:16 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 20:38:49 INFO - Reading from file tmpfile_stdout 20:38:49 INFO - Output received: 20:38:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:38:49 INFO - Running post-action listener: _resource_record_post_action 20:38:49 INFO - ##### 20:38:49 INFO - ##### Finished install step (success) 20:38:49 INFO - ##### 20:38:49 INFO - ##### 20:38:49 INFO - ##### Running run-tests step. 20:38:49 INFO - ##### 20:38:49 INFO - Running pre-action listener: _resource_record_pre_action 20:38:49 INFO - Running main action method: run_tests 20:38:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:38:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:38:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:38:50 INFO - 2016-05-26 20:38:50.010 screenresolution[1645:8278] starting screenresolution argv=screenresolution get 20:38:50 INFO - 2016-05-26 20:38:50.012 screenresolution[1645:8278] Display 0: 1600x1200x32@60 20:38:50 INFO - 2016-05-26 20:38:50.017 screenresolution[1646:8280] starting screenresolution argv=screenresolution list 20:38:50 INFO - Available Modes on Display 0 20:38:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:38:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:38:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:38:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:38:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:38:50 INFO - Intel Iris: 20:38:50 INFO - Chipset Model: Intel Iris 20:38:50 INFO - Type: GPU 20:38:50 INFO - Bus: Built-In 20:38:50 INFO - VRAM (Dynamic, Max): 1536 MB 20:38:50 INFO - Vendor: Intel (0x8086) 20:38:50 INFO - Device ID: 0x0a2e 20:38:50 INFO - Revision ID: 0x0009 20:38:50 INFO - Displays: 20:38:50 INFO - Display: 20:38:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:38:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:38:50 INFO - Display Serial Number: 1600x1200 60 20:38:50 INFO - Main Display: Yes 20:38:50 INFO - Mirror: Off 20:38:50 INFO - Online: Yes 20:38:50 INFO - Rotation: Supported 20:38:50 INFO - Return code: 0 20:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:38:50 INFO - Python 2.7.3 20:38:50 INFO - Return code: 0 20:38:50 INFO - grabbing minidump binary from tooltool 20:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:50 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 0x10fec2d30>, '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 0x10fce6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:38:50 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 20:38:50 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 20:38:50 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 20:38:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:38:50 INFO - Return code: 0 20:38:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:38:51 INFO - Return code: 0 20:38:51 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 20:38:51 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 20:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.svH5oqClSo/Render', 20:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:38:51 INFO - 'HOME': '/Users/cltbld', 20:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:38:51 INFO - 'LOGNAME': 'cltbld', 20:38:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:38:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:51 INFO - 'MOZ_NO_REMOTE': '1', 20:38:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:38:51 INFO - 'NO_EM_RESTART': '1', 20:38:51 INFO - 'PAGER': '/bin/cat', 20:38:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:51 INFO - 'PWD': '/builds/slave/test', 20:38:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:38:51 INFO - 'SHELL': '/bin/bash', 20:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nX9LaGhVHR/Listeners', 20:38:51 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:38:51 INFO - 'USER': 'cltbld', 20:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:51 INFO - 'XPC_FLAGS': '0x0', 20:38:51 INFO - 'XPC_SERVICE_NAME': '0', 20:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:38:51 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 20:38:51 INFO - mozversion application_buildid: 20160526184452 20:38:51 INFO - mozversion application_changeset: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 20:38:51 INFO - mozversion application_display_name: Nightly 20:38:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:38:51 INFO - mozversion application_name: Firefox 20:38:51 INFO - mozversion application_remotingname: firefox 20:38:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:38:51 INFO - mozversion application_vendor: Mozilla 20:38:51 INFO - mozversion application_version: 49.0a1 20:38:51 INFO - mozversion platform_buildid: 20160526184452 20:38:51 INFO - mozversion platform_changeset: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 20:38:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:38:51 INFO - mozversion platform_version: 49.0a1 20:38:51 INFO - using testdate: 1464320331 20:38:51 INFO - actual date: 1464320331 20:38:51 INFO - starting webserver on 'localhost:49276' 20:38:51 INFO - SUITE-START | Running 2 tests 20:38:51 INFO - TEST-START | dromaeo_css 20:38:51 INFO - operating with platform_type : mac_ 20:38:51 INFO - Initialising browser for dromaeo_css test... 20:38:51 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpjja2TJ/profile http://localhost:49276/getInfo.html) 20:38:54 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 20:38:54 INFO - PROCESS | 1664 | colorDepth:24 20:38:54 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 20:38:54 INFO - PROCESS | 1664 | __metrics 20:38:54 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:38:55 INFO - TEST-INFO | 1664: exit 0 20:38:55 INFO - Browser initialized. 20:38:55 INFO - Running cycle 1/1 for dromaeo_css test... 20:38:55 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpjja2TJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:07 INFO - PROCESS | 1668 | RSS: Main: 252350464 20:39:07 INFO - PROCESS | 1668 | 20:39:57 INFO - PROCESS | 1668 | 1464320397153 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] 20:42:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 20:42:09 INFO - PROCESS | 1668 | RSS: Main: 265936896 20:42:09 INFO - PROCESS | 1668 | 20:45:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 20:45:12 INFO - PROCESS | 1668 | RSS: Main: 277712896 20:45:12 INFO - PROCESS | 1668 | 20:48:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 20:48:14 INFO - PROCESS | 1668 | RSS: Main: 279838720 20:48:14 INFO - PROCESS | 1668 | 20:51:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 20:51:17 INFO - PROCESS | 1668 | RSS: Main: 281305088 20:51:17 INFO - PROCESS | 1668 | 20:54:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 20:54:20 INFO - PROCESS | 1668 | RSS: Main: 284131328 20:54:20 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 20:57:23 INFO - PROCESS | 1668 | RSS: Main: 285089792 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | __start_tp_report 20:57:23 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 20:57:23 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 20:57:23 INFO - PROCESS | 1668 | |i|pagename|runs| 20:57:23 INFO - PROCESS | 1668 | |0;dojo.html;2985.2536865783554;3497.0732755819704;3527.6472352764713;3542.3269578780046;3556.2531868307656;5794.0729483282685;5893.2338795956575;5917.319508256541;5919.5856290059655;5935.347111817697;4824.589909857657;5694.629849059808;5853.560982926287;5928.49607783339;5968.7612495500125;4628.190066738324;5152.6650767700075;5212.8436146915465;5322.840314790543;5352.91970620441;722.225404766603;5226.712530810804;5234.005538947587;5315.123004704219;5335;5257.526822585947;5259;5260.289860868791;5306.7611957462;5320.255164277004;5309.761060752276;5313.335833020872;5328.094223981932;5341.03861304965;5362.490563396471;5131.512506311894;5206.271122042917;5235.869103272411;5292.285541451894;5313.3092697949405;4752.667313288071;5614.859628509279;5821.650700957956;5824.650520968756;5829.854253643693;6250.749970001195;6268.623882567015;6291.905621415683;6297.559170858041;6305.022721478178;6217.813465596039;6239.500839932794;6274.278457977345;6276.843078923018;6379.521535884781;6038.124471951586;6050;6053.51571874249;6077.574569780118;6125.601835880742;5488.643238189505;5848.2689663792025;6242.313345531988;6376.330485298977;6436.16329877113;6168;6194.163787888668;6243.313235544087;6296.716647750863;6307.211598550181;6266.686665666698;6320.905186422207;6350.618962862243;6355.5551111421755;6364.904526432108;6167.537434692416;6181.072839074085;6249.437550620466;6252.656103914237;6267.4045965633195;5349.679019258857;6127.050307202391;6283.43449089575;6291.213598300213;6298.118263443122;4923.507649235048;5013.423456302499;5022.070916880389;5029.145045342228;5033.79864805411;4442.311441726538;4449.755263460541;4455.910881782346;4550.840720574764;4552.157850797546;5929.466348028698;5971.7611295547695;6037.184980027728;6106.430331452127;6107.816765497042;6266.235223142351;6295.716692748837;6349.015902535114;6366.045093236052;6373.776917807854;5955.821325360246;5976.820695379146;6090.908636370458;6111.9694401528595;6113.32753397126;5476.534494567926;5521.558275337963;5524.033294173584;5533.059379905345;5584.357798853102;6557.245916719543;6558.245801732862;6562.179727534059;6566.080748695282;6575.934240657532;6131.040261761288;6222.657753823583;6256.593321434092;6277.2153480814895;6289.452085457647;5790.160426738184;6534.477241820738;6584.078229048033;6587.341265873374;6589.0116482528;6260.248770147611;6267.4045965633195;6277.529185311211;6298.433141017331;6298.968505157445;6215.34738852414;6219.253689557282;6233.158523599437;6251.093591429309;6344.904826427515;6106.816795496142;6207;6235.189425374672;6273.96863015682;6282.2147231596055;6215.502759779117;6265.686715664289;6267.749290028348;6268.717907694074;6289.96855015722;5214.426413094632;5921.496672782861;5966.19456373384;6132.08018797184;6133.601315914451;6191.938080619136;6226.688665566613;6231.813045608639;6242.3133455320785;6254.437100660963;6028.90956635642;6189.195404597373;6198.783042593487;6212;6216.844578885564 20:57:23 INFO - PROCESS | 1668 | |1;ext.html;471.70282721885206;477.87575230440075;497.8406909788869;531.3437904188328;552.9585281103919;27753.16740497786;41363.58636413635;41484.792576037114;41566.37650435238;41597.3760393594;39150.804245978805;43957.56042439575;43963.34054989178;43981.34027989583;44081;9496.287778416628;9740.928497865229;9742.561584728668;9746.51267436629;9766.951165244163;9314.86027709585;9791.853122203172;9810.852837207447;9815.70552883411;9834.409935403863;9790.510474476248;9844.212463002943;9845.36005159666;9885.901140988606;9890.208783297356;9762.658306959258;9795.265355098361;9802.411855288705;9857.852132218022;9872.802543949152;9558.856617150679;9665.613375464973;9684.322097453181;9685.273604479693;9692.030796920251;40605.796971015254;40966;40995.180096397904;41034.1793164138;41213.79393103045;2759.8758055887533;2798.328401183722;2902.680705122435;3078.7536997040183;3413.9261144470356;28048.719512804815;28326.433471330663;29734;29833.25416864574;29848.701512985026;2652.8938842446278;2677.317284092544;2726.7273272672774;2751.0096365308473;2763.8618069096465;412197;476222;483388;483820;485407;26650.733492665215;31457.528137077963;33683;34273.82863085669;34555.827220863735;35411.82294088513;35818.28363432717;36312.91061268166;36325;36345;14690.338934747962;14899.851001490064;14951.850481495263;14955.77566336484;14984.625384365478;12637.620871373874;12656.620301390973;12727.809082863765;12733.872661273454;12752.93623531895;7889.250521200477;7898.210178982055;7922.920770792333;7936.325412340016;7973.162817904153;3255.8697652094124;3273.4762438009802;3286.2605913669713;3294.6870047345465;3326.4511355626532;754.9773506794805;890.7639475538988;1028.876534815827;1031.9783414419671;1056.6988408303596;28200;29295.85352073226;30261.09216723502;30273.24316892051;30347.089587312417;1027.5427434791445;1043.6190790361463;1097.7639807441437;1098.9614814000852;1128.5711429656678;15281.9235903822;15388.923055384876;15634.318311010777;15699.921500392426;15730.842691572938;703240;707683;715116.1860576764;716437;717246;59736.117152384955;60389.69805150946;61611.38388616056;61896.69051654713;62182.37817621766;1374.2304309586664;1375.803051345316;1384.2040826524787;1391.0749351681422;1394.7768357063023;29407;29428.705712943454;29781.404371912875;30069;30164.54753178748;51848.74075629598;52059.479405205464;52268;52382;52444.47555524549;229769;231990;232115;232571.8371408132;232765;20998.58002839965;24830.37924051913;26387.472250555264;27496.03763868255;28220.294492637026;45922.54077459183;46891;47097.2935405976;47314.76342618403;47429.28856067231;34074.659253407146;38006.61993380141;39094.413583796835;39477.40783888187;39675.40486892641;34175.658243417245;36898.631013690596;38099;38243.72884557098;38583.80708096441;32512.83743581267;36952.26095478021;37524.437133443564;37811.243775124894;38476.03809904775;34172.65827341794;34188;34207.82896085503;34316.82841585776;34434;25181.370465738502;25186.874065629556;25346.35248708828;25796.226113216635;25823.612645809953 20:57:23 INFO - PROCESS | 1668 | |2;jquery.html;366.97798132112075;381.862529489384;382.7148774163249;385.618237944435;399.7901101921489;15654.608634784136;18629.97535135567;21240.044198011088;21272;21573;20841;21016.36950891472;21128.4717882053;21696.566068678618;21897.671534926987;5237.816676416326;5957.31490878548;6127.87744245117;6189.535784816134;6213.440790328869;6140.877182456348;7209.603471809049;7646.006019217494;7658.808529786744;7678.692852285902;7164.319389658001;7484.850302993937;7500.737474188404;7506;7655.617219139021;7322.926770732304;7489.213632568583;7718.035245594273;7815.179406162328;7825.569593672346;6829.692663830139;6979.743646143692;7573.924260757432;7581.545107293525;7645.808854778675;28573.857130714212;28626;29060.564091538643;30050.849745751133;30218.84890575533;2212.6459766437456;2234.6201145805253;2246.932592022242;2312.849664771801;2481.727010028895;16610.418635347705;16813.327466901308;16940.491785246464;17041.4615250043;17279.568010799703;1882.1624377152173;1908.8759230650103;1947.678633025549;1950.5903760210372;1956.168628332967;55189;129739;129804;132070.3396483021;133265;21746.673799893015;22288.4826690639;22592.548149036927;22949.541009179724;23195.88402057979;11707.297562146128;12405.565805196775;12443.502259909503;36907.815460922524;36913.815430922674;7966.362690984707;8134.83730325402;8227.629756660845;8349;8359.247667709935;8588.570571471402;8684;8727.04002559718;8734.650613975497;8743.912560874436;3916.8433262669173;3919.490466239428;3995.860144894915;4023.7183397162503;4056.0873803394;1994.1724184463285;2019.7477563910177;2022.3629556689596;2024.3623258673472;2055.3320170944503;800.9867517590253;967.144077491411;973.8831340239075;981.6269817469316;1045.5295117197293;16472.341106355852;18999.765015273962;19016.904915475334;19389.418317450498;20235.392938211877;873.9119795854202;886.1050339157368;905.5472263868066;922.4218309823924;923.6628630549801;9505.382150160218;9927.453990030474;10502;10580.523876425425;10606.628767993083;562980;573964;574773;581120;587510;111826.44086779514;129007.06489402667;130503;131650.34174829064;132991.33504332416;1011.0546638892658;1044.7753732947453;1059.957601695939;1068.5725709716176;1070.3363914373138;17596.29614815393;17799.19903604367;17800.821991779918;17802.91098544499;18415.539611509284;51665;52969.470305296454;53391.932161357334;53494.46505534895;53503;74656;74871.62564187145;75598.48803024019;76431.61784191044;76989;7936.682532698627;7955.0851652060755;8018.118007019107;8122.903408039839;8273.586320683822;10414.166866650801;11426.885731142582;12300.384980750747;12360.44378002974;12737.87262127367;9257.768555786159;10292.639757608447;10849.240553161202;10962.780744385227;10965.013148816644;10649;10689.465526723478;10770.676879693621;10859;10914.563417463212;10429.895701043197;10471.528781205016;10659.307145035547;11240.988311052044;11413.258138221321;8010.879836802336;8074.313683336982;8138.552379619177;8170.305524030524;8225.218604232588;6823.317668233137;9288.071192880658;10839.458027098455;10948.178886583697;11062.612808551663 20:57:23 INFO - PROCESS | 1668 | |3;mootools.html;1463.7072585482904;1511.486094727793;1541.961450963726;1910.2359056377456;1938.8255057044862;8011.198880111986;8487.745367638965;8518;9029.593668284926;9057.230135438487;8627.698030568932;8774.912250877489;8873.334499912517;8879.067697891725;8909.643614255438;2387.1048356866177;2405.747396523366;2420.479596886669;2422.5760491913934;2430;2388.176079252655;2391.5934291170543;2423.6364545318165;2423.9515209695796;2435.5007223519224;2183.5632873425297;2336.2874323331375;2348.495073559184;2400.4958958618713;2413.891374888134;2383.642453631952;2384.96422553661;2392.617181251;2397.832151749378;2408.5544174327806;2373.0507796881384;2379.0483806477373;2397.412633904687;2405.4707964247837;2416.673749043874;8866.911330886673;8918.464892106429;8918.73243802687;8942.374033817636;8966.68616598416;5307.946920530784;5485.862853428656;5491.533219676332;5496.945030549683;5514.80698175562;3049.329147587527;3540;3602.35157671619;3611.7719975208556;3669.43123815809;1006.1749365520276;1027.8458231265295;1028.1825948370988;1035.2494441529907;1043.7860238651135;11741.589044383405;11791.17236828293;11884.227525210834;11892.524299027942;11920.10599205063;4805.663603547718;4811.32498096075;4848.660593758403;4871.196252618349;4878.780454879539;9108.954455227682;10054.044865737744;10060.798784024424;10064.748381290527;10080.395176289447;5161.458046905021;5459;5459.153831156177;5461.399246082928;5465.672059676433;4461.821527138878;4799.496052914464;4935.90128197434;4967.776450059756;4987.675801072919;3374.7300215982664;3576.2489877126095;3997.420374045805;4046.7167298288837;4186.434831297796;1115.7322242661864;1184.7678414448876;1276.5340650662442;1331.6271443995697;1334.2728213123871;866.7053201911381;892.3887137310962;893.3121496447699;916.7983043730369;917.5733284022962;5645.2096706461125;5727.885442291131;5788;5814.273215848019;5905.848359569843;425.2494347476706;432.86364795089446;441.6488891331399;448.0881406338086;450.7836238605488;3517.806520641338;3886.553046399644;4037.313656678372;4071.97964010184;4106.3429851224255;10733.570657173626;10771.56913723458;10801.567937282578;10900.291481053706;10992.615258465916;10126.797464050678;10695.625653102104;10698.03717665414;10728.356298622108;10890.673279801618;8011;8226.629801659059;8364.205400486944;8373.120822313691;8386.79033024167;5788.9131663024245;5918.704064796829;5946.316173639913;5998.190244316961;6029.879402412015;9719.85420218683;9974.251931105051;10134.986501349806;10140.188784897338;10227.590896364061;9958.302918795614;10272;10306.278560500694;10315.638952636622;10368;6938;7564.8487030260185;7707.190744971922;7889.960550197212;8245.79385515367;8254.174582541698;8385.95807020961;8390.580470976305;8449;8463.365247606578;7363.079615048119;7538.283863033003;7588.734394296173;7612.467127301035;7709.9614501927135;5978.730957107027;7393.482456228227;7459.850802983801;7506.812329691583;7521.887171692539;6929.3070692930305;7025.086738723933;7068;7084.397826184832;7086.822829429306;4645.74448405341;4753.429588449409;4806.327114204084;4836.46798852119;5015.924761128513;4344.826206951813;4922.114019476386;4977.701337919736;5011.5489605935645;5169.844904652867 20:57:23 INFO - PROCESS | 1668 | |4;prototype.html;312.8107494965546;317.0283082352589;319.4904127915974;320.17554796399276;324.87005197920814;4669.7198168109935;4677.649176311782;5222.503862133096;5468.945310546894;5545.889082218353;4238.89402764931;5364.5708343332535;5409.404965453797;5452.59105567082;5452.83641490755;3582.9219052949356;3673.9081522961874;3677.5841301099003;3829.215010922754;4045.4943132108488;3736.6823819975334;3755.5493340799144;3924.3328634132267;4114.423980642698;4144.23331683638;3282.9986854009517;4037.4347591337237;4129.719786866081;4136.937945930814;4140.751554906716;3442.431998720208;3983.721139520235;4098.4876890388705;4140.840564641905;4184.309588917825;3162.4858237701083;3402.863885444604;3541.752077354586;3544.9113772155642;3556.0754203906913;4121;5125.743712814345;5221.216817477371;5245.423003469616;5260.605454590921;4300.6344460720875;4458.554144585548;4727.267273572602;4738.223166312633;4746.335513028179;4656.930146047812;5724.427557244284;5730.856728581777;5732.541396688255;5733.971330143323;3514.332276867387;3795.203007368428;3960.980195099035;3963.663088637469;3999.8600048998437;5420.6747595144025;5427.511523962902;5759.1937128802;6091.02543593023;6194;3074.031680020786;3288.5067239913724;3903.3559462688904;3916.549596796348;3985.9835741885636;3154.3848949454637;3518.7712798668003;3948.6841052715713;3978.980105099514;4005.7982605218317;3946;4635.7450340230935;4640.721556706609;4690.882727931829;4721.716696998191;5117.181250999822;5189.662671926389;5191.402988656278;5356.946430535645;5794.739236734357;1082.821334479802;1238.4798384678456;1338.765715999696;1364.6762640238953;1367.3641756583236;795.5306369242174;818.8362327534517;834.5687146543586;836.1721895323586;841.1924552429736;4949.529794669501;5213.400458947193;5378.283966596843;5395.244665746799;5399.056339717698;4818.759062046954;5505.366882808528;5633.8309850704545;5743.592819759186;5802.013657678205;5305.519217902739;5316.548093412103;5434.619576629598;5452.5365343946205;5465.344158700981;2521.3066406738294;2818.4081342917807;3017.8038427502142;3111.0977816432983;3118.3607360491046;5409.918851217235;5984.653452973133;6158.507319414526;6213.565050446516;6245.937540624626;4980.477049909779;5682.602217844711;6130.816075517652;6166;6176.8381066626325;5467.781288748485;5809.186713860147;5962.195103661037;6230.813075607739;6270.6237625743515;5466.233124054161;5661.009323368312;5680.676804069665;5828.750748640026;5953.945888668402;4532.614727748047;5663.546916246608;5802.4197580241635;5856.326522449973;5875.030619947661;5731.828045158652;6141.293751218667;6228.626282423069;6240.500759939103;6246.812595622138;3348.8827891023698;3787.16682329898;3871.2838124946975;3887.542171685618;3933.586973367755;5405.9459405407015;5791.768329266951;5934.525237980864;5972.014617588049;5981.252343457068;4604.493505714436;5052.444231134498;5069.757909312242;5446.945530544644;5731.942680573141;5368.597355198298;5820.592558520862;5822.417758224144;5824.767009319749;5839.773647533895;4861.468637379215;4898.766813902949;5675.212308122928;5734.426557344399;5765.625234359753;4882.780274887709;5082.898342033065;5153.278541004337;5209.713465759268;5557.916631250615;5278.155495120763;5518;5649.350324712711;5728.963649265896;5820.476157145878 20:57:23 INFO - PROCESS | 1668 | |5;yui.html;589.254592939931;624.9687515624221;626.627156841679;718.192033961793;741.5106030020188;14726.631834204138;15150.318235679393;15204;15331.463398781045;15429.382824687027;14251.216183109926;14276.500322488715;14296.857031429683;14307.141571505717;14318.928405357985;685.7874059041714;864.1962974433774;882.0341725810227;897.2732087009543;904.8326059678948;891.6210610490548;899.0874262623443;900.7162743735735;902.2195800632471;902.4495058014605;871.5511511571514;945.4799860076964;953.5375342958694;957.664817313938;959.8080383923243;897.8877640294963;932.5570354081825;942;945.6926498887889;947.1522986926731;702.5257950883133;704.4294121761338;705.8694141583824;707.0737334092355;707.2891743797502;12824.743505129938;14269.286535673175;14627.268636568235;14668.633284167981;14716.337764800503;12537.686557836036;12632.621021369374;12695.809562856564;12727.363631818465;12823.171643651172;9865.210783137332;10056.748581285454;10093.747656308651;10344.896551034544;10484.213683973656;3002.9699703002907;3381.661833816623;3410.8124053177066;3430.6397828227928;3479.425894727367;64292;76740.61629691928;78958.21041789567;79312.60343698302;79361.20638793596;7890.329322007694;9518.428894266366;9565.713028609152;9675.516224188763;9776.560054797408;19714.40856774299;22234.55530889373;22258.109675612795;22260;22299.55400891973;7181;7426.368758655467;7521.7743467696055;7696.230376962259;7725.111612164561;3947.703922205789;4002.479677641888;4023.3361495352938;4031.5565287818317;4074.368472886648;3512.0693016350688;3540.5397298351563;3577.6780089791523;3578.3916734155255;3603.00917247759;629.4806784402795;636.3922454056365;637.4263163153199;642.4282388674084;652.0414989964744;469.0291097428359;477.6226780843095;509.38873351977037;526.8050821196182;544.1755740053821;7632.274933881273;7748.4188685848785;7817.960910195413;7833.7258195964005;7947.0657864109;502.5728131088546;525.6057956532601;536.44745911711;552.3675391676508;562.9268195134606;3655.798931058764;3671.1556342040944;3693.519842420468;3708.3325001499447;3759.154190307159;88364;89940.5502972494;91284;91360;92407;78150;78614.606926965;79789;79839;81362;71169.57660846754;71744.92382614265;72071.63964180145;72495.27504724886;72834.27165728275;6924.757633482804;7296.525725827804;7307.963460182665;7335.8532829344185;7442.367398771165;42024.789876050425;42111;43998;44314.3352849714;45416.31875521804;58602.70698646479;60764.6961765206;60900.086498703444;61013.08480372887;61132.16603501902;8207.302379297827;9744.135932429977;9778.071083247365;9931.801363972536;10055.944125866972;10313.27807053499;10316.123129533773;10322.690319290434;10360.119389851645;10607.94696026515;8542.419652364333;9652.613895444103;9761;9857.802843942938;9953.203743700631;9525.333226674065;9698.6120555177;9796.804063918824;10029.247806414694;10088.546015429176;9652.90347096548;9737.9026209737;9823;9842.065003824626;10037.74905627336;8374.790630234293;8440;8449.95775021121;8802;8850;8339.967360585812;8502.532360720219;8526.573671316533;8529.95735021321;8685.956570217108 20:57:23 INFO - PROCESS | 1668 | __end_tp_report 20:57:23 INFO - PROCESS | 1668 | __start_cc_report 20:57:23 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,426 20:57:23 INFO - PROCESS | 1668 | __end_cc_report 20:57:23 INFO - PROCESS | 1668 | __startTimestamp1464321443678__endTimestamp 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | ------- Summary: start ------- 20:57:23 INFO - PROCESS | 1668 | Number of tests: 6 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5799.89 Median:6125.60 stddev:777.62 (12.7%) stddev-sans-first:748.00 20:57:23 INFO - PROCESS | 1668 | Values: 2985.3 3497.1 3527.6 3542.3 3556.3 5794.1 5893.2 5917.3 5919.6 5935.3 4824.6 5694.6 5853.6 5928.5 5968.8 4628.2 5152.7 5212.8 5322.8 5352.9 722.2 5226.7 5234.0 5315.1 5335.0 5257.5 5259.0 5260.3 5306.8 5320.3 5309.8 5313.3 5328.1 5341.0 5362.5 5131.5 5206.3 5235.9 5292.3 5313.3 4752.7 5614.9 5821.7 5824.7 5829.9 6250.7 6268.6 6291.9 6297.6 6305.0 6217.8 6239.5 6274.3 6276.8 6379.5 6038.1 6050.0 6053.5 6077.6 6125.6 5488.6 5848.3 6242.3 6376.3 6436.2 6168.0 6194.2 6243.3 6296.7 6307.2 6266.7 6320.9 6350.6 6355.6 6364.9 6167.5 6181.1 6249.4 6252.7 6267.4 5349.7 6127.1 6283.4 6291.2 6298.1 4923.5 5013.4 5022.1 5029.1 5033.8 4442.3 4449.8 4455.9 4550.8 4552.2 5929.5 5971.8 6037.2 6106.4 6107.8 6266.2 6295.7 6349.0 6366.0 6373.8 5955.8 5976.8 6090.9 6112.0 6113.3 5476.5 5521.6 5524.0 5533.1 5584.4 6557.2 6558.2 6562.2 6566.1 6575.9 6131.0 6222.7 6256.6 6277.2 6289.5 5790.2 6534.5 6584.1 6587.3 6589.0 6260.2 6267.4 6277.5 6298.4 6299.0 6215.3 6219.3 6233.2 6251.1 6344.9 6106.8 6207.0 6235.2 6274.0 6282.2 6215.5 6265.7 6267.7 6268.7 6290.0 5214.4 5921.5 5966.2 6132.1 6133.6 6191.9 6226.7 6231.8 6242.3 6254.4 6028.9 6189.2 6198.8 6212.0 6216.8 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:60048.98 Median:36335.00 stddev:137557.18 (378.6%) stddev-sans-first:137870.33 20:57:23 INFO - PROCESS | 1668 | Values: 471.7 477.9 497.8 531.3 553.0 27753.2 41363.6 41484.8 41566.4 41597.4 39150.8 43957.6 43963.3 43981.3 44081.0 9496.3 9740.9 9742.6 9746.5 9767.0 9314.9 9791.9 9810.9 9815.7 9834.4 9790.5 9844.2 9845.4 9885.9 9890.2 9762.7 9795.3 9802.4 9857.9 9872.8 9558.9 9665.6 9684.3 9685.3 9692.0 40605.8 40966.0 40995.2 41034.2 41213.8 2759.9 2798.3 2902.7 3078.8 3413.9 28048.7 28326.4 29734.0 29833.3 29848.7 2652.9 2677.3 2726.7 2751.0 2763.9 412197.0 476222.0 483388.0 483820.0 485407.0 26650.7 31457.5 33683.0 34273.8 34555.8 35411.8 35818.3 36312.9 36325.0 36345.0 14690.3 14899.9 14951.9 14955.8 14984.6 12637.6 12656.6 12727.8 12733.9 12752.9 7889.3 7898.2 7922.9 7936.3 7973.2 3255.9 3273.5 3286.3 3294.7 3326.5 755.0 890.8 1028.9 1032.0 1056.7 28200.0 29295.9 30261.1 30273.2 30347.1 1027.5 1043.6 1097.8 1099.0 1128.6 15281.9 15388.9 15634.3 15699.9 15730.8 703240.0 707683.0 715116.2 716437.0 717246.0 59736.1 60389.7 61611.4 61896.7 62182.4 1374.2 1375.8 1384.2 1391.1 1394.8 29407.0 29428.7 29781.4 30069.0 30164.5 51848.7 52059.5 52268.0 52382.0 52444.5 229769.0 231990.0 232115.0 232571.8 232765.0 20998.6 24830.4 26387.5 27496.0 28220.3 45922.5 46891.0 47097.3 47314.8 47429.3 34074.7 38006.6 39094.4 39477.4 39675.4 34175.7 36898.6 38099.0 38243.7 38583.8 32512.8 36952.3 37524.4 37811.2 38476.0 34172.7 34188.0 34207.8 34316.8 34434.0 25181.4 25186.9 25346.4 25796.2 25823.6 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:35076.47 Median:29555.71 stddev:96280.00 (325.8%) stddev-sans-first:96514.82 20:57:23 INFO - PROCESS | 1668 | Values: 367.0 381.9 382.7 385.6 399.8 15654.6 18630.0 21240.0 21272.0 21573.0 20841.0 21016.4 21128.5 21696.6 21897.7 5237.8 5957.3 6127.9 6189.5 6213.4 6140.9 7209.6 7646.0 7658.8 7678.7 7164.3 7484.9 7500.7 7506.0 7655.6 7322.9 7489.2 7718.0 7815.2 7825.6 6829.7 6979.7 7573.9 7581.5 7645.8 28573.9 28626.0 29060.6 30050.8 30218.8 2212.6 2234.6 2246.9 2312.8 2481.7 16610.4 16813.3 16940.5 17041.5 17279.6 1882.2 1908.9 1947.7 1950.6 1956.2 55189.0 129739.0 129804.0 132070.3 133265.0 21746.7 22288.5 22592.5 22949.5 23195.9 11707.3 12405.6 12443.5 36907.8 36913.8 7966.4 8134.8 8227.6 8349.0 8359.2 8588.6 8684.0 8727.0 8734.7 8743.9 3916.8 3919.5 3995.9 4023.7 4056.1 1994.2 2019.7 2022.4 2024.4 2055.3 801.0 967.1 973.9 981.6 1045.5 16472.3 18999.8 19016.9 19389.4 20235.4 873.9 886.1 905.5 922.4 923.7 9505.4 9927.5 10502.0 10580.5 10606.6 562980.0 573964.0 574773.0 581120.0 587510.0 111826.4 129007.1 130503.0 131650.3 132991.3 1011.1 1044.8 1060.0 1068.6 1070.3 17596.3 17799.2 17800.8 17802.9 18415.5 51665.0 52969.5 53391.9 53494.5 53503.0 74656.0 74871.6 75598.5 76431.6 76989.0 7936.7 7955.1 8018.1 8122.9 8273.6 10414.2 11426.9 12300.4 12360.4 12737.9 9257.8 10292.6 10849.2 10962.8 10965.0 10649.0 10689.5 10770.7 10859.0 10914.6 10429.9 10471.5 10659.3 11241.0 11413.3 8010.9 8074.3 8138.6 8170.3 8225.2 6823.3 9288.1 10839.5 10948.2 11062.6 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5732.41 Median:4802.58 stddev:3251.83 (67.7%) stddev-sans-first:3245.13 20:57:23 INFO - PROCESS | 1668 | Values: 1463.7 1511.5 1542.0 1910.2 1938.8 8011.2 8487.7 8518.0 9029.6 9057.2 8627.7 8774.9 8873.3 8879.1 8909.6 2387.1 2405.7 2420.5 2422.6 2430.0 2388.2 2391.6 2423.6 2424.0 2435.5 2183.6 2336.3 2348.5 2400.5 2413.9 2383.6 2385.0 2392.6 2397.8 2408.6 2373.1 2379.0 2397.4 2405.5 2416.7 8866.9 8918.5 8918.7 8942.4 8966.7 5307.9 5485.9 5491.5 5496.9 5514.8 3049.3 3540.0 3602.4 3611.8 3669.4 1006.2 1027.8 1028.2 1035.2 1043.8 11741.6 11791.2 11884.2 11892.5 11920.1 4805.7 4811.3 4848.7 4871.2 4878.8 9109.0 10054.0 10060.8 10064.7 10080.4 5161.5 5459.0 5459.2 5461.4 5465.7 4461.8 4799.5 4935.9 4967.8 4987.7 3374.7 3576.2 3997.4 4046.7 4186.4 1115.7 1184.8 1276.5 1331.6 1334.3 866.7 892.4 893.3 916.8 917.6 5645.2 5727.9 5788.0 5814.3 5905.8 425.2 432.9 441.6 448.1 450.8 3517.8 3886.6 4037.3 4072.0 4106.3 10733.6 10771.6 10801.6 10900.3 10992.6 10126.8 10695.6 10698.0 10728.4 10890.7 8011.0 8226.6 8364.2 8373.1 8386.8 5788.9 5918.7 5946.3 5998.2 6029.9 9719.9 9974.3 10135.0 10140.2 10227.6 9958.3 10272.0 10306.3 10315.6 10368.0 6938.0 7564.8 7707.2 7890.0 8245.8 8254.2 8386.0 8390.6 8449.0 8463.4 7363.1 7538.3 7588.7 7612.5 7710.0 5978.7 7393.5 7459.9 7506.8 7521.9 6929.3 7025.1 7068.0 7084.4 7086.8 4645.7 4753.4 4806.3 4836.5 5015.9 4344.8 4922.1 4977.7 5011.5 5169.8 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:4572.83 Median:5200.56 stddev:1456.70 (28.0%) stddev-sans-first:1425.27 20:57:23 INFO - PROCESS | 1668 | Values: 312.8 317.0 319.5 320.2 324.9 4669.7 4677.6 5222.5 5468.9 5545.9 4238.9 5364.6 5409.4 5452.6 5452.8 3582.9 3673.9 3677.6 3829.2 4045.5 3736.7 3755.5 3924.3 4114.4 4144.2 3283.0 4037.4 4129.7 4136.9 4140.8 3442.4 3983.7 4098.5 4140.8 4184.3 3162.5 3402.9 3541.8 3544.9 3556.1 4121.0 5125.7 5221.2 5245.4 5260.6 4300.6 4458.6 4727.3 4738.2 4746.3 4656.9 5724.4 5730.9 5732.5 5734.0 3514.3 3795.2 3961.0 3963.7 3999.9 5420.7 5427.5 5759.2 6091.0 6194.0 3074.0 3288.5 3903.4 3916.5 3986.0 3154.4 3518.8 3948.7 3979.0 4005.8 3946.0 4635.7 4640.7 4690.9 4721.7 5117.2 5189.7 5191.4 5356.9 5794.7 1082.8 1238.5 1338.8 1364.7 1367.4 795.5 818.8 834.6 836.2 841.2 4949.5 5213.4 5378.3 5395.2 5399.1 4818.8 5505.4 5633.8 5743.6 5802.0 5305.5 5316.5 5434.6 5452.5 5465.3 2521.3 2818.4 3017.8 3111.1 3118.4 5409.9 5984.7 6158.5 6213.6 6245.9 4980.5 5682.6 6130.8 6166.0 6176.8 5467.8 5809.2 5962.2 6230.8 6270.6 5466.2 5661.0 5680.7 5828.8 5953.9 4532.6 5663.5 5802.4 5856.3 5875.0 5731.8 6141.3 6228.6 6240.5 6246.8 3348.9 3787.2 3871.3 3887.5 3933.6 5405.9 5791.8 5934.5 5972.0 5981.3 4604.5 5052.4 5069.8 5446.9 5731.9 5368.6 5820.6 5822.4 5824.8 5839.8 4861.5 4898.8 5675.2 5734.4 5765.6 4882.8 5082.9 5153.3 5209.7 5557.9 5278.2 5518.0 5649.4 5729.0 5820.5 20:57:23 INFO - PROCESS | 1668 | 20:57:23 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17492.21 Median:705.15 stddev:25003.36 (3545.8%) stddev-sans-first:25041.29 20:57:23 INFO - PROCESS | 1668 | Values: 589.3 625.0 626.6 718.2 741.5 14726.6 15150.3 15204.0 15331.5 15429.4 14251.2 14276.5 14296.9 14307.1 14318.9 685.8 864.2 882.0 897.3 904.8 891.6 899.1 900.7 902.2 902.4 871.6 945.5 953.5 957.7 959.8 897.9 932.6 942.0 945.7 947.2 702.5 704.4 705.9 707.1 707.3 12824.7 14269.3 14627.3 14668.6 14716.3 12537.7 12632.6 12695.8 12727.4 12823.2 9865.2 10056.7 10093.7 10344.9 10484.2 3003.0 3381.7 3410.8 3430.6 3479.4 64292.0 76740.6 78958.2 79312.6 79361.2 7890.3 9518.4 9565.7 9675.5 9776.6 19714.4 22234.6 22258.1 22260.0 22299.6 7181.0 7426.4 7521.8 7696.2 7725.1 3947.7 4002.5 4023.3 4031.6 4074.4 3512.1 3540.5 3577.7 3578.4 3603.0 629.5 636.4 637.4 642.4 652.0 469.0 477.6 509.4 526.8 544.2 7632.3 7748.4 7818.0 7833.7 7947.1 502.6 525.6 536.4 552.4 562.9 3655.8 3671.2 3693.5 3708.3 3759.2 88364.0 89940.6 91284.0 91360.0 92407.0 78150.0 78614.6 79789.0 79839.0 81362.0 71169.6 71744.9 72071.6 72495.3 72834.3 6924.8 7296.5 7308.0 7335.9 7442.4 42024.8 42111.0 43998.0 44314.3 45416.3 58602.7 60764.7 60900.1 61013.1 61132.2 8207.3 9744.1 9778.1 9931.8 10055.9 10313.3 10316.1 10322.7 10360.1 10607.9 8542.4 9652.6 9761.0 9857.8 9953.2 9525.3 9698.6 9796.8 10029.2 10088.5 9652.9 9737.9 9823.0 9842.1 10037.7 8374.8 8440.0 8450.0 8802.0 8850.0 8340.0 8502.5 8526.6 8530.0 8686.0 20:57:23 INFO - PROCESS | 1668 | -------- Summary: end -------- 20:57:23 INFO - PROCESS | 1668 | 20:57:24 INFO - TEST-INFO | 1668: exit 0 20:57:24 INFO - TEST-OK | dromaeo_css | took 1112558ms 20:57:24 INFO - TEST-START | kraken 20:57:24 INFO - operating with platform_type : mac_ 20:57:24 INFO - Initialising browser for kraken test... 20:57:24 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpoFE7cs/profile http://localhost:49276/getInfo.html) 20:57:27 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 20:57:27 INFO - PROCESS | 1676 | colorDepth:24 20:57:27 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 20:57:27 INFO - PROCESS | 1676 | __metrics 20:57:27 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:57:28 INFO - TEST-INFO | 1676: exit 0 20:57:28 INFO - Browser initialized. 20:57:28 INFO - Running cycle 1/1 for kraken test... 20:57:28 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpoFE7cs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:40 INFO - PROCESS | 1678 | RSS: Main: 252055552 20:57:40 INFO - PROCESS | 1678 | 20:57:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 20:57:43 INFO - PROCESS | 1678 | RSS: Main: 264044544 20:57:43 INFO - PROCESS | 1678 | 20:57:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 20:57:47 INFO - PROCESS | 1678 | RSS: Main: 268787712 20:57:47 INFO - PROCESS | 1678 | 20:57:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 20:57:51 INFO - PROCESS | 1678 | RSS: Main: 269205504 20:57:51 INFO - PROCESS | 1678 | 20:57:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 20:57:53 INFO - PROCESS | 1678 | RSS: Main: 269852672 20:57:53 INFO - PROCESS | 1678 | 20:57:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:57:56 INFO - PROCESS | 1678 | RSS: Main: 270512128 20:57:56 INFO - PROCESS | 1678 | 20:57:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 20:57:59 INFO - PROCESS | 1678 | RSS: Main: 271003648 20:57:59 INFO - PROCESS | 1678 | 20:58:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 20:58:03 INFO - PROCESS | 1678 | RSS: Main: 271159296 20:58:03 INFO - PROCESS | 1678 | 20:58:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 20:58:07 INFO - PROCESS | 1678 | RSS: Main: 271323136 20:58:07 INFO - PROCESS | 1678 | 20:58:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:58:09 INFO - PROCESS | 1678 | RSS: Main: 270966784 20:58:09 INFO - PROCESS | 1678 | 20:58:11 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:58:12 INFO - PROCESS | 1678 | RSS: Main: 270811136 20:58:12 INFO - PROCESS | 1678 | 20:58:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:58:15 INFO - PROCESS | 1678 | RSS: Main: 270856192 20:58:15 INFO - PROCESS | 1678 | 20:58:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:58:18 INFO - PROCESS | 1678 | RSS: Main: 270852096 20:58:18 INFO - PROCESS | 1678 | 20:58:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:58:22 INFO - PROCESS | 1678 | RSS: Main: 270794752 20:58:22 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 20:58:24 INFO - PROCESS | 1678 | RSS: Main: 272326656 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | __start_tp_report 20:58:24 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 20:58:24 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 20:58:24 INFO - PROCESS | 1678 | |i|pagename|runs| 20:58:24 INFO - PROCESS | 1678 | |0;ai-astar;115;110;116;151;126;117;116;117;94;174 20:58:24 INFO - PROCESS | 1678 | |1;audio-beat-detection;158;119;168;189;122;130;173;146;202;117 20:58:24 INFO - PROCESS | 1678 | |2;audio-dft;197;200;204;236;211;203;200;194;197;198 20:58:24 INFO - PROCESS | 1678 | |3;audio-fft;68;82;77;163;56;58;57;60;131;60 20:58:24 INFO - PROCESS | 1678 | |4;audio-oscillator;73;88;120;73;97;119;144;79;76;115 20:58:24 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;125;85;88;85;95;119;89;92;134;129 20:58:24 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;104;136;95;94;95;96;94;98;95 20:58:24 INFO - PROCESS | 1678 | |7;imaging-desaturate;90;94;114;144;143;89;91;105;105;103 20:58:24 INFO - PROCESS | 1678 | |8;json-parse-financial;49;50;49;49;66;89;86;101;87;58 20:58:24 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;76;103;100;82;78;76;72;69;70;101 20:58:24 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;91;112;112;109;84;107;76;101;82;96 20:58:24 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;144;162;138;148;128;151;147;164;185;164 20:58:24 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;168;170;164;230;184;218;226;169;169;165 20:58:24 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;68;66;65;67;65;65;67;68;70 20:58:24 INFO - PROCESS | 1678 | __end_tp_report 20:58:24 INFO - PROCESS | 1678 | __start_cc_report 20:58:24 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1097 20:58:24 INFO - PROCESS | 1678 | __end_cc_report 20:58:24 INFO - PROCESS | 1678 | __startTimestamp1464321504429__endTimestamp 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | ------- Summary: start ------- 20:58:24 INFO - PROCESS | 1678 | Number of tests: 14 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:123.60 Median:121.50 stddev:22.69 (18.7%) stddev-sans-first:23.85 20:58:24 INFO - PROCESS | 1678 | Values: 115.0 110.0 116.0 151.0 126.0 117.0 116.0 117.0 94.0 174.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:163.00 stddev:30.43 (18.7%) stddev-sans-first:32.21 20:58:24 INFO - PROCESS | 1678 | Values: 158.0 119.0 168.0 189.0 122.0 130.0 173.0 146.0 202.0 117.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:204.00 Median:201.50 stddev:12.20 (6.1%) stddev-sans-first:12.68 20:58:24 INFO - PROCESS | 1678 | Values: 197.0 200.0 204.0 236.0 211.0 203.0 200.0 194.0 197.0 198.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:81.20 Median:60.00 stddev:36.55 (60.9%) stddev-sans-first:38.45 20:58:24 INFO - PROCESS | 1678 | Values: 68.0 82.0 77.0 163.0 56.0 58.0 57.0 60.0 131.0 60.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:74.50 stddev:24.78 (33.3%) stddev-sans-first:24.51 20:58:24 INFO - PROCESS | 1678 | Values: 73.0 88.0 120.0 73.0 97.0 119.0 144.0 79.0 76.0 115.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:104.10 Median:86.50 stddev:20.05 (23.2%) stddev-sans-first:19.79 20:58:24 INFO - PROCESS | 1678 | Values: 125.0 85.0 88.0 85.0 95.0 119.0 89.0 92.0 134.0 129.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:95.00 stddev:12.93 (13.6%) stddev-sans-first:13.57 20:58:24 INFO - PROCESS | 1678 | Values: 95.0 104.0 136.0 95.0 94.0 95.0 96.0 94.0 98.0 95.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:116.50 stddev:20.47 (17.6%) stddev-sans-first:20.67 20:58:24 INFO - PROCESS | 1678 | Values: 90.0 94.0 114.0 144.0 143.0 89.0 91.0 105.0 105.0 103.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:62.00 stddev:20.34 (32.8%) stddev-sans-first:20.33 20:58:24 INFO - PROCESS | 1678 | Values: 49.0 50.0 49.0 49.0 66.0 89.0 86.0 101.0 87.0 58.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:82.70 Median:74.00 stddev:13.43 (18.1%) stddev-sans-first:14.02 20:58:24 INFO - PROCESS | 1678 | Values: 76.0 103.0 100.0 82.0 78.0 76.0 72.0 69.0 70.0 101.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:97.00 Median:79.00 stddev:13.26 (16.8%) stddev-sans-first:13.88 20:58:24 INFO - PROCESS | 1678 | Values: 91.0 112.0 112.0 109.0 84.0 107.0 76.0 101.0 82.0 96.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:156.50 stddev:16.13 (10.3%) stddev-sans-first:16.77 20:58:24 INFO - PROCESS | 1678 | Values: 144.0 162.0 138.0 148.0 128.0 151.0 147.0 164.0 185.0 164.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:177.00 stddev:27.17 (15.4%) stddev-sans-first:28.00 20:58:24 INFO - PROCESS | 1678 | Values: 168.0 170.0 164.0 230.0 184.0 218.0 226.0 169.0 169.0 165.0 20:58:24 INFO - PROCESS | 1678 | 20:58:24 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.72 20:58:24 INFO - PROCESS | 1678 | Values: 67.0 68.0 66.0 65.0 67.0 65.0 65.0 67.0 68.0 70.0 20:58:24 INFO - PROCESS | 1678 | -------- Summary: end -------- 20:58:24 INFO - PROCESS | 1678 | 20:58:25 INFO - TEST-INFO | 1678: exit 0 20:58:25 INFO - TEST-OK | kraken | took 60970ms 20:58:25 INFO - SUITE-END | took 1173s 20:58:25 INFO - Completed test suite (00:19:33) 20:58:25 INFO - javascript benchmark 20:58:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7084.093921816444, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2985.2536865783554, 3497.0732755819704, 3527.6472352764713, 3542.3269578780046, 3556.2531868307656, 5794.0729483282685, 5893.2338795956575, 5917.319508256541, 5919.5856290059655, 5935.347111817697, 4824.589909857657, 5694.629849059808, 5853.560982926287, 5928.49607783339, 5968.7612495500125, 4628.190066738324, 5152.6650767700075, 5212.8436146915465, 5322.840314790543, 5352.91970620441, 722.225404766603, 5226.712530810804, 5234.005538947587, 5315.123004704219, 5335.0, 5257.526822585947, 5259.0, 5260.289860868791, 5306.7611957462, 5320.255164277004, 5309.761060752276, 5313.335833020872, 5328.094223981932, 5341.03861304965, 5362.490563396471, 5131.512506311894, 5206.271122042917, 5235.869103272411, 5292.285541451894, 5313.3092697949405, 4752.667313288071, 5614.859628509279, 5821.650700957956, 5824.650520968756, 5829.854253643693, 6250.749970001195, 6268.623882567015, 6291.905621415683, 6297.559170858041, 6305.022721478178, 6217.813465596039, 6239.500839932794, 6274.278457977345, 6276.843078923018, 6379.521535884781, 6038.124471951586, 6050.0, 6053.51571874249, 6077.574569780118, 6125.601835880742, 5488.643238189505, 5848.2689663792025, 6242.313345531988, 6376.330485298977, 6436.16329877113, 6168.0, 6194.163787888668, 6243.313235544087, 6296.716647750863, 6307.211598550181, 6266.686665666698, 6320.905186422207, 6350.618962862243, 6355.5551111421755, 6364.904526432108, 6167.537434692416, 6181.072839074085, 6249.437550620466, 6252.656103914237, 6267.4045965633195, 5349.679019258857, 6127.050307202391, 6283.43449089575, 6291.213598300213, 6298.118263443122, 4923.507649235048, 5013.423456302499, 5022.070916880389, 5029.145045342228, 5033.79864805411, 4442.311441726538, 4449.755263460541, 4455.910881782346, 4550.840720574764, 4552.157850797546, 5929.466348028698, 5971.7611295547695, 6037.184980027728, 6106.430331452127, 6107.816765497042, 6266.235223142351, 6295.716692748837, 6349.015902535114, 6366.045093236052, 6373.776917807854, 5955.821325360246, 5976.820695379146, 6090.908636370458, 6111.9694401528595, 6113.32753397126, 5476.534494567926, 5521.558275337963, 5524.033294173584, 5533.059379905345, 5584.357798853102, 6557.245916719543, 6558.245801732862, 6562.179727534059, 6566.080748695282, 6575.934240657532, 6131.040261761288, 6222.657753823583, 6256.593321434092, 6277.2153480814895, 6289.452085457647, 5790.160426738184, 6534.477241820738, 6584.078229048033, 6587.341265873374, 6589.0116482528, 6260.248770147611, 6267.4045965633195, 6277.529185311211, 6298.433141017331, 6298.968505157445, 6215.34738852414, 6219.253689557282, 6233.158523599437, 6251.093591429309, 6344.904826427515, 6106.816795496142, 6207.0, 6235.189425374672, 6273.96863015682, 6282.2147231596055, 6215.502759779117, 6265.686715664289, 6267.749290028348, 6268.717907694074, 6289.96855015722, 5214.426413094632, 5921.496672782861, 5966.19456373384, 6132.08018797184, 6133.601315914451, 6191.938080619136, 6226.688665566613, 6231.813045608639, 6242.3133455320785, 6254.437100660963, 6028.90956635642, 6189.195404597373, 6198.783042593487, 6212.0, 6216.844578885564], "value": 5751.933212831973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.70282721885206, 477.87575230440075, 497.8406909788869, 531.3437904188328, 552.9585281103919, 27753.16740497786, 41363.58636413635, 41484.792576037114, 41566.37650435238, 41597.3760393594, 39150.804245978805, 43957.56042439575, 43963.34054989178, 43981.34027989583, 44081.0, 9496.287778416628, 9740.928497865229, 9742.561584728668, 9746.51267436629, 9766.951165244163, 9314.86027709585, 9791.853122203172, 9810.852837207447, 9815.70552883411, 9834.409935403863, 9790.510474476248, 9844.212463002943, 9845.36005159666, 9885.901140988606, 9890.208783297356, 9762.658306959258, 9795.265355098361, 9802.411855288705, 9857.852132218022, 9872.802543949152, 9558.856617150679, 9665.613375464973, 9684.322097453181, 9685.273604479693, 9692.030796920251, 40605.796971015254, 40966.0, 40995.180096397904, 41034.1793164138, 41213.79393103045, 2759.8758055887533, 2798.328401183722, 2902.680705122435, 3078.7536997040183, 3413.9261144470356, 28048.719512804815, 28326.433471330663, 29734.0, 29833.25416864574, 29848.701512985026, 2652.8938842446278, 2677.317284092544, 2726.7273272672774, 2751.0096365308473, 2763.8618069096465, 412197.0, 476222.0, 483388.0, 483820.0, 485407.0, 26650.733492665215, 31457.528137077963, 33683.0, 34273.82863085669, 34555.827220863735, 35411.82294088513, 35818.28363432717, 36312.91061268166, 36325.0, 36345.0, 14690.338934747962, 14899.851001490064, 14951.850481495263, 14955.77566336484, 14984.625384365478, 12637.620871373874, 12656.620301390973, 12727.809082863765, 12733.872661273454, 12752.93623531895, 7889.250521200477, 7898.210178982055, 7922.920770792333, 7936.325412340016, 7973.162817904153, 3255.8697652094124, 3273.4762438009802, 3286.2605913669713, 3294.6870047345465, 3326.4511355626532, 754.9773506794805, 890.7639475538988, 1028.876534815827, 1031.9783414419671, 1056.6988408303596, 28200.0, 29295.85352073226, 30261.09216723502, 30273.24316892051, 30347.089587312417, 1027.5427434791445, 1043.6190790361463, 1097.7639807441437, 1098.9614814000852, 1128.5711429656678, 15281.9235903822, 15388.923055384876, 15634.318311010777, 15699.921500392426, 15730.842691572938, 703240.0, 707683.0, 715116.1860576764, 716437.0, 717246.0, 59736.117152384955, 60389.69805150946, 61611.38388616056, 61896.69051654713, 62182.37817621766, 1374.2304309586664, 1375.803051345316, 1384.2040826524787, 1391.0749351681422, 1394.7768357063023, 29407.0, 29428.705712943454, 29781.404371912875, 30069.0, 30164.54753178748, 51848.74075629598, 52059.479405205464, 52268.0, 52382.0, 52444.47555524549, 229769.0, 231990.0, 232115.0, 232571.8371408132, 232765.0, 20998.58002839965, 24830.37924051913, 26387.472250555264, 27496.03763868255, 28220.294492637026, 45922.54077459183, 46891.0, 47097.2935405976, 47314.76342618403, 47429.28856067231, 34074.659253407146, 38006.61993380141, 39094.413583796835, 39477.40783888187, 39675.40486892641, 34175.658243417245, 36898.631013690596, 38099.0, 38243.72884557098, 38583.80708096441, 32512.83743581267, 36952.26095478021, 37524.437133443564, 37811.243775124894, 38476.03809904775, 34172.65827341794, 34188.0, 34207.82896085503, 34316.82841585776, 34434.0, 25181.370465738502, 25186.874065629556, 25346.35248708828, 25796.226113216635, 25823.612645809953], "value": 17822.52569530019, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.97798132112075, 381.862529489384, 382.7148774163249, 385.618237944435, 399.7901101921489, 15654.608634784136, 18629.97535135567, 21240.044198011088, 21272.0, 21573.0, 20841.0, 21016.36950891472, 21128.4717882053, 21696.566068678618, 21897.671534926987, 5237.816676416326, 5957.31490878548, 6127.87744245117, 6189.535784816134, 6213.440790328869, 6140.877182456348, 7209.603471809049, 7646.006019217494, 7658.808529786744, 7678.692852285902, 7164.319389658001, 7484.850302993937, 7500.737474188404, 7506.0, 7655.617219139021, 7322.926770732304, 7489.213632568583, 7718.035245594273, 7815.179406162328, 7825.569593672346, 6829.692663830139, 6979.743646143692, 7573.924260757432, 7581.545107293525, 7645.808854778675, 28573.857130714212, 28626.0, 29060.564091538643, 30050.849745751133, 30218.84890575533, 2212.6459766437456, 2234.6201145805253, 2246.932592022242, 2312.849664771801, 2481.727010028895, 16610.418635347705, 16813.327466901308, 16940.491785246464, 17041.4615250043, 17279.568010799703, 1882.1624377152173, 1908.8759230650103, 1947.678633025549, 1950.5903760210372, 1956.168628332967, 55189.0, 129739.0, 129804.0, 132070.3396483021, 133265.0, 21746.673799893015, 22288.4826690639, 22592.548149036927, 22949.541009179724, 23195.88402057979, 11707.297562146128, 12405.565805196775, 12443.502259909503, 36907.815460922524, 36913.815430922674, 7966.362690984707, 8134.83730325402, 8227.629756660845, 8349.0, 8359.247667709935, 8588.570571471402, 8684.0, 8727.04002559718, 8734.650613975497, 8743.912560874436, 3916.8433262669173, 3919.490466239428, 3995.860144894915, 4023.7183397162503, 4056.0873803394, 1994.1724184463285, 2019.7477563910177, 2022.3629556689596, 2024.3623258673472, 2055.3320170944503, 800.9867517590253, 967.144077491411, 973.8831340239075, 981.6269817469316, 1045.5295117197293, 16472.341106355852, 18999.765015273962, 19016.904915475334, 19389.418317450498, 20235.392938211877, 873.9119795854202, 886.1050339157368, 905.5472263868066, 922.4218309823924, 923.6628630549801, 9505.382150160218, 9927.453990030474, 10502.0, 10580.523876425425, 10606.628767993083, 562980.0, 573964.0, 574773.0, 581120.0, 587510.0, 111826.44086779514, 129007.06489402667, 130503.0, 131650.34174829064, 132991.33504332416, 1011.0546638892658, 1044.7753732947453, 1059.957601695939, 1068.5725709716176, 1070.3363914373138, 17596.29614815393, 17799.19903604367, 17800.821991779918, 17802.91098544499, 18415.539611509284, 51665.0, 52969.470305296454, 53391.932161357334, 53494.46505534895, 53503.0, 74656.0, 74871.62564187145, 75598.48803024019, 76431.61784191044, 76989.0, 7936.682532698627, 7955.0851652060755, 8018.118007019107, 8122.903408039839, 8273.586320683822, 10414.166866650801, 11426.885731142582, 12300.384980750747, 12360.44378002974, 12737.87262127367, 9257.768555786159, 10292.639757608447, 10849.240553161202, 10962.780744385227, 10965.013148816644, 10649.0, 10689.465526723478, 10770.676879693621, 10859.0, 10914.563417463212, 10429.895701043197, 10471.528781205016, 10659.307145035547, 11240.988311052044, 11413.258138221321, 8010.879836802336, 8074.313683336982, 8138.552379619177, 8170.305524030524, 8225.218604232588, 6823.317668233137, 9288.071192880658, 10839.458027098455, 10948.178886583697, 11062.612808551663], "value": 10166.471052100653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.7072585482904, 1511.486094727793, 1541.961450963726, 1910.2359056377456, 1938.8255057044862, 8011.198880111986, 8487.745367638965, 8518.0, 9029.593668284926, 9057.230135438487, 8627.698030568932, 8774.912250877489, 8873.334499912517, 8879.067697891725, 8909.643614255438, 2387.1048356866177, 2405.747396523366, 2420.479596886669, 2422.5760491913934, 2430.0, 2388.176079252655, 2391.5934291170543, 2423.6364545318165, 2423.9515209695796, 2435.5007223519224, 2183.5632873425297, 2336.2874323331375, 2348.495073559184, 2400.4958958618713, 2413.891374888134, 2383.642453631952, 2384.96422553661, 2392.617181251, 2397.832151749378, 2408.5544174327806, 2373.0507796881384, 2379.0483806477373, 2397.412633904687, 2405.4707964247837, 2416.673749043874, 8866.911330886673, 8918.464892106429, 8918.73243802687, 8942.374033817636, 8966.68616598416, 5307.946920530784, 5485.862853428656, 5491.533219676332, 5496.945030549683, 5514.80698175562, 3049.329147587527, 3540.0, 3602.35157671619, 3611.7719975208556, 3669.43123815809, 1006.1749365520276, 1027.8458231265295, 1028.1825948370988, 1035.2494441529907, 1043.7860238651135, 11741.589044383405, 11791.17236828293, 11884.227525210834, 11892.524299027942, 11920.10599205063, 4805.663603547718, 4811.32498096075, 4848.660593758403, 4871.196252618349, 4878.780454879539, 9108.954455227682, 10054.044865737744, 10060.798784024424, 10064.748381290527, 10080.395176289447, 5161.458046905021, 5459.0, 5459.153831156177, 5461.399246082928, 5465.672059676433, 4461.821527138878, 4799.496052914464, 4935.90128197434, 4967.776450059756, 4987.675801072919, 3374.7300215982664, 3576.2489877126095, 3997.420374045805, 4046.7167298288837, 4186.434831297796, 1115.7322242661864, 1184.7678414448876, 1276.5340650662442, 1331.6271443995697, 1334.2728213123871, 866.7053201911381, 892.3887137310962, 893.3121496447699, 916.7983043730369, 917.5733284022962, 5645.2096706461125, 5727.885442291131, 5788.0, 5814.273215848019, 5905.848359569843, 425.2494347476706, 432.86364795089446, 441.6488891331399, 448.0881406338086, 450.7836238605488, 3517.806520641338, 3886.553046399644, 4037.313656678372, 4071.97964010184, 4106.3429851224255, 10733.570657173626, 10771.56913723458, 10801.567937282578, 10900.291481053706, 10992.615258465916, 10126.797464050678, 10695.625653102104, 10698.03717665414, 10728.356298622108, 10890.673279801618, 8011.0, 8226.629801659059, 8364.205400486944, 8373.120822313691, 8386.79033024167, 5788.9131663024245, 5918.704064796829, 5946.316173639913, 5998.190244316961, 6029.879402412015, 9719.85420218683, 9974.251931105051, 10134.986501349806, 10140.188784897338, 10227.590896364061, 9958.302918795614, 10272.0, 10306.278560500694, 10315.638952636622, 10368.0, 6938.0, 7564.8487030260185, 7707.190744971922, 7889.960550197212, 8245.79385515367, 8254.174582541698, 8385.95807020961, 8390.580470976305, 8449.0, 8463.365247606578, 7363.079615048119, 7538.283863033003, 7588.734394296173, 7612.467127301035, 7709.9614501927135, 5978.730957107027, 7393.482456228227, 7459.850802983801, 7506.812329691583, 7521.887171692539, 6929.3070692930305, 7025.086738723933, 7068.0, 7084.397826184832, 7086.822829429306, 4645.74448405341, 4753.429588449409, 4806.327114204084, 4836.46798852119, 5015.924761128513, 4344.826206951813, 4922.114019476386, 4977.701337919736, 5011.5489605935645, 5169.844904652867], "value": 4515.286281266246, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8107494965546, 317.0283082352589, 319.4904127915974, 320.17554796399276, 324.87005197920814, 4669.7198168109935, 4677.649176311782, 5222.503862133096, 5468.945310546894, 5545.889082218353, 4238.89402764931, 5364.5708343332535, 5409.404965453797, 5452.59105567082, 5452.83641490755, 3582.9219052949356, 3673.9081522961874, 3677.5841301099003, 3829.215010922754, 4045.4943132108488, 3736.6823819975334, 3755.5493340799144, 3924.3328634132267, 4114.423980642698, 4144.23331683638, 3282.9986854009517, 4037.4347591337237, 4129.719786866081, 4136.937945930814, 4140.751554906716, 3442.431998720208, 3983.721139520235, 4098.4876890388705, 4140.840564641905, 4184.309588917825, 3162.4858237701083, 3402.863885444604, 3541.752077354586, 3544.9113772155642, 3556.0754203906913, 4121.0, 5125.743712814345, 5221.216817477371, 5245.423003469616, 5260.605454590921, 4300.6344460720875, 4458.554144585548, 4727.267273572602, 4738.223166312633, 4746.335513028179, 4656.930146047812, 5724.427557244284, 5730.856728581777, 5732.541396688255, 5733.971330143323, 3514.332276867387, 3795.203007368428, 3960.980195099035, 3963.663088637469, 3999.8600048998437, 5420.6747595144025, 5427.511523962902, 5759.1937128802, 6091.02543593023, 6194.0, 3074.031680020786, 3288.5067239913724, 3903.3559462688904, 3916.549596796348, 3985.9835741885636, 3154.3848949454637, 3518.7712798668003, 3948.6841052715713, 3978.980105099514, 4005.7982605218317, 3946.0, 4635.7450340230935, 4640.721556706609, 4690.882727931829, 4721.716696998191, 5117.181250999822, 5189.662671926389, 5191.402988656278, 5356.946430535645, 5794.739236734357, 1082.821334479802, 1238.4798384678456, 1338.765715999696, 1364.6762640238953, 1367.3641756583236, 795.5306369242174, 818.8362327534517, 834.5687146543586, 836.1721895323586, 841.1924552429736, 4949.529794669501, 5213.400458947193, 5378.283966596843, 5395.244665746799, 5399.056339717698, 4818.759062046954, 5505.366882808528, 5633.8309850704545, 5743.592819759186, 5802.013657678205, 5305.519217902739, 5316.548093412103, 5434.619576629598, 5452.5365343946205, 5465.344158700981, 2521.3066406738294, 2818.4081342917807, 3017.8038427502142, 3111.0977816432983, 3118.3607360491046, 5409.918851217235, 5984.653452973133, 6158.507319414526, 6213.565050446516, 6245.937540624626, 4980.477049909779, 5682.602217844711, 6130.816075517652, 6166.0, 6176.8381066626325, 5467.781288748485, 5809.186713860147, 5962.195103661037, 6230.813075607739, 6270.6237625743515, 5466.233124054161, 5661.009323368312, 5680.676804069665, 5828.750748640026, 5953.945888668402, 4532.614727748047, 5663.546916246608, 5802.4197580241635, 5856.326522449973, 5875.030619947661, 5731.828045158652, 6141.293751218667, 6228.626282423069, 6240.500759939103, 6246.812595622138, 3348.8827891023698, 3787.16682329898, 3871.2838124946975, 3887.542171685618, 3933.586973367755, 5405.9459405407015, 5791.768329266951, 5934.525237980864, 5972.014617588049, 5981.252343457068, 4604.493505714436, 5052.444231134498, 5069.757909312242, 5446.945530544644, 5731.942680573141, 5368.597355198298, 5820.592558520862, 5822.417758224144, 5824.767009319749, 5839.773647533895, 4861.468637379215, 4898.766813902949, 5675.212308122928, 5734.426557344399, 5765.625234359753, 4882.780274887709, 5082.898342033065, 5153.278541004337, 5209.713465759268, 5557.916631250615, 5278.155495120763, 5518.0, 5649.350324712711, 5728.963649265896, 5820.476157145878], "value": 4107.526802536627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.254592939931, 624.9687515624221, 626.627156841679, 718.192033961793, 741.5106030020188, 14726.631834204138, 15150.318235679393, 15204.0, 15331.463398781045, 15429.382824687027, 14251.216183109926, 14276.500322488715, 14296.857031429683, 14307.141571505717, 14318.928405357985, 685.7874059041714, 864.1962974433774, 882.0341725810227, 897.2732087009543, 904.8326059678948, 891.6210610490548, 899.0874262623443, 900.7162743735735, 902.2195800632471, 902.4495058014605, 871.5511511571514, 945.4799860076964, 953.5375342958694, 957.664817313938, 959.8080383923243, 897.8877640294963, 932.5570354081825, 942.0, 945.6926498887889, 947.1522986926731, 702.5257950883133, 704.4294121761338, 705.8694141583824, 707.0737334092355, 707.2891743797502, 12824.743505129938, 14269.286535673175, 14627.268636568235, 14668.633284167981, 14716.337764800503, 12537.686557836036, 12632.621021369374, 12695.809562856564, 12727.363631818465, 12823.171643651172, 9865.210783137332, 10056.748581285454, 10093.747656308651, 10344.896551034544, 10484.213683973656, 3002.9699703002907, 3381.661833816623, 3410.8124053177066, 3430.6397828227928, 3479.425894727367, 64292.0, 76740.61629691928, 78958.21041789567, 79312.60343698302, 79361.20638793596, 7890.329322007694, 9518.428894266366, 9565.713028609152, 9675.516224188763, 9776.560054797408, 19714.40856774299, 22234.55530889373, 22258.109675612795, 22260.0, 22299.55400891973, 7181.0, 7426.368758655467, 7521.7743467696055, 7696.230376962259, 7725.111612164561, 3947.703922205789, 4002.479677641888, 4023.3361495352938, 4031.5565287818317, 4074.368472886648, 3512.0693016350688, 3540.5397298351563, 3577.6780089791523, 3578.3916734155255, 3603.00917247759, 629.4806784402795, 636.3922454056365, 637.4263163153199, 642.4282388674084, 652.0414989964744, 469.0291097428359, 477.6226780843095, 509.38873351977037, 526.8050821196182, 544.1755740053821, 7632.274933881273, 7748.4188685848785, 7817.960910195413, 7833.7258195964005, 7947.0657864109, 502.5728131088546, 525.6057956532601, 536.44745911711, 552.3675391676508, 562.9268195134606, 3655.798931058764, 3671.1556342040944, 3693.519842420468, 3708.3325001499447, 3759.154190307159, 88364.0, 89940.5502972494, 91284.0, 91360.0, 92407.0, 78150.0, 78614.606926965, 79789.0, 79839.0, 81362.0, 71169.57660846754, 71744.92382614265, 72071.63964180145, 72495.27504724886, 72834.27165728275, 6924.757633482804, 7296.525725827804, 7307.963460182665, 7335.8532829344185, 7442.367398771165, 42024.789876050425, 42111.0, 43998.0, 44314.3352849714, 45416.31875521804, 58602.70698646479, 60764.6961765206, 60900.086498703444, 61013.08480372887, 61132.16603501902, 8207.302379297827, 9744.135932429977, 9778.071083247365, 9931.801363972536, 10055.944125866972, 10313.27807053499, 10316.123129533773, 10322.690319290434, 10360.119389851645, 10607.94696026515, 8542.419652364333, 9652.613895444103, 9761.0, 9857.802843942938, 9953.203743700631, 9525.333226674065, 9698.6120555177, 9796.804063918824, 10029.247806414694, 10088.546015429176, 9652.90347096548, 9737.9026209737, 9823.0, 9842.065003824626, 10037.74905627336, 8374.790630234293, 8440.0, 8449.95775021121, 8802.0, 8850.0, 8339.967360585812, 8502.532360720219, 8526.573671316533, 8529.95735021321, 8685.956570217108], "value": 6537.982710943865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1626.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 116.0, 151.0, 126.0, 117.0, 116.0, 117.0, 94.0, 174.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 119.0, 168.0, 189.0, 122.0, 130.0, 173.0, 146.0, 202.0, 117.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 204.0, 236.0, 211.0, 203.0, 200.0, 194.0, 197.0, 198.0], "value": 204.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 77.0, 163.0, 56.0, 58.0, 57.0, 60.0, 131.0, 60.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 88.0, 120.0, 73.0, 97.0, 119.0, 144.0, 79.0, 76.0, 115.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 85.0, 88.0, 85.0, 95.0, 119.0, 89.0, 92.0, 134.0, 129.0], "value": 104.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 104.0, 136.0, 95.0, 94.0, 95.0, 96.0, 94.0, 98.0, 95.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 114.0, 144.0, 143.0, 89.0, 91.0, 105.0, 105.0, 103.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 49.0, 66.0, 89.0, 86.0, 101.0, 87.0, 58.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 103.0, 100.0, 82.0, 78.0, 76.0, 72.0, 69.0, 70.0, 101.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 112.0, 112.0, 109.0, 84.0, 107.0, 76.0, 101.0, 82.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 162.0, 138.0, 148.0, 128.0, 151.0, 147.0, 164.0, 185.0, 164.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 164.0, 230.0, 184.0, 218.0, 226.0, 169.0, 169.0, 165.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 65.0, 67.0, 65.0, 65.0, 67.0, 68.0, 70.0], "value": 66.8, "unit": "score"}]}]} 20:58:25 INFO - Return code: 0 20:58:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:58:25 ERROR - # TBPL SUCCESS # 20:58:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:58:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:58:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:58:25 INFO - 2016-05-26 20:58:25.758 screenresolution[1683:10924] starting screenresolution argv=screenresolution get 20:58:25 INFO - 2016-05-26 20:58:25.761 screenresolution[1683:10924] Display 0: 1600x1200x32@60 20:58:25 INFO - 2016-05-26 20:58:25.767 screenresolution[1684:10927] starting screenresolution argv=screenresolution list 20:58:25 INFO - Available Modes on Display 0 20:58:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:58:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:58:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:58:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:58:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:58:26 INFO - Intel Iris: 20:58:26 INFO - Chipset Model: Intel Iris 20:58:26 INFO - Type: GPU 20:58:26 INFO - Bus: Built-In 20:58:26 INFO - VRAM (Dynamic, Max): 1536 MB 20:58:26 INFO - Vendor: Intel (0x8086) 20:58:26 INFO - Device ID: 0x0a2e 20:58:26 INFO - Revision ID: 0x0009 20:58:26 INFO - Displays: 20:58:26 INFO - Display: 20:58:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:58:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:58:26 INFO - Display Serial Number: 1600x1200 60 20:58:26 INFO - Main Display: Yes 20:58:26 INFO - Mirror: Off 20:58:26 INFO - Online: Yes 20:58:26 INFO - Rotation: Supported 20:58:26 INFO - Return code: 0 20:58:26 INFO - Running post-action listener: _resource_record_post_action 20:58:26 INFO - ##### 20:58:26 INFO - ##### Finished run-tests step (success) 20:58:26 INFO - ##### 20:58:26 INFO - Running post-run listener: _resource_record_post_run 20:58:26 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 32677376; Write bytes: 699370496; Read time: 328; Write time: 2124 20:58:26 INFO - TinderboxPrint: CPU usage
54.4% 20:58:26 INFO - TinderboxPrint: I/O read bytes / time
32,677,376 / 328 20:58:26 INFO - TinderboxPrint: I/O write bytes / time
699,370,496 / 2,124 20:58:26 INFO - TinderboxPrint: CPU idle
2,207.8 (45.6%) 20:58:26 INFO - TinderboxPrint: CPU system
971.1 (20.1%) 20:58:26 INFO - TinderboxPrint: CPU user
1,658.8 (34.3%) 20:58:26 INFO - TinderboxPrint: Swap in / out
426,483,712 / 0 20:58:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382861824; Write bytes: 376834048; Read time: 28488; Write time: 773 20:58:26 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31751680; Write bytes: 299676672; Read time: 314; Write time: 1283 20:58:26 INFO - Running post-run listener: _upload_blobber_files 20:58:26 INFO - Blob upload gear active. 20:58:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:58:26 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 20:58:26 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'] 20:58:26 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 20:58:26 INFO - (blobuploader) - INFO - Open directory for files ... 20:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:58:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:58:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:58:27 INFO - (blobuploader) - INFO - Done attempting. 20:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:58:29 INFO - (blobuploader) - INFO - Done attempting. 20:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:58:31 INFO - (blobuploader) - INFO - Done attempting. 20:58:31 INFO - (blobuploader) - INFO - Iteration through files over. 20:58:31 INFO - Return code: 0 20:58:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:58:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:58:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1e8883c51922855e0f9d853c32331bf0dab39538baf6a205f860adce66c3c0077ce847755ed36c4ca4e33f2aba4f7f935c7c594678a3500bde700edf0ec1d8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b16a81a849041a03ebebebbfc82e5a5994f1c9510ad40d21009450f08a992913ce0e73b1368673d9a7c5b8075d9d08e76ee8278734d1502148eb7e2c6d1149", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722d6adeb49c6f850193854964d44cdf7cdcebf94245270c7a8f897c375d77b88f1dcc91db390636121ab53bb233256484450beb734bc136f678b56467d76ff1"} 20:58:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:58:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:58:31 INFO - Contents: 20:58:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1e8883c51922855e0f9d853c32331bf0dab39538baf6a205f860adce66c3c0077ce847755ed36c4ca4e33f2aba4f7f935c7c594678a3500bde700edf0ec1d8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b16a81a849041a03ebebebbfc82e5a5994f1c9510ad40d21009450f08a992913ce0e73b1368673d9a7c5b8075d9d08e76ee8278734d1502148eb7e2c6d1149", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722d6adeb49c6f850193854964d44cdf7cdcebf94245270c7a8f897c375d77b88f1dcc91db390636121ab53bb233256484450beb734bc136f678b56467d76ff1"} 20:58:31 INFO - Running post-run listener: copy_logs_to_upload_dir 20:58:31 INFO - Copying logs to upload dir... 20:58:31 INFO - mkdir: /builds/slave/test/build/upload/logs 20:58:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1338.237676 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2016-05-26 20:58:31.894743) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 20:58:31.898198) ========= 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.svH5oqClSo/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.nX9LaGhVHR/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/a1e8883c51922855e0f9d853c32331bf0dab39538baf6a205f860adce66c3c0077ce847755ed36c4ca4e33f2aba4f7f935c7c594678a3500bde700edf0ec1d8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b16a81a849041a03ebebebbfc82e5a5994f1c9510ad40d21009450f08a992913ce0e73b1368673d9a7c5b8075d9d08e76ee8278734d1502148eb7e2c6d1149", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722d6adeb49c6f850193854964d44cdf7cdcebf94245270c7a8f897c375d77b88f1dcc91db390636121ab53bb233256484450beb734bc136f678b56467d76ff1"} build_url:https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/D4NI3j55TN2cPFIxO4sOaA/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/a1e8883c51922855e0f9d853c32331bf0dab39538baf6a205f860adce66c3c0077ce847755ed36c4ca4e33f2aba4f7f935c7c594678a3500bde700edf0ec1d8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b16a81a849041a03ebebebbfc82e5a5994f1c9510ad40d21009450f08a992913ce0e73b1368673d9a7c5b8075d9d08e76ee8278734d1502148eb7e2c6d1149", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722d6adeb49c6f850193854964d44cdf7cdcebf94245270c7a8f897c375d77b88f1dcc91db390636121ab53bb233256484450beb734bc136f678b56467d76ff1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 20:58:31.932571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:58:31.932917) ========= 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.svH5oqClSo/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.nX9LaGhVHR/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005055 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:58:31.983814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 20:58:31.984511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 20:58:31.985266) ========= ========= Total master_lag: 0.18 =========