builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1460462826.78 results: success (0) buildid: 20160412030143 builduid: 6deece908c9a44ff8788ef0752a78946 revision: 39fe246bce0f76238e7de110ad607e0019ce0550 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:06.776036) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:06.779440) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:06.779734) ========= 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.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005351 basedir: '/builds/slave/test' ========= master_lag: 0.18 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:06.961655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:06.961923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:07.951738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:07.951989) ========= 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.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.004673 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:08.071466) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:08.071731) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:08.072048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 05:07:08.072327) ========= 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.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-04-12 05:07:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.8M=0.001s 2016-04-12 05:07:09 (16.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.332048 ========= master_lag: 1.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 05:07:09.978497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 05:07:09.978771) ========= 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.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.019771 ========= master_lag: 2.61 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 05:07:12.612628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 05:07:12.612939) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 39fe246bce0f76238e7de110ad607e0019ce0550 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 39fe246bce0f76238e7de110ad607e0019ce0550 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-04-12 05:07:12,868 truncating revision to first 12 chars 2016-04-12 05:07:12,868 Setting DEBUG logging. 2016-04-12 05:07:12,868 attempt 1/10 2016-04-12 05:07:12,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/39fe246bce0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 05:07:13,951 unpacking tar archive at: mozilla-aurora-39fe246bce0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336154 ========= master_lag: 1.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-12 05:07:15.478625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:15.478930) ========= echo 39fe246bce0f76238e7de110ad607e0019ce0550 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'39fe246bce0f76238e7de110ad607e0019ce0550'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 39fe246bce0f76238e7de110ad607e0019ce0550 program finished with exit code 0 elapsedTime=0.005142 script_repo_revision: '39fe246bce0f76238e7de110ad607e0019ce0550' ========= master_lag: 0.37 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:07:15.851481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-04-12 05:07:15.851775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-04-12 05:07:20.741336) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-04-12 05:07:20.741796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:07:20 INFO - MultiFileLogger online at 20160412 05:07:20 in /builds/slave/test 05:07:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:20 INFO - {'append_to_log': False, 05:07:20 INFO - 'base_work_dir': '/builds/slave/test', 05:07:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:20 INFO - 'branch': 'Mozilla-Aurora', 05:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:20 INFO - 'config_files': ('talos/mac_config.py',), 05:07:20 INFO - 'default_actions': ('clobber', 05:07:20 INFO - 'read-buildbot-config', 05:07:20 INFO - 'download-and-extract', 05:07:20 INFO - 'populate-webroot', 05:07:20 INFO - 'create-virtualenv', 05:07:20 INFO - 'install', 05:07:20 INFO - 'run-tests'), 05:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:20 INFO - 'download_minidump_stackwalk': True, 05:07:20 INFO - 'download_symbols': 'ondemand', 05:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:20 INFO - 'installer_path': 'installer.exe', 05:07:20 INFO - 'log_level': 'info', 05:07:20 INFO - 'log_name': 'talos', 05:07:20 INFO - 'log_to_console': True, 05:07:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:20 INFO - 'opt_config_files': (), 05:07:20 INFO - 'pip_index': False, 05:07:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:20 INFO - 'cmd': ('bash', 05:07:20 INFO - '-c', 05:07:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:20 INFO - 'enabled': True, 05:07:20 INFO - 'halt_on_failure': False, 05:07:20 INFO - 'name': 'check_screen_resolution'},), 05:07:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:20 INFO - 'cmd': ('bash', 05:07:20 INFO - '-c', 05:07:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:20 INFO - 'enabled': True, 05:07:20 INFO - 'halt_on_failure': False, 05:07:20 INFO - 'name': 'check_screen_resolution'},), 05:07:20 INFO - 'run_cmd_checks_enabled': True, 05:07:20 INFO - 'sps_profile': False, 05:07:20 INFO - 'sps_profile_interval': 0, 05:07:20 INFO - 'suite': 'dromaeojs', 05:07:20 INFO - 'system_bits': '32', 05:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:20 INFO - 'title': 't-yosemite-r7-0023', 05:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:20 INFO - 'use_talos_json': True, 05:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:20 INFO - 'work_dir': 'build'} 05:07:20 INFO - ##### 05:07:20 INFO - ##### Running clobber step. 05:07:20 INFO - ##### 05:07:20 INFO - Running pre-action listener: _resource_record_pre_action 05:07:20 INFO - Running main action method: clobber 05:07:20 INFO - rmtree: /builds/slave/test/build 05:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:21 INFO - Running post-action listener: _resource_record_post_action 05:07:21 INFO - ##### 05:07:21 INFO - ##### Running read-buildbot-config step. 05:07:21 INFO - ##### 05:07:21 INFO - Running pre-action listener: _resource_record_pre_action 05:07:21 INFO - Running main action method: read_buildbot_config 05:07:21 INFO - Using buildbot properties: 05:07:21 INFO - { 05:07:21 INFO - "project": "", 05:07:21 INFO - "product": "firefox", 05:07:21 INFO - "script_repo_revision": "production", 05:07:21 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:07:21 INFO - "repository": "", 05:07:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:07:21 INFO - "buildid": "20160412030143", 05:07:21 INFO - "pgo_build": "False", 05:07:21 INFO - "basedir": "/builds/slave/test", 05:07:21 INFO - "buildnumber": 169, 05:07:21 INFO - "slavename": "t-yosemite-r7-0023", 05:07:21 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:07:21 INFO - "platform": "yosemite_r7", 05:07:21 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:07:21 INFO - "branch": "mozilla-aurora", 05:07:21 INFO - "repo_path": "releases/mozilla-aurora", 05:07:21 INFO - "revision": "39fe246bce0f76238e7de110ad607e0019ce0550", 05:07:21 INFO - "stage_platform": "macosx64", 05:07:21 INFO - "builduid": "6deece908c9a44ff8788ef0752a78946", 05:07:21 INFO - "slavebuilddir": "test" 05:07:21 INFO - } 05:07:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 05:07:21 INFO - Running post-action listener: _resource_record_post_action 05:07:21 INFO - ##### 05:07:21 INFO - ##### Running download-and-extract step. 05:07:21 INFO - ##### 05:07:21 INFO - Running pre-action listener: _resource_record_pre_action 05:07:21 INFO - Running main action method: download_and_extract 05:07:21 INFO - mkdir: /builds/slave/test/build/tests 05:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:21 INFO - https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 05:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 05:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 05:07:31 INFO - Downloaded 1277 bytes. 05:07:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:07:31 INFO - Using the following test package requirements: 05:07:31 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:07:31 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 05:07:31 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 05:07:31 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'jsshell-mac.zip'], 05:07:31 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 05:07:31 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:07:31 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 05:07:31 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 05:07:31 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 05:07:31 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:07:31 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:07:31 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 05:07:31 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:31 INFO - https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:07:33 INFO - Downloaded 17911041 bytes. 05:07:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:37 INFO - Return code: 0 05:07:37 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:37 INFO - https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:07:41 INFO - Downloaded 17911041 bytes. 05:07:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:45 INFO - Return code: 0 05:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:45 INFO - https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:07:46 INFO - Downloaded 10845168 bytes. 05:07:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:07:46 INFO - Return code: 0 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:46 INFO - https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 05:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 05:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 05:07:54 INFO - Downloaded 115195735 bytes. 05:07:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:07:54 INFO - mkdir: /builds/slave/test/properties 05:07:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:54 INFO - Contents: 05:07:54 INFO - build_url:https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 05:07:55 INFO - Running post-action listener: _resource_record_post_action 05:07:55 INFO - Running post-action listener: set_extra_try_arguments 05:07:55 INFO - ##### 05:07:55 INFO - ##### Running populate-webroot step. 05:07:55 INFO - ##### 05:07:55 INFO - Running pre-action listener: _resource_record_pre_action 05:07:55 INFO - Running main action method: populate_webroot 05:07:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:55 INFO - '--tppagecycles', 05:07:55 INFO - '7'], 05:07:55 INFO - 'tests': ['tsvgm']}}, 05:07:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:07:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:07:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'tests': ['damp', 'tps']}, 05:07:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['damp', 'tps']}, 05:07:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:07:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:55 INFO - 'other': {'tests': ['a11yr', 05:07:55 INFO - 'ts_paint', 05:07:55 INFO - 'tpaint', 05:07:55 INFO - 'sessionrestore', 05:07:55 INFO - 'sessionrestore_no_auto_restore', 05:07:55 INFO - 'tabpaint']}, 05:07:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['a11yr', 05:07:55 INFO - 'ts_paint', 05:07:55 INFO - 'tpaint', 05:07:55 INFO - 'sessionrestore', 05:07:55 INFO - 'sessionrestore_no_auto_restore', 05:07:55 INFO - 'tabpaint']}, 05:07:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['a11yr', 05:07:55 INFO - 'ts_paint', 05:07:55 INFO - 'tpaint', 05:07:55 INFO - 'sessionrestore', 05:07:55 INFO - 'sessionrestore_no_auto_restore', 05:07:55 INFO - 'tabpaint']}, 05:07:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['a11yr', 05:07:55 INFO - 'ts_paint', 05:07:55 INFO - 'tpaint', 05:07:55 INFO - 'sessionrestore', 05:07:55 INFO - 'sessionrestore_no_auto_restore', 05:07:55 INFO - 'tabpaint']}, 05:07:55 INFO - 'other_l64': {'tests': ['a11yr', 05:07:55 INFO - 'ts_paint', 05:07:55 INFO - 'tpaint', 05:07:55 INFO - 'sessionrestore', 05:07:55 INFO - 'sessionrestore_no_auto_restore', 05:07:55 INFO - 'tabpaint']}, 05:07:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:07:55 INFO - 'ts_paint', 05:07:55 INFO - 'tpaint', 05:07:55 INFO - 'sessionrestore', 05:07:55 INFO - 'sessionrestore_no_auto_restore', 05:07:55 INFO - 'tabpaint']}, 05:07:55 INFO - 'svgr': {'tests': ['tsvgx', 05:07:55 INFO - 'tsvgr_opacity', 05:07:55 INFO - 'tart', 05:07:55 INFO - 'tscrollx', 05:07:55 INFO - 'cart']}, 05:07:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['tsvgx', 05:07:55 INFO - 'tsvgr_opacity', 05:07:55 INFO - 'tart', 05:07:55 INFO - 'tscrollx', 05:07:55 INFO - 'cart']}, 05:07:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'tests': ['tp5o']}, 05:07:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'talos_options': ['--e10s'], 05:07:55 INFO - 'tests': ['tp5o']}, 05:07:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'talos_options': ['--xperf_path', 05:07:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:55 INFO - 'tests': ['tp5n']}, 05:07:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:55 INFO - 'talos_options': ['--e10s', 05:07:55 INFO - '--xperf_path', 05:07:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:55 INFO - 'tests': ['tp5n']}}, 05:07:55 INFO - 'talos.zip': {'path': '', 05:07:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:55 INFO - Running post-action listener: _resource_record_post_action 05:07:55 INFO - ##### 05:07:55 INFO - ##### Running create-virtualenv step. 05:07:55 INFO - ##### 05:07:55 INFO - Running pre-action listener: _resource_record_pre_action 05:07:55 INFO - Running main action method: create_virtualenv 05:07:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:55 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:07:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:55 INFO - Using real prefix '/tools/python27' 05:07:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:59 INFO - Installing pip.................done. 05:07:59 INFO - Return code: 0 05:07:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:07:59 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:07:59 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:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:59 INFO - 'HOME': '/Users/cltbld', 05:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:59 INFO - 'LOGNAME': 'cltbld', 05:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:59 INFO - 'MOZ_NO_REMOTE': '1', 05:07:59 INFO - 'NO_EM_RESTART': '1', 05:07:59 INFO - 'PAGER': '/bin/cat', 05:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:59 INFO - 'PWD': '/builds/slave/test', 05:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:59 INFO - 'SHELL': '/bin/bash', 05:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:07:59 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:59 INFO - 'USER': 'cltbld', 05:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:59 INFO - 'XPC_FLAGS': '0x0', 05:07:59 INFO - 'XPC_SERVICE_NAME': '0', 05:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:59 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:07:59 INFO - Cleaning up... 05:07:59 INFO - Return code: 0 05:07:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:07:59 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:07:59 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:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:59 INFO - 'HOME': '/Users/cltbld', 05:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:59 INFO - 'LOGNAME': 'cltbld', 05:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:59 INFO - 'MOZ_NO_REMOTE': '1', 05:07:59 INFO - 'NO_EM_RESTART': '1', 05:07:59 INFO - 'PAGER': '/bin/cat', 05:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:59 INFO - 'PWD': '/builds/slave/test', 05:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:59 INFO - 'SHELL': '/bin/bash', 05:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:07:59 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:59 INFO - 'USER': 'cltbld', 05:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:59 INFO - 'XPC_FLAGS': '0x0', 05:07:59 INFO - 'XPC_SERVICE_NAME': '0', 05:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Downloading/unpacking psutil>=0.7.1 05:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:03 INFO - Installing collected packages: psutil 05:08:03 INFO - Running setup.py install for psutil 05:08:03 INFO - building 'psutil._psutil_osx' extension 05:08:03 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:08:03 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:08:03 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:08:04 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:08:04 INFO - building 'psutil._psutil_posix' extension 05:08:04 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:08:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:04 INFO - ^ 05:08:04 INFO - 1 warning generated. 05:08:04 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:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:04 INFO - Successfully installed psutil 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:04 INFO - 'HOME': '/Users/cltbld', 05:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PAGER': '/bin/cat', 05:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:04 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - 'XPC_FLAGS': '0x0', 05:08:04 INFO - 'XPC_SERVICE_NAME': '0', 05:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:07 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:08:07 INFO - Installing collected packages: mozsystemmonitor 05:08:07 INFO - Running setup.py install for mozsystemmonitor 05:08:07 INFO - Successfully installed mozsystemmonitor 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:07 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:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:07 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:08:07 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:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:07 INFO - 'HOME': '/Users/cltbld', 05:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:07 INFO - 'LOGNAME': 'cltbld', 05:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:07 INFO - 'MOZ_NO_REMOTE': '1', 05:08:07 INFO - 'NO_EM_RESTART': '1', 05:08:07 INFO - 'PAGER': '/bin/cat', 05:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:07 INFO - 'PWD': '/builds/slave/test', 05:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:07 INFO - 'SHELL': '/bin/bash', 05:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:07 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:07 INFO - 'USER': 'cltbld', 05:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:07 INFO - 'XPC_FLAGS': '0x0', 05:08:07 INFO - 'XPC_SERVICE_NAME': '0', 05:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:11 INFO - Downloading docopt-0.6.1.tar.gz 05:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:11 INFO - Running setup.py install for blobuploader 05:08:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:11 INFO - Running setup.py install for requests 05:08:11 INFO - Running setup.py install for docopt 05:08:11 INFO - Successfully installed blobuploader requests docopt 05:08:11 INFO - Cleaning up... 05:08:12 INFO - Return code: 0 05:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:12 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:12 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:08:12 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:08:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:12 INFO - 'HOME': '/Users/cltbld', 05:08:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:12 INFO - 'LOGNAME': 'cltbld', 05:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:12 INFO - 'MOZ_NO_REMOTE': '1', 05:08:12 INFO - 'NO_EM_RESTART': '1', 05:08:12 INFO - 'PAGER': '/bin/cat', 05:08:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:12 INFO - 'PWD': '/builds/slave/test', 05:08:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:12 INFO - 'SHELL': '/bin/bash', 05:08:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:12 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:12 INFO - 'USER': 'cltbld', 05:08:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:12 INFO - 'XPC_FLAGS': '0x0', 05:08:12 INFO - 'XPC_SERVICE_NAME': '0', 05:08:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-diPlES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-IVx3JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jjGmlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-R8gMjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-2xN82n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-LP2FRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:12 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-EiyY7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-XGTtke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-SmUV8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-sj7sTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wurE1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Dygo_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AOTBib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-xIjfYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-2YsHtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zgCio4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:13 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Yl94RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:14 INFO - Running setup.py install for manifestparser 05:08:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Running setup.py install for mozcrash 05:08:14 INFO - Running setup.py install for mozdebug 05:08:14 INFO - Running setup.py install for mozdevice 05:08:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Running setup.py install for mozfile 05:08:14 INFO - Running setup.py install for mozhttpd 05:08:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Running setup.py install for mozinfo 05:08:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozInstall 05:08:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozleak 05:08:15 INFO - Running setup.py install for mozlog 05:08:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for moznetwork 05:08:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozprocess 05:08:15 INFO - Running setup.py install for mozprofile 05:08:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozrunner 05:08:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Running setup.py install for mozscreenshot 05:08:16 INFO - Running setup.py install for moztest 05:08:16 INFO - Running setup.py install for mozversion 05:08:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:16 INFO - Cleaning up... 05:08:16 INFO - Return code: 0 05:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:16 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:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:16 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:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:16 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:16 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:08:16 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:08:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:16 INFO - 'HOME': '/Users/cltbld', 05:08:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:16 INFO - 'LOGNAME': 'cltbld', 05:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:16 INFO - 'MOZ_NO_REMOTE': '1', 05:08:16 INFO - 'NO_EM_RESTART': '1', 05:08:16 INFO - 'PAGER': '/bin/cat', 05:08:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:16 INFO - 'PWD': '/builds/slave/test', 05:08:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:16 INFO - 'SHELL': '/bin/bash', 05:08:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:16 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:16 INFO - 'USER': 'cltbld', 05:08:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:16 INFO - 'XPC_FLAGS': '0x0', 05:08:16 INFO - 'XPC_SERVICE_NAME': '0', 05:08:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:16 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7Lacsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-oHmpe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5BPTaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rrojhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VRUMCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-uWUISo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DFaBJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fdRlRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-UXa9_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-6Ojo9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:17 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:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-A2CvkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:18 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:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-KWDEyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:18 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:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mWH_ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:18 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:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-6OxHSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:18 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:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ytNqxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:18 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:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-n0bDnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:18 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:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-nj0CmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:21 INFO - Downloading blessings-1.6.tar.gz 05:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:21 INFO - Installing collected packages: blessings 05:08:21 INFO - Running setup.py install for blessings 05:08:21 INFO - Successfully installed blessings 05:08:21 INFO - Cleaning up... 05:08:21 INFO - Return code: 0 05:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:21 INFO - Reading from file tmpfile_stdout 05:08:21 INFO - Current package versions: 05:08:21 INFO - blessings == 1.6 05:08:21 INFO - blobuploader == 1.2.4 05:08:21 INFO - docopt == 0.6.1 05:08:21 INFO - manifestparser == 1.1 05:08:21 INFO - mozInstall == 1.12 05:08:21 INFO - mozcrash == 0.17 05:08:21 INFO - mozdebug == 0.1 05:08:21 INFO - mozdevice == 0.48 05:08:21 INFO - mozfile == 1.2 05:08:21 INFO - mozhttpd == 0.7 05:08:21 INFO - mozinfo == 0.9 05:08:21 INFO - mozleak == 0.1 05:08:21 INFO - mozlog == 3.1 05:08:21 INFO - moznetwork == 0.27 05:08:21 INFO - mozprocess == 0.22 05:08:21 INFO - mozprofile == 0.28 05:08:21 INFO - mozrunner == 6.11 05:08:21 INFO - mozscreenshot == 0.1 05:08:21 INFO - mozsystemmonitor == 0.0 05:08:21 INFO - moztest == 0.7 05:08:21 INFO - mozversion == 1.4 05:08:21 INFO - psutil == 3.1.1 05:08:21 INFO - requests == 1.2.3 05:08:21 INFO - wsgiref == 0.1.2 05:08:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:21 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:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:21 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:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:21 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:21 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:08:21 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:08:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:21 INFO - 'HOME': '/Users/cltbld', 05:08:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:21 INFO - 'LOGNAME': 'cltbld', 05:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:21 INFO - 'MOZ_NO_REMOTE': '1', 05:08:21 INFO - 'NO_EM_RESTART': '1', 05:08:21 INFO - 'PAGER': '/bin/cat', 05:08:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:21 INFO - 'PWD': '/builds/slave/test', 05:08:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:21 INFO - 'SHELL': '/bin/bash', 05:08:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:21 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:21 INFO - 'USER': 'cltbld', 05:08:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:21 INFO - 'XPC_FLAGS': '0x0', 05:08:21 INFO - 'XPC_SERVICE_NAME': '0', 05:08:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 INFO - Cleaning up... 05:08:22 INFO - Return code: 0 05:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:22 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:22 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:08:22 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:08:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:22 INFO - 'HOME': '/Users/cltbld', 05:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:22 INFO - 'LOGNAME': 'cltbld', 05:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:22 INFO - 'MOZ_NO_REMOTE': '1', 05:08:22 INFO - 'NO_EM_RESTART': '1', 05:08:22 INFO - 'PAGER': '/bin/cat', 05:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:22 INFO - 'PWD': '/builds/slave/test', 05:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:22 INFO - 'SHELL': '/bin/bash', 05:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:22 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:22 INFO - 'USER': 'cltbld', 05:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:22 INFO - 'XPC_FLAGS': '0x0', 05:08:22 INFO - 'XPC_SERVICE_NAME': '0', 05:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:22 INFO - Downloading/unpacking jsonschema 05:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:22 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:08:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:25 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:25 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:08:25 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:08:25 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:08:25 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:08:25 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:08:25 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:08:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:25 INFO - warning: no files found matching '*.txt' 05:08:25 INFO - no previously-included directories found matching 'build' 05:08:25 INFO - no previously-included directories found matching 'dist' 05:08:25 INFO - no previously-included directories found matching '.git*' 05:08:25 INFO - Installing collected packages: jsonschema, functools32 05:08:25 INFO - Running setup.py install for functools32 05:08:26 INFO - warning: no files found matching '*.txt' 05:08:26 INFO - no previously-included directories found matching 'build' 05:08:26 INFO - no previously-included directories found matching 'dist' 05:08:26 INFO - no previously-included directories found matching '.git*' 05:08:26 INFO - Successfully installed jsonschema functools32 05:08:26 INFO - Cleaning up... 05:08:26 INFO - Return code: 0 05:08:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:26 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 0x110099a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c7e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, '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.bGbGUEt3OY/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.86t1b3LPtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:08:26 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:08:26 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:08:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:08:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:26 INFO - 'HOME': '/Users/cltbld', 05:08:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:26 INFO - 'LOGNAME': 'cltbld', 05:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:26 INFO - 'MOZ_NO_REMOTE': '1', 05:08:26 INFO - 'NO_EM_RESTART': '1', 05:08:26 INFO - 'PAGER': '/bin/cat', 05:08:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:26 INFO - 'PWD': '/builds/slave/test', 05:08:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:26 INFO - 'SHELL': '/bin/bash', 05:08:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:08:26 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:08:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:26 INFO - 'USER': 'cltbld', 05:08:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:26 INFO - 'XPC_FLAGS': '0x0', 05:08:26 INFO - 'XPC_SERVICE_NAME': '0', 05:08:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:26 INFO - Downloading/unpacking flake8 05:08:26 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:08:26 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:08:26 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:08:26 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:08:26 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:08:26 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:08:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:28 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:08:28 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:08:28 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:08:28 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:08:28 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:08:28 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:08:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:30 INFO - no previously-included directories found matching 'docs/_build' 05:08:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:30 INFO - Running setup.py install for pep8 05:08:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:30 INFO - no previously-included directories found matching 'docs/_build' 05:08:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:30 INFO - Cleaning up... 05:08:30 INFO - Return code: 0 05:08:30 INFO - Running post-action listener: _resource_record_post_action 05:08:30 INFO - Running post-action listener: _start_resource_monitoring 05:08:30 INFO - Starting resource monitoring. 05:08:30 INFO - ##### 05:08:30 INFO - ##### Running install step. 05:08:30 INFO - ##### 05:08:30 INFO - Running pre-action listener: _resource_record_pre_action 05:08:30 INFO - Running main action method: install 05:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:30 INFO - Reading from file tmpfile_stdout 05:08:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:30 INFO - Reading from file tmpfile_stdout 05:08:30 INFO - Output received: 05:08:30 INFO - Usage: mozinstall [options] installer 05:08:30 INFO - Options: 05:08:30 INFO - -h, --help show this help message and exit 05:08:30 INFO - -d DEST, --destination=DEST 05:08:30 INFO - Directory to install application into. [default: 05:08:30 INFO - "/builds/slave/test"] 05:08:30 INFO - --app=APP Application being installed. [default: firefox] 05:08:30 INFO - mkdir: /builds/slave/test/build/application 05:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:03 INFO - Reading from file tmpfile_stdout 05:09:03 INFO - Output received: 05:09:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:09:03 INFO - Running post-action listener: _resource_record_post_action 05:09:03 INFO - ##### 05:09:03 INFO - ##### Running run-tests step. 05:09:03 INFO - ##### 05:09:03 INFO - Running pre-action listener: _resource_record_pre_action 05:09:03 INFO - Running main action method: run_tests 05:09:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:03 INFO - 2016-04-12 05:09:03.301 screenresolution[1928:11786] starting screenresolution argv=screenresolution get 05:09:03 INFO - 2016-04-12 05:09:03.304 screenresolution[1928:11786] Display 0: 1600x1200x32@60 05:09:03 INFO - 2016-04-12 05:09:03.310 screenresolution[1929:11788] starting screenresolution argv=screenresolution list 05:09:03 INFO - Available Modes on Display 0 05:09:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:03 INFO - Intel Iris: 05:09:03 INFO - Chipset Model: Intel Iris 05:09:03 INFO - Type: GPU 05:09:03 INFO - Bus: Built-In 05:09:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:03 INFO - Vendor: Intel (0x8086) 05:09:03 INFO - Device ID: 0x0a2e 05:09:03 INFO - Revision ID: 0x0009 05:09:03 INFO - Displays: 05:09:03 INFO - Display: 05:09:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:03 INFO - Display Serial Number: 1600x1200 60 05:09:03 INFO - Main Display: Yes 05:09:03 INFO - Mirror: Off 05:09:03 INFO - Online: Yes 05:09:03 INFO - Rotation: Supported 05:09:03 INFO - Return code: 0 05:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:03 INFO - Python 2.7.3 05:09:03 INFO - Return code: 0 05:09:03 INFO - grabbing minidump binary from tooltool 05:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:03 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 0x10ff3dd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:03 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:09:03 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:09:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:03 INFO - Return code: 0 05:09:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:04 INFO - Return code: 0 05:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bGbGUEt3OY/Render', 05:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:04 INFO - 'HOME': '/Users/cltbld', 05:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:04 INFO - 'LOGNAME': 'cltbld', 05:09:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:04 INFO - 'MOZ_NO_REMOTE': '1', 05:09:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:04 INFO - 'NO_EM_RESTART': '1', 05:09:04 INFO - 'PAGER': '/bin/cat', 05:09:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:04 INFO - 'PWD': '/builds/slave/test', 05:09:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:04 INFO - 'SHELL': '/bin/bash', 05:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86t1b3LPtN/Listeners', 05:09:04 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:04 INFO - 'USER': 'cltbld', 05:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:04 INFO - 'XPC_FLAGS': '0x0', 05:09:04 INFO - 'XPC_SERVICE_NAME': '0', 05:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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:09:05 INFO - mozversion application_buildid: 20160412030143 05:09:05 INFO - mozversion application_changeset: 39fe246bce0f76238e7de110ad607e0019ce0550 05:09:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:09:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:05 INFO - mozversion application_name: Firefox 05:09:05 INFO - mozversion application_remotingname: firefox-dev 05:09:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:09:05 INFO - mozversion application_vendor: Mozilla 05:09:05 INFO - mozversion application_version: 47.0a2 05:09:05 INFO - mozversion platform_buildid: 20160412030143 05:09:05 INFO - mozversion platform_changeset: 39fe246bce0f76238e7de110ad607e0019ce0550 05:09:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:09:05 INFO - mozversion platform_version: 47.0a2 05:09:05 INFO - using testdate: 1460462945 05:09:05 INFO - actual date: 1460462945 05:09:05 INFO - starting webserver on 'localhost:51704' 05:09:05 INFO - SUITE-START | Running 2 tests 05:09:05 INFO - TEST-START | dromaeo_css 05:09:05 INFO - operating with platform_type : mac_ 05:09:05 INFO - Initialising browser for dromaeo_css test... 05:09:05 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpiFvx_h/profile http://localhost:51704/getInfo.html) 05:09:07 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 05:09:07 INFO - PROCESS | 1947 | colorDepth:24 05:09:07 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 05:09:07 INFO - PROCESS | 1947 | __metrics 05:09:07 INFO - PROCESS | 1947 | 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:09:07 INFO - PROCESS | 1947 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:07 INFO - TEST-INFO | 1947: exit 0 05:09:07 INFO - Browser initialized. 05:09:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:07 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpiFvx_h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:19 INFO - PROCESS | 1949 | RSS: Main: 208121856 05:09:19 INFO - PROCESS | 1949 | 05:10:11 INFO - PROCESS | 1949 | 1460463011187 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:12:21 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:51704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51704/tests/dromaeo/cssquery-ext.html) 05:12:22 INFO - PROCESS | 1949 | RSS: Main: 326254592 05:12:22 INFO - PROCESS | 1949 | 05:15:25 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:51704/tests/dromaeo/cssquery-ext.html (next: http://localhost:51704/tests/dromaeo/cssquery-jquery.html) 05:15:25 INFO - PROCESS | 1949 | RSS: Main: 335474688 05:15:25 INFO - PROCESS | 1949 | 05:18:27 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:51704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51704/tests/dromaeo/cssquery-mootools.html) 05:18:28 INFO - PROCESS | 1949 | RSS: Main: 346046464 05:18:28 INFO - PROCESS | 1949 | 05:21:30 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:51704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51704/tests/dromaeo/cssquery-prototype.html) 05:21:30 INFO - PROCESS | 1949 | RSS: Main: 302583808 05:21:30 INFO - PROCESS | 1949 | 05:24:33 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:51704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51704/tests/dromaeo/cssquery-yui.html) 05:24:34 INFO - PROCESS | 1949 | RSS: Main: 304254976 05:24:34 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:51704/tests/dromaeo/cssquery-yui.html (next: http://localhost:51704/tests/dromaeo/cssquery-dojo.html) 05:27:37 INFO - PROCESS | 1949 | RSS: Main: 353652736 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | __start_tp_report 05:27:37 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 05:27:37 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 05:27:37 INFO - PROCESS | 1949 | |i|pagename|runs| 05:27:37 INFO - PROCESS | 1949 | |0;dojo.html;3191.569138166348;3509.438489841626;3510.0873772819077;3542.326957878003;3563.1448452371437;5780.2485676862;5813.767449302023;5820.883582328351;5830.679312637803;5835.737391817368;5806.82579522615;5846.181534585162;5849.502792262652;5850.853728656775;5858.882822343561;5193.272941788134;5253.553447956928;5266.183741520071;5286.788528458857;5299.072662284104;4852.393450818648;4994.875128121808;5337.946620533803;5374.220737992989;5383;5288.576913846883;5328.200769884529;5362.544183744387;5385.488378604026;5394.083005889008;5324.307839980797;5369.382521010056;5369.9463005369835;5381.596380271456;5399.19012148177;5065.949340506585;5243.4232234454175;5253.369595648508;5269.051570717269;5309;5680.971595141998;5703.62926409782;5710.229119068914;5730.226419433365;5740.827775166752;6126.632402055891;6362.459190968773;6373.7450501979865;6374.203224596926;6375;6292.307846136967;6300.5589608727405;6313.558050936436;6379.266384365811;6425.100485931926;5843.211166492511;5870.559708021873;5872.412758724179;5874.559408044413;5941.732622032019;6286.119943207955;6310.368963103745;6369.490440764727;6371.617702937839;6373.426391624776;6215.9378406216265;6251.874962500725;6268.1851359323;6278.089676996901;6279.96860015697;6364.968175159094;6366.236051673736;6367.586106903036;6385.329540398284;6390.680465976682;6128.839250099703;6243.469305109116;6252.718627661766;6314.273858506331;6388.904166437507;6237.064440333987;6271.811845644638;6292.622442653455;6307.684615769193;6308.3060863305;4903.313536104948;4916.508349165055;4917.631177661689;4927.7536123193695;4947.950520494749;4405.823767049282;4417.315316126005;4481.081378317437;4521.84173553924;4537.183307004705;5776.33572139201;5791.884162316815;5792;5795.1017592273265;5817.563682723728;6357.523185761086;6393.680315984182;6395.680215989182;6396.008618664115;6404.039394090831;5665.688387138747;5720.170575266647;5753.626014309057;5771.163181338682;5842.152887831326;4562.771861406916;5418.078926582491;5424.783008679608;5433.483819037185;5436.592255580847;6357.141785858942;6395.840103997344;6413.7113829876835;6428.871422571616;6439.935600643934;6223.097650840693;6328.240611126695;6371.904421433589;6405.103285540122;6419.293877673359;6374.26695929974;6385.233771947396;6388.744450222125;6390.840228994312;6403.775867844603;6113.724882380215;6260.718267677874;6269.780557680459;6292.339304373158;6294.496440284858;6262.15460912771;6345.8730825384155;6354.936450635434;6370.331115232834;6381.840453988688;5986.491148252448;6187;6189.6286222826775;6208.441240288395;6215.192025036717;5974.581779275582;6124.142620033288;6224.9377506224355;6232.501399887908;6251.843703907439;5132.050570644443;5866.7066646668345;5991.67045812467;6015.518758499222;6036.9094463582205;6120.658718449855;6132.938670613236;6140.956037473729;6142.385761423822;6144.2319710036245;5270.762815673227;5879.353271140257;6011.969940150271;6012.188354572252;6055.455009049207 05:27:37 INFO - PROCESS | 1949 | |1;ext.html;465.25326850405077;538.2518299563604;585.4993980146975;664.6145235763257;665.6272487407053;25919.222423327283;39212.60787392125;39637.60362396383;39644.40533391998;39689.20621587574;42299;42604.57395426045;42680.57319426805;42721;42756;9649.083337083;9882.851757223647;9887.357321774098;9899.90100098997;9902.504874756234;9772.609095636166;9874.358166719176;9898.158656514204;9904.158146557551;9913.950430247838;9853.605855765796;10067.597296108146;10084.445355505444;10093.444860532667;10137.543810528507;10000.399976001427;10051.296409251356;10051.39691618498;10053.648122315684;10076.345037572572;9707.029297070307;9825.606975720963;9831.754206144831;9850.408975461496;9854.90145098547;41537.37693934594;41762;41870.79064604688;41956;41995.37006944898;3197.8560964756643;3221;3229.40256052631;3406.7615266931325;3422.9315413691834;28663.71336286652;28792.42415151685;29016.41967160645;29267.560986585217;29403.264918377212;2755.476459472694;2780.4582035951885;2801.8739156737997;2814.015094716853;2823.5341168707137;428398;431622;431703;433164;433372;58905.70547147237;58948;59040;59119.11321330183;59150;66952;76333.61833190799;77374.22625773783;77611.83582246272;77659;17757.7336339955;17761.822381776274;17905.283788648307;17962.461126166236;17978.370757023702;13420.0605957584;13473.585273546332;13478.595642130751;13480.056396052378;13500.122492037986;22435.551288974457;22758.74826884504;22787.404881658455;22790.544189116124;22809.631422114726;8675.522846243517;8914.777130571787;8928.553572321358;8974.28205743539;9088.636704494247;918.3525614441802;960.9519524023771;987.7382493639192;1015.7003683913264;1026.199564339816;23772.881135594213;29154.271143221587;29584.704152958195;29981.550276745867;30487.847560762497;991.9652812151685;1042.789286712175;1048.5229220704562;1048.5648455890873;1112.821948488238;15010.849891501164;15158.848411515964;15169.772453413208;15207.063128455387;15452.5364239073;534299;541788;542224;542410;542763;59770;60107;60135.398646013855;60155;60228;1355.5187908292612;1408.0284603623468;1519.1340935666785;1549.1092621742318;1556.0663601839033;28879.85560072186;29353;29464;29559.408811823214;30102;46142.538574615166;46483;47040.05919881652;47059.29411058768;47081.76459117683;300516;304967;305028;305687;305819;29495;30287;48135.75932120317;49175.01649966909;49817.50182498273;46359.768201158775;46908;47716.04567908553;47764;48456;36690.63309366872;38042.61957380391;38090.238195236496;38132.6186738129;38733.612663874126;36457.90626281216;37531;37665;38364;38446;38991.6100838988;39478.2104357917;39774;40197;40261;33631.83184084064;34478.219243657215;34956.47565286472;35197.64802352046;35320;25811.483770324114;26061.609075863496;26148.8692556536;26491;26588.734112658625 05:27:37 INFO - PROCESS | 1949 | |2;jquery.html;375.98872033838984;377.9414190800425;378.1416185259461;382.5371300726121;383.703083577508;20343.28798492053;20608.278710245144;21244.681329780065;21531.24640637576;21542.569148617018;11881.584144554943;12404;12433.626991190256;12442.502299907992;12445.502179912815;4737.313089602006;5988.19159413478;5990.371011043843;5998.940010599882;6002.819915402545;5970.462658360747;5991.460768530831;6010.948084085289;6011.218541589609;6082.209312789331;4809.206480930642;5875.383084776101;5893.263342082239;5987.790427335044;5988.1317209004665;5736.483716465538;5817.534597232211;5818.214541036969;5818.912716309259;5839.416058394169;5053.84838454847;5222.582193424517;5224.39919409269;5225.869353266161;5234.241035049897;13861.722765544633;13863.23752193629;13872.583822485341;21369.610975286712;25329.366765831;1862.3947217154343;2072.5440403111293;2212.0598745533084;2256.244158207003;2303.1478353009493;8196.34429245659;10311.278210525266;13082.411291491906;14269;14796.334164962602;1640.9179541022902;1711.3496871188993;1751.8773685841995;1764.1091248919213;1816.6275913437714;95567;97427;99870;101005;102857.94284114277;11393.259438136494;11506.180985658568;11624.476898539586;11715.297082174926;11954.521819127138;14412.42350305997;14480.275986200648;14480.710385792225;14499.637509062148;14508.911831612671;7930.41391721658;8467.915320846836;8746.34402419821;8816.691415800417;8837.469751814911;8381.874271885927;8988.685396011108;9011.27909767217;9036.683716069905;9075.909240907506;4597.540245975376;4601.792919318638;4606.631469482433;4620.67655264135;4645;1891.7729872415398;1920.2511020701938;1932.7777305610034;1934.5067007913174;1937.1282922684848;903.4759839293325;947.1664934857281;971.3346357744826;994.0705440413237;1008.6923488336128;17941.833780804205;19722.506937326394;20066;20475.692864607045;20726.274580389614;975.9072888075622;994.0506815990711;1001.2640709078821;1018.4296793795498;1058.2116323339162;8944.776380590407;10813.513391897384;11177.49701263445;11183.664490065312;11230.606928757454;611851;627802;641889;644273;644363;100306;101264.49367753114;110328.34507482394;129711;130991;837.7738010737066;953.0945601678433;979.9608015679436;982.2240430060173;1003.0270637481631;17626.64746705033;17779.822201778334;18073.819261807213;18441.631167376847;18737.250509979447;43645.781771090944;48917.510824891295;55709;55888.720556396955;56521;77409.87196344529;78613.60693196727;78960;82426.93932651491;82582.3483530338;7893;8110.107888132418;8155.225253600898;8409.411341206056;8436.578171091543;9495.525223738923;10664.946675266574;12408.317542535247;13517.121387109806;13747.450101995808;11169.329840209613;11403;11574.71063223426;11748.823767643664;11947.163698541019;5333.493318134771;10620.256582039183;11125.276857004268;11274.041706454715;11325;10022.699319020441;10898.291611045257;11710.180287379802;11718.531258749554;11756.11829112837;7010.4041156500225;8022.759317220492;8094;8145.837083258183;8221.218984196492;8370.832583348421;10908;11649.301041937511;11773.941130294294;11953.163278570417 05:27:37 INFO - PROCESS | 1949 | |3;mootools.html;1478.105746023655;1605.7029449551833;1631.2414727151877;1949.9707504387436;2067.7725450200473;8404.705835295757;8957.865632015517;9079.228265597416;9097.63609455621;9103.726888193349;8667.826643467128;8897.288216942645;8913.331500137483;8923.107689231074;8937.285017198625;2208.0615738311153;2277.954440911189;2284.8971796269207;2513.359093431177;2558.155808583163;2531.4177739120014;2609.0868196131296;2610.321316457725;2613.3074735195187;2615.620734993425;2476.6656501372263;2518.357818756215;2518.5718427867214;2548.872556372174;2585.3536615846037;2520.8991640334366;2535.568953277947;2541.47899680566;2546;2549.6430499730054;2530.671012768347;2557.4117952870943;2577.6777902762155;2581.9612705809427;2582.1478911959007;9085.682001129995;9125.49809760463;9147.771305717344;9153.405028673114;9170.495622740747;5556.277683901108;5739.110437882135;5777.480026797609;5777.653340799566;5791.478766910956;3612.6567976042234;3718.2563487302377;3757.9436308455397;3758.1397208381754;3796.2916687490465;1021.0963297481708;1035.2959987208694;1047.8480620310088;1049.0296475759967;1077.849101125843;11934.522619095225;12079.396030198543;12099.879001209963;12112.39438028095;12120.333381664004;5031.622628302892;5051.191809310492;5099.796008159707;5120.462351453119;5144.6398752087;10470.581176752998;10555.15558755313;10559.049685528185;10562.471876406149;10597;5638.633488823213;5669.376368599451;5690.800821971211;5694.572907031989;5701.287339082614;4569.040501494724;4690.742009189527;4920.975395123001;5129.666571672829;5137.383513978347;4166.481544560121;4170.854020109342;4170.957260684829;4199.0552125771455;4204.831806727697;1315.4343632238038;1353.7766268565774;1355.6746380868717;1360.8707172818567;1369.2469141971876;1376.4425407709693;1391.1653008195;1399.3842709207916;1418.2412409361148;1425.9287035648176;8187.672493100209;8379.916200837913;8392;8393.118722534167;8404.495730256203;524.8871492629103;528.7462018231271;537.478645713665;542.7910254552025;543.1716632136024;6305.464035556937;6319.304876463585;6353.428191462698;6364.84087897797;6369.808905732835;10743.946280268548;11169.94415027936;11220;11234.3259404436;11496.42517874103;8297.917020829835;10753.354798712102;10919;11087.445627718582;11187.608433704781;8535.445196062235;8554.572271386405;8627.266682332072;8632.913670863336;8674.6963856266;7026.332498412643;7910.011248593926;8042.678292868453;8049.315808156372;8340.416170868224;9725.562349694139;9959.103680668775;9961.800763984824;9975.251856110966;10149.441780702133;10048.246381521269;10327.845082323622;10475.214358923264;10481.685549433529;10509.054185123376;7604.467687261838;7604.619769011638;7612.7716168515035;7699.923000769921;7718.189590092959;8347.58262086881;8366.665333386596;8427.030891447317;8435.915640843514;8446.619902104543;7441.888371674321;7511.173770885308;7579.810504737426;7687.231276872268;7692;7350.595717235603;7384.556926584422;7395.556266624019;7500.362469189961;7500.9249907500225;7890.171531989058;7940.16628254025;7963.044434667645;7975;7978.122406535161;7156.105486814148;7160.212376638669;7211.38703210212;7252.166000909963;7254.45591580623;7294.525855819355;7324.926750732638;7351.8529629408185;7359.889601656087;7370.63146842645 05:27:37 INFO - PROCESS | 1949 | |4;prototype.html;328.8832464475111;332.7853534470267;336.02050024179516;339.23840977006626;340.9931801363974;6474.902876456851;6538.836529086775;6562.1141145945285;6578.309277525863;6589.637569933651;5191.273221748958;6413.935860641403;6466.256380516242;6479.222493300798;6510.479161667067;4693.131770622429;4788.664793464459;4862.0275944811;4864.173090574611;4868.196747536652;4870;4892.755362231892;4919.1637421638225;4922.163232250526;4953.653244272902;3881.922361552767;4851.563359297663;4869.951300487003;4876.146674331995;4893.608511319086;4617.815287388517;4719.150552900459;4871.658983871131;4875.463698993108;4887.486813884562;4168.083021735213;4176;4177.603127702894;4193.412922190896;4194.895127621803;5361.874006458648;5475.863103422446;6263.404976527268;6299.118123462719;6312.810615681537;5695.515881150066;5701.971490142523;5714.7428365723645;5724.627899186581;5724.856878578027;6797.150356205474;6992.230854605989;6999.860002799966;7008.544444611135;7015.4036906862975;4626.352310676508;4696.882577935545;4716.339712440261;4716.38686970695;4732.645051621143;7369.594672293022;7425.257474252639;7425.405967522639;7435.739749108755;7453.590052547108;4757.643176761757;4783.06730187617;4784.856454306377;4790.473047964721;4796.208625576811;4841.104395686809;4850.102730994778;4852.417709874838;4858.05267972742;4858.17411040124;4676.625869930397;5698.971505142447;5708.628939118944;5709.7716091356715;5730.684812335361;6751;7017.578945263199;7036.964815175891;7041.4718896082995;7051.682674279669;1313.6912825486004;1670.4153546258713;1688.6791509613379;1697.6010637500178;1698.4819630012717;959.2086528613921;1031.2471895516314;1058.6030238660503;1099.59864649404;1118.0999295567146;6435.552000799877;6591.670416479253;6617.536772425884;6638.369354911276;6645.634490102994;6296.275928268308;6982;7430.182679905206;7443.8883416748795;7447.590382528904;6159.384061593805;6472.126262954535;6584.9012264816065;6600.636964966973;6611.537192396582;3149.8425078745972;3909.6872250219913;3915.4322623219473;3918.7060970427333;3919.725619206685;6449.806505804833;6990.965045174741;7426.071741032371;7644.20986339993;7772.339351155102;7379.926200738031;7655.35409886877;7661.61691915402;7663.540187588763;7676.462647614725;7708.5760283183845;7717.57553334572;7743.683573792581;7761.3790896727;7767.611619419119;7174.713011479483;7361;7409.147947986051;7419.258074192538;7420;7234.855302893808;7248;7282.271772822675;7284.3808276294985;7284.635768211674;7716.498427602188;7726.9227307726205;7727.227277272228;7731.072271327476;7741.109772376023;3646.890593282206;4806.759662016815;4852.175130227799;4863.270509423614;4871.975640121776;7002.264762199896;7304.6347682616715;7309.744158954624;7325.120985481776;7326;6999.405050570758;7006.229314775473;7019.403350715246;7049.259827718016;7079.610621415872;7087.149542054986;7111.182214045244;7123.893141602776;7124.145102587722;7136.250693677297;5657.2928383952;6956.652167391509;6966.79099627012;6981.232064473005;6983.650817459208;6866.4506839453725;7098.964505177441;7110.608916509642;7120.465965052746;7124.038254835531;5582.441755824385;6708.496862735216;6886.932525458562;6900.2409734928115;6974.511784175262 05:27:37 INFO - PROCESS | 1949 | |5;yui.html;656.2748163279576;663.2372771312989;695.5583204665038;788.3771820261993;795.8487887301412;15163.54509364718;15563.37746490139;15577.766333505006;15585.922070389646;15610.687786244282;11697.122715796328;14133.92933035336;14147;14167.220802855838;14190.71618567628;799.8560259153364;981.8625392445064;1015.7003683913226;1017.013496907998;1017.2065788684838;842.2335674536173;984.3552473130111;996.5017491254373;1003.7239759066279;1004.4023805835516;847.063994286314;1059.2161800267822;1064.5582083435365;1065.6962765611802;1072.2226385870222;1023.4013102335143;1049.511976930731;1049.7585555322241;1051.353417648141;1055.5619417941546;781.3007358414244;786.1195461083623;786.4966421490194;786.8347646994138;786.8819677048431;15229.771553426708;15259.618509537351;15266.465673701367;15286;15300.540983770505;13032.218066916015;13184.73630527384;13265.137766045273;13434.126781759154;13778.724425511433;10141.89858101417;10242.180625550012;10259.118469103561;10448.425336606484;10725.14198864089;3528.558930133733;3557.3063252665743;3572.374834403969;3595.0832537702718;3668.413053911361;79528;80381.59809200917;80672;82200.58899705522;82413.58793205995;8135.471194372465;9967.651132210338;10094.848577271347;10100.545475453622;10164.847527287096;19298.842069475875;20374.083166257555;21499.355019349445;21805.563888722136;21882.781172188075;7560.621968901533;7574.772756817304;7638.847223055508;7849.293563579306;7908.01149856268;4082.6121518455698;4088.1823635273063;4149.460570125864;4304.397384366192;4374.58441448062;3749.1376983293994;3755.6807671347697;3774.6791522720328;3798.24035192957;3802.752821066622;645.257953353647;650.5543702563759;675.3617831149517;698.27728301208;703.7712743358429;568.2499101186477;575.6661136540796;579.8550362409397;603.2670305578743;628.4563852267755;7900;8296.87554686668;8327.541985190752;8410.537420441935;8498.575071246536;584.9210356601805;594.7442599682091;599.5683108162116;623.0809555905004;625.8435391152212;3386.6274709781906;3910.3156947534067;3929.2730844793805;3941.152652179795;4027.5771044039952;98360.50819745855;99001.56489828139;100853;101687.98312016785;101861.49069254755;76287.47425051469;77246.84129738058;77701;79120;82686;68747.65626171837;70564.2943570568;70757.99999999897;71702;72228.91656625154;7070.46971477131;7643.178410794602;7915.762527124196;8582.78543036429;8670.739877803677;51008;51296;51399.743001284754;53711.73144134254;53874.19188712094;62861.37138628555;64259.07222783324;70659.29340706527;73944.52110957858;74856.12859678334;11142.164337674545;11383;11529.884701152881;11546.884531154581;11657.18399712012;12163.81754273669;12175.634730958085;12367.196132251374;12405.565805197135;12553.748925021631;11416.31502109876;11760.647180584596;11869.406529673655;11889.940550297193;11988.220765650205;10041.849372259569;11585.594504192313;11655.825162622737;11817.940910295394;12061.51753929833;11267.492962816528;11490;11592.072634189077;11672.766544669228;12139.453724582592;8571.314294856273;8722.869156962524;8897.421667591585;8933.330000249878;9020.819583608421;9752.9024709752;9908.306418550632;9914.950425247827;10039.69880903574;10048.346857454242 05:27:37 INFO - PROCESS | 1949 | __end_tp_report 05:27:37 INFO - PROCESS | 1949 | __start_cc_report 05:27:37 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1079 05:27:37 INFO - PROCESS | 1949 | __end_cc_report 05:27:37 INFO - PROCESS | 1949 | __startTimestamp1460464057410__endTimestamp 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | ------- Summary: start ------- 05:27:37 INFO - PROCESS | 1949 | Number of tests: 6 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5810.05 Median:6011.97 stddev:658.72 (11.0%) stddev-sans-first:627.90 05:27:37 INFO - PROCESS | 1949 | Values: 3191.6 3509.4 3510.1 3542.3 3563.1 5780.2 5813.8 5820.9 5830.7 5835.7 5806.8 5846.2 5849.5 5850.9 5858.9 5193.3 5253.6 5266.2 5286.8 5299.1 4852.4 4994.9 5337.9 5374.2 5383.0 5288.6 5328.2 5362.5 5385.5 5394.1 5324.3 5369.4 5369.9 5381.6 5399.2 5065.9 5243.4 5253.4 5269.1 5309.0 5681.0 5703.6 5710.2 5730.2 5740.8 6126.6 6362.5 6373.7 6374.2 6375.0 6292.3 6300.6 6313.6 6379.3 6425.1 5843.2 5870.6 5872.4 5874.6 5941.7 6286.1 6310.4 6369.5 6371.6 6373.4 6215.9 6251.9 6268.2 6278.1 6280.0 6365.0 6366.2 6367.6 6385.3 6390.7 6128.8 6243.5 6252.7 6314.3 6388.9 6237.1 6271.8 6292.6 6307.7 6308.3 4903.3 4916.5 4917.6 4927.8 4948.0 4405.8 4417.3 4481.1 4521.8 4537.2 5776.3 5791.9 5792.0 5795.1 5817.6 6357.5 6393.7 6395.7 6396.0 6404.0 5665.7 5720.2 5753.6 5771.2 5842.2 4562.8 5418.1 5424.8 5433.5 5436.6 6357.1 6395.8 6413.7 6428.9 6439.9 6223.1 6328.2 6371.9 6405.1 6419.3 6374.3 6385.2 6388.7 6390.8 6403.8 6113.7 6260.7 6269.8 6292.3 6294.5 6262.2 6345.9 6354.9 6370.3 6381.8 5986.5 6187.0 6189.6 6208.4 6215.2 5974.6 6124.1 6224.9 6232.5 6251.8 5132.1 5866.7 5991.7 6015.5 6036.9 6120.7 6132.9 6141.0 6142.4 6144.2 5270.8 5879.4 6012.0 6012.2 6055.5 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:59146.66 Median:38405.00 stddev:115802.00 (301.5%) stddev-sans-first:116043.04 05:27:37 INFO - PROCESS | 1949 | Values: 465.3 538.3 585.5 664.6 665.6 25919.2 39212.6 39637.6 39644.4 39689.2 42299.0 42604.6 42680.6 42721.0 42756.0 9649.1 9882.9 9887.4 9899.9 9902.5 9772.6 9874.4 9898.2 9904.2 9914.0 9853.6 10067.6 10084.4 10093.4 10137.5 10000.4 10051.3 10051.4 10053.6 10076.3 9707.0 9825.6 9831.8 9850.4 9854.9 41537.4 41762.0 41870.8 41956.0 41995.4 3197.9 3221.0 3229.4 3406.8 3422.9 28663.7 28792.4 29016.4 29267.6 29403.3 2755.5 2780.5 2801.9 2814.0 2823.5 428398.0 431622.0 431703.0 433164.0 433372.0 58905.7 58948.0 59040.0 59119.1 59150.0 66952.0 76333.6 77374.2 77611.8 77659.0 17757.7 17761.8 17905.3 17962.5 17978.4 13420.1 13473.6 13478.6 13480.1 13500.1 22435.6 22758.7 22787.4 22790.5 22809.6 8675.5 8914.8 8928.6 8974.3 9088.6 918.4 961.0 987.7 1015.7 1026.2 23772.9 29154.3 29584.7 29981.6 30487.8 992.0 1042.8 1048.5 1048.6 1112.8 15010.8 15158.8 15169.8 15207.1 15452.5 534299.0 541788.0 542224.0 542410.0 542763.0 59770.0 60107.0 60135.4 60155.0 60228.0 1355.5 1408.0 1519.1 1549.1 1556.1 28879.9 29353.0 29464.0 29559.4 30102.0 46142.5 46483.0 47040.1 47059.3 47081.8 300516.0 304967.0 305028.0 305687.0 305819.0 29495.0 30287.0 48135.8 49175.0 49817.5 46359.8 46908.0 47716.0 47764.0 48456.0 36690.6 38042.6 38090.2 38132.6 38733.6 36457.9 37531.0 37665.0 38364.0 38446.0 38991.6 39478.2 39774.0 40197.0 40261.0 33631.8 34478.2 34956.5 35197.6 35320.0 25811.5 26061.6 26148.9 26491.0 26588.7 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:34702.05 Median:13816.26 stddev:104974.82 (759.8%) stddev-sans-first:105237.66 05:27:37 INFO - PROCESS | 1949 | Values: 376.0 377.9 378.1 382.5 383.7 20343.3 20608.3 21244.7 21531.2 21542.6 11881.6 12404.0 12433.6 12442.5 12445.5 4737.3 5988.2 5990.4 5998.9 6002.8 5970.5 5991.5 6010.9 6011.2 6082.2 4809.2 5875.4 5893.3 5987.8 5988.1 5736.5 5817.5 5818.2 5818.9 5839.4 5053.8 5222.6 5224.4 5225.9 5234.2 13861.7 13863.2 13872.6 21369.6 25329.4 1862.4 2072.5 2212.1 2256.2 2303.1 8196.3 10311.3 13082.4 14269.0 14796.3 1640.9 1711.3 1751.9 1764.1 1816.6 95567.0 97427.0 99870.0 101005.0 102857.9 11393.3 11506.2 11624.5 11715.3 11954.5 14412.4 14480.3 14480.7 14499.6 14508.9 7930.4 8467.9 8746.3 8816.7 8837.5 8381.9 8988.7 9011.3 9036.7 9075.9 4597.5 4601.8 4606.6 4620.7 4645.0 1891.8 1920.3 1932.8 1934.5 1937.1 903.5 947.2 971.3 994.1 1008.7 17941.8 19722.5 20066.0 20475.7 20726.3 975.9 994.1 1001.3 1018.4 1058.2 8944.8 10813.5 11177.5 11183.7 11230.6 611851.0 627802.0 641889.0 644273.0 644363.0 100306.0 101264.5 110328.3 129711.0 130991.0 837.8 953.1 980.0 982.2 1003.0 17626.6 17779.8 18073.8 18441.6 18737.3 43645.8 48917.5 55709.0 55888.7 56521.0 77409.9 78613.6 78960.0 82426.9 82582.3 7893.0 8110.1 8155.2 8409.4 8436.6 9495.5 10664.9 12408.3 13517.1 13747.5 11169.3 11403.0 11574.7 11748.8 11947.2 5333.5 10620.3 11125.3 11274.0 11325.0 10022.7 10898.3 11710.2 11718.5 11756.1 7010.4 8022.8 8094.0 8145.8 8221.2 8370.8 10908.0 11649.3 11773.9 11953.2 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:6227.90 Median:526.82 stddev:3291.64 (624.8%) stddev-sans-first:3281.51 05:27:37 INFO - PROCESS | 1949 | Values: 1478.1 1605.7 1631.2 1950.0 2067.8 8404.7 8957.9 9079.2 9097.6 9103.7 8667.8 8897.3 8913.3 8923.1 8937.3 2208.1 2278.0 2284.9 2513.4 2558.2 2531.4 2609.1 2610.3 2613.3 2615.6 2476.7 2518.4 2518.6 2548.9 2585.4 2520.9 2535.6 2541.5 2546.0 2549.6 2530.7 2557.4 2577.7 2582.0 2582.1 9085.7 9125.5 9147.8 9153.4 9170.5 5556.3 5739.1 5777.5 5777.7 5791.5 3612.7 3718.3 3757.9 3758.1 3796.3 1021.1 1035.3 1047.8 1049.0 1077.8 11934.5 12079.4 12099.9 12112.4 12120.3 5031.6 5051.2 5099.8 5120.5 5144.6 10470.6 10555.2 10559.0 10562.5 10597.0 5638.6 5669.4 5690.8 5694.6 5701.3 4569.0 4690.7 4921.0 5129.7 5137.4 4166.5 4170.9 4171.0 4199.1 4204.8 1315.4 1353.8 1355.7 1360.9 1369.2 1376.4 1391.2 1399.4 1418.2 1425.9 8187.7 8379.9 8392.0 8393.1 8404.5 524.9 528.7 537.5 542.8 543.2 6305.5 6319.3 6353.4 6364.8 6369.8 10743.9 11169.9 11220.0 11234.3 11496.4 8297.9 10753.4 10919.0 11087.4 11187.6 8535.4 8554.6 8627.3 8632.9 8674.7 7026.3 7910.0 8042.7 8049.3 8340.4 9725.6 9959.1 9961.8 9975.3 10149.4 10048.2 10327.8 10475.2 10481.7 10509.1 7604.5 7604.6 7612.8 7699.9 7718.2 8347.6 8366.7 8427.0 8435.9 8446.6 7441.9 7511.2 7579.8 7687.2 7692.0 7350.6 7384.6 7395.6 7500.4 7500.9 7890.2 7940.2 7963.0 7975.0 7978.1 7156.1 7160.2 7211.4 7252.2 7254.5 7294.5 7324.9 7351.9 7359.9 7370.6 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:5758.35 Median:6494.85 stddev:1849.06 (28.5%) stddev-sans-first:1808.78 05:27:37 INFO - PROCESS | 1949 | Values: 328.9 332.8 336.0 339.2 341.0 6474.9 6538.8 6562.1 6578.3 6589.6 5191.3 6413.9 6466.3 6479.2 6510.5 4693.1 4788.7 4862.0 4864.2 4868.2 4870.0 4892.8 4919.2 4922.2 4953.7 3881.9 4851.6 4870.0 4876.1 4893.6 4617.8 4719.2 4871.7 4875.5 4887.5 4168.1 4176.0 4177.6 4193.4 4194.9 5361.9 5475.9 6263.4 6299.1 6312.8 5695.5 5702.0 5714.7 5724.6 5724.9 6797.2 6992.2 6999.9 7008.5 7015.4 4626.4 4696.9 4716.3 4716.4 4732.6 7369.6 7425.3 7425.4 7435.7 7453.6 4757.6 4783.1 4784.9 4790.5 4796.2 4841.1 4850.1 4852.4 4858.1 4858.2 4676.6 5699.0 5708.6 5709.8 5730.7 6751.0 7017.6 7037.0 7041.5 7051.7 1313.7 1670.4 1688.7 1697.6 1698.5 959.2 1031.2 1058.6 1099.6 1118.1 6435.6 6591.7 6617.5 6638.4 6645.6 6296.3 6982.0 7430.2 7443.9 7447.6 6159.4 6472.1 6584.9 6600.6 6611.5 3149.8 3909.7 3915.4 3918.7 3919.7 6449.8 6991.0 7426.1 7644.2 7772.3 7379.9 7655.4 7661.6 7663.5 7676.5 7708.6 7717.6 7743.7 7761.4 7767.6 7174.7 7361.0 7409.1 7419.3 7420.0 7234.9 7248.0 7282.3 7284.4 7284.6 7716.5 7726.9 7727.2 7731.1 7741.1 3646.9 4806.8 4852.2 4863.3 4872.0 7002.3 7304.6 7309.7 7325.1 7326.0 6999.4 7006.2 7019.4 7049.3 7079.6 7087.1 7111.2 7123.9 7124.1 7136.3 5657.3 6956.7 6966.8 6981.2 6983.7 6866.5 7099.0 7110.6 7120.5 7124.0 5582.4 6708.5 6886.9 6900.2 6974.5 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:18758.90 Median:3984.36 stddev:26604.00 (667.7%) stddev-sans-first:26643.91 05:27:37 INFO - PROCESS | 1949 | Values: 656.3 663.2 695.6 788.4 795.8 15163.5 15563.4 15577.8 15585.9 15610.7 11697.1 14133.9 14147.0 14167.2 14190.7 799.9 981.9 1015.7 1017.0 1017.2 842.2 984.4 996.5 1003.7 1004.4 847.1 1059.2 1064.6 1065.7 1072.2 1023.4 1049.5 1049.8 1051.4 1055.6 781.3 786.1 786.5 786.8 786.9 15229.8 15259.6 15266.5 15286.0 15300.5 13032.2 13184.7 13265.1 13434.1 13778.7 10141.9 10242.2 10259.1 10448.4 10725.1 3528.6 3557.3 3572.4 3595.1 3668.4 79528.0 80381.6 80672.0 82200.6 82413.6 8135.5 9967.7 10094.8 10100.5 10164.8 19298.8 20374.1 21499.4 21805.6 21882.8 7560.6 7574.8 7638.8 7849.3 7908.0 4082.6 4088.2 4149.5 4304.4 4374.6 3749.1 3755.7 3774.7 3798.2 3802.8 645.3 650.6 675.4 698.3 703.8 568.2 575.7 579.9 603.3 628.5 7900.0 8296.9 8327.5 8410.5 8498.6 584.9 594.7 599.6 623.1 625.8 3386.6 3910.3 3929.3 3941.2 4027.6 98360.5 99001.6 100853.0 101688.0 101861.5 76287.5 77246.8 77701.0 79120.0 82686.0 68747.7 70564.3 70758.0 71702.0 72228.9 7070.5 7643.2 7915.8 8582.8 8670.7 51008.0 51296.0 51399.7 53711.7 53874.2 62861.4 64259.1 70659.3 73944.5 74856.1 11142.2 11383.0 11529.9 11546.9 11657.2 12163.8 12175.6 12367.2 12405.6 12553.7 11416.3 11760.6 11869.4 11889.9 11988.2 10041.8 11585.6 11655.8 11817.9 12061.5 11267.5 11490.0 11592.1 11672.8 12139.5 8571.3 8722.9 8897.4 8933.3 9020.8 9752.9 9908.3 9915.0 10039.7 10048.3 05:27:37 INFO - PROCESS | 1949 | -------- Summary: end -------- 05:27:37 INFO - PROCESS | 1949 | 05:27:37 INFO - TEST-INFO | 1949: exit 0 05:27:37 INFO - TEST-OK | dromaeo_css | took 1112923ms 05:27:37 INFO - TEST-START | kraken 05:27:37 INFO - operating with platform_type : mac_ 05:27:37 INFO - Initialising browser for kraken test... 05:27:37 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpGqE3Dz/profile http://localhost:51704/getInfo.html) 05:27:40 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 05:27:40 INFO - PROCESS | 1953 | colorDepth:24 05:27:40 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 05:27:40 INFO - PROCESS | 1953 | __metrics 05:27:40 INFO - PROCESS | 1953 | 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:27:40 INFO - PROCESS | 1953 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:40 INFO - TEST-INFO | 1953: exit 0 05:27:40 INFO - Browser initialized. 05:27:40 INFO - Running cycle 1/1 for kraken test... 05:27:40 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpGqE3Dz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:52 INFO - PROCESS | 1955 | RSS: Main: 208097280 05:27:52 INFO - PROCESS | 1955 | 05:27:55 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51704/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:55 INFO - PROCESS | 1955 | RSS: Main: 264470528 05:27:55 INFO - PROCESS | 1955 | 05:27:58 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51704/tests/kraken/driver.html?testName=audio-dft) 05:27:59 INFO - PROCESS | 1955 | RSS: Main: 274534400 05:27:59 INFO - PROCESS | 1955 | 05:28:02 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51704/tests/kraken/driver.html?testName=audio-fft) 05:28:02 INFO - PROCESS | 1955 | RSS: Main: 263892992 05:28:02 INFO - PROCESS | 1955 | 05:28:04 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51704/tests/kraken/driver.html?testName=audio-oscillator) 05:28:05 INFO - PROCESS | 1955 | RSS: Main: 265285632 05:28:05 INFO - PROCESS | 1955 | 05:28:07 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:08 INFO - PROCESS | 1955 | RSS: Main: 264663040 05:28:08 INFO - PROCESS | 1955 | 05:28:10 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51704/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:11 INFO - PROCESS | 1955 | RSS: Main: 265809920 05:28:11 INFO - PROCESS | 1955 | 05:28:14 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51704/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:14 INFO - PROCESS | 1955 | RSS: Main: 265977856 05:28:14 INFO - PROCESS | 1955 | 05:28:17 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51704/tests/kraken/driver.html?testName=json-parse-financial) 05:28:18 INFO - PROCESS | 1955 | RSS: Main: 266326016 05:28:18 INFO - PROCESS | 1955 | 05:28:19 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:20 INFO - PROCESS | 1955 | RSS: Main: 298844160 05:28:20 INFO - PROCESS | 1955 | 05:28:22 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:22 INFO - PROCESS | 1955 | RSS: Main: 299823104 05:28:22 INFO - PROCESS | 1955 | 05:28:25 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:25 INFO - PROCESS | 1955 | RSS: Main: 307077120 05:28:25 INFO - PROCESS | 1955 | 05:28:28 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:28 INFO - PROCESS | 1955 | RSS: Main: 308715520 05:28:28 INFO - PROCESS | 1955 | 05:28:31 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:32 INFO - PROCESS | 1955 | RSS: Main: 308592640 05:28:32 INFO - PROCESS | 1955 | 05:28:33 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51704/tests/kraken/driver.html?testName=ai-astar) 05:28:34 INFO - PROCESS | 1955 | RSS: Main: 372011008 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | __start_tp_report 05:28:34 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 05:28:34 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 05:28:34 INFO - PROCESS | 1955 | |i|pagename|runs| 05:28:34 INFO - PROCESS | 1955 | |0;ai-astar;111;109;109;111;111;112;119;111;111;110 05:28:34 INFO - PROCESS | 1955 | |1;audio-beat-detection;155;119;145;152;123;141;117;149;148;102 05:28:34 INFO - PROCESS | 1955 | |2;audio-dft;191;256;220;184;187;185;185;184;186;183 05:28:34 INFO - PROCESS | 1955 | |3;audio-fft;71;83;77;117;59;77;83;82;141;46 05:28:34 INFO - PROCESS | 1955 | |4;audio-oscillator;91;93;132;77;80;82;120;76;79;121 05:28:34 INFO - PROCESS | 1955 | |5;imaging-gaussian-blur;89;85;89;86;88;85;90;86;89;86 05:28:34 INFO - PROCESS | 1955 | |6;imaging-darkroom;94;93;94;93;94;93;93;93;94;123 05:28:34 INFO - PROCESS | 1955 | |7;imaging-desaturate;87;85;87;83;85;87;85;105;141;134 05:28:34 INFO - PROCESS | 1955 | |8;json-parse-financial;55;58;57;58;59;57;57;68;55;51 05:28:34 INFO - PROCESS | 1955 | |9;json-stringify-tinderbox;63;62;63;74;76;71;67;65;65;66 05:28:34 INFO - PROCESS | 1955 | |10;stanford-crypto-aes;81;81;97;104;104;104;81;80;82;83 05:28:34 INFO - PROCESS | 1955 | |11;stanford-crypto-ccm;130;119;132;116;120;130;129;113;117;118 05:28:34 INFO - PROCESS | 1955 | |12;stanford-crypto-pbkdf2;134;124;136;136;133;122;133;161;172;133 05:28:34 INFO - PROCESS | 1955 | |13;stanford-crypto-sha256-iterative;67;66;68;65;66;66;67;71;94;94 05:28:34 INFO - PROCESS | 1955 | __end_tp_report 05:28:34 INFO - PROCESS | 1955 | __start_cc_report 05:28:34 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,1265 05:28:34 INFO - PROCESS | 1955 | __end_cc_report 05:28:34 INFO - PROCESS | 1955 | __startTimestamp1460464114031__endTimestamp 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | ------- Summary: start ------- 05:28:34 INFO - PROCESS | 1955 | Number of tests: 14 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:2.84 (2.6%) stddev-sans-first:3.00 05:28:34 INFO - PROCESS | 1955 | Values: 111.0 109.0 109.0 111.0 111.0 112.0 119.0 111.0 111.0 110.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:146.50 stddev:18.27 (12.5%) stddev-sans-first:17.90 05:28:34 INFO - PROCESS | 1955 | Values: 155.0 119.0 145.0 152.0 123.0 141.0 117.0 149.0 148.0 102.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#2] audio-dft Cycles:10 Average:196.10 Median:186.50 stddev:23.76 (12.7%) stddev-sans-first:25.13 05:28:34 INFO - PROCESS | 1955 | Values: 191.0 256.0 220.0 184.0 187.0 185.0 185.0 184.0 186.0 183.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:27.24 (35.4%) stddev-sans-first:28.51 05:28:34 INFO - PROCESS | 1955 | Values: 71.0 83.0 77.0 117.0 59.0 77.0 83.0 82.0 141.0 46.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.50 stddev:21.15 (26.6%) stddev-sans-first:22.38 05:28:34 INFO - PROCESS | 1955 | Values: 91.0 93.0 132.0 77.0 80.0 82.0 120.0 76.0 79.0 121.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:1.89 (2.1%) stddev-sans-first:1.90 05:28:34 INFO - PROCESS | 1955 | Values: 89.0 85.0 89.0 86.0 88.0 85.0 90.0 86.0 89.0 86.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:93.50 stddev:9.36 (10.0%) stddev-sans-first:9.89 05:28:34 INFO - PROCESS | 1955 | Values: 94.0 93.0 94.0 93.0 94.0 93.0 93.0 93.0 94.0 123.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:85.00 stddev:21.83 (25.7%) stddev-sans-first:22.79 05:28:34 INFO - PROCESS | 1955 | Values: 87.0 85.0 87.0 83.0 85.0 87.0 85.0 105.0 141.0 134.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:4.33 (7.5%) stddev-sans-first:4.49 05:28:34 INFO - PROCESS | 1955 | Values: 55.0 58.0 57.0 58.0 59.0 57.0 57.0 68.0 55.0 51.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:66.50 stddev:4.85 (7.3%) stddev-sans-first:4.90 05:28:34 INFO - PROCESS | 1955 | Values: 63.0 62.0 63.0 74.0 76.0 71.0 67.0 65.0 65.0 66.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:81.00 stddev:11.02 (13.6%) stddev-sans-first:11.22 05:28:34 INFO - PROCESS | 1955 | Values: 81.0 81.0 97.0 104.0 104.0 104.0 81.0 80.0 82.0 83.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:124.50 stddev:7.04 (5.7%) stddev-sans-first:6.91 05:28:34 INFO - PROCESS | 1955 | Values: 130.0 119.0 132.0 116.0 120.0 130.0 129.0 113.0 117.0 118.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.40 Median:135.00 stddev:15.76 (11.7%) stddev-sans-first:16.63 05:28:34 INFO - PROCESS | 1955 | Values: 134.0 124.0 136.0 136.0 133.0 122.0 133.0 161.0 172.0 133.0 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - PROCESS | 1955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:67.50 stddev:11.50 (17.0%) stddev-sans-first:12.03 05:28:34 INFO - PROCESS | 1955 | Values: 67.0 66.0 68.0 65.0 66.0 66.0 67.0 71.0 94.0 94.0 05:28:34 INFO - PROCESS | 1955 | -------- Summary: end -------- 05:28:34 INFO - PROCESS | 1955 | 05:28:34 INFO - TEST-INFO | 1955: exit 0 05:28:34 INFO - TEST-OK | kraken | took 56814ms 05:28:34 INFO - SUITE-END | took 1169s 05:28:35 INFO - Completed test suite (00:19:30) 05:28:35 INFO - javascript benchmark 05:28:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.569138166348, 3509.438489841626, 3510.0873772819077, 3542.326957878003, 3563.1448452371437, 5780.2485676862, 5813.767449302023, 5820.883582328351, 5830.679312637803, 5835.737391817368, 5806.82579522615, 5846.181534585162, 5849.502792262652, 5850.853728656775, 5858.882822343561, 5193.272941788134, 5253.553447956928, 5266.183741520071, 5286.788528458857, 5299.072662284104, 4852.393450818648, 4994.875128121808, 5337.946620533803, 5374.220737992989, 5383.0, 5288.576913846883, 5328.200769884529, 5362.544183744387, 5385.488378604026, 5394.083005889008, 5324.307839980797, 5369.382521010056, 5369.9463005369835, 5381.596380271456, 5399.19012148177, 5065.949340506585, 5243.4232234454175, 5253.369595648508, 5269.051570717269, 5309.0, 5680.971595141998, 5703.62926409782, 5710.229119068914, 5730.226419433365, 5740.827775166752, 6126.632402055891, 6362.459190968773, 6373.7450501979865, 6374.203224596926, 6375.0, 6292.307846136967, 6300.5589608727405, 6313.558050936436, 6379.266384365811, 6425.100485931926, 5843.211166492511, 5870.559708021873, 5872.412758724179, 5874.559408044413, 5941.732622032019, 6286.119943207955, 6310.368963103745, 6369.490440764727, 6371.617702937839, 6373.426391624776, 6215.9378406216265, 6251.874962500725, 6268.1851359323, 6278.089676996901, 6279.96860015697, 6364.968175159094, 6366.236051673736, 6367.586106903036, 6385.329540398284, 6390.680465976682, 6128.839250099703, 6243.469305109116, 6252.718627661766, 6314.273858506331, 6388.904166437507, 6237.064440333987, 6271.811845644638, 6292.622442653455, 6307.684615769193, 6308.3060863305, 4903.313536104948, 4916.508349165055, 4917.631177661689, 4927.7536123193695, 4947.950520494749, 4405.823767049282, 4417.315316126005, 4481.081378317437, 4521.84173553924, 4537.183307004705, 5776.33572139201, 5791.884162316815, 5792.0, 5795.1017592273265, 5817.563682723728, 6357.523185761086, 6393.680315984182, 6395.680215989182, 6396.008618664115, 6404.039394090831, 5665.688387138747, 5720.170575266647, 5753.626014309057, 5771.163181338682, 5842.152887831326, 4562.771861406916, 5418.078926582491, 5424.783008679608, 5433.483819037185, 5436.592255580847, 6357.141785858942, 6395.840103997344, 6413.7113829876835, 6428.871422571616, 6439.935600643934, 6223.097650840693, 6328.240611126695, 6371.904421433589, 6405.103285540122, 6419.293877673359, 6374.26695929974, 6385.233771947396, 6388.744450222125, 6390.840228994312, 6403.775867844603, 6113.724882380215, 6260.718267677874, 6269.780557680459, 6292.339304373158, 6294.496440284858, 6262.15460912771, 6345.8730825384155, 6354.936450635434, 6370.331115232834, 6381.840453988688, 5986.491148252448, 6187.0, 6189.6286222826775, 6208.441240288395, 6215.192025036717, 5974.581779275582, 6124.142620033288, 6224.9377506224355, 6232.501399887908, 6251.843703907439, 5132.050570644443, 5866.7066646668345, 5991.67045812467, 6015.518758499222, 6036.9094463582205, 6120.658718449855, 6132.938670613236, 6140.956037473729, 6142.385761423822, 6144.2319710036245, 5270.762815673227, 5879.353271140257, 6011.969940150271, 6012.188354572252, 6055.455009049207], "unit": "score", "name": "dojo.html", "value": 5767.845918399828}, {"lowerIsBetter": false, "replicates": [465.25326850405077, 538.2518299563604, 585.4993980146975, 664.6145235763257, 665.6272487407053, 25919.222423327283, 39212.60787392125, 39637.60362396383, 39644.40533391998, 39689.20621587574, 42299.0, 42604.57395426045, 42680.57319426805, 42721.0, 42756.0, 9649.083337083, 9882.851757223647, 9887.357321774098, 9899.90100098997, 9902.504874756234, 9772.609095636166, 9874.358166719176, 9898.158656514204, 9904.158146557551, 9913.950430247838, 9853.605855765796, 10067.597296108146, 10084.445355505444, 10093.444860532667, 10137.543810528507, 10000.399976001427, 10051.296409251356, 10051.39691618498, 10053.648122315684, 10076.345037572572, 9707.029297070307, 9825.606975720963, 9831.754206144831, 9850.408975461496, 9854.90145098547, 41537.37693934594, 41762.0, 41870.79064604688, 41956.0, 41995.37006944898, 3197.8560964756643, 3221.0, 3229.40256052631, 3406.7615266931325, 3422.9315413691834, 28663.71336286652, 28792.42415151685, 29016.41967160645, 29267.560986585217, 29403.264918377212, 2755.476459472694, 2780.4582035951885, 2801.8739156737997, 2814.015094716853, 2823.5341168707137, 428398.0, 431622.0, 431703.0, 433164.0, 433372.0, 58905.70547147237, 58948.0, 59040.0, 59119.11321330183, 59150.0, 66952.0, 76333.61833190799, 77374.22625773783, 77611.83582246272, 77659.0, 17757.7336339955, 17761.822381776274, 17905.283788648307, 17962.461126166236, 17978.370757023702, 13420.0605957584, 13473.585273546332, 13478.595642130751, 13480.056396052378, 13500.122492037986, 22435.551288974457, 22758.74826884504, 22787.404881658455, 22790.544189116124, 22809.631422114726, 8675.522846243517, 8914.777130571787, 8928.553572321358, 8974.28205743539, 9088.636704494247, 918.3525614441802, 960.9519524023771, 987.7382493639192, 1015.7003683913264, 1026.199564339816, 23772.881135594213, 29154.271143221587, 29584.704152958195, 29981.550276745867, 30487.847560762497, 991.9652812151685, 1042.789286712175, 1048.5229220704562, 1048.5648455890873, 1112.821948488238, 15010.849891501164, 15158.848411515964, 15169.772453413208, 15207.063128455387, 15452.5364239073, 534299.0, 541788.0, 542224.0, 542410.0, 542763.0, 59770.0, 60107.0, 60135.398646013855, 60155.0, 60228.0, 1355.5187908292612, 1408.0284603623468, 1519.1340935666785, 1549.1092621742318, 1556.0663601839033, 28879.85560072186, 29353.0, 29464.0, 29559.408811823214, 30102.0, 46142.538574615166, 46483.0, 47040.05919881652, 47059.29411058768, 47081.76459117683, 300516.0, 304967.0, 305028.0, 305687.0, 305819.0, 29495.0, 30287.0, 48135.75932120317, 49175.01649966909, 49817.50182498273, 46359.768201158775, 46908.0, 47716.04567908553, 47764.0, 48456.0, 36690.63309366872, 38042.61957380391, 38090.238195236496, 38132.6186738129, 38733.612663874126, 36457.90626281216, 37531.0, 37665.0, 38364.0, 38446.0, 38991.6100838988, 39478.2104357917, 39774.0, 40197.0, 40261.0, 33631.83184084064, 34478.219243657215, 34956.47565286472, 35197.64802352046, 35320.0, 25811.483770324114, 26061.609075863496, 26148.8692556536, 26491.0, 26588.734112658625], "unit": "score", "name": "ext.html", "value": 20116.732928906637}, {"lowerIsBetter": false, "replicates": [375.98872033838984, 377.9414190800425, 378.1416185259461, 382.5371300726121, 383.703083577508, 20343.28798492053, 20608.278710245144, 21244.681329780065, 21531.24640637576, 21542.569148617018, 11881.584144554943, 12404.0, 12433.626991190256, 12442.502299907992, 12445.502179912815, 4737.313089602006, 5988.19159413478, 5990.371011043843, 5998.940010599882, 6002.819915402545, 5970.462658360747, 5991.460768530831, 6010.948084085289, 6011.218541589609, 6082.209312789331, 4809.206480930642, 5875.383084776101, 5893.263342082239, 5987.790427335044, 5988.1317209004665, 5736.483716465538, 5817.534597232211, 5818.214541036969, 5818.912716309259, 5839.416058394169, 5053.84838454847, 5222.582193424517, 5224.39919409269, 5225.869353266161, 5234.241035049897, 13861.722765544633, 13863.23752193629, 13872.583822485341, 21369.610975286712, 25329.366765831, 1862.3947217154343, 2072.5440403111293, 2212.0598745533084, 2256.244158207003, 2303.1478353009493, 8196.34429245659, 10311.278210525266, 13082.411291491906, 14269.0, 14796.334164962602, 1640.9179541022902, 1711.3496871188993, 1751.8773685841995, 1764.1091248919213, 1816.6275913437714, 95567.0, 97427.0, 99870.0, 101005.0, 102857.94284114277, 11393.259438136494, 11506.180985658568, 11624.476898539586, 11715.297082174926, 11954.521819127138, 14412.42350305997, 14480.275986200648, 14480.710385792225, 14499.637509062148, 14508.911831612671, 7930.41391721658, 8467.915320846836, 8746.34402419821, 8816.691415800417, 8837.469751814911, 8381.874271885927, 8988.685396011108, 9011.27909767217, 9036.683716069905, 9075.909240907506, 4597.540245975376, 4601.792919318638, 4606.631469482433, 4620.67655264135, 4645.0, 1891.7729872415398, 1920.2511020701938, 1932.7777305610034, 1934.5067007913174, 1937.1282922684848, 903.4759839293325, 947.1664934857281, 971.3346357744826, 994.0705440413237, 1008.6923488336128, 17941.833780804205, 19722.506937326394, 20066.0, 20475.692864607045, 20726.274580389614, 975.9072888075622, 994.0506815990711, 1001.2640709078821, 1018.4296793795498, 1058.2116323339162, 8944.776380590407, 10813.513391897384, 11177.49701263445, 11183.664490065312, 11230.606928757454, 611851.0, 627802.0, 641889.0, 644273.0, 644363.0, 100306.0, 101264.49367753114, 110328.34507482394, 129711.0, 130991.0, 837.7738010737066, 953.0945601678433, 979.9608015679436, 982.2240430060173, 1003.0270637481631, 17626.64746705033, 17779.822201778334, 18073.819261807213, 18441.631167376847, 18737.250509979447, 43645.781771090944, 48917.510824891295, 55709.0, 55888.720556396955, 56521.0, 77409.87196344529, 78613.60693196727, 78960.0, 82426.93932651491, 82582.3483530338, 7893.0, 8110.107888132418, 8155.225253600898, 8409.411341206056, 8436.578171091543, 9495.525223738923, 10664.946675266574, 12408.317542535247, 13517.121387109806, 13747.450101995808, 11169.329840209613, 11403.0, 11574.71063223426, 11748.823767643664, 11947.163698541019, 5333.493318134771, 10620.256582039183, 11125.276857004268, 11274.041706454715, 11325.0, 10022.699319020441, 10898.291611045257, 11710.180287379802, 11718.531258749554, 11756.11829112837, 7010.4041156500225, 8022.759317220492, 8094.0, 8145.837083258183, 8221.218984196492, 8370.832583348421, 10908.0, 11649.301041937511, 11773.941130294294, 11953.163278570417], "unit": "score", "name": "jquery.html", "value": 9258.192613284271}, {"lowerIsBetter": false, "replicates": [1478.105746023655, 1605.7029449551833, 1631.2414727151877, 1949.9707504387436, 2067.7725450200473, 8404.705835295757, 8957.865632015517, 9079.228265597416, 9097.63609455621, 9103.726888193349, 8667.826643467128, 8897.288216942645, 8913.331500137483, 8923.107689231074, 8937.285017198625, 2208.0615738311153, 2277.954440911189, 2284.8971796269207, 2513.359093431177, 2558.155808583163, 2531.4177739120014, 2609.0868196131296, 2610.321316457725, 2613.3074735195187, 2615.620734993425, 2476.6656501372263, 2518.357818756215, 2518.5718427867214, 2548.872556372174, 2585.3536615846037, 2520.8991640334366, 2535.568953277947, 2541.47899680566, 2546.0, 2549.6430499730054, 2530.671012768347, 2557.4117952870943, 2577.6777902762155, 2581.9612705809427, 2582.1478911959007, 9085.682001129995, 9125.49809760463, 9147.771305717344, 9153.405028673114, 9170.495622740747, 5556.277683901108, 5739.110437882135, 5777.480026797609, 5777.653340799566, 5791.478766910956, 3612.6567976042234, 3718.2563487302377, 3757.9436308455397, 3758.1397208381754, 3796.2916687490465, 1021.0963297481708, 1035.2959987208694, 1047.8480620310088, 1049.0296475759967, 1077.849101125843, 11934.522619095225, 12079.396030198543, 12099.879001209963, 12112.39438028095, 12120.333381664004, 5031.622628302892, 5051.191809310492, 5099.796008159707, 5120.462351453119, 5144.6398752087, 10470.581176752998, 10555.15558755313, 10559.049685528185, 10562.471876406149, 10597.0, 5638.633488823213, 5669.376368599451, 5690.800821971211, 5694.572907031989, 5701.287339082614, 4569.040501494724, 4690.742009189527, 4920.975395123001, 5129.666571672829, 5137.383513978347, 4166.481544560121, 4170.854020109342, 4170.957260684829, 4199.0552125771455, 4204.831806727697, 1315.4343632238038, 1353.7766268565774, 1355.6746380868717, 1360.8707172818567, 1369.2469141971876, 1376.4425407709693, 1391.1653008195, 1399.3842709207916, 1418.2412409361148, 1425.9287035648176, 8187.672493100209, 8379.916200837913, 8392.0, 8393.118722534167, 8404.495730256203, 524.8871492629103, 528.7462018231271, 537.478645713665, 542.7910254552025, 543.1716632136024, 6305.464035556937, 6319.304876463585, 6353.428191462698, 6364.84087897797, 6369.808905732835, 10743.946280268548, 11169.94415027936, 11220.0, 11234.3259404436, 11496.42517874103, 8297.917020829835, 10753.354798712102, 10919.0, 11087.445627718582, 11187.608433704781, 8535.445196062235, 8554.572271386405, 8627.266682332072, 8632.913670863336, 8674.6963856266, 7026.332498412643, 7910.011248593926, 8042.678292868453, 8049.315808156372, 8340.416170868224, 9725.562349694139, 9959.103680668775, 9961.800763984824, 9975.251856110966, 10149.441780702133, 10048.246381521269, 10327.845082323622, 10475.214358923264, 10481.685549433529, 10509.054185123376, 7604.467687261838, 7604.619769011638, 7612.7716168515035, 7699.923000769921, 7718.189590092959, 8347.58262086881, 8366.665333386596, 8427.030891447317, 8435.915640843514, 8446.619902104543, 7441.888371674321, 7511.173770885308, 7579.810504737426, 7687.231276872268, 7692.0, 7350.595717235603, 7384.556926584422, 7395.556266624019, 7500.362469189961, 7500.9249907500225, 7890.171531989058, 7940.16628254025, 7963.044434667645, 7975.0, 7978.122406535161, 7156.105486814148, 7160.212376638669, 7211.38703210212, 7252.166000909963, 7254.45591580623, 7294.525855819355, 7324.926750732638, 7351.8529629408185, 7359.889601656087, 7370.63146842645], "unit": "score", "name": "mootools.html", "value": 4998.723421349705}, {"lowerIsBetter": false, "replicates": [328.8832464475111, 332.7853534470267, 336.02050024179516, 339.23840977006626, 340.9931801363974, 6474.902876456851, 6538.836529086775, 6562.1141145945285, 6578.309277525863, 6589.637569933651, 5191.273221748958, 6413.935860641403, 6466.256380516242, 6479.222493300798, 6510.479161667067, 4693.131770622429, 4788.664793464459, 4862.0275944811, 4864.173090574611, 4868.196747536652, 4870.0, 4892.755362231892, 4919.1637421638225, 4922.163232250526, 4953.653244272902, 3881.922361552767, 4851.563359297663, 4869.951300487003, 4876.146674331995, 4893.608511319086, 4617.815287388517, 4719.150552900459, 4871.658983871131, 4875.463698993108, 4887.486813884562, 4168.083021735213, 4176.0, 4177.603127702894, 4193.412922190896, 4194.895127621803, 5361.874006458648, 5475.863103422446, 6263.404976527268, 6299.118123462719, 6312.810615681537, 5695.515881150066, 5701.971490142523, 5714.7428365723645, 5724.627899186581, 5724.856878578027, 6797.150356205474, 6992.230854605989, 6999.860002799966, 7008.544444611135, 7015.4036906862975, 4626.352310676508, 4696.882577935545, 4716.339712440261, 4716.38686970695, 4732.645051621143, 7369.594672293022, 7425.257474252639, 7425.405967522639, 7435.739749108755, 7453.590052547108, 4757.643176761757, 4783.06730187617, 4784.856454306377, 4790.473047964721, 4796.208625576811, 4841.104395686809, 4850.102730994778, 4852.417709874838, 4858.05267972742, 4858.17411040124, 4676.625869930397, 5698.971505142447, 5708.628939118944, 5709.7716091356715, 5730.684812335361, 6751.0, 7017.578945263199, 7036.964815175891, 7041.4718896082995, 7051.682674279669, 1313.6912825486004, 1670.4153546258713, 1688.6791509613379, 1697.6010637500178, 1698.4819630012717, 959.2086528613921, 1031.2471895516314, 1058.6030238660503, 1099.59864649404, 1118.0999295567146, 6435.552000799877, 6591.670416479253, 6617.536772425884, 6638.369354911276, 6645.634490102994, 6296.275928268308, 6982.0, 7430.182679905206, 7443.8883416748795, 7447.590382528904, 6159.384061593805, 6472.126262954535, 6584.9012264816065, 6600.636964966973, 6611.537192396582, 3149.8425078745972, 3909.6872250219913, 3915.4322623219473, 3918.7060970427333, 3919.725619206685, 6449.806505804833, 6990.965045174741, 7426.071741032371, 7644.20986339993, 7772.339351155102, 7379.926200738031, 7655.35409886877, 7661.61691915402, 7663.540187588763, 7676.462647614725, 7708.5760283183845, 7717.57553334572, 7743.683573792581, 7761.3790896727, 7767.611619419119, 7174.713011479483, 7361.0, 7409.147947986051, 7419.258074192538, 7420.0, 7234.855302893808, 7248.0, 7282.271772822675, 7284.3808276294985, 7284.635768211674, 7716.498427602188, 7726.9227307726205, 7727.227277272228, 7731.072271327476, 7741.109772376023, 3646.890593282206, 4806.759662016815, 4852.175130227799, 4863.270509423614, 4871.975640121776, 7002.264762199896, 7304.6347682616715, 7309.744158954624, 7325.120985481776, 7326.0, 6999.405050570758, 7006.229314775473, 7019.403350715246, 7049.259827718016, 7079.610621415872, 7087.149542054986, 7111.182214045244, 7123.893141602776, 7124.145102587722, 7136.250693677297, 5657.2928383952, 6956.652167391509, 6966.79099627012, 6981.232064473005, 6983.650817459208, 6866.4506839453725, 7098.964505177441, 7110.608916509642, 7120.465965052746, 7124.038254835531, 5582.441755824385, 6708.496862735216, 6886.932525458562, 6900.2409734928115, 6974.511784175262], "unit": "score", "name": "prototype.html", "value": 5142.897179562103}, {"lowerIsBetter": false, "replicates": [656.2748163279576, 663.2372771312989, 695.5583204665038, 788.3771820261993, 795.8487887301412, 15163.54509364718, 15563.37746490139, 15577.766333505006, 15585.922070389646, 15610.687786244282, 11697.122715796328, 14133.92933035336, 14147.0, 14167.220802855838, 14190.71618567628, 799.8560259153364, 981.8625392445064, 1015.7003683913226, 1017.013496907998, 1017.2065788684838, 842.2335674536173, 984.3552473130111, 996.5017491254373, 1003.7239759066279, 1004.4023805835516, 847.063994286314, 1059.2161800267822, 1064.5582083435365, 1065.6962765611802, 1072.2226385870222, 1023.4013102335143, 1049.511976930731, 1049.7585555322241, 1051.353417648141, 1055.5619417941546, 781.3007358414244, 786.1195461083623, 786.4966421490194, 786.8347646994138, 786.8819677048431, 15229.771553426708, 15259.618509537351, 15266.465673701367, 15286.0, 15300.540983770505, 13032.218066916015, 13184.73630527384, 13265.137766045273, 13434.126781759154, 13778.724425511433, 10141.89858101417, 10242.180625550012, 10259.118469103561, 10448.425336606484, 10725.14198864089, 3528.558930133733, 3557.3063252665743, 3572.374834403969, 3595.0832537702718, 3668.413053911361, 79528.0, 80381.59809200917, 80672.0, 82200.58899705522, 82413.58793205995, 8135.471194372465, 9967.651132210338, 10094.848577271347, 10100.545475453622, 10164.847527287096, 19298.842069475875, 20374.083166257555, 21499.355019349445, 21805.563888722136, 21882.781172188075, 7560.621968901533, 7574.772756817304, 7638.847223055508, 7849.293563579306, 7908.01149856268, 4082.6121518455698, 4088.1823635273063, 4149.460570125864, 4304.397384366192, 4374.58441448062, 3749.1376983293994, 3755.6807671347697, 3774.6791522720328, 3798.24035192957, 3802.752821066622, 645.257953353647, 650.5543702563759, 675.3617831149517, 698.27728301208, 703.7712743358429, 568.2499101186477, 575.6661136540796, 579.8550362409397, 603.2670305578743, 628.4563852267755, 7900.0, 8296.87554686668, 8327.541985190752, 8410.537420441935, 8498.575071246536, 584.9210356601805, 594.7442599682091, 599.5683108162116, 623.0809555905004, 625.8435391152212, 3386.6274709781906, 3910.3156947534067, 3929.2730844793805, 3941.152652179795, 4027.5771044039952, 98360.50819745855, 99001.56489828139, 100853.0, 101687.98312016785, 101861.49069254755, 76287.47425051469, 77246.84129738058, 77701.0, 79120.0, 82686.0, 68747.65626171837, 70564.2943570568, 70757.99999999897, 71702.0, 72228.91656625154, 7070.46971477131, 7643.178410794602, 7915.762527124196, 8582.78543036429, 8670.739877803677, 51008.0, 51296.0, 51399.743001284754, 53711.73144134254, 53874.19188712094, 62861.37138628555, 64259.07222783324, 70659.29340706527, 73944.52110957858, 74856.12859678334, 11142.164337674545, 11383.0, 11529.884701152881, 11546.884531154581, 11657.18399712012, 12163.81754273669, 12175.634730958085, 12367.196132251374, 12405.565805197135, 12553.748925021631, 11416.31502109876, 11760.647180584596, 11869.406529673655, 11889.940550297193, 11988.220765650205, 10041.849372259569, 11585.594504192313, 11655.825162622737, 11817.940910295394, 12061.51753929833, 11267.492962816528, 11490.0, 11592.072634189077, 11672.766544669228, 12139.453724582592, 8571.314294856273, 8722.869156962524, 8897.421667591585, 8933.330000249878, 9020.819583608421, 9752.9024709752, 9908.306418550632, 9914.950425247827, 10039.69880903574, 10048.346857454242], "unit": "score", "name": "yui.html", "value": 7100.143027756687}], "name": "dromaeo_css", "value": 7622.152408415034}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 111.0, 111.0, 112.0, 119.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 145.0, 152.0, 123.0, 141.0, 117.0, 149.0, 148.0, 102.0], "unit": "score", "name": "audio-beat-detection", "value": 135.1}, {"lowerIsBetter": true, "replicates": [191.0, 256.0, 220.0, 184.0, 187.0, 185.0, 185.0, 184.0, 186.0, 183.0], "unit": "score", "name": "audio-dft", "value": 196.1}, {"lowerIsBetter": true, "replicates": [71.0, 83.0, 77.0, 117.0, 59.0, 77.0, 83.0, 82.0, 141.0, 46.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 132.0, 77.0, 80.0, 82.0, 120.0, 76.0, 79.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 85.0, 90.0, 86.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 123.0], "unit": "score", "name": "imaging-darkroom", "value": 96.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 83.0, 85.0, 87.0, 85.0, 105.0, 141.0, 134.0], "unit": "score", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 58.0, 59.0, 57.0, 57.0, 68.0, 55.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 74.0, 76.0, 71.0, 67.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 97.0, 104.0, 104.0, 104.0, 81.0, 80.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.7}, {"lowerIsBetter": true, "replicates": [130.0, 119.0, 132.0, 116.0, 120.0, 130.0, 129.0, 113.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [134.0, 124.0, 136.0, 136.0, 133.0, 122.0, 133.0, 161.0, 172.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 65.0, 66.0, 66.0, 67.0, 71.0, 94.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1450.5000000000002}]} 05:28:35 INFO - Return code: 0 05:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:35 INFO - # TBPL SUCCESS # 05:28:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:35 INFO - 2016-04-12 05:28:35.322 screenresolution[1959:13907] starting screenresolution argv=screenresolution get 05:28:35 INFO - 2016-04-12 05:28:35.325 screenresolution[1959:13907] Display 0: 1600x1200x32@60 05:28:35 INFO - 2016-04-12 05:28:35.330 screenresolution[1960:13910] starting screenresolution argv=screenresolution list 05:28:35 INFO - Available Modes on Display 0 05:28:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:35 INFO - Intel Iris: 05:28:35 INFO - Chipset Model: Intel Iris 05:28:35 INFO - Type: GPU 05:28:35 INFO - Bus: Built-In 05:28:35 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:35 INFO - Vendor: Intel (0x8086) 05:28:35 INFO - Device ID: 0x0a2e 05:28:35 INFO - Revision ID: 0x0009 05:28:35 INFO - Displays: 05:28:35 INFO - Display: 05:28:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:35 INFO - Display Serial Number: 1600x1200 60 05:28:35 INFO - Main Display: Yes 05:28:35 INFO - Mirror: Off 05:28:35 INFO - Online: Yes 05:28:35 INFO - Rotation: Supported 05:28:35 INFO - Return code: 0 05:28:35 INFO - Running post-action listener: _resource_record_post_action 05:28:35 INFO - Running post-run listener: _resource_record_post_run 05:28:36 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 606208; Write bytes: 663503872; Read time: 10; Write time: 2277 05:28:36 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 352938496; Write bytes: 353482240; Read time: 28189; Write time: 695 05:28:36 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 606208; Write bytes: 299683328; Read time: 10; Write time: 1553 05:28:36 INFO - Running post-run listener: _upload_blobber_files 05:28:36 INFO - Blob upload gear active. 05:28:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:36 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:28:36 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:28:36 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:28:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:38 INFO - (blobuploader) - INFO - Done attempting. 05:28:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:39 INFO - (blobuploader) - INFO - Done attempting. 05:28:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:39 INFO - Return code: 0 05:28:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/460d1e8280e230fcea8e52dff0ed65cd28dd1459fa6d68cedc0e82d442c060b900c7dc4a3a9b8b17b9882402ee3f73bda5558c4b01ac3ccb3cdc940f45010835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd526faee89220345a09bb15dc26ea7a9d394a31b0eaa6a13f4a869699d64b4a95a6dea49ee1d53bcf20a88c8b0b910fe210bd0cc6f802675ddc5977bf1ca531"} 05:28:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:39 INFO - Contents: 05:28:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/460d1e8280e230fcea8e52dff0ed65cd28dd1459fa6d68cedc0e82d442c060b900c7dc4a3a9b8b17b9882402ee3f73bda5558c4b01ac3ccb3cdc940f45010835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd526faee89220345a09bb15dc26ea7a9d394a31b0eaa6a13f4a869699d64b4a95a6dea49ee1d53bcf20a88c8b0b910fe210bd0cc6f802675ddc5977bf1ca531"} 05:28:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:39 INFO - Copying logs to upload dir... 05:28:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.444393 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-04-12 05:28:39.235060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:28:39.238753) ========= 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.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/Mozilla-Aurora/sha512/460d1e8280e230fcea8e52dff0ed65cd28dd1459fa6d68cedc0e82d442c060b900c7dc4a3a9b8b17b9882402ee3f73bda5558c4b01ac3ccb3cdc940f45010835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd526faee89220345a09bb15dc26ea7a9d394a31b0eaa6a13f4a869699d64b4a95a6dea49ee1d53bcf20a88c8b0b910fe210bd0cc6f802675ddc5977bf1ca531"} build_url:https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/LV0DHCnmSOOE4qjNekUWmw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/460d1e8280e230fcea8e52dff0ed65cd28dd1459fa6d68cedc0e82d442c060b900c7dc4a3a9b8b17b9882402ee3f73bda5558c4b01ac3ccb3cdc940f45010835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd526faee89220345a09bb15dc26ea7a9d394a31b0eaa6a13f4a869699d64b4a95a6dea49ee1d53bcf20a88c8b0b910fe210bd0cc6f802675ddc5977bf1ca531"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:28:39.266681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:28:39.267005) ========= 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.bGbGUEt3OY/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.86t1b3LPtN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005255 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:28:39.316196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:28:39.316529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:28:39.316923) ========= ========= Total master_lag: 6.49 =========