builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1458735412.4 results: success (0) buildid: 20160323030400 builduid: 1b3fc73fb01b487582b4b79f308c55d8 revision: efe7d026ac641759838dd3897c37892e37e5b244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:52.399298) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:52.399660) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2016-03-23 05:16:52.399958) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005387 basedir: '/builds/slave/test' ========= master_lag: 3.76 ========= ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2016-03-23 05:16:56.160887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.161208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.185611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.185966) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005711 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.237275) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.237605) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.238051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.238364) ========= 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.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-03-23 05:16:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.8M=0.001s 2016-03-23 05:16:56 (17.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.436897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.437307) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.026803 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:56.714369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 05:16:56.714765) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev efe7d026ac641759838dd3897c37892e37e5b244 --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 efe7d026ac641759838dd3897c37892e37e5b244 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-03-23 05:16:56,792 truncating revision to first 12 chars 2016-03-23 05:16:56,792 Setting DEBUG logging. 2016-03-23 05:16:56,792 attempt 1/10 2016-03-23 05:16:56,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/efe7d026ac64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 05:16:58,136 unpacking tar archive at: mozilla-central-efe7d026ac64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.591548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 05:16:58.324238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:58.324644) ========= echo efe7d026ac641759838dd3897c37892e37e5b244 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'efe7d026ac641759838dd3897c37892e37e5b244'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 efe7d026ac641759838dd3897c37892e37e5b244 program finished with exit code 0 elapsedTime=0.005378 script_repo_revision: 'efe7d026ac641759838dd3897c37892e37e5b244' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:58.379021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:58.379368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 05:16:58.393579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-03-23 05:16:58.393900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:16:58 INFO - MultiFileLogger online at 20160323 05:16:58 in /builds/slave/test 05:16:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:16:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:58 INFO - {'append_to_log': False, 05:16:58 INFO - 'base_work_dir': '/builds/slave/test', 05:16:58 INFO - 'blob_upload_branch': 'Firefox', 05:16:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:58 INFO - 'branch': 'Firefox', 05:16:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:58 INFO - 'config_files': ('talos/mac_config.py',), 05:16:58 INFO - 'default_actions': ('clobber', 05:16:58 INFO - 'read-buildbot-config', 05:16:58 INFO - 'download-and-extract', 05:16:58 INFO - 'populate-webroot', 05:16:58 INFO - 'create-virtualenv', 05:16:58 INFO - 'install', 05:16:58 INFO - 'run-tests'), 05:16:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:58 INFO - 'download_minidump_stackwalk': True, 05:16:58 INFO - 'download_symbols': 'ondemand', 05:16:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:58 INFO - 'installer_path': 'installer.exe', 05:16:58 INFO - 'log_level': 'info', 05:16:58 INFO - 'log_name': 'talos', 05:16:58 INFO - 'log_to_console': True, 05:16:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:58 INFO - 'opt_config_files': (), 05:16:58 INFO - 'pip_index': False, 05:16:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:58 INFO - 'cmd': ('bash', 05:16:58 INFO - '-c', 05:16:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:58 INFO - 'enabled': True, 05:16:58 INFO - 'halt_on_failure': False, 05:16:58 INFO - 'name': 'check_screen_resolution'},), 05:16:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:58 INFO - 'cmd': ('bash', 05:16:58 INFO - '-c', 05:16:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:58 INFO - 'enabled': True, 05:16:58 INFO - 'halt_on_failure': False, 05:16:58 INFO - 'name': 'check_screen_resolution'},), 05:16:58 INFO - 'run_cmd_checks_enabled': True, 05:16:58 INFO - 'sps_profile': False, 05:16:58 INFO - 'sps_profile_interval': 0, 05:16:58 INFO - 'suite': 'dromaeojs', 05:16:58 INFO - 'system_bits': '32', 05:16:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:58 INFO - 'title': 't-yosemite-r7-0037', 05:16:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:58 INFO - 'use_talos_json': True, 05:16:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:58 INFO - 'work_dir': 'build'} 05:16:58 INFO - ##### 05:16:58 INFO - ##### Running clobber step. 05:16:58 INFO - ##### 05:16:58 INFO - Running pre-action listener: _resource_record_pre_action 05:16:58 INFO - Running main action method: clobber 05:16:58 INFO - rmtree: /builds/slave/test/build 05:16:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:00 INFO - Running post-action listener: _resource_record_post_action 05:17:00 INFO - ##### 05:17:00 INFO - ##### Running read-buildbot-config step. 05:17:00 INFO - ##### 05:17:00 INFO - Running pre-action listener: _resource_record_pre_action 05:17:00 INFO - Running main action method: read_buildbot_config 05:17:00 INFO - Using buildbot properties: 05:17:00 INFO - { 05:17:00 INFO - "project": "", 05:17:00 INFO - "product": "firefox", 05:17:00 INFO - "script_repo_revision": "production", 05:17:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:17:00 INFO - "repository": "", 05:17:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:17:00 INFO - "buildid": "20160323030400", 05:17:00 INFO - "stage_platform": "macosx64", 05:17:00 INFO - "basedir": "/builds/slave/test", 05:17:00 INFO - "nightly_build": "True", 05:17:00 INFO - "buildnumber": 180, 05:17:00 INFO - "slavename": "t-yosemite-r7-0037", 05:17:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:17:00 INFO - "platform": "yosemite_r7", 05:17:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:17:00 INFO - "branch": "mozilla-central", 05:17:00 INFO - "repo_path": "mozilla-central", 05:17:00 INFO - "revision": "efe7d026ac641759838dd3897c37892e37e5b244", 05:17:00 INFO - "pgo_build": "False", 05:17:00 INFO - "builduid": "1b3fc73fb01b487582b4b79f308c55d8", 05:17:00 INFO - "slavebuilddir": "test" 05:17:00 INFO - } 05:17:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:17:00 INFO - Running post-action listener: _resource_record_post_action 05:17:00 INFO - ##### 05:17:00 INFO - ##### Running download-and-extract step. 05:17:00 INFO - ##### 05:17:00 INFO - Running pre-action listener: _resource_record_pre_action 05:17:00 INFO - Running main action method: download_and_extract 05:17:00 INFO - mkdir: /builds/slave/test/build/tests 05:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:00 INFO - https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:17:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:17:02 INFO - Downloaded 1199 bytes. 05:17:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:17:02 INFO - Using the following test package requirements: 05:17:02 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:17:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:17:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:17:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'jsshell-mac.zip'], 05:17:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:17:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:17:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:17:02 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:17:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:17:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:17:02 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:17:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:02 INFO - https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:17:03 INFO - Downloaded 17895828 bytes. 05:17:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:17:06 INFO - Return code: 0 05:17:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:06 INFO - https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:17:21 INFO - Downloaded 17895828 bytes. 05:17:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:17:24 INFO - Return code: 0 05:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:24 INFO - https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:17:25 INFO - Downloaded 10848120 bytes. 05:17:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:17:26 INFO - Return code: 0 05:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:26 INFO - https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:17:33 INFO - Downloaded 111464395 bytes. 05:17:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:33 INFO - mkdir: /builds/slave/test/properties 05:17:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:33 INFO - Contents: 05:17:33 INFO - build_url:https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:17:34 INFO - Running post-action listener: _resource_record_post_action 05:17:34 INFO - Running post-action listener: set_extra_try_arguments 05:17:34 INFO - ##### 05:17:34 INFO - ##### Running populate-webroot step. 05:17:34 INFO - ##### 05:17:34 INFO - Running pre-action listener: _resource_record_pre_action 05:17:34 INFO - Running main action method: populate_webroot 05:17:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:34 INFO - '--tppagecycles', 05:17:34 INFO - '7'], 05:17:34 INFO - 'tests': ['tsvgm']}}, 05:17:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:17:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:17:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'tests': ['damp', 'tps']}, 05:17:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['damp', 'tps']}, 05:17:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:17:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:34 INFO - 'other': {'tests': ['a11yr', 05:17:34 INFO - 'ts_paint', 05:17:34 INFO - 'tpaint', 05:17:34 INFO - 'sessionrestore', 05:17:34 INFO - 'sessionrestore_no_auto_restore', 05:17:34 INFO - 'tabpaint']}, 05:17:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['a11yr', 05:17:34 INFO - 'ts_paint', 05:17:34 INFO - 'tpaint', 05:17:34 INFO - 'sessionrestore', 05:17:34 INFO - 'sessionrestore_no_auto_restore', 05:17:34 INFO - 'tabpaint']}, 05:17:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['a11yr', 05:17:34 INFO - 'ts_paint', 05:17:34 INFO - 'tpaint', 05:17:34 INFO - 'sessionrestore', 05:17:34 INFO - 'sessionrestore_no_auto_restore', 05:17:34 INFO - 'tabpaint']}, 05:17:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['a11yr', 05:17:34 INFO - 'ts_paint', 05:17:34 INFO - 'tpaint', 05:17:34 INFO - 'sessionrestore', 05:17:34 INFO - 'sessionrestore_no_auto_restore', 05:17:34 INFO - 'tabpaint']}, 05:17:34 INFO - 'other_l64': {'tests': ['a11yr', 05:17:34 INFO - 'ts_paint', 05:17:34 INFO - 'tpaint', 05:17:34 INFO - 'sessionrestore', 05:17:34 INFO - 'sessionrestore_no_auto_restore', 05:17:34 INFO - 'tabpaint']}, 05:17:34 INFO - 'other_nol64': {'tests': ['a11yr', 05:17:34 INFO - 'ts_paint', 05:17:34 INFO - 'tpaint', 05:17:34 INFO - 'sessionrestore', 05:17:34 INFO - 'sessionrestore_no_auto_restore', 05:17:34 INFO - 'tabpaint']}, 05:17:34 INFO - 'svgr': {'tests': ['tsvgx', 05:17:34 INFO - 'tsvgr_opacity', 05:17:34 INFO - 'tart', 05:17:34 INFO - 'tscrollx', 05:17:34 INFO - 'cart']}, 05:17:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['tsvgx', 05:17:34 INFO - 'tsvgr_opacity', 05:17:34 INFO - 'tart', 05:17:34 INFO - 'tscrollx', 05:17:34 INFO - 'cart']}, 05:17:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'tests': ['tp5o']}, 05:17:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'talos_options': ['--e10s'], 05:17:34 INFO - 'tests': ['tp5o']}, 05:17:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'talos_options': ['--xperf_path', 05:17:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:34 INFO - 'tests': ['tp5n']}, 05:17:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:34 INFO - 'talos_options': ['--e10s', 05:17:34 INFO - '--xperf_path', 05:17:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:34 INFO - 'tests': ['tp5n']}}, 05:17:34 INFO - 'talos.zip': {'path': '', 05:17:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:34 INFO - Running post-action listener: _resource_record_post_action 05:17:34 INFO - ##### 05:17:34 INFO - ##### Running create-virtualenv step. 05:17:34 INFO - ##### 05:17:34 INFO - Running pre-action listener: _resource_record_pre_action 05:17:34 INFO - Running main action method: create_virtualenv 05:17:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:17:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:34 INFO - Using real prefix '/tools/python27' 05:17:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:38 INFO - Installing pip.................done. 05:17:38 INFO - Return code: 0 05:17:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 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 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:38 INFO - 'HOME': '/Users/cltbld', 05:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:38 INFO - 'LOGNAME': 'cltbld', 05:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:38 INFO - 'MOZ_NO_REMOTE': '1', 05:17:38 INFO - 'NO_EM_RESTART': '1', 05:17:38 INFO - 'PAGER': '/bin/cat', 05:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:38 INFO - 'PWD': '/builds/slave/test', 05:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:38 INFO - 'SHELL': '/bin/bash', 05:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:17:38 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:38 INFO - 'USER': 'cltbld', 05:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:38 INFO - 'XPC_FLAGS': '0x0', 05:17:38 INFO - 'XPC_SERVICE_NAME': '0', 05:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:17:38 INFO - Cleaning up... 05:17:38 INFO - Return code: 0 05:17:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:38 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>=0.7.1'] in /builds/slave/test/build 05:17:38 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>=0.7.1 05:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:38 INFO - 'HOME': '/Users/cltbld', 05:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:38 INFO - 'LOGNAME': 'cltbld', 05:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:38 INFO - 'MOZ_NO_REMOTE': '1', 05:17:38 INFO - 'NO_EM_RESTART': '1', 05:17:38 INFO - 'PAGER': '/bin/cat', 05:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:38 INFO - 'PWD': '/builds/slave/test', 05:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:38 INFO - 'SHELL': '/bin/bash', 05:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:17:38 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:38 INFO - 'USER': 'cltbld', 05:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:38 INFO - 'XPC_FLAGS': '0x0', 05:17:38 INFO - 'XPC_SERVICE_NAME': '0', 05:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:38 INFO - Downloading/unpacking psutil>=0.7.1 05:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:41 INFO - Installing collected packages: psutil 05:17:41 INFO - Running setup.py install for psutil 05:17:41 INFO - building 'psutil._psutil_osx' extension 05:17:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:17:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:17:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:17:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:17:42 INFO - building 'psutil._psutil_posix' extension 05:17:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:17:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:17:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:17:42 INFO - ^ 05:17:42 INFO - 1 warning generated. 05:17:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:17:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:42 INFO - Successfully installed psutil 05:17:42 INFO - Cleaning up... 05:17:42 INFO - Return code: 0 05:17:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:43 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:43 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.0.0'] in /builds/slave/test/build 05:17:43 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.0.0 05:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:43 INFO - 'HOME': '/Users/cltbld', 05:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:43 INFO - 'LOGNAME': 'cltbld', 05:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:43 INFO - 'MOZ_NO_REMOTE': '1', 05:17:43 INFO - 'NO_EM_RESTART': '1', 05:17:43 INFO - 'PAGER': '/bin/cat', 05:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:43 INFO - 'PWD': '/builds/slave/test', 05:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:43 INFO - 'SHELL': '/bin/bash', 05:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:17:43 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:43 INFO - 'USER': 'cltbld', 05:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:43 INFO - 'XPC_FLAGS': '0x0', 05:17:43 INFO - 'XPC_SERVICE_NAME': '0', 05:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:17:46 INFO - Installing collected packages: mozsystemmonitor 05:17:46 INFO - Running setup.py install for mozsystemmonitor 05:17:46 INFO - Successfully installed mozsystemmonitor 05:17:46 INFO - Cleaning up... 05:17:46 INFO - Return code: 0 05:17:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:17:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:17:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:46 INFO - 'HOME': '/Users/cltbld', 05:17:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:46 INFO - 'LOGNAME': 'cltbld', 05:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:46 INFO - 'MOZ_NO_REMOTE': '1', 05:17:46 INFO - 'NO_EM_RESTART': '1', 05:17:46 INFO - 'PAGER': '/bin/cat', 05:17:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:46 INFO - 'PWD': '/builds/slave/test', 05:17:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:46 INFO - 'SHELL': '/bin/bash', 05:17:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:17:46 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:17:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:46 INFO - 'USER': 'cltbld', 05:17:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:46 INFO - 'XPC_FLAGS': '0x0', 05:17:46 INFO - 'XPC_SERVICE_NAME': '0', 05:17:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:50 INFO - Downloading docopt-0.6.1.tar.gz 05:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:50 INFO - Running setup.py install for blobuploader 05:17:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:50 INFO - Running setup.py install for requests 05:17:51 INFO - Running setup.py install for docopt 05:17:51 INFO - Successfully installed blobuploader requests docopt 05:17:51 INFO - Cleaning up... 05:17:51 INFO - Return code: 0 05:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:51 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 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:17:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:51 INFO - 'HOME': '/Users/cltbld', 05:17:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:51 INFO - 'LOGNAME': 'cltbld', 05:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:51 INFO - 'MOZ_NO_REMOTE': '1', 05:17:51 INFO - 'NO_EM_RESTART': '1', 05:17:51 INFO - 'PAGER': '/bin/cat', 05:17:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:51 INFO - 'PWD': '/builds/slave/test', 05:17:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:51 INFO - 'SHELL': '/bin/bash', 05:17:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:17:51 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:17:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:51 INFO - 'USER': 'cltbld', 05:17:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:51 INFO - 'XPC_FLAGS': '0x0', 05:17:51 INFO - 'XPC_SERVICE_NAME': '0', 05:17:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-f6GQeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1SyXUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-sSpfuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-RXFq6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1n_KWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UdI9LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-cY0l81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-nOkC_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-79HJA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-lSmVcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-z5rHm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-lHdmJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Tn8FVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XL9_jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-srxNaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-He3UCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-TKS7p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:53 INFO - Running setup.py install for manifestparser 05:17:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:53 INFO - Running setup.py install for mozcrash 05:17:53 INFO - Running setup.py install for mozdebug 05:17:54 INFO - Running setup.py install for mozdevice 05:17:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Running setup.py install for mozfile 05:17:54 INFO - Running setup.py install for mozhttpd 05:17:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Running setup.py install for mozinfo 05:17:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Running setup.py install for mozInstall 05:17:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:54 INFO - Running setup.py install for mozleak 05:17:54 INFO - Running setup.py install for mozlog 05:17:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:55 INFO - Running setup.py install for moznetwork 05:17:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:55 INFO - Running setup.py install for mozprocess 05:17:55 INFO - Running setup.py install for mozprofile 05:17:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:55 INFO - Running setup.py install for mozrunner 05:17:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:55 INFO - Running setup.py install for mozscreenshot 05:17:55 INFO - Running setup.py install for moztest 05:17:56 INFO - Running setup.py install for mozversion 05:17:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:56 INFO - Cleaning up... 05:17:56 INFO - Return code: 0 05:17:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:56 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 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:17:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:56 INFO - 'HOME': '/Users/cltbld', 05:17:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:56 INFO - 'LOGNAME': 'cltbld', 05:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:56 INFO - 'MOZ_NO_REMOTE': '1', 05:17:56 INFO - 'NO_EM_RESTART': '1', 05:17:56 INFO - 'PAGER': '/bin/cat', 05:17:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:56 INFO - 'PWD': '/builds/slave/test', 05:17:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:56 INFO - 'SHELL': '/bin/bash', 05:17:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:17:56 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:17:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:56 INFO - 'USER': 'cltbld', 05:17:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:56 INFO - 'XPC_FLAGS': '0x0', 05:17:56 INFO - 'XPC_SERVICE_NAME': '0', 05:17:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-mXLexj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fpaaAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fK6uS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-H8lyb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tIutgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pUgqrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Xk0Pih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-N9Vxeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-B4UWcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-BaOyYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-QtJRcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-If1VuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rYPBPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tz0BYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rOU4HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:58 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-B3xBNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:58 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qHIVrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:00 INFO - Downloading blessings-1.6.tar.gz 05:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:01 INFO - Installing collected packages: blessings 05:18:01 INFO - Running setup.py install for blessings 05:18:01 INFO - Successfully installed blessings 05:18:01 INFO - Cleaning up... 05:18:01 INFO - Return code: 0 05:18:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:01 INFO - Reading from file tmpfile_stdout 05:18:01 INFO - Current package versions: 05:18:01 INFO - blessings == 1.6 05:18:01 INFO - blobuploader == 1.2.4 05:18:01 INFO - docopt == 0.6.1 05:18:01 INFO - manifestparser == 1.1 05:18:01 INFO - mozInstall == 1.12 05:18:01 INFO - mozcrash == 0.17 05:18:01 INFO - mozdebug == 0.1 05:18:01 INFO - mozdevice == 0.48 05:18:01 INFO - mozfile == 1.2 05:18:01 INFO - mozhttpd == 0.7 05:18:01 INFO - mozinfo == 0.9 05:18:01 INFO - mozleak == 0.1 05:18:01 INFO - mozlog == 3.1 05:18:01 INFO - moznetwork == 0.27 05:18:01 INFO - mozprocess == 0.22 05:18:01 INFO - mozprofile == 0.28 05:18:01 INFO - mozrunner == 6.11 05:18:01 INFO - mozscreenshot == 0.1 05:18:01 INFO - mozsystemmonitor == 0.0 05:18:01 INFO - moztest == 0.7 05:18:01 INFO - mozversion == 1.4 05:18:01 INFO - psutil == 3.1.1 05:18:01 INFO - requests == 1.2.3 05:18:01 INFO - wsgiref == 0.1.2 05:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:01 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 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:18:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:01 INFO - 'HOME': '/Users/cltbld', 05:18:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:01 INFO - 'LOGNAME': 'cltbld', 05:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:01 INFO - 'MOZ_NO_REMOTE': '1', 05:18:01 INFO - 'NO_EM_RESTART': '1', 05:18:01 INFO - 'PAGER': '/bin/cat', 05:18:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:01 INFO - 'PWD': '/builds/slave/test', 05:18:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:01 INFO - 'SHELL': '/bin/bash', 05:18:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:18:01 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:18:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:01 INFO - 'USER': 'cltbld', 05:18:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:01 INFO - 'XPC_FLAGS': '0x0', 05:18:01 INFO - 'XPC_SERVICE_NAME': '0', 05:18:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:18:01 INFO - Cleaning up... 05:18:01 INFO - Return code: 0 05:18:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:01 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 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:18:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:18:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:01 INFO - 'HOME': '/Users/cltbld', 05:18:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:01 INFO - 'LOGNAME': 'cltbld', 05:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:01 INFO - 'MOZ_NO_REMOTE': '1', 05:18:01 INFO - 'NO_EM_RESTART': '1', 05:18:01 INFO - 'PAGER': '/bin/cat', 05:18:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:01 INFO - 'PWD': '/builds/slave/test', 05:18:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:01 INFO - 'SHELL': '/bin/bash', 05:18:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:18:01 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:18:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:01 INFO - 'USER': 'cltbld', 05:18:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:01 INFO - 'XPC_FLAGS': '0x0', 05:18:01 INFO - 'XPC_SERVICE_NAME': '0', 05:18:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:02 INFO - Downloading/unpacking jsonschema 05:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:05 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:05 INFO - warning: no files found matching '*.txt' 05:18:05 INFO - no previously-included directories found matching 'build' 05:18:05 INFO - no previously-included directories found matching 'dist' 05:18:05 INFO - no previously-included directories found matching '.git*' 05:18:05 INFO - Installing collected packages: jsonschema, functools32 05:18:05 INFO - Running setup.py install for functools32 05:18:06 INFO - warning: no files found matching '*.txt' 05:18:06 INFO - no previously-included directories found matching 'build' 05:18:06 INFO - no previously-included directories found matching 'dist' 05:18:06 INFO - no previously-included directories found matching '.git*' 05:18:06 INFO - Successfully installed jsonschema functools32 05:18:06 INFO - Cleaning up... 05:18:06 INFO - Return code: 0 05:18:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f15cd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, '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.CUWOubNK2E/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.TF9bpRcYem/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:18:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:18:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:06 INFO - 'HOME': '/Users/cltbld', 05:18:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:06 INFO - 'LOGNAME': 'cltbld', 05:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:06 INFO - 'MOZ_NO_REMOTE': '1', 05:18:06 INFO - 'NO_EM_RESTART': '1', 05:18:06 INFO - 'PAGER': '/bin/cat', 05:18:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:06 INFO - 'PWD': '/builds/slave/test', 05:18:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:06 INFO - 'SHELL': '/bin/bash', 05:18:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:18:06 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:18:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:06 INFO - 'USER': 'cltbld', 05:18:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:06 INFO - 'XPC_FLAGS': '0x0', 05:18:06 INFO - 'XPC_SERVICE_NAME': '0', 05:18:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:06 INFO - Downloading/unpacking flake8 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:10 INFO - no previously-included directories found matching 'docs/_build' 05:18:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:10 INFO - Running setup.py install for pep8 05:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:10 INFO - no previously-included directories found matching 'docs/_build' 05:18:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:10 INFO - Cleaning up... 05:18:10 INFO - Return code: 0 05:18:10 INFO - Running post-action listener: _resource_record_post_action 05:18:10 INFO - Running post-action listener: _start_resource_monitoring 05:18:10 INFO - Starting resource monitoring. 05:18:10 INFO - ##### 05:18:10 INFO - ##### Running install step. 05:18:10 INFO - ##### 05:18:10 INFO - Running pre-action listener: _resource_record_pre_action 05:18:10 INFO - Running main action method: install 05:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:10 INFO - Reading from file tmpfile_stdout 05:18:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:10 INFO - Reading from file tmpfile_stdout 05:18:10 INFO - Output received: 05:18:10 INFO - Usage: mozinstall [options] installer 05:18:10 INFO - Options: 05:18:10 INFO - -h, --help show this help message and exit 05:18:10 INFO - -d DEST, --destination=DEST 05:18:10 INFO - Directory to install application into. [default: 05:18:10 INFO - "/builds/slave/test"] 05:18:10 INFO - --app=APP Application being installed. [default: firefox] 05:18:10 INFO - mkdir: /builds/slave/test/build/application 05:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:18:44 INFO - Reading from file tmpfile_stdout 05:18:44 INFO - Output received: 05:18:44 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:18:44 INFO - Running post-action listener: _resource_record_post_action 05:18:44 INFO - ##### 05:18:44 INFO - ##### Running run-tests step. 05:18:44 INFO - ##### 05:18:44 INFO - Running pre-action listener: _resource_record_pre_action 05:18:44 INFO - Running main action method: run_tests 05:18:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:44 INFO - 2016-03-23 05:18:44.584 screenresolution[1644:7480] starting screenresolution argv=screenresolution get 05:18:44 INFO - 2016-03-23 05:18:44.587 screenresolution[1644:7480] Display 0: 1600x1200x32@60 05:18:44 INFO - 2016-03-23 05:18:44.594 screenresolution[1645:7482] starting screenresolution argv=screenresolution list 05:18:44 INFO - Available Modes on Display 0 05:18:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:44 INFO - Intel Iris: 05:18:44 INFO - Chipset Model: Intel Iris 05:18:44 INFO - Type: GPU 05:18:44 INFO - Bus: Built-In 05:18:44 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:44 INFO - Vendor: Intel (0x8086) 05:18:44 INFO - Device ID: 0x0a2e 05:18:44 INFO - Revision ID: 0x0009 05:18:44 INFO - Displays: 05:18:44 INFO - Display: 05:18:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:44 INFO - Display Serial Number: 1600x1200 60 05:18:44 INFO - Main Display: Yes 05:18:44 INFO - Mirror: Off 05:18:44 INFO - Online: Yes 05:18:44 INFO - Rotation: Supported 05:18:44 INFO - Return code: 0 05:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:44 INFO - Python 2.7.3 05:18:44 INFO - Return code: 0 05:18:44 INFO - grabbing minidump binary from tooltool 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e1de00>, '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 0x101c46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:18:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:18:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:44 INFO - Return code: 0 05:18:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:18:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:18:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:18:46 INFO - Return code: 0 05:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CUWOubNK2E/Render', 05:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:46 INFO - 'HOME': '/Users/cltbld', 05:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:46 INFO - 'LOGNAME': 'cltbld', 05:18:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:46 INFO - 'MOZ_NO_REMOTE': '1', 05:18:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:46 INFO - 'NO_EM_RESTART': '1', 05:18:46 INFO - 'PAGER': '/bin/cat', 05:18:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:46 INFO - 'PWD': '/builds/slave/test', 05:18:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:46 INFO - 'SHELL': '/bin/bash', 05:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TF9bpRcYem/Listeners', 05:18:46 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:46 INFO - 'USER': 'cltbld', 05:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:46 INFO - 'XPC_FLAGS': '0x0', 05:18:46 INFO - 'XPC_SERVICE_NAME': '0', 05:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:18:46 INFO - mozversion application_buildid: 20160323030400 05:18:46 INFO - mozversion application_changeset: efe7d026ac641759838dd3897c37892e37e5b244 05:18:46 INFO - mozversion application_display_name: Nightly 05:18:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:46 INFO - mozversion application_name: Firefox 05:18:46 INFO - mozversion application_remotingname: firefox 05:18:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:18:46 INFO - mozversion application_vendor: Mozilla 05:18:46 INFO - mozversion application_version: 48.0a1 05:18:46 INFO - mozversion platform_buildid: 20160323030400 05:18:46 INFO - mozversion platform_changeset: efe7d026ac641759838dd3897c37892e37e5b244 05:18:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:18:46 INFO - mozversion platform_version: 48.0a1 05:18:46 INFO - using testdate: 1458735526 05:18:46 INFO - actual date: 1458735526 05:18:46 INFO - starting webserver on 'localhost:49271' 05:18:46 INFO - SUITE-START | Running 2 tests 05:18:46 INFO - TEST-START | dromaeo_css 05:18:46 INFO - operating with platform_type : mac_ 05:18:46 INFO - Initialising browser for dromaeo_css test... 05:18:46 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpFj_79r/profile http://localhost:49271/getInfo.html) 05:18:48 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 05:18:48 INFO - PROCESS | 1663 | colorDepth:24 05:18:48 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 05:18:48 INFO - PROCESS | 1663 | __metrics 05:18:48 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:18:48 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:18:49 INFO - TEST-INFO | 1663: exit 0 05:18:49 INFO - Browser initialized. 05:18:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:49 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpFj_79r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:01 INFO - PROCESS | 1667 | RSS: Main: 245686272 05:19:01 INFO - PROCESS | 1667 | 05:19:52 INFO - PROCESS | 1667 | 1458735592334 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:22:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 05:22:04 INFO - PROCESS | 1667 | RSS: Main: 352301056 05:22:04 INFO - PROCESS | 1667 | 05:25:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 05:25:07 INFO - PROCESS | 1667 | RSS: Main: 376119296 05:25:07 INFO - PROCESS | 1667 | 05:28:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 05:28:09 INFO - PROCESS | 1667 | RSS: Main: 374693888 05:28:09 INFO - PROCESS | 1667 | 05:31:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 05:31:12 INFO - PROCESS | 1667 | RSS: Main: 333606912 05:31:12 INFO - PROCESS | 1667 | 05:34:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 05:34:15 INFO - PROCESS | 1667 | RSS: Main: 338612224 05:34:15 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 05:37:18 INFO - PROCESS | 1667 | RSS: Main: 383270912 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | __start_tp_report 05:37:18 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:37:18 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:37:18 INFO - PROCESS | 1667 | |i|pagename|runs| 05:37:18 INFO - PROCESS | 1667 | |0;dojo.html;3238.206639373353;3444.2594842108942;3462.463318185682;3469.1500582357326;3533.8939831805037;5480.725963701809;5571.0807716726795;5622.690752008638;5630.239917611121;5660.5471562275025;5651.717414129298;5661.830145095643;5739.139129130633;5771;5795.043817770063;5055.1658976269055;5076.187809950408;5101;5118.948810511884;5238.711870847102;5202.06362854686;5258.211268309746;5268.841934741964;5269.736513174345;5326.6537675051195;5090.363704536914;5175.094358487249;5180.974095129538;5182.222666600002;5197.610179236553;5121.462246464105;5164.2253661950635;5168.405633352175;5199.6360254782185;5219.42586315505;5049.990001999615;5091.694498330112;5100.846974590731;5114.156164232934;5159.303494028333;5492.47821456961;5610.607257491977;5615.971920140414;5616.943830561724;5624.128260119688;6129.693515324216;6133.885575987434;6241.438270555672;6261.186045814015;6268.811935641938;6223.346548612421;6252.18721566198;6253.7185826637915;6258.374162583706;6269.87460250797;5434.64674796137;5783.392743761887;5788.900108979323;5788.971055144697;5791.855203619901;5597.412271711411;6180.381961803873;6181.567290289637;6278.748850046039;6286.119943207955;6128.387161283925;6140.8771824564155;6155.47678447337;6157.4458298753325;6196.318404975449;6133.570650054453;6255.499560035186;6284.340144284784;6286.5599408041;6289.937100629027;6094.169091873675;6140.4473597376455;6187.628742275478;6195.81412557624;6209.5032397408095;6212.502999760009;6230.345813689497;6233.688315584202;6238.75044998195;6247.250329960434;4790.5448982346625;4806.639502037361;4849.927251091236;4885.560299572984;4921.261810728348;4347.000189956265;4386.232409328355;4401.7358958461955;4441.7779111044965;4482.193205223091;5603.579731520153;5627.943720562824;5670.5463562914865;5674.858128546819;5687.118496633028;6125.113363430769;6249.6562689052535;6265.216847894013;6267.341929097379;6270.561060725797;5115.897682046412;5455.072637651609;5623.5220006299105;5718.170865224519;5742.454466825645;5326.840194794162;5328.92006619901;5330.706811125426;5332.653377530448;5335.11970524859;5370.301860758076;6256.687165641609;6272.40412160844;6275.184226050585;6310.211223597051;6099.521645064636;6150.969245153746;6158.599691020069;6258.718357673824;6272.655003974643;6255.749770009149;6295.779647712308;6296.590721603081;6309.716062777278;6314.4632706218645;5108.795648174031;5934.525237981037;6181;6198.442140207223;6201.193844800147;6074.240719910012;6130.734471166852;6139.584134579286;6165.445109940127;6172.135900973957;6111.257501106225;6121.265448146251;6127.220070483952;6139.741353022709;6147.108669243024;6100.302186760357;6113.081058500098;6131.156386454651;6144.324124346408;6155.907661384993;5796.130580412803;5890.764369425175;5916.171735956884;5972.283326000907;5988.640681558946;6109.910512419943;6113.463251060979;6122.173506576733;6135.14108024868;6143.464133966509;5997.970010149921;5999.130126131599;6000.249968753906;6010.368911264429;6027.156198132177 05:37:18 INFO - PROCESS | 1667 | |1;ext.html;494.61420092327995;579.556639171034;582.5601670738589;634.936506349365;635.7520566978878;38259.852204433875;38770.61229387705;38777.61222387779;38822.61177388225;38846.80576597116;41408;41982.58017419825;41992.37011444823;42009.7899510502;42028;9415.105564971316;9438.19775319097;9663;9672.419654820733;9677.322587418883;9411;9590.328676992613;9599.4720290384;9601.519924003807;9610.75973100671;9672.081152290557;9744.90255097447;9754.170895473893;9760.365576237522;9763.414195148278;9513.90486095137;9543.713688589354;9631.085046920567;9697.757556061155;9754;9525.333226674136;9578.281628877861;9710.17463515602;9746.415215087118;9755.707328780078;40451;40851.38722919158;40873.386899196536;40933.59066409357;40947.385789213185;3232.046546268833;3369.22507823202;3673.540807399075;3819.8731374244667;3871.1676989447406;28141.57787633187;28927.987520436895;29307.85346073256;29445;29461.263468413246;2292.403974966504;2742.204760619418;2788.3726161613677;2819.4783964966546;2851.2871782054485;335410.3229483837;338573;339028.21943560994;339363.303183485;339825;44686.32970505445;45313.773431132635;45339.77330113328;45395.54604453979;61094.694526527084;36892.446613300825;43999.78000109979;44136.3379549307;44221.778891105336;44259.55740442554;15461;15608.609784755472;15617.828662850332;15629.14039727826;15647.765283520755;12478.688032799071;12555.121141520189;12558.309292988974;12572.811407828889;12791.296478693575;14769.556913292618;14792.890533210053;14799.778003329959;14825.40698372053;14912.70174596502;6441.903371449432;6560.606363618198;6573.868522629521;6578.572392794453;6616.073749675049;928.9117533834275;974.6929717139078;995.5072239241622;1008.2790804574764;1062.3413483640193;29127.417451650846;29302.560461593093;29420.705792942226;29721.10836674903;29914;1108.7373647459128;1124.662601219631;1151.5163631274884;1160.495184594704;1214.9331786751636;14690.926545367205;14787.482438114614;14846.628834279014;15121.017133886262;15123.16822574747;492855.5357223191;496718;501950;503020;504910;57951.8409631805;58301.66793328304;58316;58516.122258166164;58605.70697146487;1322.3123975532862;1432.957011289663;1444.5738507140418;1469.1478942213491;1472.639203395175;28347.57478637781;28771.671703514825;28957.42085158243;29029.7097029027;30784;32316.515252271704;46519.53480465152;47088.52911470841;47127.76436117797;47149.7642511799;355731;357967;358283;359745;360374;28480.85759571189;32719.836400817843;33185.66814331826;33613.327733444705;33735.83132084422;37251.323690433455;39122.21755564816;41849;42230.577694222666;42699.35950960676;34000.1499962493;34985.65014349824;35228.47157292591;36008.4598731014;36353.27293454063;30808.53787193239;32546;35349.469757953135;36520.81739591285;36568;35137.648623513436;35493;36205.81897090498;36273.093172670895;36460.270794583426;23192.84035798237;26882.73117268802;30951.071467856;31173.688263117077;31796.36407271888;21752.021159047563;23279.952402141607;24102.52328265592;24208.394790130387;24242.87878560596 05:37:18 INFO - PROCESS | 1667 | |2;jquery.html;358.5715070490764;359.5703134753969;360.54571240237294;370.83127177134406;372.1069433359936;19958.70061949072;20925.37223883284;21209.15163393464;21457.46356341092;21680.674789878165;20715.792842071576;20799.896000520013;21535.461613459673;21561.784382156173;21626.459338516546;5707.942920570793;5928.2293301870695;5970.8805823883495;5973.551983601225;5982.132590774335;5537.640053396516;5877.588568800185;5883.970580147115;5888.617239879394;5889.469947704706;5807.854803629901;5834.445727655866;5836.066229403296;5838.357780644125;5843.123531470293;5644.4637759413;5700.429957004308;5777.942220577804;5834.504067154255;5840.532757379399;5062.164742817431;5107.693538387672;5116.797552575142;5116.974415127937;5120.385553733576;25888.352791180183;26126;26498;26565.468690626272;26568.601470977952;2151.7955794199684;2201.559688062394;2236.865788052722;2245.932622021342;2395.8203134764963;13292.667683307898;14845.628859278497;14962.700745985128;15092.868034897427;15273.541793746206;1550.9686058770903;1739.7303417970236;1789.2038043070838;1858.9814101859079;1866.3747644539096;75228.49777361179;99976.50011749967;100554.2210445505;103851;105619.94380056178;10635.627753028606;10796.730081747863;10870;11064.723381915355;11215.158863085302;13229.73540529184;13372.06395552302;13458.259795711134;13459.394327255297;13459.93270033663;8713.782155446164;8799.12008799115;8807.251383632463;8903.910960890438;8910.955445222862;8983.146601072887;8998.59506322217;8999.37004409698;9002.954985225031;9099.590518426687;6519.185101862267;6580.901286480706;6585.769498067544;6607.240167380716;6608.43828274602;1807.9186436610385;1823.3253696132515;1836.7520384748154;1843.824836640517;1848.0759620189906;913.7213149989317;935.7426707655313;952.3238500664605;979.0014185530719;1017.3692310767372;20454.795452045288;20919;21101.894490527757;21204.681929771064;21324.253651122137;939.915407613318;946.7585765629858;949.5584553182803;984.158544444504;1012.3015119567475;11134.61028864002;11593.536258549731;11618.419079046014;11655.009324207367;11666.766664666658;592946;595189;605700.9714951398;609736;609782;69577;89937;94458;102646.48676756569;103479.48260258802;984.6898227058454;1014.2554805733978;1031.231732359397;1031.7162780235344;1032.0762917189224;17826;17878.731819022985;17881.28474860991;18397.54006149857;18417.723734144267;44114.779426102665;45424.54575454335;45845.31232031589;45872.8531786708;46856.53143468522;64140.679296605085;66449.0032649501;66793.66603166953;67024.66487667726;67180.65638687297;6280.623162610258;7518.990856621694;7666.278471142664;7752.712949679971;7791.4935529190425;12073.335966521925;12365.876341236473;12587.496500139892;12617.621471355875;12620.55828046014;10419.322744021614;10628.627998020032;10690.893091069302;10986.780264394507;11037.337759734442;10381.325213861075;10561.947190264;10676.039156475645;10998.505067271832;11028.22802403856;10442.216833737348;10588.311759735592;10775.892241077489;10956.945215273872;11215.214934954474;7715.57564333967;7745.22547745221;7795.142534321107;7873.5275883447175;8142.063662678867;8756.4308319959;8813.42712723671;10688.786224275627;10802;11087.611933582286 05:37:18 INFO - PROCESS | 1667 | |3;mootools.html;1412.6044707481908;1550.4650895441073;1583.5328578069468;1855.1559040636512;2007.7289565908607;7843.76468705939;8456.830863382736;8663.480191188526;8677.826443471127;8680.73957781266;8497.405181637288;8524.744257672264;8640.265577425926;8640.351973601973;8647.827043459127;2096.486360841596;2413.0589070262613;2439.48770758141;2464.8890799914047;2467;2479.1818699829014;2480.5659009673327;2482.590372588521;2483.044028049205;2484.167803785725;2383.3157918364736;2403.495265994143;2424.9393765155924;2452.3623857796924;2452.5217582571318;2405.374602603336;2441.6093425051995;2453.8895749691305;2458.938526536833;2468.0991438125134;2417.4439878827966;2431.963520547193;2433.3673244956262;2441.2432146034607;2442.096424322994;8731.738047858575;8807.119288071142;8835.469871807712;8862.291016718647;8869.86695199566;5360.678359298455;5512.586556008276;5516.255305533742;5518.613697041209;5523.199136125279;3564.269324788412;3635.781853088823;3702.981485092584;3711.3690672585453;3725.8882233533036;934.6728644974205;1014.5840205515703;1017.9440130792804;1024.2727663359024;1062.7715041266088;11077.723056923562;11258.887411125948;11260.268082574607;11266.549338026469;11348.432578371048;4605.631549476034;4614.146382919171;4657.045305712389;4691.812327506861;4705.529447055267;9167.679131230376;9182.67860624875;9195.816083678288;9197.49413782235;9197.494137822485;5253.343332083489;5297.655652382583;5304.124819404755;5313.123334649817;5317.069512835238;4414.006848459071;4458.242098843204;4466.553344665507;4516.9096618068115;4980.77586508608;3663.7618554793853;3689.2252626948107;3794.2221844521805;3794.753341032824;3797.5063241778394;1169.6724917023248;1178.9469473873696;1182.3201659046083;1190.565443613075;1197.4012993503247;1119.8264269038311;1160.7504386556932;1160.8606967163994;1349.1230700045048;1415.4833485777617;8050.31572316348;8149.511029338259;8187.26314631686;8269.04905935825;8307.127751586117;1205.9397030148457;1212.9514819407302;1222.8777122287877;1242.3229340009716;1247.1394737631188;6226.377362263828;6232.594881332699;6328.6202827830475;6329;6331;10257.794844103226;10613.628523001658;10713.303635263683;10725.766536848207;10739.624113156002;10342.327748696462;10491.580336786596;10548.841767373495;10589.15286777056;10651.041406273473;8196.754097377088;8343.457675251211;8379.790505237417;8382.371322150862;8388.245057944814;7879.921200787919;7932.920670793218;7943.682252709827;8002.3198028165925;8019.1579884111325;9337.439753614804;9592.712218633453;9635.421874687541;9743.26925480606;9766.36518626287;9689.563969621244;9893.159081478156;10043.397396156253;10065.899341006496;10078.244131690299;6983.790486285419;7011.544249623758;7043.2604576518725;7101.076860008166;7128.679209435484;8239.176082391712;8272.83454330922;8304.626291817003;8322.20939010793;8322.45904016237;7410.555366678017;7497.625118743932;7512.436567257587;7646.197149299243;7668.769936901902;7148.535345202546;7188.28117188277;7240.1311842579225;7311.451641127043;7322.524035937647;7643.7324693635455;7800;7800.45396822217;7806.102298235775;7832.530048197126;6969.616671083139;6990.685419156049;7065.187503437171;7075.575465472089;7076.469264805057;7109.537880037781;7175;7184.1738200105565;7185.101862267216;7186.281371862772 05:37:18 INFO - PROCESS | 1667 | |4;prototype.html;322.36333241847353;323.2065279738243;331.3158328052573;333.6380027669979;338.018057542838;6527.869442611145;6587.2424671162835;6596.6581863438505;6606.933930660698;6615.610721748427;6470.126532918055;6479.514036447262;6528.4777217822575;6529.085927970076;6553.311902250267;3844.692424606025;4550.635949124062;4645.4657714362775;4690.202665546865;4844.442889067758;4701.670883038171;4703.6472264580125;4735.763211839394;4748.9077512172225;4757.1437141314545;4076.77696690993;4555.111753208126;4716.103940251359;4740.431148262213;4761.523847615245;4619.214733495314;4676.789544470507;4772.9976704892015;4787.6648634595595;4852.805887764485;4075.32757095079;4092.5088989321175;4099.97950010251;4105.178964207171;4111.691623128278;6150.108234306045;6162.784302549389;6290.591111577779;6301;6303.55875088744;5737.053386191315;5740.512056475204;5755.22304488897;5757.395473475309;5757.942420575824;6922.342377474132;6923.723051077951;6930.20302665195;6937.68780404883;6953.096097507342;4506.459224893001;4634.582887540138;4691.15559199344;4699.436067671867;4720.527947205286;7330.523515971445;7363.815904602374;7373.930780036918;7385.224551422077;7427.554346739213;3481.060113769268;4452.777361131931;4571.085782843445;4758.714477131383;4770.332153498513;4637.976810115928;4831.323614693945;4832.9275060874115;4845.781939812717;4858.1012512685265;5681.005823980787;5693.601447898607;5697.544196464273;5699.572532060112;5704.543636509069;6737.292584278678;6994.195667498303;7012.474064445187;7024.297570242935;7030.613316267552;1669.4824604372684;1678.3706110208673;1686.9072201029062;1686.9240884160242;1687.7974643042915;1021.5198856537415;1085.2132204152085;1099.5766629847567;1110.4558766204502;1120.8206686930052;5680.488756011896;5977.3126090500145;6255.186825712628;6385.584936979081;6441.903371449432;7059.717611295593;7183.676734546958;7206.891896621555;7208.459365547605;7208.855822883618;5270.393904700932;6458.6770661466735;6571.277159512545;6604.174478190226;6617.841877671388;3837.175007373428;3886.7279290449396;3887.4168874669026;3892.3966785148345;3903.6681882039775;7356.337929586363;7634.580098094547;7691.192859534566;7697.615119244016;7699.769006929801;6139.907901381483;7557;7571.583562903983;7580.3556697681315;7597.202293759186;7576.28025337592;7598.126215485179;7615;7616.961915190389;7622;6084.14821924922;6840.41856442208;7079.82300442493;7332.633368331455;7336.082989626297;7206.351428371262;7226.855462890608;7229.530080544748;7241.493095483265;7242.094738157731;7591.506552074097;7612.8477430449975;7619.961900190464;7625.809354766176;7657.234276572298;4739.123262196505;4755.048990202043;4759.762011899322;4759.833405830779;4766.3327134200545;6953.304669533006;7237.131544214728;7267.927320726725;7270.709171633075;7273.3453989141235;7035.683394247373;7057.752978645723;7057.964710176621;7068.222495525385;7072.186698529735;6995.755148569776;7005.684744186626;7040.014397984389;7047.541909775849;7051.858962820817;6849.691763870538;6849.7260109597055;6875.140607424072;6878.209005964378;6883.208431030495;6154.476869466145;6673;6767.932320676927;7037.1555413350725;7110.217876033736;5535.25274087993;6562.573432726857;6756.560823546453;6886.51794374389;6906.551074180162 05:37:18 INFO - PROCESS | 1667 | |5;yui.html;666.5833853841349;706.7879636109166;725.7133432294244;756.7654027251551;810.0805585660274;16914.407995720136;17574.209160587787;17597.912010439944;17675.381361652344;17686;16325.91837040816;16329.938553993981;16428.01431914083;16446.588835279123;16554.172291385414;753.1940823319023;936.4708939449206;951.9619215231382;952.6998995316487;954.6897258391016;772.0503780350173;930.4091901642472;946.8106378724249;946.8721722567468;949.1647350331733;990.8414653655417;991.2664628175135;1000.2348203624233;1003.9196864250843;1004.6684594083971;794.3486341200161;976.4190306767462;992.3797626483448;992.6327258914212;996.3374356053216;735.5292612727804;736.4697417859132;737.6717360774458;737.8229224986019;738.3539403022355;15540.222988850512;15665.686686266325;15669.608259793482;15716.764248536281;15720.135392553406;12686.682832929251;12700.174488658207;12781.808272875915;12956.870431295662;13150.934245328712;9096.999330073686;10108.39349639024;10373.585056597727;10482.58069677212;10795.730106747316;3581.230035542345;3656.926861462756;3666.77999320039;3679.356112680297;3681;84674;85768.57115714444;87926.5603671984;88263.55868220617;88620.55689721575;7769.844603107907;9422.120549035264;9518.381305215138;9645.035496450299;10012.499375031364;21588.35234942954;21806.781932180475;21913.780862191175;21936.232231871807;21940.45148871291;7337.88993165103;7447;7477.513961592479;7504.812379690551;7659.080910290801;4085.8569950051606;4117.608827161415;4172.979135104305;4175.812088456027;4198.265303571863;3628.5827129880404;3687.9262414752093;3689.5572531296416;3712.276106159327;3716.2381711749567;653.6698967021624;671.5601281160848;673.7877568565887;676.1750664189681;679.0866284846873;463.47858659008614;559.608274208056;575.8992176369119;577.7568565270107;618.264265524025;7026.789196324016;7816.8827467588035;8161.877571836427;8289.83023830402;8309.584520774059;592.1147883913577;592.5230189697335;602.6835911146683;606.6633018674589;617.219217689614;3695.334839728821;3782.111203867089;3801.961980380216;3874.748141370802;3894.1432884765304;92588.14823703624;93701;93889.5305523468;94132.52933735425;94362;72666.273337267;75552;78068;78154.82767758488;79159;54547;71404.64297678582;72214.63892680503;72740.27259727335;73655.26344736484;7671.578063206577;7682.500637458547;7686.615669216405;7720.382369410321;7726.845463090819;47954.28068578905;49981.50018499768;50169.49830501794;50917.49082509128;51215.743921280155;53054;64616.67691661511;66096.66951665211;67536.6623166881;67671;8780.385373023826;10023.198144148597;10090.243231757795;10331.741706457098;10735.0338469535;11990.160688752052;12161.635150945485;12309.69225769327;12312.076594255646;12370.876291236973;11282.210245282751;11483.311001339946;11598.94200528992;11645.731211696622;11727.76544469123;11484.827727583926;11490.368029758443;11513.30920144794;11859.466324015613;12275.079369047178;10987.566412882628;11145.387003714874;11325.773484530428;11513.827292590786;11518.94240528792;9648.75878103053;9741.610335586498;9763.658271960732;10329.483525823829;10362.5336859843;9445.291603129655;9527.523623818643;9533.23734101284;9546.713598592054;9591.040895910353 05:37:18 INFO - PROCESS | 1667 | __end_tp_report 05:37:18 INFO - PROCESS | 1667 | __start_cc_report 05:37:18 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1082 05:37:18 INFO - PROCESS | 1667 | __end_cc_report 05:37:18 INFO - PROCESS | 1667 | __startTimestamp1458736638959__endTimestamp 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:37:18 INFO - PROCESS | 1667 | Number of tests: 6 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5703.20 Median:5972.28 stddev:638.72 (10.7%) stddev-sans-first:610.71 05:37:18 INFO - PROCESS | 1667 | Values: 3238.2 3444.3 3462.5 3469.2 3533.9 5480.7 5571.1 5622.7 5630.2 5660.5 5651.7 5661.8 5739.1 5771.0 5795.0 5055.2 5076.2 5101.0 5118.9 5238.7 5202.1 5258.2 5268.8 5269.7 5326.7 5090.4 5175.1 5181.0 5182.2 5197.6 5121.5 5164.2 5168.4 5199.6 5219.4 5050.0 5091.7 5100.8 5114.2 5159.3 5492.5 5610.6 5616.0 5616.9 5624.1 6129.7 6133.9 6241.4 6261.2 6268.8 6223.3 6252.2 6253.7 6258.4 6269.9 5434.6 5783.4 5788.9 5789.0 5791.9 5597.4 6180.4 6181.6 6278.7 6286.1 6128.4 6140.9 6155.5 6157.4 6196.3 6133.6 6255.5 6284.3 6286.6 6289.9 6094.2 6140.4 6187.6 6195.8 6209.5 6212.5 6230.3 6233.7 6238.8 6247.3 4790.5 4806.6 4849.9 4885.6 4921.3 4347.0 4386.2 4401.7 4441.8 4482.2 5603.6 5627.9 5670.5 5674.9 5687.1 6125.1 6249.7 6265.2 6267.3 6270.6 5115.9 5455.1 5623.5 5718.2 5742.5 5326.8 5328.9 5330.7 5332.7 5335.1 5370.3 6256.7 6272.4 6275.2 6310.2 6099.5 6151.0 6158.6 6258.7 6272.7 6255.7 6295.8 6296.6 6309.7 6314.5 5108.8 5934.5 6181.0 6198.4 6201.2 6074.2 6130.7 6139.6 6165.4 6172.1 6111.3 6121.3 6127.2 6139.7 6147.1 6100.3 6113.1 6131.2 6144.3 6155.9 5796.1 5890.8 5916.2 5972.3 5988.6 6109.9 6113.5 6122.2 6135.1 6143.5 5998.0 5999.1 6000.2 6010.4 6027.2 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:54258.12 Median:36313.18 stddev:107434.86 (295.9%) stddev-sans-first:107660.41 05:37:18 INFO - PROCESS | 1667 | Values: 494.6 579.6 582.6 634.9 635.8 38259.9 38770.6 38777.6 38822.6 38846.8 41408.0 41982.6 41992.4 42009.8 42028.0 9415.1 9438.2 9663.0 9672.4 9677.3 9411.0 9590.3 9599.5 9601.5 9610.8 9672.1 9744.9 9754.2 9760.4 9763.4 9513.9 9543.7 9631.1 9697.8 9754.0 9525.3 9578.3 9710.2 9746.4 9755.7 40451.0 40851.4 40873.4 40933.6 40947.4 3232.0 3369.2 3673.5 3819.9 3871.2 28141.6 28928.0 29307.9 29445.0 29461.3 2292.4 2742.2 2788.4 2819.5 2851.3 335410.3 338573.0 339028.2 339363.3 339825.0 44686.3 45313.8 45339.8 45395.5 61094.7 36892.4 43999.8 44136.3 44221.8 44259.6 15461.0 15608.6 15617.8 15629.1 15647.8 12478.7 12555.1 12558.3 12572.8 12791.3 14769.6 14792.9 14799.8 14825.4 14912.7 6441.9 6560.6 6573.9 6578.6 6616.1 928.9 974.7 995.5 1008.3 1062.3 29127.4 29302.6 29420.7 29721.1 29914.0 1108.7 1124.7 1151.5 1160.5 1214.9 14690.9 14787.5 14846.6 15121.0 15123.2 492855.5 496718.0 501950.0 503020.0 504910.0 57951.8 58301.7 58316.0 58516.1 58605.7 1322.3 1433.0 1444.6 1469.1 1472.6 28347.6 28771.7 28957.4 29029.7 30784.0 32316.5 46519.5 47088.5 47127.8 47149.8 355731.0 357967.0 358283.0 359745.0 360374.0 28480.9 32719.8 33185.7 33613.3 33735.8 37251.3 39122.2 41849.0 42230.6 42699.4 34000.1 34985.7 35228.5 36008.5 36353.3 30808.5 32546.0 35349.5 36520.8 36568.0 35137.6 35493.0 36205.8 36273.1 36460.3 23192.8 26882.7 30951.1 31173.7 31796.4 21752.0 23280.0 24102.5 24208.4 24242.9 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33164.85 Median:26312.00 stddev:99216.79 (377.1%) stddev-sans-first:99464.54 05:37:18 INFO - PROCESS | 1667 | Values: 358.6 359.6 360.5 370.8 372.1 19958.7 20925.4 21209.2 21457.5 21680.7 20715.8 20799.9 21535.5 21561.8 21626.5 5707.9 5928.2 5970.9 5973.6 5982.1 5537.6 5877.6 5884.0 5888.6 5889.5 5807.9 5834.4 5836.1 5838.4 5843.1 5644.5 5700.4 5777.9 5834.5 5840.5 5062.2 5107.7 5116.8 5117.0 5120.4 25888.4 26126.0 26498.0 26565.5 26568.6 2151.8 2201.6 2236.9 2245.9 2395.8 13292.7 14845.6 14962.7 15092.9 15273.5 1551.0 1739.7 1789.2 1859.0 1866.4 75228.5 99976.5 100554.2 103851.0 105619.9 10635.6 10796.7 10870.0 11064.7 11215.2 13229.7 13372.1 13458.3 13459.4 13459.9 8713.8 8799.1 8807.3 8903.9 8911.0 8983.1 8998.6 8999.4 9003.0 9099.6 6519.2 6580.9 6585.8 6607.2 6608.4 1807.9 1823.3 1836.8 1843.8 1848.1 913.7 935.7 952.3 979.0 1017.4 20454.8 20919.0 21101.9 21204.7 21324.3 939.9 946.8 949.6 984.2 1012.3 11134.6 11593.5 11618.4 11655.0 11666.8 592946.0 595189.0 605701.0 609736.0 609782.0 69577.0 89937.0 94458.0 102646.5 103479.5 984.7 1014.3 1031.2 1031.7 1032.1 17826.0 17878.7 17881.3 18397.5 18417.7 44114.8 45424.5 45845.3 45872.9 46856.5 64140.7 66449.0 66793.7 67024.7 67180.7 6280.6 7519.0 7666.3 7752.7 7791.5 12073.3 12365.9 12587.5 12617.6 12620.6 10419.3 10628.6 10690.9 10986.8 11037.3 10381.3 10561.9 10676.0 10998.5 11028.2 10442.2 10588.3 10775.9 10956.9 11215.2 7715.6 7745.2 7795.1 7873.5 8142.1 8756.4 8813.4 10688.8 10802.0 11087.6 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5995.20 Median:5315.10 stddev:3127.82 (58.8%) stddev-sans-first:3117.63 05:37:18 INFO - PROCESS | 1667 | Values: 1412.6 1550.5 1583.5 1855.2 2007.7 7843.8 8456.8 8663.5 8677.8 8680.7 8497.4 8524.7 8640.3 8640.4 8647.8 2096.5 2413.1 2439.5 2464.9 2467.0 2479.2 2480.6 2482.6 2483.0 2484.2 2383.3 2403.5 2424.9 2452.4 2452.5 2405.4 2441.6 2453.9 2458.9 2468.1 2417.4 2432.0 2433.4 2441.2 2442.1 8731.7 8807.1 8835.5 8862.3 8869.9 5360.7 5512.6 5516.3 5518.6 5523.2 3564.3 3635.8 3703.0 3711.4 3725.9 934.7 1014.6 1017.9 1024.3 1062.8 11077.7 11258.9 11260.3 11266.5 11348.4 4605.6 4614.1 4657.0 4691.8 4705.5 9167.7 9182.7 9195.8 9197.5 9197.5 5253.3 5297.7 5304.1 5313.1 5317.1 4414.0 4458.2 4466.6 4516.9 4980.8 3663.8 3689.2 3794.2 3794.8 3797.5 1169.7 1178.9 1182.3 1190.6 1197.4 1119.8 1160.8 1160.9 1349.1 1415.5 8050.3 8149.5 8187.3 8269.0 8307.1 1205.9 1213.0 1222.9 1242.3 1247.1 6226.4 6232.6 6328.6 6329.0 6331.0 10257.8 10613.6 10713.3 10725.8 10739.6 10342.3 10491.6 10548.8 10589.2 10651.0 8196.8 8343.5 8379.8 8382.4 8388.2 7879.9 7932.9 7943.7 8002.3 8019.2 9337.4 9592.7 9635.4 9743.3 9766.4 9689.6 9893.2 10043.4 10065.9 10078.2 6983.8 7011.5 7043.3 7101.1 7128.7 8239.2 8272.8 8304.6 8322.2 8322.5 7410.6 7497.6 7512.4 7646.2 7668.8 7148.5 7188.3 7240.1 7311.5 7322.5 7643.7 7800.0 7800.5 7806.1 7832.5 6969.6 6990.7 7065.2 7075.6 7076.5 7109.5 7175.0 7184.2 7185.1 7186.3 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5712.72 Median:6464.40 stddev:1828.58 (28.3%) stddev-sans-first:1788.39 05:37:18 INFO - PROCESS | 1667 | Values: 322.4 323.2 331.3 333.6 338.0 6527.9 6587.2 6596.7 6606.9 6615.6 6470.1 6479.5 6528.5 6529.1 6553.3 3844.7 4550.6 4645.5 4690.2 4844.4 4701.7 4703.6 4735.8 4748.9 4757.1 4076.8 4555.1 4716.1 4740.4 4761.5 4619.2 4676.8 4773.0 4787.7 4852.8 4075.3 4092.5 4100.0 4105.2 4111.7 6150.1 6162.8 6290.6 6301.0 6303.6 5737.1 5740.5 5755.2 5757.4 5757.9 6922.3 6923.7 6930.2 6937.7 6953.1 4506.5 4634.6 4691.2 4699.4 4720.5 7330.5 7363.8 7373.9 7385.2 7427.6 3481.1 4452.8 4571.1 4758.7 4770.3 4638.0 4831.3 4832.9 4845.8 4858.1 5681.0 5693.6 5697.5 5699.6 5704.5 6737.3 6994.2 7012.5 7024.3 7030.6 1669.5 1678.4 1686.9 1686.9 1687.8 1021.5 1085.2 1099.6 1110.5 1120.8 5680.5 5977.3 6255.2 6385.6 6441.9 7059.7 7183.7 7206.9 7208.5 7208.9 5270.4 6458.7 6571.3 6604.2 6617.8 3837.2 3886.7 3887.4 3892.4 3903.7 7356.3 7634.6 7691.2 7697.6 7699.8 6139.9 7557.0 7571.6 7580.4 7597.2 7576.3 7598.1 7615.0 7617.0 7622.0 6084.1 6840.4 7079.8 7332.6 7336.1 7206.4 7226.9 7229.5 7241.5 7242.1 7591.5 7612.8 7620.0 7625.8 7657.2 4739.1 4755.0 4759.8 4759.8 4766.3 6953.3 7237.1 7267.9 7270.7 7273.3 7035.7 7057.8 7058.0 7068.2 7072.2 6995.8 7005.7 7040.0 7047.5 7051.9 6849.7 6849.7 6875.1 6878.2 6883.2 6154.5 6673.0 6767.9 7037.2 7110.2 5535.3 6562.6 6756.6 6886.5 6906.6 05:37:18 INFO - PROCESS | 1667 | 05:37:18 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18492.49 Median:592.32 stddev:25939.93 (4379.4%) stddev-sans-first:25978.17 05:37:18 INFO - PROCESS | 1667 | Values: 666.6 706.8 725.7 756.8 810.1 16914.4 17574.2 17597.9 17675.4 17686.0 16325.9 16329.9 16428.0 16446.6 16554.2 753.2 936.5 952.0 952.7 954.7 772.1 930.4 946.8 946.9 949.2 990.8 991.3 1000.2 1003.9 1004.7 794.3 976.4 992.4 992.6 996.3 735.5 736.5 737.7 737.8 738.4 15540.2 15665.7 15669.6 15716.8 15720.1 12686.7 12700.2 12781.8 12956.9 13150.9 9097.0 10108.4 10373.6 10482.6 10795.7 3581.2 3656.9 3666.8 3679.4 3681.0 84674.0 85768.6 87926.6 88263.6 88620.6 7769.8 9422.1 9518.4 9645.0 10012.5 21588.4 21806.8 21913.8 21936.2 21940.5 7337.9 7447.0 7477.5 7504.8 7659.1 4085.9 4117.6 4173.0 4175.8 4198.3 3628.6 3687.9 3689.6 3712.3 3716.2 653.7 671.6 673.8 676.2 679.1 463.5 559.6 575.9 577.8 618.3 7026.8 7816.9 8161.9 8289.8 8309.6 592.1 592.5 602.7 606.7 617.2 3695.3 3782.1 3802.0 3874.7 3894.1 92588.1 93701.0 93889.5 94132.5 94362.0 72666.3 75552.0 78068.0 78154.8 79159.0 54547.0 71404.6 72214.6 72740.3 73655.3 7671.6 7682.5 7686.6 7720.4 7726.8 47954.3 49981.5 50169.5 50917.5 51215.7 53054.0 64616.7 66096.7 67536.7 67671.0 8780.4 10023.2 10090.2 10331.7 10735.0 11990.2 12161.6 12309.7 12312.1 12370.9 11282.2 11483.3 11598.9 11645.7 11727.8 11484.8 11490.4 11513.3 11859.5 12275.1 10987.6 11145.4 11325.8 11513.8 11518.9 9648.8 9741.6 9763.7 10329.5 10362.5 9445.3 9527.5 9533.2 9546.7 9591.0 05:37:18 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:37:18 INFO - PROCESS | 1667 | 05:37:19 INFO - TEST-INFO | 1667: exit 0 05:37:19 INFO - TEST-OK | dromaeo_css | took 1113209ms 05:37:19 INFO - TEST-START | kraken 05:37:19 INFO - operating with platform_type : mac_ 05:37:19 INFO - Initialising browser for kraken test... 05:37:19 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp8BO5mN/profile http://localhost:49271/getInfo.html) 05:37:21 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 05:37:21 INFO - PROCESS | 1675 | colorDepth:24 05:37:21 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 05:37:21 INFO - PROCESS | 1675 | __metrics 05:37:21 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:37:21 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:37:22 INFO - TEST-INFO | 1675: exit 0 05:37:22 INFO - Browser initialized. 05:37:22 INFO - Running cycle 1/1 for kraken test... 05:37:22 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp8BO5mN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:34 INFO - PROCESS | 1678 | RSS: Main: 247492608 05:37:34 INFO - PROCESS | 1678 | 05:37:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:37 INFO - PROCESS | 1678 | RSS: Main: 291442688 05:37:37 INFO - PROCESS | 1678 | 05:37:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 05:37:40 INFO - PROCESS | 1678 | RSS: Main: 302809088 05:37:40 INFO - PROCESS | 1678 | 05:37:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 05:37:44 INFO - PROCESS | 1678 | RSS: Main: 287952896 05:37:44 INFO - PROCESS | 1678 | 05:37:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 05:37:47 INFO - PROCESS | 1678 | RSS: Main: 291254272 05:37:47 INFO - PROCESS | 1678 | 05:37:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:49 INFO - PROCESS | 1678 | RSS: Main: 292052992 05:37:49 INFO - PROCESS | 1678 | 05:37:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:53 INFO - PROCESS | 1678 | RSS: Main: 293285888 05:37:53 INFO - PROCESS | 1678 | 05:37:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:56 INFO - PROCESS | 1678 | RSS: Main: 292728832 05:37:56 INFO - PROCESS | 1678 | 05:37:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 05:38:00 INFO - PROCESS | 1678 | RSS: Main: 293285888 05:38:00 INFO - PROCESS | 1678 | 05:38:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:02 INFO - PROCESS | 1678 | RSS: Main: 325955584 05:38:02 INFO - PROCESS | 1678 | 05:38:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:04 INFO - PROCESS | 1678 | RSS: Main: 325234688 05:38:04 INFO - PROCESS | 1678 | 05:38:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:07 INFO - PROCESS | 1678 | RSS: Main: 333262848 05:38:07 INFO - PROCESS | 1678 | 05:38:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:10 INFO - PROCESS | 1678 | RSS: Main: 335257600 05:38:10 INFO - PROCESS | 1678 | 05:38:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:13 INFO - PROCESS | 1678 | RSS: Main: 334663680 05:38:13 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 05:38:15 INFO - PROCESS | 1678 | RSS: Main: 394485760 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | __start_tp_report 05:38:15 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 05:38:15 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 05:38:15 INFO - PROCESS | 1678 | |i|pagename|runs| 05:38:15 INFO - PROCESS | 1678 | |0;ai-astar;110;107;110;109;109;110;115;110;110;110 05:38:15 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;124;139;157;119;140;162;148;156;120 05:38:15 INFO - PROCESS | 1678 | |2;audio-dft;184;185;184;182;184;183;183;180;181;179 05:38:15 INFO - PROCESS | 1678 | |3;audio-fft;73;79;85;78;56;58;58;78;75;55 05:38:15 INFO - PROCESS | 1678 | |4;audio-oscillator;87;94;126;80;78;86;114;78;78;117 05:38:15 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;85;86;84;91;130;116;85;86;83 05:38:15 INFO - PROCESS | 1678 | |6;imaging-darkroom;137;92;93;93;111;150;149;92;92;92 05:38:15 INFO - PROCESS | 1678 | |7;imaging-desaturate;86;87;86;86;87;84;86;87;86;84 05:38:15 INFO - PROCESS | 1678 | |8;json-parse-financial;57;56;54;54;54;54;55;65;57;53 05:38:15 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;62;68;65;72;69;68;66;65;66;68 05:38:15 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;82;82;83;82;83;82;82;82;84;83 05:38:15 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;120;127;120;119;140;127;126;127;117;120 05:38:15 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;137;127;138;137;138;124;136;137;136;135 05:38:15 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;67;67;67;66;67 05:38:15 INFO - PROCESS | 1678 | __end_tp_report 05:38:15 INFO - PROCESS | 1678 | __start_cc_report 05:38:15 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1199 05:38:15 INFO - PROCESS | 1678 | __end_cc_report 05:38:15 INFO - PROCESS | 1678 | __startTimestamp1458736695345__endTimestamp 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | ------- Summary: start ------- 05:38:15 INFO - PROCESS | 1678 | Number of tests: 14 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:2.12 05:38:15 INFO - PROCESS | 1678 | Values: 110.0 107.0 110.0 109.0 109.0 110.0 115.0 110.0 110.0 110.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:151.00 stddev:16.16 (10.7%) stddev-sans-first:16.54 05:38:15 INFO - PROCESS | 1678 | Values: 154.0 124.0 139.0 157.0 119.0 140.0 162.0 148.0 156.0 120.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.50 stddev:1.96 (1.1%) stddev-sans-first:2.00 05:38:15 INFO - PROCESS | 1678 | Values: 184.0 185.0 184.0 182.0 184.0 183.0 183.0 180.0 181.0 179.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:69.50 Median:76.50 stddev:11.42 (14.9%) stddev-sans-first:12.05 05:38:15 INFO - PROCESS | 1678 | Values: 73.0 79.0 85.0 78.0 56.0 58.0 58.0 78.0 75.0 55.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:79.00 stddev:18.35 (23.2%) stddev-sans-first:19.29 05:38:15 INFO - PROCESS | 1678 | Values: 87.0 94.0 126.0 80.0 78.0 86.0 114.0 78.0 78.0 117.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:85.50 stddev:16.14 (18.9%) stddev-sans-first:16.96 05:38:15 INFO - PROCESS | 1678 | Values: 87.0 85.0 86.0 84.0 91.0 130.0 116.0 85.0 86.0 83.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:110.10 Median:92.00 stddev:25.22 (27.4%) stddev-sans-first:24.80 05:38:15 INFO - PROCESS | 1678 | Values: 137.0 92.0 93.0 93.0 111.0 150.0 149.0 92.0 92.0 92.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.10 (1.3%) stddev-sans-first:1.17 05:38:15 INFO - PROCESS | 1678 | Values: 86.0 87.0 86.0 86.0 87.0 84.0 86.0 87.0 86.0 84.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:3.48 (6.3%) stddev-sans-first:3.67 05:38:15 INFO - PROCESS | 1678 | Values: 57.0 56.0 54.0 54.0 54.0 54.0 55.0 65.0 57.0 53.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:68.00 stddev:2.73 (4.0%) stddev-sans-first:2.24 05:38:15 INFO - PROCESS | 1678 | Values: 62.0 68.0 65.0 72.0 69.0 68.0 66.0 65.0 66.0 68.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 05:38:15 INFO - PROCESS | 1678 | Values: 82.0 82.0 83.0 82.0 83.0 82.0 82.0 82.0 84.0 83.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:126.50 stddev:6.73 (5.3%) stddev-sans-first:6.96 05:38:15 INFO - PROCESS | 1678 | Values: 120.0 127.0 120.0 119.0 140.0 127.0 126.0 127.0 117.0 120.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.50 Median:137.00 stddev:4.88 (3.6%) stddev-sans-first:5.09 05:38:15 INFO - PROCESS | 1678 | Values: 137.0 127.0 138.0 137.0 138.0 124.0 136.0 137.0 136.0 135.0 05:38:15 INFO - PROCESS | 1678 | 05:38:15 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 05:38:15 INFO - PROCESS | 1678 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 05:38:15 INFO - PROCESS | 1678 | -------- Summary: end -------- 05:38:15 INFO - PROCESS | 1678 | 05:38:16 INFO - TEST-INFO | 1678: exit 0 05:38:16 INFO - TEST-OK | kraken | took 56552ms 05:38:16 INFO - SUITE-END | took 1169s 05:38:16 INFO - Completed test suite (00:19:30) 05:38:16 INFO - javascript benchmark 05:38:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3238.206639373353, 3444.2594842108942, 3462.463318185682, 3469.1500582357326, 3533.8939831805037, 5480.725963701809, 5571.0807716726795, 5622.690752008638, 5630.239917611121, 5660.5471562275025, 5651.717414129298, 5661.830145095643, 5739.139129130633, 5771.0, 5795.043817770063, 5055.1658976269055, 5076.187809950408, 5101.0, 5118.948810511884, 5238.711870847102, 5202.06362854686, 5258.211268309746, 5268.841934741964, 5269.736513174345, 5326.6537675051195, 5090.363704536914, 5175.094358487249, 5180.974095129538, 5182.222666600002, 5197.610179236553, 5121.462246464105, 5164.2253661950635, 5168.405633352175, 5199.6360254782185, 5219.42586315505, 5049.990001999615, 5091.694498330112, 5100.846974590731, 5114.156164232934, 5159.303494028333, 5492.47821456961, 5610.607257491977, 5615.971920140414, 5616.943830561724, 5624.128260119688, 6129.693515324216, 6133.885575987434, 6241.438270555672, 6261.186045814015, 6268.811935641938, 6223.346548612421, 6252.18721566198, 6253.7185826637915, 6258.374162583706, 6269.87460250797, 5434.64674796137, 5783.392743761887, 5788.900108979323, 5788.971055144697, 5791.855203619901, 5597.412271711411, 6180.381961803873, 6181.567290289637, 6278.748850046039, 6286.119943207955, 6128.387161283925, 6140.8771824564155, 6155.47678447337, 6157.4458298753325, 6196.318404975449, 6133.570650054453, 6255.499560035186, 6284.340144284784, 6286.5599408041, 6289.937100629027, 6094.169091873675, 6140.4473597376455, 6187.628742275478, 6195.81412557624, 6209.5032397408095, 6212.502999760009, 6230.345813689497, 6233.688315584202, 6238.75044998195, 6247.250329960434, 4790.5448982346625, 4806.639502037361, 4849.927251091236, 4885.560299572984, 4921.261810728348, 4347.000189956265, 4386.232409328355, 4401.7358958461955, 4441.7779111044965, 4482.193205223091, 5603.579731520153, 5627.943720562824, 5670.5463562914865, 5674.858128546819, 5687.118496633028, 6125.113363430769, 6249.6562689052535, 6265.216847894013, 6267.341929097379, 6270.561060725797, 5115.897682046412, 5455.072637651609, 5623.5220006299105, 5718.170865224519, 5742.454466825645, 5326.840194794162, 5328.92006619901, 5330.706811125426, 5332.653377530448, 5335.11970524859, 5370.301860758076, 6256.687165641609, 6272.40412160844, 6275.184226050585, 6310.211223597051, 6099.521645064636, 6150.969245153746, 6158.599691020069, 6258.718357673824, 6272.655003974643, 6255.749770009149, 6295.779647712308, 6296.590721603081, 6309.716062777278, 6314.4632706218645, 5108.795648174031, 5934.525237981037, 6181.0, 6198.442140207223, 6201.193844800147, 6074.240719910012, 6130.734471166852, 6139.584134579286, 6165.445109940127, 6172.135900973957, 6111.257501106225, 6121.265448146251, 6127.220070483952, 6139.741353022709, 6147.108669243024, 6100.302186760357, 6113.081058500098, 6131.156386454651, 6144.324124346408, 6155.907661384993, 5796.130580412803, 5890.764369425175, 5916.171735956884, 5972.283326000907, 5988.640681558946, 6109.910512419943, 6113.463251060979, 6122.173506576733, 6135.14108024868, 6143.464133966509, 5997.970010149921, 5999.130126131599, 6000.249968753906, 6010.368911264429, 6027.156198132177], "unit": "score", "name": "dojo.html", "value": 5663.084962996793}, {"lowerIsBetter": false, "replicates": [494.61420092327995, 579.556639171034, 582.5601670738589, 634.936506349365, 635.7520566978878, 38259.852204433875, 38770.61229387705, 38777.61222387779, 38822.61177388225, 38846.80576597116, 41408.0, 41982.58017419825, 41992.37011444823, 42009.7899510502, 42028.0, 9415.105564971316, 9438.19775319097, 9663.0, 9672.419654820733, 9677.322587418883, 9411.0, 9590.328676992613, 9599.4720290384, 9601.519924003807, 9610.75973100671, 9672.081152290557, 9744.90255097447, 9754.170895473893, 9760.365576237522, 9763.414195148278, 9513.90486095137, 9543.713688589354, 9631.085046920567, 9697.757556061155, 9754.0, 9525.333226674136, 9578.281628877861, 9710.17463515602, 9746.415215087118, 9755.707328780078, 40451.0, 40851.38722919158, 40873.386899196536, 40933.59066409357, 40947.385789213185, 3232.046546268833, 3369.22507823202, 3673.540807399075, 3819.8731374244667, 3871.1676989447406, 28141.57787633187, 28927.987520436895, 29307.85346073256, 29445.0, 29461.263468413246, 2292.403974966504, 2742.204760619418, 2788.3726161613677, 2819.4783964966546, 2851.2871782054485, 335410.3229483837, 338573.0, 339028.21943560994, 339363.303183485, 339825.0, 44686.32970505445, 45313.773431132635, 45339.77330113328, 45395.54604453979, 61094.694526527084, 36892.446613300825, 43999.78000109979, 44136.3379549307, 44221.778891105336, 44259.55740442554, 15461.0, 15608.609784755472, 15617.828662850332, 15629.14039727826, 15647.765283520755, 12478.688032799071, 12555.121141520189, 12558.309292988974, 12572.811407828889, 12791.296478693575, 14769.556913292618, 14792.890533210053, 14799.778003329959, 14825.40698372053, 14912.70174596502, 6441.903371449432, 6560.606363618198, 6573.868522629521, 6578.572392794453, 6616.073749675049, 928.9117533834275, 974.6929717139078, 995.5072239241622, 1008.2790804574764, 1062.3413483640193, 29127.417451650846, 29302.560461593093, 29420.705792942226, 29721.10836674903, 29914.0, 1108.7373647459128, 1124.662601219631, 1151.5163631274884, 1160.495184594704, 1214.9331786751636, 14690.926545367205, 14787.482438114614, 14846.628834279014, 15121.017133886262, 15123.16822574747, 492855.5357223191, 496718.0, 501950.0, 503020.0, 504910.0, 57951.8409631805, 58301.66793328304, 58316.0, 58516.122258166164, 58605.70697146487, 1322.3123975532862, 1432.957011289663, 1444.5738507140418, 1469.1478942213491, 1472.639203395175, 28347.57478637781, 28771.671703514825, 28957.42085158243, 29029.7097029027, 30784.0, 32316.515252271704, 46519.53480465152, 47088.52911470841, 47127.76436117797, 47149.7642511799, 355731.0, 357967.0, 358283.0, 359745.0, 360374.0, 28480.85759571189, 32719.836400817843, 33185.66814331826, 33613.327733444705, 33735.83132084422, 37251.323690433455, 39122.21755564816, 41849.0, 42230.577694222666, 42699.35950960676, 34000.1499962493, 34985.65014349824, 35228.47157292591, 36008.4598731014, 36353.27293454063, 30808.53787193239, 32546.0, 35349.469757953135, 36520.81739591285, 36568.0, 35137.648623513436, 35493.0, 36205.81897090498, 36273.093172670895, 36460.270794583426, 23192.84035798237, 26882.73117268802, 30951.071467856, 31173.688263117077, 31796.36407271888, 21752.021159047563, 23279.952402141607, 24102.52328265592, 24208.394790130387, 24242.87878560596], "unit": "score", "name": "ext.html", "value": 18546.392707320945}, {"lowerIsBetter": false, "replicates": [358.5715070490764, 359.5703134753969, 360.54571240237294, 370.83127177134406, 372.1069433359936, 19958.70061949072, 20925.37223883284, 21209.15163393464, 21457.46356341092, 21680.674789878165, 20715.792842071576, 20799.896000520013, 21535.461613459673, 21561.784382156173, 21626.459338516546, 5707.942920570793, 5928.2293301870695, 5970.8805823883495, 5973.551983601225, 5982.132590774335, 5537.640053396516, 5877.588568800185, 5883.970580147115, 5888.617239879394, 5889.469947704706, 5807.854803629901, 5834.445727655866, 5836.066229403296, 5838.357780644125, 5843.123531470293, 5644.4637759413, 5700.429957004308, 5777.942220577804, 5834.504067154255, 5840.532757379399, 5062.164742817431, 5107.693538387672, 5116.797552575142, 5116.974415127937, 5120.385553733576, 25888.352791180183, 26126.0, 26498.0, 26565.468690626272, 26568.601470977952, 2151.7955794199684, 2201.559688062394, 2236.865788052722, 2245.932622021342, 2395.8203134764963, 13292.667683307898, 14845.628859278497, 14962.700745985128, 15092.868034897427, 15273.541793746206, 1550.9686058770903, 1739.7303417970236, 1789.2038043070838, 1858.9814101859079, 1866.3747644539096, 75228.49777361179, 99976.50011749967, 100554.2210445505, 103851.0, 105619.94380056178, 10635.627753028606, 10796.730081747863, 10870.0, 11064.723381915355, 11215.158863085302, 13229.73540529184, 13372.06395552302, 13458.259795711134, 13459.394327255297, 13459.93270033663, 8713.782155446164, 8799.12008799115, 8807.251383632463, 8903.910960890438, 8910.955445222862, 8983.146601072887, 8998.59506322217, 8999.37004409698, 9002.954985225031, 9099.590518426687, 6519.185101862267, 6580.901286480706, 6585.769498067544, 6607.240167380716, 6608.43828274602, 1807.9186436610385, 1823.3253696132515, 1836.7520384748154, 1843.824836640517, 1848.0759620189906, 913.7213149989317, 935.7426707655313, 952.3238500664605, 979.0014185530719, 1017.3692310767372, 20454.795452045288, 20919.0, 21101.894490527757, 21204.681929771064, 21324.253651122137, 939.915407613318, 946.7585765629858, 949.5584553182803, 984.158544444504, 1012.3015119567475, 11134.61028864002, 11593.536258549731, 11618.419079046014, 11655.009324207367, 11666.766664666658, 592946.0, 595189.0, 605700.9714951398, 609736.0, 609782.0, 69577.0, 89937.0, 94458.0, 102646.48676756569, 103479.48260258802, 984.6898227058454, 1014.2554805733978, 1031.231732359397, 1031.7162780235344, 1032.0762917189224, 17826.0, 17878.731819022985, 17881.28474860991, 18397.54006149857, 18417.723734144267, 44114.779426102665, 45424.54575454335, 45845.31232031589, 45872.8531786708, 46856.53143468522, 64140.679296605085, 66449.0032649501, 66793.66603166953, 67024.66487667726, 67180.65638687297, 6280.623162610258, 7518.990856621694, 7666.278471142664, 7752.712949679971, 7791.4935529190425, 12073.335966521925, 12365.876341236473, 12587.496500139892, 12617.621471355875, 12620.55828046014, 10419.322744021614, 10628.627998020032, 10690.893091069302, 10986.780264394507, 11037.337759734442, 10381.325213861075, 10561.947190264, 10676.039156475645, 10998.505067271832, 11028.22802403856, 10442.216833737348, 10588.311759735592, 10775.892241077489, 10956.945215273872, 11215.214934954474, 7715.57564333967, 7745.22547745221, 7795.142534321107, 7873.5275883447175, 8142.063662678867, 8756.4308319959, 8813.42712723671, 10688.786224275627, 10802.0, 11087.611933582286], "unit": "score", "name": "jquery.html", "value": 9441.824308780499}, {"lowerIsBetter": false, "replicates": [1412.6044707481908, 1550.4650895441073, 1583.5328578069468, 1855.1559040636512, 2007.7289565908607, 7843.76468705939, 8456.830863382736, 8663.480191188526, 8677.826443471127, 8680.73957781266, 8497.405181637288, 8524.744257672264, 8640.265577425926, 8640.351973601973, 8647.827043459127, 2096.486360841596, 2413.0589070262613, 2439.48770758141, 2464.8890799914047, 2467.0, 2479.1818699829014, 2480.5659009673327, 2482.590372588521, 2483.044028049205, 2484.167803785725, 2383.3157918364736, 2403.495265994143, 2424.9393765155924, 2452.3623857796924, 2452.5217582571318, 2405.374602603336, 2441.6093425051995, 2453.8895749691305, 2458.938526536833, 2468.0991438125134, 2417.4439878827966, 2431.963520547193, 2433.3673244956262, 2441.2432146034607, 2442.096424322994, 8731.738047858575, 8807.119288071142, 8835.469871807712, 8862.291016718647, 8869.86695199566, 5360.678359298455, 5512.586556008276, 5516.255305533742, 5518.613697041209, 5523.199136125279, 3564.269324788412, 3635.781853088823, 3702.981485092584, 3711.3690672585453, 3725.8882233533036, 934.6728644974205, 1014.5840205515703, 1017.9440130792804, 1024.2727663359024, 1062.7715041266088, 11077.723056923562, 11258.887411125948, 11260.268082574607, 11266.549338026469, 11348.432578371048, 4605.631549476034, 4614.146382919171, 4657.045305712389, 4691.812327506861, 4705.529447055267, 9167.679131230376, 9182.67860624875, 9195.816083678288, 9197.49413782235, 9197.494137822485, 5253.343332083489, 5297.655652382583, 5304.124819404755, 5313.123334649817, 5317.069512835238, 4414.006848459071, 4458.242098843204, 4466.553344665507, 4516.9096618068115, 4980.77586508608, 3663.7618554793853, 3689.2252626948107, 3794.2221844521805, 3794.753341032824, 3797.5063241778394, 1169.6724917023248, 1178.9469473873696, 1182.3201659046083, 1190.565443613075, 1197.4012993503247, 1119.8264269038311, 1160.7504386556932, 1160.8606967163994, 1349.1230700045048, 1415.4833485777617, 8050.31572316348, 8149.511029338259, 8187.26314631686, 8269.04905935825, 8307.127751586117, 1205.9397030148457, 1212.9514819407302, 1222.8777122287877, 1242.3229340009716, 1247.1394737631188, 6226.377362263828, 6232.594881332699, 6328.6202827830475, 6329.0, 6331.0, 10257.794844103226, 10613.628523001658, 10713.303635263683, 10725.766536848207, 10739.624113156002, 10342.327748696462, 10491.580336786596, 10548.841767373495, 10589.15286777056, 10651.041406273473, 8196.754097377088, 8343.457675251211, 8379.790505237417, 8382.371322150862, 8388.245057944814, 7879.921200787919, 7932.920670793218, 7943.682252709827, 8002.3198028165925, 8019.1579884111325, 9337.439753614804, 9592.712218633453, 9635.421874687541, 9743.26925480606, 9766.36518626287, 9689.563969621244, 9893.159081478156, 10043.397396156253, 10065.899341006496, 10078.244131690299, 6983.790486285419, 7011.544249623758, 7043.2604576518725, 7101.076860008166, 7128.679209435484, 8239.176082391712, 8272.83454330922, 8304.626291817003, 8322.20939010793, 8322.45904016237, 7410.555366678017, 7497.625118743932, 7512.436567257587, 7646.197149299243, 7668.769936901902, 7148.535345202546, 7188.28117188277, 7240.1311842579225, 7311.451641127043, 7322.524035937647, 7643.7324693635455, 7800.0, 7800.45396822217, 7806.102298235775, 7832.530048197126, 6969.616671083139, 6990.685419156049, 7065.187503437171, 7075.575465472089, 7076.469264805057, 7109.537880037781, 7175.0, 7184.1738200105565, 7185.101862267216, 7186.281371862772], "unit": "score", "name": "mootools.html", "value": 4894.064566711195}, {"lowerIsBetter": false, "replicates": [322.36333241847353, 323.2065279738243, 331.3158328052573, 333.6380027669979, 338.018057542838, 6527.869442611145, 6587.2424671162835, 6596.6581863438505, 6606.933930660698, 6615.610721748427, 6470.126532918055, 6479.514036447262, 6528.4777217822575, 6529.085927970076, 6553.311902250267, 3844.692424606025, 4550.635949124062, 4645.4657714362775, 4690.202665546865, 4844.442889067758, 4701.670883038171, 4703.6472264580125, 4735.763211839394, 4748.9077512172225, 4757.1437141314545, 4076.77696690993, 4555.111753208126, 4716.103940251359, 4740.431148262213, 4761.523847615245, 4619.214733495314, 4676.789544470507, 4772.9976704892015, 4787.6648634595595, 4852.805887764485, 4075.32757095079, 4092.5088989321175, 4099.97950010251, 4105.178964207171, 4111.691623128278, 6150.108234306045, 6162.784302549389, 6290.591111577779, 6301.0, 6303.55875088744, 5737.053386191315, 5740.512056475204, 5755.22304488897, 5757.395473475309, 5757.942420575824, 6922.342377474132, 6923.723051077951, 6930.20302665195, 6937.68780404883, 6953.096097507342, 4506.459224893001, 4634.582887540138, 4691.15559199344, 4699.436067671867, 4720.527947205286, 7330.523515971445, 7363.815904602374, 7373.930780036918, 7385.224551422077, 7427.554346739213, 3481.060113769268, 4452.777361131931, 4571.085782843445, 4758.714477131383, 4770.332153498513, 4637.976810115928, 4831.323614693945, 4832.9275060874115, 4845.781939812717, 4858.1012512685265, 5681.005823980787, 5693.601447898607, 5697.544196464273, 5699.572532060112, 5704.543636509069, 6737.292584278678, 6994.195667498303, 7012.474064445187, 7024.297570242935, 7030.613316267552, 1669.4824604372684, 1678.3706110208673, 1686.9072201029062, 1686.9240884160242, 1687.7974643042915, 1021.5198856537415, 1085.2132204152085, 1099.5766629847567, 1110.4558766204502, 1120.8206686930052, 5680.488756011896, 5977.3126090500145, 6255.186825712628, 6385.584936979081, 6441.903371449432, 7059.717611295593, 7183.676734546958, 7206.891896621555, 7208.459365547605, 7208.855822883618, 5270.393904700932, 6458.6770661466735, 6571.277159512545, 6604.174478190226, 6617.841877671388, 3837.175007373428, 3886.7279290449396, 3887.4168874669026, 3892.3966785148345, 3903.6681882039775, 7356.337929586363, 7634.580098094547, 7691.192859534566, 7697.615119244016, 7699.769006929801, 6139.907901381483, 7557.0, 7571.583562903983, 7580.3556697681315, 7597.202293759186, 7576.28025337592, 7598.126215485179, 7615.0, 7616.961915190389, 7622.0, 6084.14821924922, 6840.41856442208, 7079.82300442493, 7332.633368331455, 7336.082989626297, 7206.351428371262, 7226.855462890608, 7229.530080544748, 7241.493095483265, 7242.094738157731, 7591.506552074097, 7612.8477430449975, 7619.961900190464, 7625.809354766176, 7657.234276572298, 4739.123262196505, 4755.048990202043, 4759.762011899322, 4759.833405830779, 4766.3327134200545, 6953.304669533006, 7237.131544214728, 7267.927320726725, 7270.709171633075, 7273.3453989141235, 7035.683394247373, 7057.752978645723, 7057.964710176621, 7068.222495525385, 7072.186698529735, 6995.755148569776, 7005.684744186626, 7040.014397984389, 7047.541909775849, 7051.858962820817, 6849.691763870538, 6849.7260109597055, 6875.140607424072, 6878.209005964378, 6883.208431030495, 6154.476869466145, 6673.0, 6767.932320676927, 7037.1555413350725, 7110.217876033736, 5535.25274087993, 6562.573432726857, 6756.560823546453, 6886.51794374389, 6906.551074180162], "unit": "score", "name": "prototype.html", "value": 5108.493085034271}, {"lowerIsBetter": false, "replicates": [666.5833853841349, 706.7879636109166, 725.7133432294244, 756.7654027251551, 810.0805585660274, 16914.407995720136, 17574.209160587787, 17597.912010439944, 17675.381361652344, 17686.0, 16325.91837040816, 16329.938553993981, 16428.01431914083, 16446.588835279123, 16554.172291385414, 753.1940823319023, 936.4708939449206, 951.9619215231382, 952.6998995316487, 954.6897258391016, 772.0503780350173, 930.4091901642472, 946.8106378724249, 946.8721722567468, 949.1647350331733, 990.8414653655417, 991.2664628175135, 1000.2348203624233, 1003.9196864250843, 1004.6684594083971, 794.3486341200161, 976.4190306767462, 992.3797626483448, 992.6327258914212, 996.3374356053216, 735.5292612727804, 736.4697417859132, 737.6717360774458, 737.8229224986019, 738.3539403022355, 15540.222988850512, 15665.686686266325, 15669.608259793482, 15716.764248536281, 15720.135392553406, 12686.682832929251, 12700.174488658207, 12781.808272875915, 12956.870431295662, 13150.934245328712, 9096.999330073686, 10108.39349639024, 10373.585056597727, 10482.58069677212, 10795.730106747316, 3581.230035542345, 3656.926861462756, 3666.77999320039, 3679.356112680297, 3681.0, 84674.0, 85768.57115714444, 87926.5603671984, 88263.55868220617, 88620.55689721575, 7769.844603107907, 9422.120549035264, 9518.381305215138, 9645.035496450299, 10012.499375031364, 21588.35234942954, 21806.781932180475, 21913.780862191175, 21936.232231871807, 21940.45148871291, 7337.88993165103, 7447.0, 7477.513961592479, 7504.812379690551, 7659.080910290801, 4085.8569950051606, 4117.608827161415, 4172.979135104305, 4175.812088456027, 4198.265303571863, 3628.5827129880404, 3687.9262414752093, 3689.5572531296416, 3712.276106159327, 3716.2381711749567, 653.6698967021624, 671.5601281160848, 673.7877568565887, 676.1750664189681, 679.0866284846873, 463.47858659008614, 559.608274208056, 575.8992176369119, 577.7568565270107, 618.264265524025, 7026.789196324016, 7816.8827467588035, 8161.877571836427, 8289.83023830402, 8309.584520774059, 592.1147883913577, 592.5230189697335, 602.6835911146683, 606.6633018674589, 617.219217689614, 3695.334839728821, 3782.111203867089, 3801.961980380216, 3874.748141370802, 3894.1432884765304, 92588.14823703624, 93701.0, 93889.5305523468, 94132.52933735425, 94362.0, 72666.273337267, 75552.0, 78068.0, 78154.82767758488, 79159.0, 54547.0, 71404.64297678582, 72214.63892680503, 72740.27259727335, 73655.26344736484, 7671.578063206577, 7682.500637458547, 7686.615669216405, 7720.382369410321, 7726.845463090819, 47954.28068578905, 49981.50018499768, 50169.49830501794, 50917.49082509128, 51215.743921280155, 53054.0, 64616.67691661511, 66096.66951665211, 67536.6623166881, 67671.0, 8780.385373023826, 10023.198144148597, 10090.243231757795, 10331.741706457098, 10735.0338469535, 11990.160688752052, 12161.635150945485, 12309.69225769327, 12312.076594255646, 12370.876291236973, 11282.210245282751, 11483.311001339946, 11598.94200528992, 11645.731211696622, 11727.76544469123, 11484.827727583926, 11490.368029758443, 11513.30920144794, 11859.466324015613, 12275.079369047178, 10987.566412882628, 11145.387003714874, 11325.773484530428, 11513.827292590786, 11518.94240528792, 9648.75878103053, 9741.610335586498, 9763.658271960732, 10329.483525823829, 10362.5336859843, 9445.291603129655, 9527.523623818643, 9533.23734101284, 9546.713598592054, 9591.040895910353], "unit": "score", "name": "yui.html", "value": 7006.126348781054}], "name": "dromaeo_css", "value": 7469.765780090517}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 110.0, 109.0, 109.0, 110.0, 115.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 139.0, 157.0, 119.0, 140.0, 162.0, 148.0, 156.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 184.0, 182.0, 184.0, 183.0, 183.0, 180.0, 181.0, 179.0], "unit": "score", "name": "audio-dft", "value": 182.5}, {"lowerIsBetter": true, "replicates": [73.0, 79.0, 85.0, 78.0, 56.0, 58.0, 58.0, 78.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.5}, {"lowerIsBetter": true, "replicates": [87.0, 94.0, 126.0, 80.0, 78.0, 86.0, 114.0, 78.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 84.0, 91.0, 130.0, 116.0, 85.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.3}, {"lowerIsBetter": true, "replicates": [137.0, 92.0, 93.0, 93.0, 111.0, 150.0, 149.0, 92.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 110.1}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 86.0, 87.0, 84.0, 86.0, 87.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 54.0, 54.0, 54.0, 54.0, 55.0, 65.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 65.0, 72.0, 69.0, 68.0, 66.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 82.0, 83.0, 82.0, 82.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 120.0, 119.0, 140.0, 127.0, 126.0, 127.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [137.0, 127.0, 138.0, 137.0, 138.0, 124.0, 136.0, 137.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1417.8999999999996}]} 05:38:16 INFO - Return code: 0 05:38:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:16 ERROR - # TBPL SUCCESS # 05:38:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:16 INFO - 2016-03-23 05:38:16.657 screenresolution[1682:9612] starting screenresolution argv=screenresolution get 05:38:16 INFO - 2016-03-23 05:38:16.659 screenresolution[1682:9612] Display 0: 1600x1200x32@60 05:38:16 INFO - 2016-03-23 05:38:16.665 screenresolution[1683:9615] starting screenresolution argv=screenresolution list 05:38:16 INFO - Available Modes on Display 0 05:38:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:16 INFO - Intel Iris: 05:38:16 INFO - Chipset Model: Intel Iris 05:38:16 INFO - Type: GPU 05:38:16 INFO - Bus: Built-In 05:38:16 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:16 INFO - Vendor: Intel (0x8086) 05:38:16 INFO - Device ID: 0x0a2e 05:38:16 INFO - Revision ID: 0x0009 05:38:16 INFO - Displays: 05:38:16 INFO - Display: 05:38:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:16 INFO - Display Serial Number: 1600x1200 60 05:38:16 INFO - Main Display: Yes 05:38:16 INFO - Mirror: Off 05:38:16 INFO - Online: Yes 05:38:16 INFO - Rotation: Supported 05:38:16 INFO - Return code: 0 05:38:16 INFO - Running post-action listener: _resource_record_post_action 05:38:16 INFO - Running post-run listener: _resource_record_post_run 05:38:17 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39745024; Write bytes: 706719744; Read time: 460; Write time: 2070 05:38:17 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 384664064; Write bytes: 374625792; Read time: 28456; Write time: 659 05:38:17 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33578496; Write bytes: 300087296; Read time: 372; Write time: 1265 05:38:17 INFO - Running post-run listener: _upload_blobber_files 05:38:17 INFO - Blob upload gear active. 05:38:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:38:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:38:19 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:38:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:21 INFO - (blobuploader) - INFO - Done attempting. 05:38:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:38:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:38:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:24 INFO - (blobuploader) - INFO - Done attempting. 05:38:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:24 INFO - Return code: 0 05:38:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344ffa5e2ec6221cba801022959cf1dd5c7aa5ccaaca1e1b290de22d258186d35e688de72d65d84b427cd6fc61ca91eb4296f01d32740a0441a66691ebdfb8fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac25c01b0ef4a5dfdb08eda4805c81bdd5347a324e863f63ad28c4795031dd0df50abce72e5178fef2c4baaebe71a2ab4778397dd8979662f158702c7a4e149"} 05:38:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:24 INFO - Contents: 05:38:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344ffa5e2ec6221cba801022959cf1dd5c7aa5ccaaca1e1b290de22d258186d35e688de72d65d84b427cd6fc61ca91eb4296f01d32740a0441a66691ebdfb8fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac25c01b0ef4a5dfdb08eda4805c81bdd5347a324e863f63ad28c4795031dd0df50abce72e5178fef2c4baaebe71a2ab4778397dd8979662f158702c7a4e149"} 05:38:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:24 INFO - Copying logs to upload dir... 05:38:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.992372 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-03-23 05:38:24.499752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 05:38:24.505289) ========= 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.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344ffa5e2ec6221cba801022959cf1dd5c7aa5ccaaca1e1b290de22d258186d35e688de72d65d84b427cd6fc61ca91eb4296f01d32740a0441a66691ebdfb8fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac25c01b0ef4a5dfdb08eda4805c81bdd5347a324e863f63ad28c4795031dd0df50abce72e5178fef2c4baaebe71a2ab4778397dd8979662f158702c7a4e149"} build_url:https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011020 build_url: 'https://queue.taskcluster.net/v1/task/H3Q1alQ-SJmax05kccAwaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344ffa5e2ec6221cba801022959cf1dd5c7aa5ccaaca1e1b290de22d258186d35e688de72d65d84b427cd6fc61ca91eb4296f01d32740a0441a66691ebdfb8fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac25c01b0ef4a5dfdb08eda4805c81bdd5347a324e863f63ad28c4795031dd0df50abce72e5178fef2c4baaebe71a2ab4778397dd8979662f158702c7a4e149"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 05:38:24.694943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:38:24.695272) ========= 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.CUWOubNK2E/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.TF9bpRcYem/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.004956 ========= master_lag: 0.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:38:25.089963) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 05:38:25.090308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 05:38:25.090701) ========= ========= Total master_lag: 4.82 =========