builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0107 starttime: 1454034171.27 results: success (0) buildid: 20160128163036 builduid: 527d92b1a77344d5b9d5aa9b1b056c5f revision: a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.272836) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.273228) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.273520) ========= 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.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005631 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.373364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.373682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.570388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.570649) ========= 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.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005562 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.661236) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.661548) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.661906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.662178) ========= 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.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-01-28 18:22:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 52.6M=0s 2016-01-28 18:22:52 (52.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.516624 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.267257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.267546) ========= 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.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.018989 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.373071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-28 18:22:52.373370) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-01-28 18:22:52,466 truncating revision to first 12 chars 2016-01-28 18:22:52,466 Setting DEBUG logging. 2016-01-28 18:22:52,466 attempt 1/10 2016-01-28 18:22:52,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a152a1cbdcf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-28 18:22:53,188 unpacking tar archive at: mozilla-central-a152a1cbdcf0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969587 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-28 18:22:53.377205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:53.377551) ========= echo a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac program finished with exit code 0 elapsedTime=0.005168 script_repo_revision: 'a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:53.426598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:53.426893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:53.439546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-28 18:22:53.439816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:22:53 INFO - MultiFileLogger online at 20160128 18:22:53 in /builds/slave/test 18:22:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:22:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:53 INFO - {'append_to_log': False, 18:22:53 INFO - 'base_work_dir': '/builds/slave/test', 18:22:53 INFO - 'blob_upload_branch': 'Firefox', 18:22:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:53 INFO - 'branch': 'Firefox', 18:22:53 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:53 INFO - 'config_files': ('talos/mac_config.py',), 18:22:53 INFO - 'default_actions': ('clobber', 18:22:53 INFO - 'read-buildbot-config', 18:22:53 INFO - 'download-and-extract', 18:22:53 INFO - 'populate-webroot', 18:22:53 INFO - 'create-virtualenv', 18:22:53 INFO - 'install', 18:22:53 INFO - 'run-tests'), 18:22:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:53 INFO - 'download_minidump_stackwalk': True, 18:22:53 INFO - 'download_symbols': 'ondemand', 18:22:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:53 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:53 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:53 INFO - 'installer_path': 'installer.exe', 18:22:53 INFO - 'log_level': 'info', 18:22:53 INFO - 'log_name': 'talos', 18:22:53 INFO - 'log_to_console': True, 18:22:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:22:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:22:53 INFO - 'opt_config_files': (), 18:22:53 INFO - 'pip_index': False, 18:22:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:22:53 INFO - 'cmd': ('bash', 18:22:53 INFO - '-c', 18:22:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:22:53 INFO - 'enabled': True, 18:22:53 INFO - 'halt_on_failure': False, 18:22:53 INFO - 'name': 'check_screen_resolution'},), 18:22:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:22:53 INFO - 'cmd': ('bash', 18:22:53 INFO - '-c', 18:22:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:22:53 INFO - 'enabled': True, 18:22:53 INFO - 'halt_on_failure': False, 18:22:53 INFO - 'name': 'check_screen_resolution'},), 18:22:53 INFO - 'run_cmd_checks_enabled': True, 18:22:53 INFO - 'sps_profile': False, 18:22:53 INFO - 'sps_profile_interval': 0, 18:22:53 INFO - 'suite': 'dromaeojs', 18:22:53 INFO - 'system_bits': '32', 18:22:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:53 INFO - 'title': 't-yosemite-r7-0107', 18:22:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:53 INFO - 'use_talos_json': True, 18:22:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:53 INFO - 'work_dir': 'build'} 18:22:53 INFO - ##### 18:22:53 INFO - ##### Running clobber step. 18:22:53 INFO - ##### 18:22:53 INFO - Running pre-action listener: _resource_record_pre_action 18:22:53 INFO - Running main action method: clobber 18:22:53 INFO - rmtree: /builds/slave/test/build 18:22:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:55 INFO - Running post-action listener: _resource_record_post_action 18:22:55 INFO - ##### 18:22:55 INFO - ##### Running read-buildbot-config step. 18:22:55 INFO - ##### 18:22:55 INFO - Running pre-action listener: _resource_record_pre_action 18:22:55 INFO - Running main action method: read_buildbot_config 18:22:55 INFO - Using buildbot properties: 18:22:55 INFO - { 18:22:55 INFO - "project": "", 18:22:55 INFO - "product": "firefox", 18:22:55 INFO - "script_repo_revision": "production", 18:22:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:22:55 INFO - "repository": "", 18:22:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:22:55 INFO - "buildid": "20160128163036", 18:22:55 INFO - "pgo_build": "False", 18:22:55 INFO - "basedir": "/builds/slave/test", 18:22:55 INFO - "buildnumber": 132, 18:22:55 INFO - "slavename": "t-yosemite-r7-0107", 18:22:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:22:55 INFO - "platform": "yosemite_r7", 18:22:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:22:55 INFO - "branch": "mozilla-central", 18:22:55 INFO - "repo_path": "mozilla-central", 18:22:55 INFO - "revision": "a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac", 18:22:55 INFO - "stage_platform": "macosx64", 18:22:55 INFO - "builduid": "527d92b1a77344d5b9d5aa9b1b056c5f", 18:22:55 INFO - "slavebuilddir": "test" 18:22:55 INFO - } 18:22:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:22:55 INFO - Running post-action listener: _resource_record_post_action 18:22:55 INFO - ##### 18:22:55 INFO - ##### Running download-and-extract step. 18:22:55 INFO - ##### 18:22:55 INFO - Running pre-action listener: _resource_record_pre_action 18:22:55 INFO - Running main action method: download_and_extract 18:22:55 INFO - mkdir: /builds/slave/test/build/tests 18:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:55 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json 18:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json 18:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:22:59 INFO - Downloaded 1277 bytes. 18:22:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:22:59 INFO - Using the following test package requirements: 18:22:59 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:22:59 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:22:59 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:22:59 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'jsshell-mac.zip'], 18:22:59 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:22:59 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:22:59 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:22:59 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:22:59 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:22:59 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:22:59 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:59 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:22:59 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:22: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')]} 18:22:59 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:01 INFO - Downloaded 16726789 bytes. 18:23:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:23:04 INFO - Return code: 0 18:23:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:23: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')]} 18:23:04 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:11 INFO - Downloaded 16726789 bytes. 18:23:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:23:14 INFO - Return code: 0 18:23:14 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')]} 18:23:14 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:23:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:23:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:23:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:23:15 INFO - Downloaded 10706582 bytes. 18:23:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:23:15 INFO - Return code: 0 18:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:15 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 18:23:21 INFO - Downloaded 111012885 bytes. 18:23:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:21 INFO - mkdir: /builds/slave/test/properties 18:23:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:21 INFO - Contents: 18:23:21 INFO - build_url:https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:21 INFO - Running post-action listener: _resource_record_post_action 18:23:21 INFO - Running post-action listener: set_extra_try_arguments 18:23:21 INFO - ##### 18:23:21 INFO - ##### Running populate-webroot step. 18:23:21 INFO - ##### 18:23:21 INFO - Running pre-action listener: _resource_record_pre_action 18:23:21 INFO - Running main action method: populate_webroot 18:23:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:21 INFO - '--tppagecycles', 18:23:21 INFO - '7'], 18:23:21 INFO - 'tests': ['tsvgm']}}, 18:23:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:23:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:23:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:23:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'tests': ['damp', 'tps']}, 18:23:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['damp', 'tps']}, 18:23:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:23:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:21 INFO - 'other': {'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other_l64': {'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other_nol64': {'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'svgr': {'tests': ['tsvgx', 18:23:21 INFO - 'tsvgr_opacity', 18:23:21 INFO - 'tart', 18:23:21 INFO - 'tscrollx', 18:23:21 INFO - 'cart']}, 18:23:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tsvgx', 18:23:21 INFO - 'tsvgr_opacity', 18:23:21 INFO - 'tart', 18:23:21 INFO - 'tscrollx', 18:23:21 INFO - 'cart']}, 18:23:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'tests': ['tp5o']}, 18:23:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tp5o']}, 18:23:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--xperf_path', 18:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:21 INFO - 'tests': ['tp5n']}, 18:23:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s', 18:23:21 INFO - '--xperf_path', 18:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:21 INFO - 'tests': ['tp5n']}}, 18:23:21 INFO - 'talos.zip': {'path': '', 18:23:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:21 INFO - Running post-action listener: _resource_record_post_action 18:23:21 INFO - ##### 18:23:21 INFO - ##### Running create-virtualenv step. 18:23:21 INFO - ##### 18:23:21 INFO - Running pre-action listener: _resource_record_pre_action 18:23:21 INFO - Running main action method: create_virtualenv 18:23:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:21 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 18:23:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:21 INFO - Using real prefix '/tools/python27' 18:23:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:25 INFO - Installing pip.................done. 18:23:25 INFO - Return code: 0 18:23:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23:25 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')]} 18:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:25 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')]} 18:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:25 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:25 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 18:23:25 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 18:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:25 INFO - 'HOME': '/Users/cltbld', 18:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:25 INFO - 'LOGNAME': 'cltbld', 18:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:25 INFO - 'MOZ_NO_REMOTE': '1', 18:23:25 INFO - 'NO_EM_RESTART': '1', 18:23:25 INFO - 'PAGER': '/bin/cat', 18:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:25 INFO - 'PWD': '/builds/slave/test', 18:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:25 INFO - 'SHELL': '/bin/bash', 18:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:25 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:25 INFO - 'USER': 'cltbld', 18:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:25 INFO - 'XPC_FLAGS': '0x0', 18:23:25 INFO - 'XPC_SERVICE_NAME': '0', 18:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:25 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 18:23:25 INFO - Cleaning up... 18:23:25 INFO - Return code: 0 18:23:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:23:25 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')]} 18:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:25 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')]} 18:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:25 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:25 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 18:23:25 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 18:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:25 INFO - 'HOME': '/Users/cltbld', 18:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:25 INFO - 'LOGNAME': 'cltbld', 18:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:25 INFO - 'MOZ_NO_REMOTE': '1', 18:23:25 INFO - 'NO_EM_RESTART': '1', 18:23:25 INFO - 'PAGER': '/bin/cat', 18:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:25 INFO - 'PWD': '/builds/slave/test', 18:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:25 INFO - 'SHELL': '/bin/bash', 18:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:25 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:25 INFO - 'USER': 'cltbld', 18:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:25 INFO - 'XPC_FLAGS': '0x0', 18:23:25 INFO - 'XPC_SERVICE_NAME': '0', 18:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:26 INFO - Downloading/unpacking psutil>=0.7.1 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:29 INFO - Installing collected packages: psutil 18:23:29 INFO - Running setup.py install for psutil 18:23:29 INFO - building 'psutil._psutil_osx' extension 18:23:29 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 18:23:29 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 18:23:29 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 18:23:29 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 18:23:29 INFO - building 'psutil._psutil_posix' extension 18:23:29 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 18:23:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:23:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:23:29 INFO - ^ 18:23:29 INFO - 1 warning generated. 18:23:29 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 18:23:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:30 INFO - Successfully installed psutil 18:23:30 INFO - Cleaning up... 18:23:30 INFO - Return code: 0 18:23:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:23:30 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')]} 18:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:30 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')]} 18:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:30 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:30 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 18:23:30 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 18:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:30 INFO - 'HOME': '/Users/cltbld', 18:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:30 INFO - 'LOGNAME': 'cltbld', 18:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:30 INFO - 'MOZ_NO_REMOTE': '1', 18:23:30 INFO - 'NO_EM_RESTART': '1', 18:23:30 INFO - 'PAGER': '/bin/cat', 18:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:30 INFO - 'PWD': '/builds/slave/test', 18:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:30 INFO - 'SHELL': '/bin/bash', 18:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:30 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:30 INFO - 'USER': 'cltbld', 18:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:30 INFO - 'XPC_FLAGS': '0x0', 18:23:30 INFO - 'XPC_SERVICE_NAME': '0', 18:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:23:32 INFO - Installing collected packages: mozsystemmonitor 18:23:32 INFO - Running setup.py install for mozsystemmonitor 18:23:32 INFO - Successfully installed mozsystemmonitor 18:23:32 INFO - Cleaning up... 18:23:32 INFO - Return code: 0 18:23:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:32 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:32 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 18:23:32 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 18:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:32 INFO - 'HOME': '/Users/cltbld', 18:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:32 INFO - 'LOGNAME': 'cltbld', 18:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:32 INFO - 'MOZ_NO_REMOTE': '1', 18:23:32 INFO - 'NO_EM_RESTART': '1', 18:23:32 INFO - 'PAGER': '/bin/cat', 18:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:32 INFO - 'PWD': '/builds/slave/test', 18:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:32 INFO - 'SHELL': '/bin/bash', 18:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:32 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:32 INFO - 'USER': 'cltbld', 18:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:32 INFO - 'XPC_FLAGS': '0x0', 18:23:32 INFO - 'XPC_SERVICE_NAME': '0', 18:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:33 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:35 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 18:23:35 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 18:23:35 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 18:23:35 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 18:23:35 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 18:23:35 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 18:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 INFO - Downloading docopt-0.6.1.tar.gz 18:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:36 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:36 INFO - Running setup.py install for blobuploader 18:23:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:36 INFO - Running setup.py install for requests 18:23:37 INFO - Running setup.py install for docopt 18:23:37 INFO - Successfully installed blobuploader requests docopt 18:23:37 INFO - Cleaning up... 18:23:37 INFO - Return code: 0 18:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:37 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:37 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 18:23:37 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 18:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:37 INFO - 'HOME': '/Users/cltbld', 18:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:37 INFO - 'LOGNAME': 'cltbld', 18:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:37 INFO - 'MOZ_NO_REMOTE': '1', 18:23:37 INFO - 'NO_EM_RESTART': '1', 18:23:37 INFO - 'PAGER': '/bin/cat', 18:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:37 INFO - 'PWD': '/builds/slave/test', 18:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:37 INFO - 'SHELL': '/bin/bash', 18:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:37 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:37 INFO - 'USER': 'cltbld', 18:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:37 INFO - 'XPC_FLAGS': '0x0', 18:23:37 INFO - 'XPC_SERVICE_NAME': '0', 18:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:37 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Xi8nfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-DwMI8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-QvpYGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-JweYGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ysqg9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-NqVGTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-HXYSUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-BG98so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Dfmafl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Y3GdDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:38 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-7pZCJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:39 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-34c6fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:39 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-1C62VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:39 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-dWqDqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:39 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-dqZhq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:39 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-IXNkpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:39 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-W5cE3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:39 INFO - Running setup.py install for manifestparser 18:23:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:39 INFO - Running setup.py install for mozcrash 18:23:39 INFO - Running setup.py install for mozdebug 18:23:40 INFO - Running setup.py install for mozdevice 18:23:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozfile 18:23:40 INFO - Running setup.py install for mozhttpd 18:23:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozinfo 18:23:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozInstall 18:23:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozleak 18:23:40 INFO - Running setup.py install for mozlog 18:23:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:41 INFO - Running setup.py install for moznetwork 18:23:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:41 INFO - Running setup.py install for mozprocess 18:23:41 INFO - Running setup.py install for mozprofile 18:23:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:41 INFO - Running setup.py install for mozrunner 18:23:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:41 INFO - Running setup.py install for mozscreenshot 18:23:41 INFO - Running setup.py install for moztest 18:23:42 INFO - Running setup.py install for mozversion 18:23:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:42 INFO - Cleaning up... 18:23:42 INFO - Return code: 0 18:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:42 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:42 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 18:23:42 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 18:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:42 INFO - 'HOME': '/Users/cltbld', 18:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:42 INFO - 'LOGNAME': 'cltbld', 18:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:42 INFO - 'MOZ_NO_REMOTE': '1', 18:23:42 INFO - 'NO_EM_RESTART': '1', 18:23:42 INFO - 'PAGER': '/bin/cat', 18:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:42 INFO - 'PWD': '/builds/slave/test', 18:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:42 INFO - 'SHELL': '/bin/bash', 18:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:42 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:42 INFO - 'USER': 'cltbld', 18:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:42 INFO - 'XPC_FLAGS': '0x0', 18:23:42 INFO - 'XPC_SERVICE_NAME': '0', 18:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-vxOWOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-FlAsjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-S2ytnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ZZ7HcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-BpXqJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-d41NTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-_gNYtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-5EpKvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-iOfoY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-G33JN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-dkBi2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-suSj8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4YWLgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:43 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)) 18:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-r5NdPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:44 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)) 18:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:44 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-3W3BeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:44 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)) 18:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:44 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Ep1fol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:44 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)) 18:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:44 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-wDZicw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:44 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)) 18:23:44 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:23:44 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:46 INFO - Downloading blessings-1.6.tar.gz 18:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:46 INFO - Installing collected packages: blessings 18:23:46 INFO - Running setup.py install for blessings 18:23:46 INFO - Successfully installed blessings 18:23:46 INFO - Cleaning up... 18:23:47 INFO - Return code: 0 18:23:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:47 INFO - Reading from file tmpfile_stdout 18:23:47 INFO - Current package versions: 18:23:47 INFO - blessings == 1.6 18:23:47 INFO - blobuploader == 1.2.4 18:23:47 INFO - docopt == 0.6.1 18:23:47 INFO - manifestparser == 1.1 18:23:47 INFO - mozInstall == 1.12 18:23:47 INFO - mozcrash == 0.16 18:23:47 INFO - mozdebug == 0.1 18:23:47 INFO - mozdevice == 0.48 18:23:47 INFO - mozfile == 1.2 18:23:47 INFO - mozhttpd == 0.7 18:23:47 INFO - mozinfo == 0.9 18:23:47 INFO - mozleak == 0.1 18:23:47 INFO - mozlog == 3.1 18:23:47 INFO - moznetwork == 0.27 18:23:47 INFO - mozprocess == 0.22 18:23:47 INFO - mozprofile == 0.28 18:23:47 INFO - mozrunner == 6.11 18:23:47 INFO - mozscreenshot == 0.1 18:23:47 INFO - mozsystemmonitor == 0.0 18:23:47 INFO - moztest == 0.7 18:23:47 INFO - mozversion == 1.4 18:23:47 INFO - psutil == 3.1.1 18:23:47 INFO - requests == 1.2.3 18:23:47 INFO - wsgiref == 0.1.2 18:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:47 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')]} 18:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:47 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')]} 18:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:47 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:47 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 18:23:47 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 18:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:47 INFO - 'HOME': '/Users/cltbld', 18:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:47 INFO - 'LOGNAME': 'cltbld', 18:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:47 INFO - 'MOZ_NO_REMOTE': '1', 18:23:47 INFO - 'NO_EM_RESTART': '1', 18:23:47 INFO - 'PAGER': '/bin/cat', 18:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:47 INFO - 'PWD': '/builds/slave/test', 18:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:47 INFO - 'SHELL': '/bin/bash', 18:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:47 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:47 INFO - 'USER': 'cltbld', 18:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:47 INFO - 'XPC_FLAGS': '0x0', 18:23:47 INFO - 'XPC_SERVICE_NAME': '0', 18:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 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)) 18:23:47 INFO - Cleaning up... 18:23:47 INFO - Return code: 0 18:23:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:23:47 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')]} 18:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:47 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')]} 18:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:47 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 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:47 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 18:23:47 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 18:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:47 INFO - 'HOME': '/Users/cltbld', 18:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:47 INFO - 'LOGNAME': 'cltbld', 18:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:47 INFO - 'MOZ_NO_REMOTE': '1', 18:23:47 INFO - 'NO_EM_RESTART': '1', 18:23:47 INFO - 'PAGER': '/bin/cat', 18:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:47 INFO - 'PWD': '/builds/slave/test', 18:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:47 INFO - 'SHELL': '/bin/bash', 18:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:47 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:47 INFO - 'USER': 'cltbld', 18:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:47 INFO - 'XPC_FLAGS': '0x0', 18:23:47 INFO - 'XPC_SERVICE_NAME': '0', 18:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:47 INFO - Downloading/unpacking jsonschema 18:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:50 INFO - Downloading/unpacking functools32 (from jsonschema) 18:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:50 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:50 INFO - warning: no files found matching '*.txt' 18:23:50 INFO - no previously-included directories found matching 'build' 18:23:50 INFO - no previously-included directories found matching 'dist' 18:23:50 INFO - no previously-included directories found matching '.git*' 18:23:50 INFO - Installing collected packages: jsonschema, functools32 18:23:50 INFO - Running setup.py install for functools32 18:23:50 INFO - warning: no files found matching '*.txt' 18:23:50 INFO - no previously-included directories found matching 'build' 18:23:50 INFO - no previously-included directories found matching 'dist' 18:23:50 INFO - no previously-included directories found matching '.git*' 18:23:50 INFO - Successfully installed jsonschema functools32 18:23:50 INFO - Cleaning up... 18:23:50 INFO - Return code: 0 18:23:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86c85c8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, '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.UTHDFrtnZo/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.wJp20szCLB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 18:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:23:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:23:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:50 INFO - 'HOME': '/Users/cltbld', 18:23:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:50 INFO - 'LOGNAME': 'cltbld', 18:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:50 INFO - 'MOZ_NO_REMOTE': '1', 18:23:50 INFO - 'NO_EM_RESTART': '1', 18:23:50 INFO - 'PAGER': '/bin/cat', 18:23:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:50 INFO - 'PWD': '/builds/slave/test', 18:23:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:50 INFO - 'SHELL': '/bin/bash', 18:23:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:23:50 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:23:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:50 INFO - 'USER': 'cltbld', 18:23:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:50 INFO - 'XPC_FLAGS': '0x0', 18:23:50 INFO - 'XPC_SERVICE_NAME': '0', 18:23:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:51 INFO - Downloading/unpacking flake8 18:23:51 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 18:23:51 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 18:23:51 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 18:23:51 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 18:23:51 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 18:23:51 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 18:23:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:23:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:23:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:23:54 INFO - no previously-included directories found matching 'docs/_build' 18:23:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:23:54 INFO - Running setup.py install for pep8 18:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:23:54 INFO - no previously-included directories found matching 'docs/_build' 18:23:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:23:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:23:54 INFO - Cleaning up... 18:23:54 INFO - Return code: 0 18:23:54 INFO - Running post-action listener: _resource_record_post_action 18:23:54 INFO - Running post-action listener: _start_resource_monitoring 18:23:54 INFO - Starting resource monitoring. 18:23:54 INFO - ##### 18:23:54 INFO - ##### Running install step. 18:23:54 INFO - ##### 18:23:54 INFO - Running pre-action listener: _resource_record_pre_action 18:23:54 INFO - Running main action method: install 18:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:55 INFO - Reading from file tmpfile_stdout 18:23:55 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:55 INFO - Reading from file tmpfile_stdout 18:23:55 INFO - Output received: 18:23:55 INFO - Usage: mozinstall [options] installer 18:23:55 INFO - Options: 18:23:55 INFO - -h, --help show this help message and exit 18:23:55 INFO - -d DEST, --destination=DEST 18:23:55 INFO - Directory to install application into. [default: 18:23:55 INFO - "/builds/slave/test"] 18:23:55 INFO - --app=APP Application being installed. [default: firefox] 18:23:55 INFO - mkdir: /builds/slave/test/build/application 18:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:24:29 INFO - Reading from file tmpfile_stdout 18:24:29 INFO - Output received: 18:24:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:24:29 INFO - Running post-action listener: _resource_record_post_action 18:24:29 INFO - ##### 18:24:29 INFO - ##### Running run-tests step. 18:24:29 INFO - ##### 18:24:29 INFO - Running pre-action listener: _resource_record_pre_action 18:24:29 INFO - Running main action method: run_tests 18:24:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:24:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:24:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:24:29 INFO - 2016-01-28 18:24:29.570 screenresolution[1953:12633] starting screenresolution argv=screenresolution get 18:24:29 INFO - 2016-01-28 18:24:29.573 screenresolution[1953:12633] Display 0: 1600x1200x32@60 18:24:29 INFO - 2016-01-28 18:24:29.578 screenresolution[1954:12635] starting screenresolution argv=screenresolution list 18:24:29 INFO - Available Modes on Display 0 18:24:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:24:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:24:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:24:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:24:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:24:29 INFO - Intel Iris: 18:24:29 INFO - Chipset Model: Intel Iris 18:24:29 INFO - Type: GPU 18:24:29 INFO - Bus: Built-In 18:24:29 INFO - VRAM (Dynamic, Max): 1536 MB 18:24:29 INFO - Vendor: Intel (0x8086) 18:24:29 INFO - Device ID: 0x0a2e 18:24:29 INFO - Revision ID: 0x0009 18:24:29 INFO - Displays: 18:24:29 INFO - Display: 18:24:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:24:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:24:29 INFO - Display Serial Number: 1600x1200 60 18:24:29 INFO - Main Display: Yes 18:24:29 INFO - Mirror: Off 18:24:29 INFO - Online: Yes 18:24:29 INFO - Rotation: Supported 18:24:29 INFO - Return code: 0 18:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:29 INFO - Python 2.7.3 18:24:29 INFO - Return code: 0 18:24:29 INFO - grabbing minidump binary from tooltool 18:24:29 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')]} 18:24:29 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 0x10b681d30>, '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 0x10b4a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b677b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24:29 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 18:24:29 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 18:24:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:29 INFO - Return code: 0 18:24:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:24:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:24:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:24:31 INFO - Return code: 0 18:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--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 18:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --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 18:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTHDFrtnZo/Render', 18:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:31 INFO - 'HOME': '/Users/cltbld', 18:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:31 INFO - 'LOGNAME': 'cltbld', 18:24:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:31 INFO - 'MOZ_NO_REMOTE': '1', 18:24:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:31 INFO - 'NO_EM_RESTART': '1', 18:24:31 INFO - 'PAGER': '/bin/cat', 18:24:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:31 INFO - 'PWD': '/builds/slave/test', 18:24:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:31 INFO - 'SHELL': '/bin/bash', 18:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wJp20szCLB/Listeners', 18:24:31 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 18:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:31 INFO - 'USER': 'cltbld', 18:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:31 INFO - 'XPC_FLAGS': '0x0', 18:24:31 INFO - 'XPC_SERVICE_NAME': '0', 18:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--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 18:24:31 INFO - mozversion application_buildid: 20160128163036 18:24:31 INFO - mozversion application_changeset: a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac 18:24:31 INFO - mozversion application_display_name: Nightly 18:24:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:24:31 INFO - mozversion application_name: Firefox 18:24:31 INFO - mozversion application_remotingname: firefox 18:24:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:24:31 INFO - mozversion application_vendor: Mozilla 18:24:31 INFO - mozversion application_version: 47.0a1 18:24:31 INFO - mozversion platform_buildid: 20160128163036 18:24:31 INFO - mozversion platform_changeset: a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac 18:24:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:24:31 INFO - mozversion platform_version: 47.0a1 18:24:31 INFO - using testdate: 1454034271 18:24:31 INFO - actual date: 1454034271 18:24:31 INFO - starting webserver on 'localhost:49565' 18:24:31 INFO - SUITE-START | Running 2 tests 18:24:31 INFO - TEST-START | dromaeo_css 18:24:31 INFO - operating with platform_type : mac_ 18:24:31 INFO - Initialising browser for dromaeo_css test... 18:24:31 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpxOJlJF/profile http://localhost:49565/getInfo.html) 18:24:34 INFO - PROCESS | 1972 | __metrics Screen width/height:1600/1200 18:24:34 INFO - PROCESS | 1972 | colorDepth:24 18:24:34 INFO - PROCESS | 1972 | Browser inner width/height: 1024/689 18:24:34 INFO - PROCESS | 1972 | __metrics 18:24:34 INFO - PROCESS | 1972 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:24:34 INFO - PROCESS | 1972 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:24:34 INFO - PROCESS | 1972 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:34 INFO - TEST-INFO | 1972: exit 0 18:24:34 INFO - Browser initialized. 18:24:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:24:34 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpxOJlJF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:46 INFO - PROCESS | 1975 | RSS: Main: 243572736 18:24:46 INFO - PROCESS | 1975 | 18:25:38 INFO - PROCESS | 1975 | 1454034338397 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] 18:27:48 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49565/tests/dromaeo/cssquery-ext.html) 18:27:49 INFO - PROCESS | 1975 | RSS: Main: 374689792 18:27:49 INFO - PROCESS | 1975 | 18:30:52 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49565/tests/dromaeo/cssquery-ext.html (next: http://localhost:49565/tests/dromaeo/cssquery-jquery.html) 18:30:52 INFO - PROCESS | 1975 | RSS: Main: 378933248 18:30:52 INFO - PROCESS | 1975 | 18:33:55 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49565/tests/dromaeo/cssquery-mootools.html) 18:33:55 INFO - PROCESS | 1975 | RSS: Main: 374222848 18:33:55 INFO - PROCESS | 1975 | 18:36:57 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49565/tests/dromaeo/cssquery-prototype.html) 18:36:58 INFO - PROCESS | 1975 | RSS: Main: 337711104 18:36:58 INFO - PROCESS | 1975 | 18:40:01 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49565/tests/dromaeo/cssquery-yui.html) 18:40:02 INFO - PROCESS | 1975 | RSS: Main: 339341312 18:40:02 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49565/tests/dromaeo/cssquery-yui.html (next: http://localhost:49565/tests/dromaeo/cssquery-dojo.html) 18:43:05 INFO - PROCESS | 1975 | RSS: Main: 387551232 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | __start_tp_report 18:43:05 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 18:43:05 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 18:43:05 INFO - PROCESS | 1975 | |i|pagename|runs| 18:43:05 INFO - PROCESS | 1975 | |0;dojo.html;3339.6326404095553;3430.245346023874;3433.227523807144;3451.016460308812;3486.093615659929;5368.758405871736;5405.54052905503;5436.18457231415;5444.156155795853;5458.372287186975;5419.674819510832;5467.425920278373;5485.780568777254;5526.171074338851;5631.63394379365;4980.352554167962;5004.549590536851;5008.949910500903;5022.497750224985;5052;4590.173768721629;5031.220160875052;5124.846254612349;5128.230765385185;5184.066867963765;4946.356973593446;5031.622628302855;5039.3196918415915;5066.417362003362;5082.339295891529;5009.674371165863;5013.573846223039;5028.145215313369;5031.018951304497;5031.949680503185;4929.408470983505;4973.5523802857915;4985.277134815431;4987.127252730757;4989.550940415344;5399.487048730403;5403.675779453206;5418.620696551243;5420.349558053059;5456.727163641842;5987.251593550806;5997.610155339889;5998.430149135868;6012.338642749294;6017.7592896284095;5953.493953013999;6027.668478233695;6044.093385992092;6074.969625151846;6080.483158931496;5541.944580554224;5604.215409842625;5664.773409063632;5665.3201615806365;5670.319561652587;5279.604029697788;6114.785982490592;6145.047517634774;6193.1329613854095;6196.318404975449;5769.769209231584;5917.053271476543;5918.082697181943;5919.763209471659;5924.5852790305125;5974.61165024272;5982.282126144803;5984.281886173687;5992.221011268507;6007.609505382224;5893.705314734246;5899.764009439575;5901.114832775118;5902.2032025676845;5905.734241959122;5830.62100963436;5891.764329426775;5905.43898329658;5908.320543137508;5910.202122713465;4674.485806561275;4697.037107392976;4703.435587729495;4708.882277943078;4716;4247.915041699149;4250.192463431938;4281.293586558245;4282.593153650399;4293.248681480791;5555.944440555542;5561.138023606348;5574.665520068809;5577.330720313507;5593.804216852391;5925.614835035709;6063.211782468251;6064.241969753781;6094.725737341831;6110.9611366067875;5529.976954263474;5569.944300557024;5575.637583557056;5581.330240371181;5632.957902787997;5180.404253510895;5206.062908676399;5212.791488340424;5218.765155568009;5274.841754747364;6102.33777323244;6196.318404975359;6199.256089269316;6229.813105606839;6230;6065.302490213682;6110.984061328523;6115.575014303803;6129.756146212572;6131.376666649982;6164.198654174928;6201.596896201732;6209.161763161916;6209.441150296495;6213.59611625261;5764.452377024176;5863.296404431496;5876.794312199053;5932.1694962706115;6024.156618073561;6000.97983342824;6028.4272994065495;6059.424354686298;6075.726592303268;6114.5414093942245;5804.912926306024;5812.418758124154;5814.680192589448;5842.3281322646735;5847.181394604674;5692.117721753135;5793.9420605795085;5818.185454036523;5858.794942177004;5886.558508111994;4260.978695106504;5659.207710920557;5695.060315047971;5728.140778883201;5759.884802303846;5780.537556995346;5789.8263052108505;5791.333996590446;5823.970880145572;5842.38654941225;5622.465865742748;5696.943030569807;5711.286089238845;5717.971410142923;5730.255066841451 18:43:05 INFO - PROCESS | 1975 | |1;ext.html;455.6810232837015;571.174652626954;578.1258212014505;595.6634501506649;611.6085705148704;23901.76098239017;29910.55134172989;29912.95304664337;29922;29924.1022769317;27012;30614.846925765396;31087.68912310876;38400.23199536015;40842.591574084254;9445.905540944588;9609.80780384392;9630.085141911508;9637.132658060773;9643.180329671952;9407.435553866755;9539.47203990943;9540.33217674763;9540.856887146663;9555.044495550424;9515.143637072662;9559.28305377096;9591.66429174979;9595.088466595662;9610.807783844319;9472.336936414455;9527.09492598202;9555.996620354832;9558.761030974212;9559.90440095604;9314.580843861975;9465.66870159541;9472.336936414455;9472.57373418191;9613.90386096137;39751.60248397508;40152;40156.196876062604;40172.79481615556;40227.39658905119;3110.237991692027;3196.0891146023505;3331.083951913219;3429.639887811769;3522.20750331176;28396.432071358664;28739.42521149586;28917.69870355818;28950.565741513896;29380.55929161043;2367.964480532776;2716.2258756254373;2825.9717402825913;2910.9957064812606;2939.2064142681356;479133;481718;481724;482536.5873170647;482889;57977.4202257972;58233.544161396305;58272.70863645655;58405;58550.70724646435;62844;63075;63107.368926311065;63131.368686313464;63137.368626313146;14936.25318734059;16333.918330408273;16512.587185320222;16538.338466461206;16549.751753723704;11444.771104577861;11523.30860148377;11544.076473882069;11544.480498377594;11545.538178472934;15969.600759981093;18793.966331851607;19167.616647666968;19197.424077277705;19203.423897283104;7456.440766942501;8230.711925082593;8241.052278987872;8260.463069900437;8269.255766981001;959.4003747657714;989.7228775942748;999.3753903810118;1068.9786204275872;1127.4588197665166;26256.86871565668;28993.56509652357;29338.853305733333;29541.85229073884;30133;956.7177682583655;1033.3902997231519;1067.514281002142;1117.2737720481753;1207.4747484844122;11739.823902641467;13806;14054.016218864786;14241.359138838778;14244.002919795723;535958;548502;549584;549606;549910;55612.443875560726;55853.44146558564;55961.16058259129;55977.44022559804;56002;1385.0789225165354;1405.206058576901;1420.7655736803517;1420.936057877398;1424.8717615414662;27505.587416188373;28208;28257.587120643475;32386.35227295488;32524.83737581297;56192.157117644085;56929.43070569407;56963.860722784484;57070.42929570651;57153.42846571481;307452;313590.4807139519;358852;365502;397684;43286.56713432825;43674.56325436705;43720.78139609282;44338.669839904855;44408.111837762415;45368.546314536434;45385.31922021238;45781.54218457773;46705.832354191414;46818.82952926204;38588.421173681854;38872.8338149856;39042.80478597589;39142.412863807636;39646;38106.42840357452;38257.278422470496;38916.61083389243;39000;39072;37852.81073594614;38228.6177138225;39076;39135;39199.80400097981;31453.528197076605;33811.3237735239;34480.31039379248;34674.826625866706;34909.476357854146;25455.109071182418;25457;25593;25730.434045186084;25800.483990319713 18:43:05 INFO - PROCESS | 1975 | |2;jquery.html;357.07161380410935;363.2281402020706;365.92315613721115;366.21081569218325;371.09082747269196;18882.811171888294;18896.338628148;19264.133114009866;19625.313114040993;20382.796172038274;19381.515462113453;19488.610227795434;19804.30684926028;20038;20051;5910.0543912973935;6118.4799292060225;6120;6122.693865306717;6124.632522048669;5837.824865254049;6000.789972350969;6080;6089.2692876854835;6092.634441933476;3949.111449923773;4031.1937612477477;4188.078622703016;6084.817455476321;6098.32918378978;4106.8562600309;6450.774222902176;6620;6633.369829866155;6666.166729158856;5511.779528818883;5759.568032397587;5759.68321742304;5761.827145185651;5791.65250084992;9183.816323673489;12055.819162712567;12059.93970030153;12862.356882155855;13119.672008199776;2033.7559492860803;2204.911803527857;2267.263139479676;2381.2856143156982;2401.327628264089;9470.479123648196;9818.509074546244;9966.302358834884;10074.949625251827;10239.12967397772;1767.690654135521;1769.9911500442545;1780.0921530019655;1829.8170182981728;1850.6206227723285;92943;94543.58184627305;96784;98577;99978;10931.508082136323;10999.670009899715;11045.33727976324;11057.905074463653;11096.889031109748;13299.26854023038;13434.93282533581;13464.461421543225;13496.662583435493;13520.459181632821;8331.708390206435;8412.369072319601;8416.537090460084;8451.070382258069;8464.492130472068;8451.915480845235;8481.321494280442;8484.575771211537;8593.269572086318;8601.22588966996;4334.848280310174;4427.180971520214;4428.247197976351;4479.61923236522;4487.8653640390185;1543.6449616588247;1571.9449819256272;1858.5818190906937;1872.26981477224;1887.7545919030713;677.9457942898741;935.4995077633433;939.6758118449125;956.712986104166;977.8826540815147;14454.566363009126;18602.255909763728;18909.24363025491;19418.155275248828;19658.31195908165;829.6059371798468;898.2679116520015;930.5300823084299;978.9021097890154;1013.0426746724422;8985.505797181218;10536.473176341153;10615.946920265349;10695.518701658444;10879.83680244797;724301;726881;729331;749583;752217;111975;112646;114524;116843.41578292054;117718;1126.2566705974182;1142.166218660366;1149.2759561476216;1173.9413029348498;1175.8059920113085;18262;18274.90862545679;18343.082845857385;18436.63126737431;18568.721469177704;48247.75876120597;49169.26246106383;49613.50386496089;53672;54268.72865635646;71215.28784712087;71512.28487715057;71961;72090.63954680193;72737;7300.96349518249;7301.890471643036;7416.480846340704;7432.182459929511;7768.417368697257;11512.251703639236;11791.233569817934;11830.881691182978;11916.76166476683;12193.817092743793;9961.452120133463;10256.333338332985;10389.740256493647;10558.630447934285;10645.201609879136;3897.493325867619;8573.74278771638;9893.455859927773;10042.69871903844;10162.323216669167;7422.851542969219;10263.589456421958;10347.689569312932;10390.532426040998;10418.843717344398;7379.889301660587;7403.7408690695565;7459.830724960417;7807.219278072147;7807.96096019539;10481.889197450422;10604.946975265075;10641.680749577525;10837.45812709377;10845.728856778644 18:43:05 INFO - PROCESS | 1975 | |3;mootools.html;1407.7888316752492;1547.4506550174685;1569.0742461947448;1797.5685835399509;1925.855560832937;7905.051393832734;8116.431849770511;8472.703455379064;8622.568871556412;8632.007319158298;8346.41575089744;8459;8555.572221388937;8558.871616925751;8578.828423431543;2187.4093994621444;2255.334676270504;2478.5042991401656;2507.2979565721535;2512.723600403954;2265.2071774878827;2458.557459657261;2524.5329614021375;2525.1414519063514;2527.4945010997876;2445.364205306615;2478.7149477810012;2492.277239600514;2509.1970569417795;2513.6606558114604;2443.7800597946093;2495.500899820034;2507.7492250774867;2516.8615726135054;2519.710233323173;2450.950980980388;2489.8132640051886;2499.0128899084943;2500.4499010217723;2502.649629051934;8745.737627871174;8804.603792829337;8811.206991370807;8812.735617931472;8823;5363;5524.447555244484;5526.005319042611;5526.557875370001;5528.806491772769;3590.7486475946694;3606.5672119345586;3680.1351682354625;3742.8128593570214;3770.472133901256;1070.0743856564015;1077.5959015369237;1083.9864726480766;1113.716002419386;1116.9218154729172;12001.87998120025;12005.63983080509;12022.879771202264;12022.978046866026;12042.277463352228;4902.240152776325;4905.3132561441425;4937.1606826839525;4974.5771609413605;4985.052839960396;10100.898991010143;10112.988701129976;10113.595456181818;10114.54484548197;10137.087662110445;5481.643693159932;5483.232347471358;5488.423715509894;5497.780088796403;5499.340079190442;4916.483769204182;4981.750912454363;4986.351774269322;4988.800447982113;4994.675346102492;3313.8343082845763;3333.883314084044;3596.9640303597153;3649.50731651229;3652.634736526326;1300.5578103444875;1304.9151805132826;1309.4827543120414;1315.8223140702153;1322.702391961801;1314.66476048607;1316.5326309160303;1343.93952272148;1350.3923234544495;1351.175782772508;7953.761387158394;7985;8002.51984880909;8087.919120808834;8377.581120943929;1107.7396811749231;1164.959226427071;1209.564556759566;1221.5480272299305;1235.7528494301175;6180.81457556274;6228.439440450381;6245.500359971192;6251.874962500725;6256.6871656417;10223.079922806983;10407.115395191342;10527.894721052691;10542.47287635615;10585.364878107339;9989.40063596172;10319.896801032044;10329.483525823829;10348.741281468023;10417.687469375931;8005.599720013976;8150.83698326042;8215.055268644182;8221.917780822116;8226.383021273428;7930.762077137695;7935.801604959922;8000.159983201913;8021.959890200512;8159.83680326402;9454.05459454049;9523.666671666459;9560.56977436031;9687.66093186735;9732.026797320212;9311.487868167316;9597.376170548892;9748;9879.604815807576;10057.748556286151;7504.662290196845;7507.549547027196;7524.774256772305;7638.350740186924;7653;7281;7476.813079672834;7481;7966.203379661987;8055.597220139087;7521.548707077593;7544.886826697494;7611.695532178873;7691.115521714851;7704.191059938626;7484.775456736306;7487.513311634726;7544.132424771222;7638.388928885564;7654.349380302737;7631.809204769926;7643.082830060428;7687.0006899102755;7707.229277072248;7713.884291735741;6953.548019378724;7017.543859649107;7021.859562808818;7088.539244949062;7093.32613401726;7083.6812343443635;7140.285971402818;7152.785416437307;7172.426205903411;7180.461465390013 18:43:05 INFO - PROCESS | 1975 | |4;prototype.html;322.77567090871844;330.99338013239736;333.10893360261304;335.24736965512426;340.3957974595092;6160.4763595094355;6334.239891213049;6394.712237949292;6414.583052101621;6419.679016049196;6133.172021777059;6264.31092579817;6280.309165991737;6299.937000629992;6319.526035547329;4761.190597598399;4774.188387974035;4795.112904112751;4803.687760295587;4810.855674329776;4541.931871021938;4679.92980105297;4714.929276060861;4797.90404191916;4806;3815.618438156176;4470.619997300233;4627.884302892421;4638.257878739402;4746.121967436018;4702.412198475191;4712.340272361872;4715.198416269225;4716.198246298138;4738.763061846894;3329.866805327784;3333.8833140840197;4051.6556092732153;4063.7764922929523;4085;5955.196048533436;5958.076498142795;5964.791232306892;5968.4031596840405;5984.281886173643;5328.8401347959625;5548.750306236229;5557.444255574451;5585.273914391103;5596.804111856066;6723.7646682365885;6741.528093033489;6744.123263975701;6745;6751.223609284946;4339.132173565299;4431.8670439886855;4584.541545845422;4586.678932474728;4593.425821772278;6057.757689692407;6450.838729031765;7009.859802803966;7046.224915259318;7058.2941705830035;4626.357643036741;4651.906961860744;4661.044485880387;4678.485366609671;4684.344191813149;4719.669623126349;4739;4741.857744267609;4749.620030397629;4762.976185119052;5357.383900851452;5478.972605136949;5500.42245564218;5531.225628412026;5566.997940370772;6754.425873800684;6889.827754306082;6938.757143499954;6944.583325000415;6959.512834101665;1623.7320842060928;1653.80154381475;1654.8510634042993;1655.114513735146;1656.8757343199309;1072.6245813965206;1086.440483151178;1094.7591529863416;1108.95564177432;1118.0384869012642;6443.29123796382;6451.774187903401;6455.903161452582;6468;6498.447631951242;6997.825054373681;7005.684744186524;7006.369426751617;7012.7545535906;7030.945358196312;5129.384473863161;6367.140436041168;6528.738850445929;6579.967100164565;6587.80236592903;3671.3024525340634;3705.796181210005;3712.1276500022473;3715.5169827922196;3718.5909549949483;7393.112826460859;7393.260673932671;7396.408287337;7397.18630950595;7397.18630950595;6228.968855155696;6789.93210067893;6979.092717946736;7188.353048225685;7199.89200161998;7357.337839594462;7362.889556656654;7378.557286562716;7382.926170738224;7385.593792341473;6911.723531058701;6951;6955.808920190124;6967.2684368142645;6976.372126508639;6587.736490540325;6613.14029176204;6764.49266305039;6786.660666966533;6880.896786548105;7347.8163045924275;7359.926400735924;7394.445416593884;7402.9629851850395;7478.429529798803;4691.225947718588;4692;4705.623550116051;4707.987782626752;4725.5510726480925;5809.680467574324;6731.663416829041;6838.8290292741085;6975.79072627822;7003.859922801617;6693.799186024427;6709.664516774044;6740.325967403221;6750.3924646782025;6788.898166527605;6578.407943285128;6744.258131605618;6752.155980502437;6761.93238067613;6763.830904227434;6623.4038936495945;6691.732330706912;6780.1524809398825;6793.048973143665;6793.558418702769;6731.730730770714;6733.124693789776;6738.124043874265;6740.12378390806;6761.898571521333;6447.097406363207;6573.441257492976;6649.667516624246;6654.600723956578;6655.700493477902 18:43:05 INFO - PROCESS | 1975 | |5;yui.html;640.2796853539768;656.481379710029;691.2810676896029;702.2661318921729;713.5789883968457;14828.332725027372;14998.100113993154;15057.17185554794;15066.246687665627;15093.245337733111;13645.727085458286;13720.451181952734;13743.106698064645;13749.450021999108;13755.587332380019;503.6197670758572;677.6984242012306;689.0766373060098;702.2275496953362;783.7021931665959;843.6625349860044;847.817719190374;848.1730312944891;848.2238751542332;849.2865992566243;871.9825603487926;893.1425831202054;893.950832704201;894.0567701075363;895.1317222294364;696.8153439338579;715.7065603102754;716.5199316457986;885.4421714320001;887.3256325192867;643.0771842406162;664.0669858848325;666.014298837718;668.4451904918906;670.1489108831756;14553.417863285456;14614.196219208046;14620.634484137876;14623.415063397451;14626.853731462656;12147.93926030373;12236.632901012896;12407.813882791765;12411.317377544232;12520.624381268577;10176.033276838689;10216.13162881156;10224.233182511342;10331.690049298533;10936.617218397318;3499.6500349965054;3525.9294814103832;3526.982365088184;3535.5403797506415;3540.539729835105;81234;82199;83470.58264708698;84010;84062;9511.90488095124;9517;9555.952220238854;9742.025797420201;9745.756356091013;21430.249941251983;21432;21438.928053597258;21453.463663408227;21458.678119827902;7462.477626566197;7523.586202758901;7665.425093118039;7802.570858602718;7824.804379890435;4102.261592913304;4133.710640255214;4150.833966641361;4150.875473735793;4154.231467178582;3569.803660798629;3616.1140520572626;3616.8372423241017;3622.5109610202285;3626.5648122225502;636.6784773689258;654.607235658601;659.1793217444217;672.9394354508117;673.7002034094879;515.8246196293278;579.7565022690396;596.4423264247943;602.9418370759289;627.6391075131818;8595.31237501011;8683.739487815375;8749.912500875038;8833.64665413389;8925.73222803317;518.9688618682891;566;609.5763444406184;618.3569088148365;636.6307541625846;3674.2467794102145;3740.345439548068;4084.448599439097;4175.290200665894;4228.76741779199;57342;76334.98482659351;76388.61805690936;76806.61596691981;76815.61592192003;62594.68702656458;70375;79185.20814791779;81166;82441;68541.28646783771;69425.30574694189;69929.65035174791;70353.64823175954;70994;8134.511929284262;8142;8279.461834980708;8384.958075209584;8397.580120993804;47437.05125897394;47594.762026189645;48011;48928.755356224414;50271.74864125656;66786.66606666935;67688.3231167682;68563.65718171377;68795.31204687888;70695.29304706887;10985.560577576807;10995.395253261147;11130.554777808797;11226.270292430965;11497.367644779282;12006.879931200576;12418.192817466836;12419;12542.561010364958;12669.239845609292;11704.297742135499;11735.647930562096;11751.353675547585;11918;11969;11543.307401555934;11803.586874459354;11824.763504729684;11996.100292478273;12070.336131512851;9369.812603748023;11317.830232546683;11484.138689598482;11491.827622585835;11505.42472876336;9213.928076974778;9299.256059515357;9303.581338839904;9614.89732748374;9824.80350392974;7693.730719424793;8967.968683601208;8995.28037756991;9466.195373393339;10072.143867771321 18:43:05 INFO - PROCESS | 1975 | __end_tp_report 18:43:05 INFO - PROCESS | 1975 | __start_cc_report 18:43:05 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,1119 18:43:05 INFO - PROCESS | 1975 | __end_cc_report 18:43:05 INFO - PROCESS | 1975 | __startTimestamp1454035385429__endTimestamp 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | ------- Summary: start ------- 18:43:05 INFO - PROCESS | 1975 | Number of tests: 6 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5531.84 Median:5711.29 stddev:610.14 (10.7%) stddev-sans-first:587.27 18:43:05 INFO - PROCESS | 1975 | Values: 3339.6 3430.2 3433.2 3451.0 3486.1 5368.8 5405.5 5436.2 5444.2 5458.4 5419.7 5467.4 5485.8 5526.2 5631.6 4980.4 5004.5 5008.9 5022.5 5052.0 4590.2 5031.2 5124.8 5128.2 5184.1 4946.4 5031.6 5039.3 5066.4 5082.3 5009.7 5013.6 5028.1 5031.0 5031.9 4929.4 4973.6 4985.3 4987.1 4989.6 5399.5 5403.7 5418.6 5420.3 5456.7 5987.3 5997.6 5998.4 6012.3 6017.8 5953.5 6027.7 6044.1 6075.0 6080.5 5541.9 5604.2 5664.8 5665.3 5670.3 5279.6 6114.8 6145.0 6193.1 6196.3 5769.8 5917.1 5918.1 5919.8 5924.6 5974.6 5982.3 5984.3 5992.2 6007.6 5893.7 5899.8 5901.1 5902.2 5905.7 5830.6 5891.8 5905.4 5908.3 5910.2 4674.5 4697.0 4703.4 4708.9 4716.0 4247.9 4250.2 4281.3 4282.6 4293.2 5555.9 5561.1 5574.7 5577.3 5593.8 5925.6 6063.2 6064.2 6094.7 6111.0 5530.0 5569.9 5575.6 5581.3 5633.0 5180.4 5206.1 5212.8 5218.8 5274.8 6102.3 6196.3 6199.3 6229.8 6230.0 6065.3 6111.0 6115.6 6129.8 6131.4 6164.2 6201.6 6209.2 6209.4 6213.6 5764.5 5863.3 5876.8 5932.2 6024.2 6001.0 6028.4 6059.4 6075.7 6114.5 5804.9 5812.4 5814.7 5842.3 5847.2 5692.1 5793.9 5818.2 5858.8 5886.6 4261.0 5659.2 5695.1 5728.1 5759.9 5780.5 5789.8 5791.3 5824.0 5842.4 5622.5 5696.9 5711.3 5718.0 5730.3 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:60900.73 Median:39138.71 stddev:124143.68 (317.2%) stddev-sans-first:124408.98 18:43:05 INFO - PROCESS | 1975 | Values: 455.7 571.2 578.1 595.7 611.6 23901.8 29910.6 29913.0 29922.0 29924.1 27012.0 30614.8 31087.7 38400.2 40842.6 9445.9 9609.8 9630.1 9637.1 9643.2 9407.4 9539.5 9540.3 9540.9 9555.0 9515.1 9559.3 9591.7 9595.1 9610.8 9472.3 9527.1 9556.0 9558.8 9559.9 9314.6 9465.7 9472.3 9472.6 9613.9 39751.6 40152.0 40156.2 40172.8 40227.4 3110.2 3196.1 3331.1 3429.6 3522.2 28396.4 28739.4 28917.7 28950.6 29380.6 2368.0 2716.2 2826.0 2911.0 2939.2 479133.0 481718.0 481724.0 482536.6 482889.0 57977.4 58233.5 58272.7 58405.0 58550.7 62844.0 63075.0 63107.4 63131.4 63137.4 14936.3 16333.9 16512.6 16538.3 16549.8 11444.8 11523.3 11544.1 11544.5 11545.5 15969.6 18794.0 19167.6 19197.4 19203.4 7456.4 8230.7 8241.1 8260.5 8269.3 959.4 989.7 999.4 1069.0 1127.5 26256.9 28993.6 29338.9 29541.9 30133.0 956.7 1033.4 1067.5 1117.3 1207.5 11739.8 13806.0 14054.0 14241.4 14244.0 535958.0 548502.0 549584.0 549606.0 549910.0 55612.4 55853.4 55961.2 55977.4 56002.0 1385.1 1405.2 1420.8 1420.9 1424.9 27505.6 28208.0 28257.6 32386.4 32524.8 56192.2 56929.4 56963.9 57070.4 57153.4 307452.0 313590.5 358852.0 365502.0 397684.0 43286.6 43674.6 43720.8 44338.7 44408.1 45368.5 45385.3 45781.5 46705.8 46818.8 38588.4 38872.8 39042.8 39142.4 39646.0 38106.4 38257.3 38916.6 39000.0 39072.0 37852.8 38228.6 39076.0 39135.0 39199.8 31453.5 33811.3 34480.3 34674.8 34909.5 25455.1 25457.0 25593.0 25730.4 25800.5 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:36902.51 Median:2134.29 stddev:121312.74 (5684.0%) stddev-sans-first:121622.02 18:43:05 INFO - PROCESS | 1975 | Values: 357.1 363.2 365.9 366.2 371.1 18882.8 18896.3 19264.1 19625.3 20382.8 19381.5 19488.6 19804.3 20038.0 20051.0 5910.1 6118.5 6120.0 6122.7 6124.6 5837.8 6000.8 6080.0 6089.3 6092.6 3949.1 4031.2 4188.1 6084.8 6098.3 4106.9 6450.8 6620.0 6633.4 6666.2 5511.8 5759.6 5759.7 5761.8 5791.7 9183.8 12055.8 12059.9 12862.4 13119.7 2033.8 2204.9 2267.3 2381.3 2401.3 9470.5 9818.5 9966.3 10074.9 10239.1 1767.7 1770.0 1780.1 1829.8 1850.6 92943.0 94543.6 96784.0 98577.0 99978.0 10931.5 10999.7 11045.3 11057.9 11096.9 13299.3 13434.9 13464.5 13496.7 13520.5 8331.7 8412.4 8416.5 8451.1 8464.5 8451.9 8481.3 8484.6 8593.3 8601.2 4334.8 4427.2 4428.2 4479.6 4487.9 1543.6 1571.9 1858.6 1872.3 1887.8 677.9 935.5 939.7 956.7 977.9 14454.6 18602.3 18909.2 19418.2 19658.3 829.6 898.3 930.5 978.9 1013.0 8985.5 10536.5 10615.9 10695.5 10879.8 724301.0 726881.0 729331.0 749583.0 752217.0 111975.0 112646.0 114524.0 116843.4 117718.0 1126.3 1142.2 1149.3 1173.9 1175.8 18262.0 18274.9 18343.1 18436.6 18568.7 48247.8 49169.3 49613.5 53672.0 54268.7 71215.3 71512.3 71961.0 72090.6 72737.0 7301.0 7301.9 7416.5 7432.2 7768.4 11512.3 11791.2 11830.9 11916.8 12193.8 9961.5 10256.3 10389.7 10558.6 10645.2 3897.5 8573.7 9893.5 10042.7 10162.3 7422.9 10263.6 10347.7 10390.5 10418.8 7379.9 7403.7 7459.8 7807.2 7808.0 10481.9 10604.9 10641.7 10837.5 10845.7 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:6043.21 Median:5422.32 stddev:3141.63 (57.9%) stddev-sans-first:3131.11 18:43:05 INFO - PROCESS | 1975 | Values: 1407.8 1547.5 1569.1 1797.6 1925.9 7905.1 8116.4 8472.7 8622.6 8632.0 8346.4 8459.0 8555.6 8558.9 8578.8 2187.4 2255.3 2478.5 2507.3 2512.7 2265.2 2458.6 2524.5 2525.1 2527.5 2445.4 2478.7 2492.3 2509.2 2513.7 2443.8 2495.5 2507.7 2516.9 2519.7 2451.0 2489.8 2499.0 2500.4 2502.6 8745.7 8804.6 8811.2 8812.7 8823.0 5363.0 5524.4 5526.0 5526.6 5528.8 3590.7 3606.6 3680.1 3742.8 3770.5 1070.1 1077.6 1084.0 1113.7 1116.9 12001.9 12005.6 12022.9 12023.0 12042.3 4902.2 4905.3 4937.2 4974.6 4985.1 10100.9 10113.0 10113.6 10114.5 10137.1 5481.6 5483.2 5488.4 5497.8 5499.3 4916.5 4981.8 4986.4 4988.8 4994.7 3313.8 3333.9 3597.0 3649.5 3652.6 1300.6 1304.9 1309.5 1315.8 1322.7 1314.7 1316.5 1343.9 1350.4 1351.2 7953.8 7985.0 8002.5 8087.9 8377.6 1107.7 1165.0 1209.6 1221.5 1235.8 6180.8 6228.4 6245.5 6251.9 6256.7 10223.1 10407.1 10527.9 10542.5 10585.4 9989.4 10319.9 10329.5 10348.7 10417.7 8005.6 8150.8 8215.1 8221.9 8226.4 7930.8 7935.8 8000.2 8022.0 8159.8 9454.1 9523.7 9560.6 9687.7 9732.0 9311.5 9597.4 9748.0 9879.6 10057.7 7504.7 7507.5 7524.8 7638.4 7653.0 7281.0 7476.8 7481.0 7966.2 8055.6 7521.5 7544.9 7611.7 7691.1 7704.2 7484.8 7487.5 7544.1 7638.4 7654.3 7631.8 7643.1 7687.0 7707.2 7713.9 6953.5 7017.5 7021.9 7088.5 7093.3 7083.7 7140.3 7152.8 7172.4 7180.5 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:5567.34 Median:6350.69 stddev:1744.56 (27.5%) stddev-sans-first:1704.46 18:43:05 INFO - PROCESS | 1975 | Values: 322.8 331.0 333.1 335.2 340.4 6160.5 6334.2 6394.7 6414.6 6419.7 6133.2 6264.3 6280.3 6299.9 6319.5 4761.2 4774.2 4795.1 4803.7 4810.9 4541.9 4679.9 4714.9 4797.9 4806.0 3815.6 4470.6 4627.9 4638.3 4746.1 4702.4 4712.3 4715.2 4716.2 4738.8 3329.9 3333.9 4051.7 4063.8 4085.0 5955.2 5958.1 5964.8 5968.4 5984.3 5328.8 5548.8 5557.4 5585.3 5596.8 6723.8 6741.5 6744.1 6745.0 6751.2 4339.1 4431.9 4584.5 4586.7 4593.4 6057.8 6450.8 7009.9 7046.2 7058.3 4626.4 4651.9 4661.0 4678.5 4684.3 4719.7 4739.0 4741.9 4749.6 4763.0 5357.4 5479.0 5500.4 5531.2 5567.0 6754.4 6889.8 6938.8 6944.6 6959.5 1623.7 1653.8 1654.9 1655.1 1656.9 1072.6 1086.4 1094.8 1109.0 1118.0 6443.3 6451.8 6455.9 6468.0 6498.4 6997.8 7005.7 7006.4 7012.8 7030.9 5129.4 6367.1 6528.7 6580.0 6587.8 3671.3 3705.8 3712.1 3715.5 3718.6 7393.1 7393.3 7396.4 7397.2 7397.2 6229.0 6789.9 6979.1 7188.4 7199.9 7357.3 7362.9 7378.6 7382.9 7385.6 6911.7 6951.0 6955.8 6967.3 6976.4 6587.7 6613.1 6764.5 6786.7 6880.9 7347.8 7359.9 7394.4 7403.0 7478.4 4691.2 4692.0 4705.6 4708.0 4725.6 5809.7 6731.7 6838.8 6975.8 7003.9 6693.8 6709.7 6740.3 6750.4 6788.9 6578.4 6744.3 6752.2 6761.9 6763.8 6623.4 6691.7 6780.2 6793.0 6793.6 6731.7 6733.1 6738.1 6740.1 6761.9 6447.1 6573.4 6649.7 6654.6 6655.7 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:17718.73 Median:31611.16 stddev:24291.12 (76.8%) stddev-sans-first:24325.42 18:43:05 INFO - PROCESS | 1975 | Values: 640.3 656.5 691.3 702.3 713.6 14828.3 14998.1 15057.2 15066.2 15093.2 13645.7 13720.5 13743.1 13749.5 13755.6 503.6 677.7 689.1 702.2 783.7 843.7 847.8 848.2 848.2 849.3 872.0 893.1 894.0 894.1 895.1 696.8 715.7 716.5 885.4 887.3 643.1 664.1 666.0 668.4 670.1 14553.4 14614.2 14620.6 14623.4 14626.9 12147.9 12236.6 12407.8 12411.3 12520.6 10176.0 10216.1 10224.2 10331.7 10936.6 3499.7 3525.9 3527.0 3535.5 3540.5 81234.0 82199.0 83470.6 84010.0 84062.0 9511.9 9517.0 9556.0 9742.0 9745.8 21430.2 21432.0 21438.9 21453.5 21458.7 7462.5 7523.6 7665.4 7802.6 7824.8 4102.3 4133.7 4150.8 4150.9 4154.2 3569.8 3616.1 3616.8 3622.5 3626.6 636.7 654.6 659.2 672.9 673.7 515.8 579.8 596.4 602.9 627.6 8595.3 8683.7 8749.9 8833.6 8925.7 519.0 566.0 609.6 618.4 636.6 3674.2 3740.3 4084.4 4175.3 4228.8 57342.0 76335.0 76388.6 76806.6 76815.6 62594.7 70375.0 79185.2 81166.0 82441.0 68541.3 69425.3 69929.7 70353.6 70994.0 8134.5 8142.0 8279.5 8385.0 8397.6 47437.1 47594.8 48011.0 48928.8 50271.7 66786.7 67688.3 68563.7 68795.3 70695.3 10985.6 10995.4 11130.6 11226.3 11497.4 12006.9 12418.2 12419.0 12542.6 12669.2 11704.3 11735.6 11751.4 11918.0 11969.0 11543.3 11803.6 11824.8 11996.1 12070.3 9369.8 11317.8 11484.1 11491.8 11505.4 9213.9 9299.3 9303.6 9614.9 9824.8 7693.7 8968.0 8995.3 9466.2 10072.1 18:43:05 INFO - PROCESS | 1975 | -------- Summary: end -------- 18:43:05 INFO - PROCESS | 1975 | 18:43:05 INFO - TEST-INFO | 1975: exit 0 18:43:05 INFO - TEST-OK | dromaeo_css | took 1114250ms 18:43:05 INFO - TEST-START | kraken 18:43:05 INFO - operating with platform_type : mac_ 18:43:05 INFO - Initialising browser for kraken test... 18:43:05 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpmV8xXb/profile http://localhost:49565/getInfo.html) 18:43:07 INFO - PROCESS | 1979 | __metrics Screen width/height:1600/1200 18:43:07 INFO - PROCESS | 1979 | colorDepth:24 18:43:07 INFO - PROCESS | 1979 | Browser inner width/height: 1024/689 18:43:07 INFO - PROCESS | 1979 | __metrics 18:43:07 INFO - PROCESS | 1979 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:43:08 INFO - PROCESS | 1979 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:43:08 INFO - PROCESS | 1979 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:08 INFO - TEST-INFO | 1979: exit 0 18:43:08 INFO - Browser initialized. 18:43:08 INFO - Running cycle 1/1 for kraken test... 18:43:08 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpmV8xXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:20 INFO - PROCESS | 1981 | RSS: Main: 241827840 18:43:20 INFO - PROCESS | 1981 | 18:43:23 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49565/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:23 INFO - PROCESS | 1981 | RSS: Main: 289550336 18:43:23 INFO - PROCESS | 1981 | 18:43:26 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49565/tests/kraken/driver.html?testName=audio-dft) 18:43:26 INFO - PROCESS | 1981 | RSS: Main: 300482560 18:43:26 INFO - PROCESS | 1981 | 18:43:30 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49565/tests/kraken/driver.html?testName=audio-fft) 18:43:30 INFO - PROCESS | 1981 | RSS: Main: 287698944 18:43:30 INFO - PROCESS | 1981 | 18:43:32 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49565/tests/kraken/driver.html?testName=audio-oscillator) 18:43:33 INFO - PROCESS | 1981 | RSS: Main: 289746944 18:43:33 INFO - PROCESS | 1981 | 18:43:35 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:36 INFO - PROCESS | 1981 | RSS: Main: 291569664 18:43:36 INFO - PROCESS | 1981 | 18:43:39 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49565/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:39 INFO - PROCESS | 1981 | RSS: Main: 291217408 18:43:39 INFO - PROCESS | 1981 | 18:43:42 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49565/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:43 INFO - PROCESS | 1981 | RSS: Main: 292679680 18:43:43 INFO - PROCESS | 1981 | 18:43:45 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49565/tests/kraken/driver.html?testName=json-parse-financial) 18:43:46 INFO - PROCESS | 1981 | RSS: Main: 290889728 18:43:46 INFO - PROCESS | 1981 | 18:43:48 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:43:48 INFO - PROCESS | 1981 | RSS: Main: 325472256 18:43:48 INFO - PROCESS | 1981 | 18:43:50 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:51 INFO - PROCESS | 1981 | RSS: Main: 328044544 18:43:51 INFO - PROCESS | 1981 | 18:43:53 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:43:53 INFO - PROCESS | 1981 | RSS: Main: 332652544 18:43:53 INFO - PROCESS | 1981 | 18:43:56 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:43:56 INFO - PROCESS | 1981 | RSS: Main: 334950400 18:43:56 INFO - PROCESS | 1981 | 18:43:59 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:00 INFO - PROCESS | 1981 | RSS: Main: 334458880 18:44:00 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49565/tests/kraken/driver.html?testName=ai-astar) 18:44:01 INFO - PROCESS | 1981 | RSS: Main: 395141120 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | __start_tp_report 18:44:01 INFO - PROCESS | 1981 | _x_x_mozilla_page_load 18:44:01 INFO - PROCESS | 1981 | _x_x_mozilla_page_load_details 18:44:01 INFO - PROCESS | 1981 | |i|pagename|runs| 18:44:01 INFO - PROCESS | 1981 | |0;ai-astar;111;108;112;111;111;110;116;111;112;112 18:44:01 INFO - PROCESS | 1981 | |1;audio-beat-detection;161;119;145;158;120;145;121;155;147;122 18:44:01 INFO - PROCESS | 1981 | |2;audio-dft;177;183;188;183;188;185;189;186;182;185 18:44:01 INFO - PROCESS | 1981 | |3;audio-fft;74;74;87;103;81;85;84;86;76;56 18:44:01 INFO - PROCESS | 1981 | |4;audio-oscillator;95;82;140;112;117;119;148;83;80;114 18:44:01 INFO - PROCESS | 1981 | |5;imaging-gaussian-blur;86;89;87;94;87;92;86;92;87;94 18:44:01 INFO - PROCESS | 1981 | |6;imaging-darkroom;95;96;97;95;96;96;96;100;129;96 18:44:01 INFO - PROCESS | 1981 | |7;imaging-desaturate;86;87;85;87;86;86;85;113;140;74 18:44:01 INFO - PROCESS | 1981 | |8;json-parse-financial;56;55;54;53;52;55;54;64;52;52 18:44:01 INFO - PROCESS | 1981 | |9;json-stringify-tinderbox;64;64;78;72;70;69;67;67;67;67 18:44:01 INFO - PROCESS | 1981 | |10;stanford-crypto-aes;79;84;82;80;81;82;83;82;82;83 18:44:01 INFO - PROCESS | 1981 | |11;stanford-crypto-ccm;126;145;107;132;123;121;126;112;129;121 18:44:01 INFO - PROCESS | 1981 | |12;stanford-crypto-pbkdf2;139;126;145;135;137;134;144;173;170;130 18:44:01 INFO - PROCESS | 1981 | |13;stanford-crypto-sha256-iterative;66;68;65;67;65;67;66;66;66;66 18:44:01 INFO - PROCESS | 1981 | __end_tp_report 18:44:01 INFO - PROCESS | 1981 | __start_cc_report 18:44:01 INFO - PROCESS | 1981 | _x_x_mozilla_cycle_collect,1159 18:44:01 INFO - PROCESS | 1981 | __end_cc_report 18:44:01 INFO - PROCESS | 1981 | __startTimestamp1454035441970__endTimestamp 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | ------- Summary: start ------- 18:44:01 INFO - PROCESS | 1981 | Number of tests: 14 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:2.01 (1.8%) stddev-sans-first:2.13 18:44:01 INFO - PROCESS | 1981 | Values: 111.0 108.0 112.0 111.0 111.0 110.0 116.0 111.0 112.0 112.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:146.00 stddev:17.03 (11.7%) stddev-sans-first:16.15 18:44:01 INFO - PROCESS | 1981 | Values: 161.0 119.0 145.0 158.0 120.0 145.0 121.0 155.0 147.0 122.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.50 stddev:3.57 (1.9%) stddev-sans-first:2.51 18:44:01 INFO - PROCESS | 1981 | Values: 177.0 183.0 188.0 183.0 188.0 185.0 189.0 186.0 182.0 185.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#3] audio-fft Cycles:10 Average:80.60 Median:82.50 stddev:12.09 (14.7%) stddev-sans-first:12.59 18:44:01 INFO - PROCESS | 1981 | Values: 74.0 74.0 87.0 103.0 81.0 85.0 84.0 86.0 76.0 56.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:114.00 stddev:23.86 (20.9%) stddev-sans-first:24.76 18:44:01 INFO - PROCESS | 1981 | Values: 95.0 82.0 140.0 112.0 117.0 119.0 148.0 83.0 80.0 114.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.50 stddev:3.27 (3.6%) stddev-sans-first:3.23 18:44:01 INFO - PROCESS | 1981 | Values: 86.0 89.0 87.0 94.0 87.0 92.0 86.0 92.0 87.0 94.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:96.00 stddev:10.43 (10.9%) stddev-sans-first:10.93 18:44:01 INFO - PROCESS | 1981 | Values: 95.0 96.0 97.0 95.0 96.0 96.0 96.0 100.0 129.0 96.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:86.00 stddev:19.20 (22.3%) stddev-sans-first:20.20 18:44:01 INFO - PROCESS | 1981 | Values: 86.0 87.0 85.0 87.0 86.0 86.0 85.0 113.0 140.0 74.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:3.56 (6.5%) stddev-sans-first:3.75 18:44:01 INFO - PROCESS | 1981 | Values: 56.0 55.0 54.0 53.0 52.0 55.0 54.0 64.0 52.0 52.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:4.14 (6.1%) stddev-sans-first:4.06 18:44:01 INFO - PROCESS | 1981 | Values: 64.0 64.0 78.0 72.0 70.0 69.0 67.0 67.0 67.0 67.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.48 (1.8%) stddev-sans-first:1.17 18:44:01 INFO - PROCESS | 1981 | Values: 79.0 84.0 82.0 80.0 81.0 82.0 83.0 82.0 82.0 83.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.00 stddev:10.49 (8.3%) stddev-sans-first:11.10 18:44:01 INFO - PROCESS | 1981 | Values: 126.0 145.0 107.0 132.0 123.0 121.0 126.0 112.0 129.0 121.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:141.50 stddev:15.94 (11.3%) stddev-sans-first:16.84 18:44:01 INFO - PROCESS | 1981 | Values: 139.0 126.0 145.0 135.0 137.0 134.0 144.0 173.0 170.0 130.0 18:44:01 INFO - PROCESS | 1981 | 18:44:01 INFO - PROCESS | 1981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 18:44:01 INFO - PROCESS | 1981 | Values: 66.0 68.0 65.0 67.0 65.0 67.0 66.0 66.0 66.0 66.0 18:44:01 INFO - PROCESS | 1981 | -------- Summary: end -------- 18:44:01 INFO - PROCESS | 1981 | 18:44:02 INFO - TEST-INFO | 1981: exit 0 18:44:02 INFO - TEST-OK | kraken | took 56739ms 18:44:02 INFO - SUITE-END | took 1170s 18:44:03 INFO - Completed test suite (00:19:31) 18:44:03 INFO - Working with test: dromaeo_css 18:44:03 INFO - Generating results file: dromaeo_css 18:44:03 INFO - Working with test: kraken 18:44:03 INFO - Generating results file: kraken 18:44:03 INFO - javascript benchmark 18:44:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 18:44:03 INFO - process_Request line: dromaeo_css 7371.84 graph.html#tests=[[72,1,59]] 18:44:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:03 INFO - process_Request line: kraken 1445.50 graph.html#tests=[[232,1,59]] 18:44:03 INFO - RETURN: dromaeo_css: 7371.84 18:44:03 INFO - RETURN: kraken: 1445.50 18:44:03 INFO - javascript benchmark 18:44:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3339.6326404095553, 3430.245346023874, 3433.227523807144, 3451.016460308812, 3486.093615659929, 5368.758405871736, 5405.54052905503, 5436.18457231415, 5444.156155795853, 5458.372287186975, 5419.674819510832, 5467.425920278373, 5485.780568777254, 5526.171074338851, 5631.63394379365, 4980.352554167962, 5004.549590536851, 5008.949910500903, 5022.497750224985, 5052.0, 4590.173768721629, 5031.220160875052, 5124.846254612349, 5128.230765385185, 5184.066867963765, 4946.356973593446, 5031.622628302855, 5039.3196918415915, 5066.417362003362, 5082.339295891529, 5009.674371165863, 5013.573846223039, 5028.145215313369, 5031.018951304497, 5031.949680503185, 4929.408470983505, 4973.5523802857915, 4985.277134815431, 4987.127252730757, 4989.550940415344, 5399.487048730403, 5403.675779453206, 5418.620696551243, 5420.349558053059, 5456.727163641842, 5987.251593550806, 5997.610155339889, 5998.430149135868, 6012.338642749294, 6017.7592896284095, 5953.493953013999, 6027.668478233695, 6044.093385992092, 6074.969625151846, 6080.483158931496, 5541.944580554224, 5604.215409842625, 5664.773409063632, 5665.3201615806365, 5670.319561652587, 5279.604029697788, 6114.785982490592, 6145.047517634774, 6193.1329613854095, 6196.318404975449, 5769.769209231584, 5917.053271476543, 5918.082697181943, 5919.763209471659, 5924.5852790305125, 5974.61165024272, 5982.282126144803, 5984.281886173687, 5992.221011268507, 6007.609505382224, 5893.705314734246, 5899.764009439575, 5901.114832775118, 5902.2032025676845, 5905.734241959122, 5830.62100963436, 5891.764329426775, 5905.43898329658, 5908.320543137508, 5910.202122713465, 4674.485806561275, 4697.037107392976, 4703.435587729495, 4708.882277943078, 4716.0, 4247.915041699149, 4250.192463431938, 4281.293586558245, 4282.593153650399, 4293.248681480791, 5555.944440555542, 5561.138023606348, 5574.665520068809, 5577.330720313507, 5593.804216852391, 5925.614835035709, 6063.211782468251, 6064.241969753781, 6094.725737341831, 6110.9611366067875, 5529.976954263474, 5569.944300557024, 5575.637583557056, 5581.330240371181, 5632.957902787997, 5180.404253510895, 5206.062908676399, 5212.791488340424, 5218.765155568009, 5274.841754747364, 6102.33777323244, 6196.318404975359, 6199.256089269316, 6229.813105606839, 6230.0, 6065.302490213682, 6110.984061328523, 6115.575014303803, 6129.756146212572, 6131.376666649982, 6164.198654174928, 6201.596896201732, 6209.161763161916, 6209.441150296495, 6213.59611625261, 5764.452377024176, 5863.296404431496, 5876.794312199053, 5932.1694962706115, 6024.156618073561, 6000.97983342824, 6028.4272994065495, 6059.424354686298, 6075.726592303268, 6114.5414093942245, 5804.912926306024, 5812.418758124154, 5814.680192589448, 5842.3281322646735, 5847.181394604674, 5692.117721753135, 5793.9420605795085, 5818.185454036523, 5858.794942177004, 5886.558508111994, 4260.978695106504, 5659.207710920557, 5695.060315047971, 5728.140778883201, 5759.884802303846, 5780.537556995346, 5789.8263052108505, 5791.333996590446, 5823.970880145572, 5842.38654941225, 5622.465865742748, 5696.943030569807, 5711.286089238845, 5717.971410142923, 5730.255066841451], "unit": "score", "name": "dojo.html", "value": 5494.96665398072}, {"lowerIsBetter": false, "replicates": [455.6810232837015, 571.174652626954, 578.1258212014505, 595.6634501506649, 611.6085705148704, 23901.76098239017, 29910.55134172989, 29912.95304664337, 29922.0, 29924.1022769317, 27012.0, 30614.846925765396, 31087.68912310876, 38400.23199536015, 40842.591574084254, 9445.905540944588, 9609.80780384392, 9630.085141911508, 9637.132658060773, 9643.180329671952, 9407.435553866755, 9539.47203990943, 9540.33217674763, 9540.856887146663, 9555.044495550424, 9515.143637072662, 9559.28305377096, 9591.66429174979, 9595.088466595662, 9610.807783844319, 9472.336936414455, 9527.09492598202, 9555.996620354832, 9558.761030974212, 9559.90440095604, 9314.580843861975, 9465.66870159541, 9472.336936414455, 9472.57373418191, 9613.90386096137, 39751.60248397508, 40152.0, 40156.196876062604, 40172.79481615556, 40227.39658905119, 3110.237991692027, 3196.0891146023505, 3331.083951913219, 3429.639887811769, 3522.20750331176, 28396.432071358664, 28739.42521149586, 28917.69870355818, 28950.565741513896, 29380.55929161043, 2367.964480532776, 2716.2258756254373, 2825.9717402825913, 2910.9957064812606, 2939.2064142681356, 479133.0, 481718.0, 481724.0, 482536.5873170647, 482889.0, 57977.4202257972, 58233.544161396305, 58272.70863645655, 58405.0, 58550.70724646435, 62844.0, 63075.0, 63107.368926311065, 63131.368686313464, 63137.368626313146, 14936.25318734059, 16333.918330408273, 16512.587185320222, 16538.338466461206, 16549.751753723704, 11444.771104577861, 11523.30860148377, 11544.076473882069, 11544.480498377594, 11545.538178472934, 15969.600759981093, 18793.966331851607, 19167.616647666968, 19197.424077277705, 19203.423897283104, 7456.440766942501, 8230.711925082593, 8241.052278987872, 8260.463069900437, 8269.255766981001, 959.4003747657714, 989.7228775942748, 999.3753903810118, 1068.9786204275872, 1127.4588197665166, 26256.86871565668, 28993.56509652357, 29338.853305733333, 29541.85229073884, 30133.0, 956.7177682583655, 1033.3902997231519, 1067.514281002142, 1117.2737720481753, 1207.4747484844122, 11739.823902641467, 13806.0, 14054.016218864786, 14241.359138838778, 14244.002919795723, 535958.0, 548502.0, 549584.0, 549606.0, 549910.0, 55612.443875560726, 55853.44146558564, 55961.16058259129, 55977.44022559804, 56002.0, 1385.0789225165354, 1405.206058576901, 1420.7655736803517, 1420.936057877398, 1424.8717615414662, 27505.587416188373, 28208.0, 28257.587120643475, 32386.35227295488, 32524.83737581297, 56192.157117644085, 56929.43070569407, 56963.860722784484, 57070.42929570651, 57153.42846571481, 307452.0, 313590.4807139519, 358852.0, 365502.0, 397684.0, 43286.56713432825, 43674.56325436705, 43720.78139609282, 44338.669839904855, 44408.111837762415, 45368.546314536434, 45385.31922021238, 45781.54218457773, 46705.832354191414, 46818.82952926204, 38588.421173681854, 38872.8338149856, 39042.80478597589, 39142.412863807636, 39646.0, 38106.42840357452, 38257.278422470496, 38916.61083389243, 39000.0, 39072.0, 37852.81073594614, 38228.6177138225, 39076.0, 39135.0, 39199.80400097981, 31453.528197076605, 33811.3237735239, 34480.31039379248, 34674.826625866706, 34909.476357854146, 25455.109071182418, 25457.0, 25593.0, 25730.434045186084, 25800.483990319713], "unit": "score", "name": "ext.html", "value": 19454.679967358148}, {"lowerIsBetter": false, "replicates": [357.07161380410935, 363.2281402020706, 365.92315613721115, 366.21081569218325, 371.09082747269196, 18882.811171888294, 18896.338628148, 19264.133114009866, 19625.313114040993, 20382.796172038274, 19381.515462113453, 19488.610227795434, 19804.30684926028, 20038.0, 20051.0, 5910.0543912973935, 6118.4799292060225, 6120.0, 6122.693865306717, 6124.632522048669, 5837.824865254049, 6000.789972350969, 6080.0, 6089.2692876854835, 6092.634441933476, 3949.111449923773, 4031.1937612477477, 4188.078622703016, 6084.817455476321, 6098.32918378978, 4106.8562600309, 6450.774222902176, 6620.0, 6633.369829866155, 6666.166729158856, 5511.779528818883, 5759.568032397587, 5759.68321742304, 5761.827145185651, 5791.65250084992, 9183.816323673489, 12055.819162712567, 12059.93970030153, 12862.356882155855, 13119.672008199776, 2033.7559492860803, 2204.911803527857, 2267.263139479676, 2381.2856143156982, 2401.327628264089, 9470.479123648196, 9818.509074546244, 9966.302358834884, 10074.949625251827, 10239.12967397772, 1767.690654135521, 1769.9911500442545, 1780.0921530019655, 1829.8170182981728, 1850.6206227723285, 92943.0, 94543.58184627305, 96784.0, 98577.0, 99978.0, 10931.508082136323, 10999.670009899715, 11045.33727976324, 11057.905074463653, 11096.889031109748, 13299.26854023038, 13434.93282533581, 13464.461421543225, 13496.662583435493, 13520.459181632821, 8331.708390206435, 8412.369072319601, 8416.537090460084, 8451.070382258069, 8464.492130472068, 8451.915480845235, 8481.321494280442, 8484.575771211537, 8593.269572086318, 8601.22588966996, 4334.848280310174, 4427.180971520214, 4428.247197976351, 4479.61923236522, 4487.8653640390185, 1543.6449616588247, 1571.9449819256272, 1858.5818190906937, 1872.26981477224, 1887.7545919030713, 677.9457942898741, 935.4995077633433, 939.6758118449125, 956.712986104166, 977.8826540815147, 14454.566363009126, 18602.255909763728, 18909.24363025491, 19418.155275248828, 19658.31195908165, 829.6059371798468, 898.2679116520015, 930.5300823084299, 978.9021097890154, 1013.0426746724422, 8985.505797181218, 10536.473176341153, 10615.946920265349, 10695.518701658444, 10879.83680244797, 724301.0, 726881.0, 729331.0, 749583.0, 752217.0, 111975.0, 112646.0, 114524.0, 116843.41578292054, 117718.0, 1126.2566705974182, 1142.166218660366, 1149.2759561476216, 1173.9413029348498, 1175.8059920113085, 18262.0, 18274.90862545679, 18343.082845857385, 18436.63126737431, 18568.721469177704, 48247.75876120597, 49169.26246106383, 49613.50386496089, 53672.0, 54268.72865635646, 71215.28784712087, 71512.28487715057, 71961.0, 72090.63954680193, 72737.0, 7300.96349518249, 7301.890471643036, 7416.480846340704, 7432.182459929511, 7768.417368697257, 11512.251703639236, 11791.233569817934, 11830.881691182978, 11916.76166476683, 12193.817092743793, 9961.452120133463, 10256.333338332985, 10389.740256493647, 10558.630447934285, 10645.201609879136, 3897.493325867619, 8573.74278771638, 9893.455859927773, 10042.69871903844, 10162.323216669167, 7422.851542969219, 10263.589456421958, 10347.689569312932, 10390.532426040998, 10418.843717344398, 7379.889301660587, 7403.7408690695565, 7459.830724960417, 7807.219278072147, 7807.96096019539, 10481.889197450422, 10604.946975265075, 10641.680749577525, 10837.45812709377, 10845.728856778644], "unit": "score", "name": "jquery.html", "value": 8983.110640082865}, {"lowerIsBetter": false, "replicates": [1407.7888316752492, 1547.4506550174685, 1569.0742461947448, 1797.5685835399509, 1925.855560832937, 7905.051393832734, 8116.431849770511, 8472.703455379064, 8622.568871556412, 8632.007319158298, 8346.41575089744, 8459.0, 8555.572221388937, 8558.871616925751, 8578.828423431543, 2187.4093994621444, 2255.334676270504, 2478.5042991401656, 2507.2979565721535, 2512.723600403954, 2265.2071774878827, 2458.557459657261, 2524.5329614021375, 2525.1414519063514, 2527.4945010997876, 2445.364205306615, 2478.7149477810012, 2492.277239600514, 2509.1970569417795, 2513.6606558114604, 2443.7800597946093, 2495.500899820034, 2507.7492250774867, 2516.8615726135054, 2519.710233323173, 2450.950980980388, 2489.8132640051886, 2499.0128899084943, 2500.4499010217723, 2502.649629051934, 8745.737627871174, 8804.603792829337, 8811.206991370807, 8812.735617931472, 8823.0, 5363.0, 5524.447555244484, 5526.005319042611, 5526.557875370001, 5528.806491772769, 3590.7486475946694, 3606.5672119345586, 3680.1351682354625, 3742.8128593570214, 3770.472133901256, 1070.0743856564015, 1077.5959015369237, 1083.9864726480766, 1113.716002419386, 1116.9218154729172, 12001.87998120025, 12005.63983080509, 12022.879771202264, 12022.978046866026, 12042.277463352228, 4902.240152776325, 4905.3132561441425, 4937.1606826839525, 4974.5771609413605, 4985.052839960396, 10100.898991010143, 10112.988701129976, 10113.595456181818, 10114.54484548197, 10137.087662110445, 5481.643693159932, 5483.232347471358, 5488.423715509894, 5497.780088796403, 5499.340079190442, 4916.483769204182, 4981.750912454363, 4986.351774269322, 4988.800447982113, 4994.675346102492, 3313.8343082845763, 3333.883314084044, 3596.9640303597153, 3649.50731651229, 3652.634736526326, 1300.5578103444875, 1304.9151805132826, 1309.4827543120414, 1315.8223140702153, 1322.702391961801, 1314.66476048607, 1316.5326309160303, 1343.93952272148, 1350.3923234544495, 1351.175782772508, 7953.761387158394, 7985.0, 8002.51984880909, 8087.919120808834, 8377.581120943929, 1107.7396811749231, 1164.959226427071, 1209.564556759566, 1221.5480272299305, 1235.7528494301175, 6180.81457556274, 6228.439440450381, 6245.500359971192, 6251.874962500725, 6256.6871656417, 10223.079922806983, 10407.115395191342, 10527.894721052691, 10542.47287635615, 10585.364878107339, 9989.40063596172, 10319.896801032044, 10329.483525823829, 10348.741281468023, 10417.687469375931, 8005.599720013976, 8150.83698326042, 8215.055268644182, 8221.917780822116, 8226.383021273428, 7930.762077137695, 7935.801604959922, 8000.159983201913, 8021.959890200512, 8159.83680326402, 9454.05459454049, 9523.666671666459, 9560.56977436031, 9687.66093186735, 9732.026797320212, 9311.487868167316, 9597.376170548892, 9748.0, 9879.604815807576, 10057.748556286151, 7504.662290196845, 7507.549547027196, 7524.774256772305, 7638.350740186924, 7653.0, 7281.0, 7476.813079672834, 7481.0, 7966.203379661987, 8055.597220139087, 7521.548707077593, 7544.886826697494, 7611.695532178873, 7691.115521714851, 7704.191059938626, 7484.775456736306, 7487.513311634726, 7544.132424771222, 7638.388928885564, 7654.349380302737, 7631.809204769926, 7643.082830060428, 7687.0006899102755, 7707.229277072248, 7713.884291735741, 6953.548019378724, 7017.543859649107, 7021.859562808818, 7088.539244949062, 7093.32613401726, 7083.6812343443635, 7140.285971402818, 7152.785416437307, 7172.426205903411, 7180.461465390013], "unit": "score", "name": "mootools.html", "value": 4955.16423620522}, {"lowerIsBetter": false, "replicates": [322.77567090871844, 330.99338013239736, 333.10893360261304, 335.24736965512426, 340.3957974595092, 6160.4763595094355, 6334.239891213049, 6394.712237949292, 6414.583052101621, 6419.679016049196, 6133.172021777059, 6264.31092579817, 6280.309165991737, 6299.937000629992, 6319.526035547329, 4761.190597598399, 4774.188387974035, 4795.112904112751, 4803.687760295587, 4810.855674329776, 4541.931871021938, 4679.92980105297, 4714.929276060861, 4797.90404191916, 4806.0, 3815.618438156176, 4470.619997300233, 4627.884302892421, 4638.257878739402, 4746.121967436018, 4702.412198475191, 4712.340272361872, 4715.198416269225, 4716.198246298138, 4738.763061846894, 3329.866805327784, 3333.8833140840197, 4051.6556092732153, 4063.7764922929523, 4085.0, 5955.196048533436, 5958.076498142795, 5964.791232306892, 5968.4031596840405, 5984.281886173643, 5328.8401347959625, 5548.750306236229, 5557.444255574451, 5585.273914391103, 5596.804111856066, 6723.7646682365885, 6741.528093033489, 6744.123263975701, 6745.0, 6751.223609284946, 4339.132173565299, 4431.8670439886855, 4584.541545845422, 4586.678932474728, 4593.425821772278, 6057.757689692407, 6450.838729031765, 7009.859802803966, 7046.224915259318, 7058.2941705830035, 4626.357643036741, 4651.906961860744, 4661.044485880387, 4678.485366609671, 4684.344191813149, 4719.669623126349, 4739.0, 4741.857744267609, 4749.620030397629, 4762.976185119052, 5357.383900851452, 5478.972605136949, 5500.42245564218, 5531.225628412026, 5566.997940370772, 6754.425873800684, 6889.827754306082, 6938.757143499954, 6944.583325000415, 6959.512834101665, 1623.7320842060928, 1653.80154381475, 1654.8510634042993, 1655.114513735146, 1656.8757343199309, 1072.6245813965206, 1086.440483151178, 1094.7591529863416, 1108.95564177432, 1118.0384869012642, 6443.29123796382, 6451.774187903401, 6455.903161452582, 6468.0, 6498.447631951242, 6997.825054373681, 7005.684744186524, 7006.369426751617, 7012.7545535906, 7030.945358196312, 5129.384473863161, 6367.140436041168, 6528.738850445929, 6579.967100164565, 6587.80236592903, 3671.3024525340634, 3705.796181210005, 3712.1276500022473, 3715.5169827922196, 3718.5909549949483, 7393.112826460859, 7393.260673932671, 7396.408287337, 7397.18630950595, 7397.18630950595, 6228.968855155696, 6789.93210067893, 6979.092717946736, 7188.353048225685, 7199.89200161998, 7357.337839594462, 7362.889556656654, 7378.557286562716, 7382.926170738224, 7385.593792341473, 6911.723531058701, 6951.0, 6955.808920190124, 6967.2684368142645, 6976.372126508639, 6587.736490540325, 6613.14029176204, 6764.49266305039, 6786.660666966533, 6880.896786548105, 7347.8163045924275, 7359.926400735924, 7394.445416593884, 7402.9629851850395, 7478.429529798803, 4691.225947718588, 4692.0, 4705.623550116051, 4707.987782626752, 4725.5510726480925, 5809.680467574324, 6731.663416829041, 6838.8290292741085, 6975.79072627822, 7003.859922801617, 6693.799186024427, 6709.664516774044, 6740.325967403221, 6750.3924646782025, 6788.898166527605, 6578.407943285128, 6744.258131605618, 6752.155980502437, 6761.93238067613, 6763.830904227434, 6623.4038936495945, 6691.732330706912, 6780.1524809398825, 6793.048973143665, 6793.558418702769, 6731.730730770714, 6733.124693789776, 6738.124043874265, 6740.12378390806, 6761.898571521333, 6447.097406363207, 6573.441257492976, 6649.667516624246, 6654.600723956578, 6655.700493477902], "unit": "score", "name": "prototype.html", "value": 4994.158603657538}, {"lowerIsBetter": false, "replicates": [640.2796853539768, 656.481379710029, 691.2810676896029, 702.2661318921729, 713.5789883968457, 14828.332725027372, 14998.100113993154, 15057.17185554794, 15066.246687665627, 15093.245337733111, 13645.727085458286, 13720.451181952734, 13743.106698064645, 13749.450021999108, 13755.587332380019, 503.6197670758572, 677.6984242012306, 689.0766373060098, 702.2275496953362, 783.7021931665959, 843.6625349860044, 847.817719190374, 848.1730312944891, 848.2238751542332, 849.2865992566243, 871.9825603487926, 893.1425831202054, 893.950832704201, 894.0567701075363, 895.1317222294364, 696.8153439338579, 715.7065603102754, 716.5199316457986, 885.4421714320001, 887.3256325192867, 643.0771842406162, 664.0669858848325, 666.014298837718, 668.4451904918906, 670.1489108831756, 14553.417863285456, 14614.196219208046, 14620.634484137876, 14623.415063397451, 14626.853731462656, 12147.93926030373, 12236.632901012896, 12407.813882791765, 12411.317377544232, 12520.624381268577, 10176.033276838689, 10216.13162881156, 10224.233182511342, 10331.690049298533, 10936.617218397318, 3499.6500349965054, 3525.9294814103832, 3526.982365088184, 3535.5403797506415, 3540.539729835105, 81234.0, 82199.0, 83470.58264708698, 84010.0, 84062.0, 9511.90488095124, 9517.0, 9555.952220238854, 9742.025797420201, 9745.756356091013, 21430.249941251983, 21432.0, 21438.928053597258, 21453.463663408227, 21458.678119827902, 7462.477626566197, 7523.586202758901, 7665.425093118039, 7802.570858602718, 7824.804379890435, 4102.261592913304, 4133.710640255214, 4150.833966641361, 4150.875473735793, 4154.231467178582, 3569.803660798629, 3616.1140520572626, 3616.8372423241017, 3622.5109610202285, 3626.5648122225502, 636.6784773689258, 654.607235658601, 659.1793217444217, 672.9394354508117, 673.7002034094879, 515.8246196293278, 579.7565022690396, 596.4423264247943, 602.9418370759289, 627.6391075131818, 8595.31237501011, 8683.739487815375, 8749.912500875038, 8833.64665413389, 8925.73222803317, 518.9688618682891, 566.0, 609.5763444406184, 618.3569088148365, 636.6307541625846, 3674.2467794102145, 3740.345439548068, 4084.448599439097, 4175.290200665894, 4228.76741779199, 57342.0, 76334.98482659351, 76388.61805690936, 76806.61596691981, 76815.61592192003, 62594.68702656458, 70375.0, 79185.20814791779, 81166.0, 82441.0, 68541.28646783771, 69425.30574694189, 69929.65035174791, 70353.64823175954, 70994.0, 8134.511929284262, 8142.0, 8279.461834980708, 8384.958075209584, 8397.580120993804, 47437.05125897394, 47594.762026189645, 48011.0, 48928.755356224414, 50271.74864125656, 66786.66606666935, 67688.3231167682, 68563.65718171377, 68795.31204687888, 70695.29304706887, 10985.560577576807, 10995.395253261147, 11130.554777808797, 11226.270292430965, 11497.367644779282, 12006.879931200576, 12418.192817466836, 12419.0, 12542.561010364958, 12669.239845609292, 11704.297742135499, 11735.647930562096, 11751.353675547585, 11918.0, 11969.0, 11543.307401555934, 11803.586874459354, 11824.763504729684, 11996.100292478273, 12070.336131512851, 9369.812603748023, 11317.830232546683, 11484.138689598482, 11491.827622585835, 11505.42472876336, 9213.928076974778, 9299.256059515357, 9303.581338839904, 9614.89732748374, 9824.80350392974, 7693.730719424793, 8967.968683601208, 8995.28037756991, 9466.195373393339, 10072.143867771321], "unit": "score", "name": "yui.html", "value": 6752.797918697367}], "name": "dromaeo_css", "value": 7371.839356573706}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 111.0, 111.0, 110.0, 116.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [161.0, 119.0, 145.0, 158.0, 120.0, 145.0, 121.0, 155.0, 147.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 139.3}, {"lowerIsBetter": true, "replicates": [177.0, 183.0, 188.0, 183.0, 188.0, 185.0, 189.0, 186.0, 182.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 87.0, 103.0, 81.0, 85.0, 84.0, 86.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 82.0, 140.0, 112.0, 117.0, 119.0, 148.0, 83.0, 80.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [86.0, 89.0, 87.0, 94.0, 87.0, 92.0, 86.0, 92.0, 87.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 100.0, 129.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 99.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 85.0, 87.0, 86.0, 86.0, 85.0, 113.0, 140.0, 74.0], "unit": "score", "name": "imaging-desaturate", "value": 92.9}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 53.0, 52.0, 55.0, 54.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 78.0, 72.0, 70.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [79.0, 84.0, 82.0, 80.0, 81.0, 82.0, 83.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [126.0, 145.0, 107.0, 132.0, 123.0, 121.0, 126.0, 112.0, 129.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [139.0, 126.0, 145.0, 135.0, 137.0, 134.0, 144.0, 173.0, 170.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 67.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1445.5}]} 18:44:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1445.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7371.84"}}} 18:44:03 INFO - Return code: 0 18:44:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:44:03 INFO - # TBPL SUCCESS # 18:44:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:44:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:44:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:44:03 INFO - 2016-01-28 18:44:03.393 screenresolution[1985:14625] starting screenresolution argv=screenresolution get 18:44:03 INFO - 2016-01-28 18:44:03.396 screenresolution[1985:14625] Display 0: 1600x1200x32@60 18:44:03 INFO - 2016-01-28 18:44:03.402 screenresolution[1986:14628] starting screenresolution argv=screenresolution list 18:44:03 INFO - Available Modes on Display 0 18:44:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:44:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:44:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:44:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:44:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:44:03 INFO - Intel Iris: 18:44:03 INFO - Chipset Model: Intel Iris 18:44:03 INFO - Type: GPU 18:44:03 INFO - Bus: Built-In 18:44:03 INFO - VRAM (Dynamic, Max): 1536 MB 18:44:03 INFO - Vendor: Intel (0x8086) 18:44:03 INFO - Device ID: 0x0a2e 18:44:03 INFO - Revision ID: 0x0009 18:44:03 INFO - Displays: 18:44:03 INFO - Display: 18:44:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:44:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:44:03 INFO - Display Serial Number: 1600x1200 60 18:44:03 INFO - Main Display: Yes 18:44:03 INFO - Mirror: Off 18:44:03 INFO - Online: Yes 18:44:03 INFO - Rotation: Supported 18:44:03 INFO - Return code: 0 18:44:03 INFO - Running post-action listener: _resource_record_post_action 18:44:03 INFO - Running post-run listener: _resource_record_post_run 18:44:04 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2383872; Write bytes: 706980864; Read time: 35; Write time: 1966 18:44:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392921600; Write bytes: 387201024; Read time: 30048; Write time: 737 18:44:04 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2383872; Write bytes: 300127232; Read time: 35; Write time: 1183 18:44:04 INFO - Running post-run listener: _upload_blobber_files 18:44:04 INFO - Blob upload gear active. 18:44:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:44:04 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 18:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:44:05 INFO - (blobuploader) - INFO - Open directory for files ... 18:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:06 INFO - (blobuploader) - INFO - Done attempting. 18:44:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:44:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:44:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:07 INFO - (blobuploader) - INFO - Done attempting. 18:44:07 INFO - (blobuploader) - INFO - Iteration through files over. 18:44:07 INFO - Return code: 0 18:44:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:44:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:44:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53c2e7be2c3b5e6bde80606ddf5912e3fd70564871368592e1fc29dc74671b7e5aec84de3ffaeffe6ab835082ae687e330de94e71ec7f02b8e48c04e3505526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70fe04a5f96a9d25804861a5a47036eb27f9fc8c6c32369e6c44daea92f87aeeda7aeab4e0f0e2aa04072af676b154629896d26a4d1826968656c7603e7f37a"} 18:44:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:44:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:44:07 INFO - Contents: 18:44:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53c2e7be2c3b5e6bde80606ddf5912e3fd70564871368592e1fc29dc74671b7e5aec84de3ffaeffe6ab835082ae687e330de94e71ec7f02b8e48c04e3505526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70fe04a5f96a9d25804861a5a47036eb27f9fc8c6c32369e6c44daea92f87aeeda7aeab4e0f0e2aa04072af676b154629896d26a4d1826968656c7603e7f37a"} 18:44:07 INFO - Running post-run listener: copy_logs_to_upload_dir 18:44:07 INFO - Copying logs to upload dir... 18:44:07 INFO - mkdir: /builds/slave/test/build/upload/logs 18:44:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.145260 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-28 18:44:07.676767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 18:44:07.679775) ========= 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.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53c2e7be2c3b5e6bde80606ddf5912e3fd70564871368592e1fc29dc74671b7e5aec84de3ffaeffe6ab835082ae687e330de94e71ec7f02b8e48c04e3505526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70fe04a5f96a9d25804861a5a47036eb27f9fc8c6c32369e6c44daea92f87aeeda7aeab4e0f0e2aa04072af676b154629896d26a4d1826968656c7603e7f37a"} build_url:https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53c2e7be2c3b5e6bde80606ddf5912e3fd70564871368592e1fc29dc74671b7e5aec84de3ffaeffe6ab835082ae687e330de94e71ec7f02b8e48c04e3505526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70fe04a5f96a9d25804861a5a47036eb27f9fc8c6c32369e6c44daea92f87aeeda7aeab4e0f0e2aa04072af676b154629896d26a4d1826968656c7603e7f37a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 18:44:07.705802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:44:07.706086) ========= 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.UTHDFrtnZo/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.wJp20szCLB/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005275 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:44:07.753844) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 18:44:07.754122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 18:44:07.754465) ========= ========= Total master_lag: 0.58 =========