builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1458406568.19 results: success (0) buildid: 20160319082435 builduid: ea36be8131d8457bb2d84da35b56412d revision: 720fb3d55e2859286fd438bfaee0773b91c334ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.193394) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.193851) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.194146) ========= 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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005879 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.219103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.219375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.235026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.235284) ========= 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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005401 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.283344) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.283605) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.283933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.284205) ========= 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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-19 09:56:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-03-19 09:56:08 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.419962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.420378) ========= 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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.020097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.469275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:08.469591) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720fb3d55e2859286fd438bfaee0773b91c334ac --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 720fb3d55e2859286fd438bfaee0773b91c334ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-19 09:56:08,547 truncating revision to first 12 chars 2016-03-19 09:56:08,547 Setting DEBUG logging. 2016-03-19 09:56:08,547 attempt 1/10 2016-03-19 09:56:08,547 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720fb3d55e28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-19 09:56:09,232 unpacking tar archive at: mozilla-central-720fb3d55e28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:09.419072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:09.419401) ========= echo 720fb3d55e2859286fd438bfaee0773b91c334ac in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'720fb3d55e2859286fd438bfaee0773b91c334ac'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 720fb3d55e2859286fd438bfaee0773b91c334ac program finished with exit code 0 elapsedTime=0.005177 script_repo_revision: '720fb3d55e2859286fd438bfaee0773b91c334ac' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:09.468202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:09.468493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 09:56:09.482393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-03-19 09:56:09.482682) ========= /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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:56:09 INFO - MultiFileLogger online at 20160319 09:56:09 in /builds/slave/test 09:56:09 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 09:56:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:09 INFO - {'append_to_log': False, 09:56:09 INFO - 'base_work_dir': '/builds/slave/test', 09:56:09 INFO - 'blob_upload_branch': 'Firefox', 09:56:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:09 INFO - 'branch': 'Firefox', 09:56:09 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:09 INFO - 'config_files': ('talos/mac_config.py',), 09:56:09 INFO - 'default_actions': ('clobber', 09:56:09 INFO - 'read-buildbot-config', 09:56:09 INFO - 'download-and-extract', 09:56:09 INFO - 'populate-webroot', 09:56:09 INFO - 'create-virtualenv', 09:56:09 INFO - 'install', 09:56:09 INFO - 'run-tests'), 09:56:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:09 INFO - 'download_minidump_stackwalk': True, 09:56:09 INFO - 'download_symbols': 'ondemand', 09:56:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:09 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:09 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:09 INFO - 'installer_path': 'installer.exe', 09:56:09 INFO - 'log_level': 'info', 09:56:09 INFO - 'log_name': 'talos', 09:56:09 INFO - 'log_to_console': True, 09:56:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:56:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:56:09 INFO - 'opt_config_files': (), 09:56:09 INFO - 'pip_index': False, 09:56:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:09 INFO - 'cmd': ('bash', 09:56:09 INFO - '-c', 09:56:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:09 INFO - 'enabled': True, 09:56:09 INFO - 'halt_on_failure': False, 09:56:09 INFO - 'name': 'check_screen_resolution'},), 09:56:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:09 INFO - 'cmd': ('bash', 09:56:09 INFO - '-c', 09:56:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:09 INFO - 'enabled': True, 09:56:09 INFO - 'halt_on_failure': False, 09:56:09 INFO - 'name': 'check_screen_resolution'},), 09:56:09 INFO - 'run_cmd_checks_enabled': True, 09:56:09 INFO - 'sps_profile': False, 09:56:09 INFO - 'sps_profile_interval': 0, 09:56:09 INFO - 'suite': 'dromaeojs', 09:56:09 INFO - 'system_bits': '32', 09:56:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:09 INFO - 'title': 't-yosemite-r7-0192', 09:56:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:09 INFO - 'use_talos_json': True, 09:56:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:09 INFO - 'work_dir': 'build'} 09:56:09 INFO - ##### 09:56:09 INFO - ##### Running clobber step. 09:56:09 INFO - ##### 09:56:09 INFO - Running pre-action listener: _resource_record_pre_action 09:56:09 INFO - Running main action method: clobber 09:56:09 INFO - rmtree: /builds/slave/test/build 09:56:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:11 INFO - Running post-action listener: _resource_record_post_action 09:56:11 INFO - ##### 09:56:11 INFO - ##### Running read-buildbot-config step. 09:56:11 INFO - ##### 09:56:11 INFO - Running pre-action listener: _resource_record_pre_action 09:56:11 INFO - Running main action method: read_buildbot_config 09:56:11 INFO - Using buildbot properties: 09:56:11 INFO - { 09:56:11 INFO - "project": "", 09:56:11 INFO - "product": "firefox", 09:56:11 INFO - "script_repo_revision": "production", 09:56:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:56:11 INFO - "repository": "", 09:56:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:56:11 INFO - "buildid": "20160319082435", 09:56:11 INFO - "pgo_build": "False", 09:56:11 INFO - "basedir": "/builds/slave/test", 09:56:11 INFO - "buildnumber": 175, 09:56:11 INFO - "slavename": "t-yosemite-r7-0192", 09:56:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:56:11 INFO - "platform": "yosemite_r7", 09:56:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:56:11 INFO - "branch": "mozilla-central", 09:56:11 INFO - "repo_path": "mozilla-central", 09:56:11 INFO - "revision": "720fb3d55e2859286fd438bfaee0773b91c334ac", 09:56:11 INFO - "stage_platform": "macosx64", 09:56:11 INFO - "builduid": "ea36be8131d8457bb2d84da35b56412d", 09:56:11 INFO - "slavebuilddir": "test" 09:56:11 INFO - } 09:56:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:56:11 INFO - Running post-action listener: _resource_record_post_action 09:56:11 INFO - ##### 09:56:11 INFO - ##### Running download-and-extract step. 09:56:11 INFO - ##### 09:56:11 INFO - Running pre-action listener: _resource_record_pre_action 09:56:11 INFO - Running main action method: download_and_extract 09:56:11 INFO - mkdir: /builds/slave/test/build/tests 09:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:11 INFO - https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:56:14 INFO - Downloaded 1199 bytes. 09:56:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:14 INFO - Using the following test package requirements: 09:56:14 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:56:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:56:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:56:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'jsshell-mac.zip'], 09:56:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:56:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:56:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:56:14 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:56:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:56:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:14 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:56:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:56: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')]} 09:56:14 INFO - https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:56:16 INFO - Downloaded 17873211 bytes. 09:56:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:56:19 INFO - Return code: 0 09:56:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:56:19 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')]} 09:56:19 INFO - https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:56:38 INFO - Downloaded 17873211 bytes. 09:56:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:56:42 INFO - Return code: 0 09:56: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')]} 09:56:42 INFO - https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:56:44 INFO - Downloaded 10847637 bytes. 09:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:56:44 INFO - Return code: 0 09:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:44 INFO - https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:56:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:56:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:56:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:56:49 INFO - Downloaded 111196147 bytes. 09:56:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:56:49 INFO - mkdir: /builds/slave/test/properties 09:56:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:49 INFO - Contents: 09:56:49 INFO - build_url:https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:56:51 INFO - Running post-action listener: _resource_record_post_action 09:56:51 INFO - Running post-action listener: set_extra_try_arguments 09:56:51 INFO - ##### 09:56:51 INFO - ##### Running populate-webroot step. 09:56:51 INFO - ##### 09:56:51 INFO - Running pre-action listener: _resource_record_pre_action 09:56:51 INFO - Running main action method: populate_webroot 09:56:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:51 INFO - '--tppagecycles', 09:56:51 INFO - '7'], 09:56:51 INFO - 'tests': ['tsvgm']}}, 09:56:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:56:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:56:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'tests': ['damp', 'tps']}, 09:56:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['damp', 'tps']}, 09:56:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:56:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:51 INFO - 'other': {'tests': ['a11yr', 09:56:51 INFO - 'ts_paint', 09:56:51 INFO - 'tpaint', 09:56:51 INFO - 'sessionrestore', 09:56:51 INFO - 'sessionrestore_no_auto_restore', 09:56:51 INFO - 'tabpaint']}, 09:56:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['a11yr', 09:56:51 INFO - 'ts_paint', 09:56:51 INFO - 'tpaint', 09:56:51 INFO - 'sessionrestore', 09:56:51 INFO - 'sessionrestore_no_auto_restore', 09:56:51 INFO - 'tabpaint']}, 09:56:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['a11yr', 09:56:51 INFO - 'ts_paint', 09:56:51 INFO - 'tpaint', 09:56:51 INFO - 'sessionrestore', 09:56:51 INFO - 'sessionrestore_no_auto_restore', 09:56:51 INFO - 'tabpaint']}, 09:56:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['a11yr', 09:56:51 INFO - 'ts_paint', 09:56:51 INFO - 'tpaint', 09:56:51 INFO - 'sessionrestore', 09:56:51 INFO - 'sessionrestore_no_auto_restore', 09:56:51 INFO - 'tabpaint']}, 09:56:51 INFO - 'other_l64': {'tests': ['a11yr', 09:56:51 INFO - 'ts_paint', 09:56:51 INFO - 'tpaint', 09:56:51 INFO - 'sessionrestore', 09:56:51 INFO - 'sessionrestore_no_auto_restore', 09:56:51 INFO - 'tabpaint']}, 09:56:51 INFO - 'other_nol64': {'tests': ['a11yr', 09:56:51 INFO - 'ts_paint', 09:56:51 INFO - 'tpaint', 09:56:51 INFO - 'sessionrestore', 09:56:51 INFO - 'sessionrestore_no_auto_restore', 09:56:51 INFO - 'tabpaint']}, 09:56:51 INFO - 'svgr': {'tests': ['tsvgx', 09:56:51 INFO - 'tsvgr_opacity', 09:56:51 INFO - 'tart', 09:56:51 INFO - 'tscrollx', 09:56:51 INFO - 'cart']}, 09:56:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['tsvgx', 09:56:51 INFO - 'tsvgr_opacity', 09:56:51 INFO - 'tart', 09:56:51 INFO - 'tscrollx', 09:56:51 INFO - 'cart']}, 09:56:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'tests': ['tp5o']}, 09:56:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'talos_options': ['--e10s'], 09:56:51 INFO - 'tests': ['tp5o']}, 09:56:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'talos_options': ['--xperf_path', 09:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:51 INFO - 'tests': ['tp5n']}, 09:56:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:51 INFO - 'talos_options': ['--e10s', 09:56:51 INFO - '--xperf_path', 09:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:51 INFO - 'tests': ['tp5n']}}, 09:56:51 INFO - 'talos.zip': {'path': '', 09:56:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:51 INFO - Running post-action listener: _resource_record_post_action 09:56:51 INFO - ##### 09:56:51 INFO - ##### Running create-virtualenv step. 09:56:51 INFO - ##### 09:56:51 INFO - Running pre-action listener: _resource_record_pre_action 09:56:51 INFO - Running main action method: create_virtualenv 09:56:51 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:51 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 09:56:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:51 INFO - Using real prefix '/tools/python27' 09:56:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:51 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:54 INFO - Installing pip.................done. 09:56:54 INFO - Return code: 0 09:56:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:54 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:56:54 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 09:56:54 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 09:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:54 INFO - 'HOME': '/Users/cltbld', 09:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:54 INFO - 'LOGNAME': 'cltbld', 09:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:54 INFO - 'MOZ_NO_REMOTE': '1', 09:56:54 INFO - 'NO_EM_RESTART': '1', 09:56:54 INFO - 'PAGER': '/bin/cat', 09:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:54 INFO - 'PWD': '/builds/slave/test', 09:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:54 INFO - 'SHELL': '/bin/bash', 09:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:56:54 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:54 INFO - 'USER': 'cltbld', 09:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:54 INFO - 'XPC_FLAGS': '0x0', 09:56:54 INFO - 'XPC_SERVICE_NAME': '0', 09:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:55 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 09:56:55 INFO - Cleaning up... 09:56:55 INFO - Return code: 0 09:56:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:55 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:56:55 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 09:56:55 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 09:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:55 INFO - 'HOME': '/Users/cltbld', 09:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:55 INFO - 'LOGNAME': 'cltbld', 09:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:55 INFO - 'MOZ_NO_REMOTE': '1', 09:56:55 INFO - 'NO_EM_RESTART': '1', 09:56:55 INFO - 'PAGER': '/bin/cat', 09:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:55 INFO - 'PWD': '/builds/slave/test', 09:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:55 INFO - 'SHELL': '/bin/bash', 09:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:56:55 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:55 INFO - 'USER': 'cltbld', 09:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:55 INFO - 'XPC_FLAGS': '0x0', 09:56:55 INFO - 'XPC_SERVICE_NAME': '0', 09:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:55 INFO - Downloading/unpacking psutil>=0.7.1 09:56:55 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 09:56:55 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 09:56:55 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 09:56:55 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 09:56:55 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 09:56:55 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 09:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:58 INFO - Installing collected packages: psutil 09:56:58 INFO - Running setup.py install for psutil 09:56:58 INFO - building 'psutil._psutil_osx' extension 09:56:58 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 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 INFO - building 'psutil._psutil_posix' extension 09:56:59 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 09:56:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:56:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:56:59 INFO - ^ 09:56:59 INFO - 1 warning generated. 09:56:59 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 09:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:59 INFO - Successfully installed psutil 09:56:59 INFO - Cleaning up... 09:56:59 INFO - Return code: 0 09:56:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:59 INFO - 'HOME': '/Users/cltbld', 09:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:59 INFO - 'LOGNAME': 'cltbld', 09:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:59 INFO - 'MOZ_NO_REMOTE': '1', 09:56:59 INFO - 'NO_EM_RESTART': '1', 09:56:59 INFO - 'PAGER': '/bin/cat', 09:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:59 INFO - 'PWD': '/builds/slave/test', 09:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:59 INFO - 'SHELL': '/bin/bash', 09:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:56:59 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:59 INFO - 'USER': 'cltbld', 09:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:59 INFO - 'XPC_FLAGS': '0x0', 09:56:59 INFO - 'XPC_SERVICE_NAME': '0', 09:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 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 09:57:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:02 INFO - Installing collected packages: mozsystemmonitor 09:57:02 INFO - Running setup.py install for mozsystemmonitor 09:57:02 INFO - Successfully installed mozsystemmonitor 09:57:02 INFO - Cleaning up... 09:57:02 INFO - Return code: 0 09:57:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:02 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:57:02 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 09:57:02 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 09:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:02 INFO - 'HOME': '/Users/cltbld', 09:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:02 INFO - 'LOGNAME': 'cltbld', 09:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:02 INFO - 'MOZ_NO_REMOTE': '1', 09:57:02 INFO - 'NO_EM_RESTART': '1', 09:57:02 INFO - 'PAGER': '/bin/cat', 09:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:02 INFO - 'PWD': '/builds/slave/test', 09:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:02 INFO - 'SHELL': '/bin/bash', 09:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:57:02 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:02 INFO - 'USER': 'cltbld', 09:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:02 INFO - 'XPC_FLAGS': '0x0', 09:57:02 INFO - 'XPC_SERVICE_NAME': '0', 09:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:02 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:06 INFO - Downloading docopt-0.6.1.tar.gz 09:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:06 INFO - Running setup.py install for blobuploader 09:57:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:06 INFO - Running setup.py install for requests 09:57:07 INFO - Running setup.py install for docopt 09:57:07 INFO - Successfully installed blobuploader requests docopt 09:57:07 INFO - Cleaning up... 09:57:07 INFO - Return code: 0 09:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:07 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:57:07 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 09:57:07 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 09:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:07 INFO - 'HOME': '/Users/cltbld', 09:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:07 INFO - 'LOGNAME': 'cltbld', 09:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:07 INFO - 'MOZ_NO_REMOTE': '1', 09:57:07 INFO - 'NO_EM_RESTART': '1', 09:57:07 INFO - 'PAGER': '/bin/cat', 09:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:07 INFO - 'PWD': '/builds/slave/test', 09:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:07 INFO - 'SHELL': '/bin/bash', 09:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:57:07 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:07 INFO - 'USER': 'cltbld', 09:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:07 INFO - 'XPC_FLAGS': '0x0', 09:57:07 INFO - 'XPC_SERVICE_NAME': '0', 09:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-tiMcXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xSokZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-scqupr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:07 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ghTJPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-bmzmi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-hNxynN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-GqIqGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-jp4X0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-VX2SLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-bCuweI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-_Jdt6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dXE8je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:08 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-MvFI6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:09 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-h1O0gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:09 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-SzGO6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:09 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-I_V6LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:09 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dclT7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:09 INFO - Running setup.py install for manifestparser 09:57:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:09 INFO - Running setup.py install for mozcrash 09:57:09 INFO - Running setup.py install for mozdebug 09:57:09 INFO - Running setup.py install for mozdevice 09:57:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Running setup.py install for mozfile 09:57:10 INFO - Running setup.py install for mozhttpd 09:57:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Running setup.py install for mozinfo 09:57:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Running setup.py install for mozInstall 09:57:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Running setup.py install for mozleak 09:57:10 INFO - Running setup.py install for mozlog 09:57:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:10 INFO - Running setup.py install for moznetwork 09:57:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:11 INFO - Running setup.py install for mozprocess 09:57:11 INFO - Running setup.py install for mozprofile 09:57:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:11 INFO - Running setup.py install for mozrunner 09:57:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:11 INFO - Running setup.py install for mozscreenshot 09:57:11 INFO - Running setup.py install for moztest 09:57:11 INFO - Running setup.py install for mozversion 09:57:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:11 INFO - Cleaning up... 09:57:12 INFO - Return code: 0 09:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:12 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:57:12 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 09:57:12 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 09:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:12 INFO - 'HOME': '/Users/cltbld', 09:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:12 INFO - 'LOGNAME': 'cltbld', 09:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:12 INFO - 'MOZ_NO_REMOTE': '1', 09:57:12 INFO - 'NO_EM_RESTART': '1', 09:57:12 INFO - 'PAGER': '/bin/cat', 09:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:12 INFO - 'PWD': '/builds/slave/test', 09:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:12 INFO - 'SHELL': '/bin/bash', 09:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:57:12 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:12 INFO - 'USER': 'cltbld', 09:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:12 INFO - 'XPC_FLAGS': '0x0', 09:57:12 INFO - 'XPC_SERVICE_NAME': '0', 09:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HH1k6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:12 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)) 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-szFPFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-nfQnMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:12 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)) 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-tsoPMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:12 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)) 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9K2yZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:12 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)) 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-m4ugcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:12 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)) 09:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:12 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-UD5X1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-JYYn4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3Cy75I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-0B5wZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-aPQ9fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-fwALma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-lzXfL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-PTB_PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6CObSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zlZsn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:13 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)) 09:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:13 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-iXCJJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:14 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)) 09:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:16 INFO - Downloading blessings-1.6.tar.gz 09:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:16 INFO - Installing collected packages: blessings 09:57:16 INFO - Running setup.py install for blessings 09:57:17 INFO - Successfully installed blessings 09:57:17 INFO - Cleaning up... 09:57:17 INFO - Return code: 0 09:57:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:17 INFO - Reading from file tmpfile_stdout 09:57:17 INFO - Current package versions: 09:57:17 INFO - blessings == 1.6 09:57:17 INFO - blobuploader == 1.2.4 09:57:17 INFO - docopt == 0.6.1 09:57:17 INFO - manifestparser == 1.1 09:57:17 INFO - mozInstall == 1.12 09:57:17 INFO - mozcrash == 0.17 09:57:17 INFO - mozdebug == 0.1 09:57:17 INFO - mozdevice == 0.48 09:57:17 INFO - mozfile == 1.2 09:57:17 INFO - mozhttpd == 0.7 09:57:17 INFO - mozinfo == 0.9 09:57:17 INFO - mozleak == 0.1 09:57:17 INFO - mozlog == 3.1 09:57:17 INFO - moznetwork == 0.27 09:57:17 INFO - mozprocess == 0.22 09:57:17 INFO - mozprofile == 0.28 09:57:17 INFO - mozrunner == 6.11 09:57:17 INFO - mozscreenshot == 0.1 09:57:17 INFO - mozsystemmonitor == 0.0 09:57:17 INFO - moztest == 0.7 09:57:17 INFO - mozversion == 1.4 09:57:17 INFO - psutil == 3.1.1 09:57:17 INFO - requests == 1.2.3 09:57:17 INFO - wsgiref == 0.1.2 09:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:57:17 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 09:57:17 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 09:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:17 INFO - 'HOME': '/Users/cltbld', 09:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:17 INFO - 'LOGNAME': 'cltbld', 09:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:17 INFO - 'MOZ_NO_REMOTE': '1', 09:57:17 INFO - 'NO_EM_RESTART': '1', 09:57:17 INFO - 'PAGER': '/bin/cat', 09:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:17 INFO - 'PWD': '/builds/slave/test', 09:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:17 INFO - 'SHELL': '/bin/bash', 09:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:57:17 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:17 INFO - 'USER': 'cltbld', 09:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:17 INFO - 'XPC_FLAGS': '0x0', 09:57:17 INFO - 'XPC_SERVICE_NAME': '0', 09:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 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)) 09:57:17 INFO - Cleaning up... 09:57:17 INFO - Return code: 0 09:57:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:57:17 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 09:57:17 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 09:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:17 INFO - 'HOME': '/Users/cltbld', 09:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:17 INFO - 'LOGNAME': 'cltbld', 09:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:17 INFO - 'MOZ_NO_REMOTE': '1', 09:57:17 INFO - 'NO_EM_RESTART': '1', 09:57:17 INFO - 'PAGER': '/bin/cat', 09:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:17 INFO - 'PWD': '/builds/slave/test', 09:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:17 INFO - 'SHELL': '/bin/bash', 09:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:57:17 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:17 INFO - 'USER': 'cltbld', 09:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:17 INFO - 'XPC_FLAGS': '0x0', 09:57:17 INFO - 'XPC_SERVICE_NAME': '0', 09:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:17 INFO - Downloading/unpacking jsonschema 09:57:17 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 09:57:17 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 09:57:17 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 09:57:17 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 09:57:17 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 09:57:17 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 09:57:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:20 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:20 INFO - warning: no files found matching '*.txt' 09:57:20 INFO - no previously-included directories found matching 'build' 09:57:20 INFO - no previously-included directories found matching 'dist' 09:57:20 INFO - no previously-included directories found matching '.git*' 09:57:20 INFO - Installing collected packages: jsonschema, functools32 09:57:20 INFO - Running setup.py install for functools32 09:57:20 INFO - warning: no files found matching '*.txt' 09:57:20 INFO - no previously-included directories found matching 'build' 09:57:20 INFO - no previously-included directories found matching 'dist' 09:57:20 INFO - no previously-included directories found matching '.git*' 09:57:21 INFO - Successfully installed jsonschema functools32 09:57:21 INFO - Cleaning up... 09:57:21 INFO - Return code: 0 09:57:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 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 0x102dd0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102de0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbea2590640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, '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.utxwxP4P6q/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.R4NnyHRc1v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 09:57:21 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 09:57:21 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 09:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:21 INFO - 'HOME': '/Users/cltbld', 09:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:21 INFO - 'LOGNAME': 'cltbld', 09:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:21 INFO - 'MOZ_NO_REMOTE': '1', 09:57:21 INFO - 'NO_EM_RESTART': '1', 09:57:21 INFO - 'PAGER': '/bin/cat', 09:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:21 INFO - 'PWD': '/builds/slave/test', 09:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:21 INFO - 'SHELL': '/bin/bash', 09:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:57:21 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:21 INFO - 'USER': 'cltbld', 09:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:21 INFO - 'XPC_FLAGS': '0x0', 09:57:21 INFO - 'XPC_SERVICE_NAME': '0', 09:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:21 INFO - Downloading/unpacking flake8 09:57:21 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 09:57:21 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 09:57:21 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 09:57:21 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 09:57:21 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 09:57:21 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 09:57:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:57:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:57:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:57:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:24 INFO - no previously-included directories found matching 'docs/_build' 09:57:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:57:25 INFO - Running setup.py install for pep8 09:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:25 INFO - no previously-included directories found matching 'docs/_build' 09:57:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:57:25 INFO - Cleaning up... 09:57:25 INFO - Return code: 0 09:57:25 INFO - Running post-action listener: _resource_record_post_action 09:57:25 INFO - Running post-action listener: _start_resource_monitoring 09:57:25 INFO - Starting resource monitoring. 09:57:25 INFO - ##### 09:57:25 INFO - ##### Running install step. 09:57:25 INFO - ##### 09:57:25 INFO - Running pre-action listener: _resource_record_pre_action 09:57:25 INFO - Running main action method: install 09:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:25 INFO - Reading from file tmpfile_stdout 09:57:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:25 INFO - Reading from file tmpfile_stdout 09:57:25 INFO - Output received: 09:57:25 INFO - Usage: mozinstall [options] installer 09:57:25 INFO - Options: 09:57:25 INFO - -h, --help show this help message and exit 09:57:25 INFO - -d DEST, --destination=DEST 09:57:25 INFO - Directory to install application into. [default: 09:57:25 INFO - "/builds/slave/test"] 09:57:25 INFO - --app=APP Application being installed. [default: firefox] 09:57:25 INFO - mkdir: /builds/slave/test/build/application 09:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:57:59 INFO - Reading from file tmpfile_stdout 09:57:59 INFO - Output received: 09:57:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:57:59 INFO - Running post-action listener: _resource_record_post_action 09:57:59 INFO - ##### 09:57:59 INFO - ##### Running run-tests step. 09:57:59 INFO - ##### 09:57:59 INFO - Running pre-action listener: _resource_record_pre_action 09:57:59 INFO - Running main action method: run_tests 09:57:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:59 INFO - 2016-03-19 09:57:59.585 screenresolution[2291:15131] starting screenresolution argv=screenresolution get 09:57:59 INFO - 2016-03-19 09:57:59.587 screenresolution[2291:15131] Display 0: 1600x1200x32@60 09:57:59 INFO - 2016-03-19 09:57:59.594 screenresolution[2292:15133] starting screenresolution argv=screenresolution list 09:57:59 INFO - Available Modes on Display 0 09:57:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:59 INFO - Intel Iris: 09:57:59 INFO - Chipset Model: Intel Iris 09:57:59 INFO - Type: GPU 09:57:59 INFO - Bus: Built-In 09:57:59 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:59 INFO - Vendor: Intel (0x8086) 09:57:59 INFO - Device ID: 0x0a2e 09:57:59 INFO - Revision ID: 0x0009 09:57:59 INFO - Displays: 09:57:59 INFO - Display: 09:57:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:59 INFO - Display Serial Number: 1600x1200 60 09:57:59 INFO - Main Display: Yes 09:57:59 INFO - Mirror: Off 09:57:59 INFO - Online: Yes 09:57:59 INFO - Rotation: Supported 09:57:59 INFO - Return code: 0 09:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:59 INFO - Python 2.7.3 09:57:59 INFO - Return code: 0 09:57:59 INFO - grabbing minidump binary from tooltool 09:57: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')]} 09:57:59 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 0x102c6fe00>, '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 0x102a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c6ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:59 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 09:57:59 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 09:57:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:59 INFO - Return code: 0 09:57:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:57:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:57:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:01 INFO - Return code: 0 09:58:01 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/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 09:58:01 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/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 09:58:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.utxwxP4P6q/Render', 09:58:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:01 INFO - 'HOME': '/Users/cltbld', 09:58:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:01 INFO - 'LOGNAME': 'cltbld', 09:58:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:01 INFO - 'MOZ_NO_REMOTE': '1', 09:58:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:01 INFO - 'NO_EM_RESTART': '1', 09:58:01 INFO - 'PAGER': '/bin/cat', 09:58:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:01 INFO - 'PWD': '/builds/slave/test', 09:58:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:01 INFO - 'SHELL': '/bin/bash', 09:58:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4NnyHRc1v/Listeners', 09:58:01 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 09:58:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:01 INFO - 'USER': 'cltbld', 09:58:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:01 INFO - 'XPC_FLAGS': '0x0', 09:58:01 INFO - 'XPC_SERVICE_NAME': '0', 09:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:01 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/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 09:58:01 INFO - mozversion application_buildid: 20160319082435 09:58:01 INFO - mozversion application_changeset: 720fb3d55e2859286fd438bfaee0773b91c334ac 09:58:01 INFO - mozversion application_display_name: Nightly 09:58:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:01 INFO - mozversion application_name: Firefox 09:58:01 INFO - mozversion application_remotingname: firefox 09:58:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:58:01 INFO - mozversion application_vendor: Mozilla 09:58:01 INFO - mozversion application_version: 48.0a1 09:58:01 INFO - mozversion platform_buildid: 20160319082435 09:58:01 INFO - mozversion platform_changeset: 720fb3d55e2859286fd438bfaee0773b91c334ac 09:58:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:58:01 INFO - mozversion platform_version: 48.0a1 09:58:01 INFO - using testdate: 1458406681 09:58:01 INFO - actual date: 1458406681 09:58:01 INFO - starting webserver on 'localhost:49630' 09:58:01 INFO - SUITE-START | Running 2 tests 09:58:01 INFO - TEST-START | dromaeo_css 09:58:01 INFO - operating with platform_type : mac_ 09:58:01 INFO - Initialising browser for dromaeo_css test... 09:58:01 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpfe_hYn/profile http://localhost:49630/getInfo.html) 09:58:03 INFO - PROCESS | 2310 | __metrics Screen width/height:1600/1200 09:58:03 INFO - PROCESS | 2310 | colorDepth:24 09:58:03 INFO - PROCESS | 2310 | Browser inner width/height: 1024/689 09:58:03 INFO - PROCESS | 2310 | __metrics 09:58:03 INFO - PROCESS | 2310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:58:03 ERROR - PROCESS | 2310 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:58:04 INFO - TEST-INFO | 2310: exit 0 09:58:04 INFO - Browser initialized. 09:58:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:04 INFO - TEST-INFO | started process 2313 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpfe_hYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:16 INFO - PROCESS | 2313 | RSS: Main: 247128064 09:58:16 INFO - PROCESS | 2313 | 09:59:07 INFO - PROCESS | 2313 | 1458406747354 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] 10:01:18 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49630/tests/dromaeo/cssquery-ext.html) 10:01:20 INFO - PROCESS | 2313 | RSS: Main: 471109632 10:01:20 INFO - PROCESS | 2313 | 10:04:23 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-ext.html (next: http://localhost:49630/tests/dromaeo/cssquery-jquery.html) 10:04:24 INFO - PROCESS | 2313 | RSS: Main: 383197184 10:04:24 INFO - PROCESS | 2313 | 10:07:26 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49630/tests/dromaeo/cssquery-mootools.html) 10:07:26 INFO - PROCESS | 2313 | RSS: Main: 378089472 10:07:26 INFO - PROCESS | 2313 | 10:10:29 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49630/tests/dromaeo/cssquery-prototype.html) 10:10:29 INFO - PROCESS | 2313 | RSS: Main: 340463616 10:10:29 INFO - PROCESS | 2313 | 10:13:32 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49630/tests/dromaeo/cssquery-yui.html) 10:13:33 INFO - PROCESS | 2313 | RSS: Main: 341389312 10:13:33 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-yui.html (next: http://localhost:49630/tests/dromaeo/cssquery-dojo.html) 10:16:36 INFO - PROCESS | 2313 | RSS: Main: 416423936 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | __start_tp_report 10:16:36 INFO - PROCESS | 2313 | _x_x_mozilla_page_load 10:16:36 INFO - PROCESS | 2313 | _x_x_mozilla_page_load_details 10:16:36 INFO - PROCESS | 2313 | |i|pagename|runs| 10:16:36 INFO - PROCESS | 2313 | |0;dojo.html;3089.8918537851173;3346.682065203805;3349.2464195556004;3389.491576263562;3410.079278594781;5486.725663716808;5496.3953965063865;5533.584981126416;5566.443355664432;5588.329400471939;4731.503192164825;5637.041702910505;5651.7739290428435;5661.179129026289;5742.253507044089;5051.469595692454;5096.719680417585;5106.183010718286;5116.744162791864;5200.843974680765;4329.631981281595;5191.5327620514145;5221.112410890139;5234.973825130869;5246.239295302179;5015.849524514252;5026.547610715053;5084.44071152173;5089.41471730752;5115.616328775357;4257.382679511454;4860.927086093711;5095.79616815327;5150.330457040598;5157.871053223662;4528.366028755977;5042.873928151789;5082.08522465956;5099.08216521026;5148.510891465342;5375.6774593524515;5541.695206763627;5551.694656793875;5665.433456654343;5666.716664166775;6125.693715314216;6127.0561091552745;6137.570370074097;6146.508279337687;6177.196964394645;6178.7219575119225;6197.4732147767045;6197.907031394533;6209.254889413254;6223.066540018988;5570.3315602127595;5669.348024977139;5699.74351154199;5764.913526297109;5800.7099645018425;6205.441510264098;6207.689615519296;6213.068039793977;6219.222597175353;6230;5976.252968378953;6026.819195424145;6028.3971602839365;6058.4244496772735;6077.817665470043;6005.219321488178;6032.698365081728;6139.4781443577795;6142.723577439026;6194.721237544321;5894;6081.787137450168;6084.421979911901;6111.236095488064;6124.326324104345;5890.882182356415;5894.793682221101;6111.388861113853;6112.724927378279;6126.785562505291;4628.305754136906;4634.768261586974;4640.350350950869;4670.719756814602;4682.906341873144;3809;4336.588024137702;4348.065165989327;4358.237308471068;4361.084172323847;5475.7262136893;5501.14732216507;5513.3108361454815;5571.1086226203615;5604.635698679573;6213.471854892385;6225.221847269091;6244.875102497925;6258.123862659231;6260.060990851409;5373.973130134403;5463.31708536433;5472.370677372073;5568.136938774496;5573.916391254134;5252.816151434681;5265;5282.339707536558;5296.205569164579;5296.788128474895;6264.436200741955;6264.968675156595;6265.592736472115;6267.9373206267355;6270.2475702915945;6058.606190597597;6216.72024758896;6232.314445410911;6237.500999919905;6239.376062393906;6197.5351848610635;6246.500279977682;6288.937110628835;6417.03744438338;6443.710033048618;6079.513638908788;6122.510199184144;6123.14276001369;6123.8469038272615;6127.172831667846;6016.759329626941;6169.629822210682;6194.659293738888;6204.162438070803;6236.594621349598;5838.065909454467;5862.12068189775;5870.5010074144175;5881.588288819741;5903;4686.742229177428;5848.152017957287;5849.444302791228;5851.385604511635;5856.502197313106;5744.023516002373;5750.223719797774;5751.568632352507;5757.65454072757;5764.625299355528;4557.612602928788;5583.330000399978;5865.3254875689845;5867.794627188028;5963.493103086113;5842.38654941242;5843.795467158629;5850.502707269759;5852.297724272944;5924.703764811656 10:16:36 INFO - PROCESS | 2313 | |1;ext.html;487.1936944357088;579.3511267380532;597.6384287506062;640.5740182778453;644.2011905237506;38222;38302.80848595757;38341;39009.024774380654;39027.804860975724;39767.40348894769;40420.19159616806;40597.59402405975;40613;40667;9365.969743328245;9606.711798646016;9640;9640.80718385632;9647.903520964806;9436.197923176538;9721.854172187388;9728.367656102366;9741.366811157288;9744.658936937209;9679.128878400943;9749.707508774713;9771.706848794547;9772.218222542215;9784.804303913954;9675.032496750338;9762.707118786448;9767.023297670246;9775.902240977606;9796.90203097967;8279.461834980768;9583.952080239624;9702.854457183148;9737.367071140354;9752.658656946973;39300.017499562455;39746.60886868975;39811.60188398108;39827.8008609958;39854.402183967264;1900.7148927660824;3198.2164369729335;3372.814495202763;3452.9482057769155;3502.964970350289;27489.90040398382;28355.574666379813;28830.567541486893;29128.126156215134;29129.56305655417;2749.793765467598;2756.6691996960294;2855.9857200714073;2876.985615071932;2886.9895536562244;355712;358368;360867.19566402264;360900;361836;58645.70677146587;59900.10149847756;68400;69607;69670.30329696638;51136.886311368566;63915.680421598525;64390.91699913006;64488.355116448234;64657.67671161614;16319.184040797913;16435.753463698053;16667.49997500077;16669.99980001204;16672;12632.747345053047;12683.302418367079;12684.936575317064;12809.423575939105;12810.935945320214;20855.8957205213;21128.471788205417;21144.577108457746;21158.47103822386;21188.894055529625;6278.497720182466;7894.21057894206;8217.630206640715;8239.382046346547;8308.750737477885;983.9901600983899;1016.9491525423699;1020.9234307426973;1063.2344711807486;1115.7489564847845;27917.860410697816;27922.155688622755;28088.85955570209;28243.71756282411;28588.714112859023;958.7171784323641;1059.2902755154066;1094.441834664327;1103.9834402483968;1150.1891166727437;14463.92768036153;14621.122732636077;14633.560993170222;14699.118052916645;14929.925350373178;614287;617167.3690999348;619786;620412;621663;61555.6922215395;61838.69080654568;61883.07175392373;62017.379826202065;62083;1271.8172099947137;1361.8297712785902;1379.165604809096;1486.9851301487063;1515.0455213215603;26735.732642674102;29170.562441562968;29579.704202957695;29848.403031938804;30438.543421848248;47558.81102972454;56349.43650563442;57263.42736572581;57386;57571.71214143903;409391;432226;454667;461893;464489;36848.89453316405;37387.43918841165;37503.249935001695;37736.433953491265;38554;43243.918902027704;44030.77984610185;44097;44542;45336.31995520136;37255;39047.609523905536;39535.2092958145;39955.40066898941;40659.390109148975;35986.28027439489;36043.459348109274;36404.16565079553;36530.8173459131;36792.63207367892;35412.46881296834;35630.28739425249;36133.27733445369;36743.81628091842;36816.07959801026;24931.62602560927;30628;32171.195720107185;32282.35435291234;33281.66718332786;24468.51062978766;24697.382565436008;24698.753012470363;25300;25374.492510150063 10:16:36 INFO - PROCESS | 2313 | |2;jquery.html;336.61650615968364;361.0162307711486;366.6260414377336;370.5386793442165;375.84778164843215;19335.903320483394;19446.222151113958;19768.9011554942;19804.207831686734;19884.900575497137;18119.72820407695;19689.70465443016;20907.581848363025;20910.16359345628;20951.266705665304;5205.531502164814;5400.864978375553;5435;5446.809361672343;5452.182172674091;3984.322665146932;4175.749455032693;5379.838604841861;5617.494425501704;5861.267341582302;5829.038208695561;5835.795747148851;5846.678432686201;5850.151727999459;5851.7074146292725;5688.374278829326;5808.97095514524;6020.2775666919815;6026.03583426654;6026.0659597762415;5717.685527295997;5727.627704199213;5744.22452968848;5747.137929310595;5748.396418376052;13460.596182114552;23946.16188433414;24736.876315618487;24776.3805904852;24976.50046999068;2044.8875311857842;2122.734658167729;2136.8824714640687;2308.8499247549025;2727.0046433051793;10074.99250074994;10854;12519.12366134371;13775.522905267206;13924.37340319688;1670.4320531019512;1754.280744894587;1770.9380171694058;1773.15775006872;1777.5911540345664;100514;103084.96915030829;103800.48099759528;104059.479702601;106292;11097.500612472459;11266.957921361187;11346.432678366049;11350.375729334966;11468.598599048993;13664.795028074586;13762.311884405739;13763.518276860263;13770.449182032808;13779.655508612364;6716.261211266757;8502.234798868132;8506.447080939843;8608.268297194683;8641.222289993932;8564.400491965502;8579;8580.356473264404;8692.565371731389;8701.520741473838;4370.541093185233;4445.177642136216;4459.620932220798;4515.209838278354;4518.661100417482;1715.9142042897806;1804.49474147239;1818.2636032406897;1871.1392759330588;1944.562473443464;929.9442033478012;944.4427787605208;1014.8579198912158;1019.3679918450608;1079.0666073846066;19475.41573752761;20192.798072019094;20370.083346249157;20371.388858334274;20663.380098597067;750.6659536506312;994.4381424495137;1024.0322894864282;1035.8756949165997;1050.968470945873;10717.249792514449;10810.29733067348;10858.13134949218;10862;10862.293950893167;550496;564359.89100272;572215;574992;594220;85038.57480712557;108085;109685.42347984476;111404;115280;923.5520772425368;1030.7680771826278;1031.1647565471992;1033.405791669793;1042.3641578637025;15648.295826688054;17957.551061223574;17978.01120938361;18036.90981545084;18308.633827323112;45873;46252.306215406126;47011.52988470208;48125;49559.75220123876;68725.65637171782;69358;69747.95378069434;69859;71294;7271.127464704058;7720.961395192988;7733.574653394117;7803.531788092732;7874.409419293462;11177.664670059587;12054.578089766816;12066.939665301617;12420.51589682049;12476.18904771187;10469.31949423285;10698.62554810578;10776.892231077589;10788.406637635006;10868.456577171268;10503.212259080752;10563.577456901638;10660.147188224768;10785.676429707122;10848.891511084788;9680.903190968;9720.805583888425;10063.194944404577;10182.79108306959;11096.61161859331;7717.3440257576485;7735.6518956648215;7740.92259077402;7785.532868027936;7914.366850652049;10346.482675866328;10578.523966421375;10840.403777792297;10846.186536009673;10856.945715271373 10:16:36 INFO - PROCESS | 2313 | |3;mootools.html;1459.5767227504025;1479.4673917389741;1632.4204907257922;1891.1017266798272;2054.928077517286;7851.175626559208;8452.8732069019;8631.91368086319;8637.179467950542;8648.65405383784;8265.462744921591;8527.91472085279;8532.23209911108;8533.487990720561;8536.359773017017;2163.7078994335798;2395.425097976482;2449.926502204932;2464.9137280195196;2475.628655701641;2472.8269021168435;2477.2444404456633;2477.838940468873;2478.3556275368355;2481.0323973650293;2424.781769640732;2462.1997850698503;2489.3278814720106;2489.65144879717;2493.650888875559;2441.645961335614;2451.1298489036312;2465.0263146057296;2479.3429741118616;2486.76375744304;2437.768412000875;2482.8510289382516;2485.9186253979396;2488.751124887515;2495.2264797912526;8688.304935605136;8738.563071846445;8748.387612867102;8750;8750.431221970552;5343.438938911398;5503.807366742145;5508.228847961249;5509.972450137764;5523.6685798851795;3526;3622.3479773640734;3694.113412780913;3698.3158115748674;3712.3317802795486;1007.0885848307294;1016.8423894296396;1032.2928793776287;1046.2519298701466;1062.7024433158729;11717;11732.237404568676;11743.295402275891;11745.823812642817;11753.177277590572;4805.783739731721;4862.82980095695;4944.307796908436;4952.653314267966;4962.677425967373;10049.949750251348;10070.295079344522;10073.546690398949;10092.697219083439;10113.19094472455;5482.616216864861;5496.038193316153;5496.532794712414;5501.889962200734;5520.751566179531;4392.604665580049;4561.863144105682;4803.855884323476;4846.61227101831;4927.581155601814;3353.5472711184166;3878.146807702301;3966.1076257841755;3971.5035620547433;4015.437838702584;1318.1432069154935;1320.3794216718127;1321.9933900330436;1328.2362641481186;1332.5535945458187;1346.2461021827808;1373.5604606526015;1376.0986553807072;1397.6925076483158;1400.8949328800381;8123.593820308961;8173.754787356389;8178.672853085929;8185.754427367188;8187.549684767395;500.95992320614266;503.59460634189827;505.9443461219263;508.27570711735626;527.3855957809186;6202.038684003986;6210.037444196157;6258.311585725566;6273.12176295319;6274.309825919146;10299.74250643725;10574.89425105739;10590.947045264878;10699.572017119228;10739.409332486632;10142.391456512632;10441.321314114559;10467.476626168662;10539.789204215873;10554.841677374845;7094.68073936674;8275.00699916026;8305.086440491541;8314.667413303521;8317.043539992977;7718.498297610638;7784.727534536264;7812.609369531614;7823.100343460575;7864.6854125834325;9341.813163736822;9383.859242111237;9409.764755880884;9428.057194280516;9436.811263774824;9490.905090949002;9795.80408391814;9838.655647052605;9906.900930990887;9937.304388692723;6668.533202675766;6890.8621827564175;7107.431405487445;7393.260673932564;7549;6645.169353830771;8143.75568732939;8188.631511582113;8189.877151842847;8204.138565450781;7162.391196748335;7270.9636451817405;7279.8544029120185;7399.630018499161;7440.776776696708;7053.153621565445;7123.715051397886;7205.819854503679;7226.494145409771;7259.745908893164;7519.812004699927;7575.204603516551;7591.962040189764;7595.848083038198;7619.619019049136;6836.692348844214;6940.514164008471;6944.444444444332;6946;6955.339242771928;6879.346462086094;7004.124484439445;7014.228434872262;7029.9648501757165;7074.575525468488 10:16:36 INFO - PROCESS | 2313 | |4;prototype.html;320.9165616939596;327.4139290669701;330.17456359102243;332.96836800503957;337.2210194450817;6376.42612164905;6420.486361091119;6424.646644434554;6481.189851268591;6530.608163510181;5124.666896651715;6349.7142628581705;6373.968130159343;6404.42360187583;6415.1981002374705;4498.122866041123;4596.287575425815;4654.208784506625;4776.116418462579;4784.952150478494;4735.834245801398;4746.76266186691;4748.7863046163;4750.738709370983;4752.263399173116;4693.48371679115;4696.459907110692;4697;4702.153612349775;4704.176769065417;4478.552144785528;4596.264597664358;4687.367205427292;4716.434027916672;4720.787564559603;4040.6363427291685;4045.7572545647354;4057.736247143926;4062.7968601569805;4063.878083657495;6125.601835880653;6135.601185922946;6234.968825155891;6243.56295059346;6245.094461303085;4922;5069.188929771219;5079.542841144278;5311.423959379697;5588.776448942038;5465.398806131322;6827.795166145023;6841.452683785285;6841.828954276133;6852.211995620518;4031.5363733170475;4429.756363400012;4436.400121976427;4556.157110934488;4638.11875743611;7210.927890721078;7244.529105608171;7248.746293879742;7251.70993160273;7263.782086537412;4663.860084197479;4678.157931572282;4684.648651351163;4688.4373875134515;4701.247800351927;4748.4539277982785;4749.910039582573;4753.168195565762;4753.738544380023;4759.143354196209;5562.638428502134;5568.665880047129;5585.888282234414;5588.944110558842;5593.216949627055;5647.745851436695;6666.166729158856;6848.452123830081;6898.379145876896;6901.689423975933;1626.414490783317;1631.9673606527804;1645.2267434305857;1646.102873933709;1650.0347296831487;1006.8791744990501;1046.8482070099792;1074.9247552671238;1078.730317420645;1105.690406686129;6319.652419116901;6419.871602567922;6452;6458.515611329169;6477;7223.2415596361625;7227.5302105364035;7230.493865429475;7240.782776516713;7240.818979525554;5216.452272511332;6384.936150638527;6413.935860641427;6417.518686098561;6428.260750013808;3746.6253374662315;3794.886153415402;3796.0130366105013;3796.069962859062;3798.3732684106812;7148.142222933281;7418.851622967511;7452.621265065872;7454.701811927463;7469.813254668568;7317.1219453664835;7367.557946523226;7378.151512576015;7384.1877393486675;7386.519876208029;6104.725287362079;7420.591867447342;7428.294312040348;7428.517146385468;7433.1823499416105;6130.877382452237;6599.9010014848855;7179.246179151114;7183.281671832775;7187.964060179875;7013.509054366145;7028.875379939185;7039.084918960502;7041.753538626123;7046.859062818818;7364.852702946018;7418.443616728875;7425.294597013275;7429.5542267464125;7442.367398771165;3849.7305188637647;4673.532646735299;4679.064187162649;4683.859484215479;4688.320193571981;5711.514521265739;7120.893186602309;7131.393831524379;7150.6424678764815;7152.356287933902;6668.466522678271;6896.27589103137;6937.895931561132;6938.757143499954;6941.167059952636;6845.349691779273;6891.414229790524;6892.689828957809;6905.033295338757;6938.548994315353;6750.5274630775375;6751.426128779109;6754.966225168842;6761;6770.627615481196;6665.666716664245;6876.312368763083;6882.793516194522;6895.448364130757;6910.067140935909;5464.781408743765;6498.512611554058;6616.4045235929;6633.336666333521;6758.5269031167345 10:16:36 INFO - PROCESS | 2313 | |5;yui.html;651.4918363676331;776.7242628866752;777.090803759602;785.6778720724502;787.267840907956;14904.776428353583;15056.247187640629;15074.547763567083;15086.849131508681;15133.924330378346;12090.818637720418;13149.408276627551;13424.530141445051;13704.588862334122;14473.914456415758;770.2451597434517;776.4332037612546;936.1434287626813;940.2149205413488;942.3215284994793;952.1953948913157;952.2477242978074;954.6229239450413;955.5270141280076;955.8183945050453;1025.0927928783005;1030.3251370352432;1031.0411317474745;1033.8759348878145;1035.4874337203096;804.1315379390273;920.2867777472445;934.7429456899339;987.5309228116658;1022.6369638778239;742.1057625561186;743.4424181863602;744.7616762635959;745.7464462082918;747.671024749114;15096.471623493126;15136;15158.772618410732;15166;15169.24153792306;12518.1863178894;12563.623091307276;12567.497300107985;12588.68528286791;12968.481260749559;9713.757156071155;9912.702618921372;9994.300398972075;10232.232582556338;10833.404162771045;4025.9194816103513;4055.3105971984537;4162.854300099482;4177.352510360899;4189.832406703728;77967;79257.60371198165;80636.79044814332;80813;81053.59473202655;9094.136057074567;9148.496832674135;9192.95403522978;9362.157405833508;9369.578368973413;20988.895055524623;20991.16035358599;21015.474613134487;21017.68473472899;21021.789782101983;7283.781486555412;7342.816429589197;7368;7406.259374062658;7434.1822399536;4055.614716601918;4088.795560221977;4109.732867363612;4125.814338354781;4369.80335884886;3354.2788300515017;3408.880689175867;3411.2324726936736;3414.760966732305;3421.5894092709036;464.7420681521788;626.9435750782452;645.7352485480931;652.2824892618177;669.394198250584;502.32186548159694;532.5499952540098;551.2117671729385;589.0608630334665;591.1428428778289;7656.540607563453;7881.0936742274225;8245;8578.313734901192;8658.87011694825;517.6066189695858;554.1493807006226;618.3476432363809;625.2247213455373;625.7465726380823;3126.8592913318957;3574.6246644102516;3866.2074274773604;3875.5930627284292;4033.757974521538;83471;84674.15325846786;91745.54127229321;91827.54086229527;92413.5379323099;71937.64031179811;71956.64021679858;72483.63758181175;73354;73764;65929.01106483406;66197.33802662008;66556.52937770776;67359.66320168466;68474;7781.455298129076;7783.922160778547;7800.570968596781;7847.450678452682;7948.125706172201;34441.311173776885;44800.75996200112;45715.77142114268;46123;46721.766391167825;62606.68696656488;64659;64907.35092649013;65802;66085.33914660984;9887.060729230712;9931.205503559842;9995.100440960348;10018.39889606626;10351.792964140524;10834.458277085956;10892.836607450736;10970.067544258827;11217.66347009591;11377.772444551229;10428.95710428951;10443;10657.14742820557;10722.51748671296;10723.731906702395;10366.792664146524;10373.014563616445;10479.371237725762;10509.369437833755;10732.73168170802;9942.602295908082;10128.696139115838;10152.289339746147;10418.166546676097;10477.738056548342;8728.415687946639;8935.106489351012;9029.322800789836;9045.954770226106;9172.862407063765;8093.5953202340825;8605.612747426256;8769.912300877164;8852.64589416442;8900.510471923848 10:16:36 INFO - PROCESS | 2313 | __end_tp_report 10:16:36 INFO - PROCESS | 2313 | __start_cc_report 10:16:36 INFO - PROCESS | 2313 | _x_x_mozilla_cycle_collect,2274 10:16:36 INFO - PROCESS | 2313 | __end_cc_report 10:16:36 INFO - PROCESS | 2313 | __startTimestamp1458407796256__endTimestamp 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | ------- Summary: start ------- 10:16:36 INFO - PROCESS | 2313 | Number of tests: 6 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | [#0] dojo.html Cycles:165 Average:5595.80 Median:5800.71 stddev:681.10 (11.7%) stddev-sans-first:654.21 10:16:36 INFO - PROCESS | 2313 | Values: 3089.9 3346.7 3349.2 3389.5 3410.1 5486.7 5496.4 5533.6 5566.4 5588.3 4731.5 5637.0 5651.8 5661.2 5742.3 5051.5 5096.7 5106.2 5116.7 5200.8 4329.6 5191.5 5221.1 5235.0 5246.2 5015.8 5026.5 5084.4 5089.4 5115.6 4257.4 4860.9 5095.8 5150.3 5157.9 4528.4 5042.9 5082.1 5099.1 5148.5 5375.7 5541.7 5551.7 5665.4 5666.7 6125.7 6127.1 6137.6 6146.5 6177.2 6178.7 6197.5 6197.9 6209.3 6223.1 5570.3 5669.3 5699.7 5764.9 5800.7 6205.4 6207.7 6213.1 6219.2 6230.0 5976.3 6026.8 6028.4 6058.4 6077.8 6005.2 6032.7 6139.5 6142.7 6194.7 5894.0 6081.8 6084.4 6111.2 6124.3 5890.9 5894.8 6111.4 6112.7 6126.8 4628.3 4634.8 4640.4 4670.7 4682.9 3809.0 4336.6 4348.1 4358.2 4361.1 5475.7 5501.1 5513.3 5571.1 5604.6 6213.5 6225.2 6244.9 6258.1 6260.1 5374.0 5463.3 5472.4 5568.1 5573.9 5252.8 5265.0 5282.3 5296.2 5296.8 6264.4 6265.0 6265.6 6267.9 6270.2 6058.6 6216.7 6232.3 6237.5 6239.4 6197.5 6246.5 6288.9 6417.0 6443.7 6079.5 6122.5 6123.1 6123.8 6127.2 6016.8 6169.6 6194.7 6204.2 6236.6 5838.1 5862.1 5870.5 5881.6 5903.0 4686.7 5848.2 5849.4 5851.4 5856.5 5744.0 5750.2 5751.6 5757.7 5764.6 4557.6 5583.3 5865.3 5867.8 5963.5 5842.4 5843.8 5850.5 5852.3 5924.7 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | [#1] ext.html Cycles:180 Average:62545.11 Median:38447.50 stddev:129693.93 (337.3%) stddev-sans-first:129974.06 10:16:36 INFO - PROCESS | 2313 | Values: 487.2 579.4 597.6 640.6 644.2 38222.0 38302.8 38341.0 39009.0 39027.8 39767.4 40420.2 40597.6 40613.0 40667.0 9366.0 9606.7 9640.0 9640.8 9647.9 9436.2 9721.9 9728.4 9741.4 9744.7 9679.1 9749.7 9771.7 9772.2 9784.8 9675.0 9762.7 9767.0 9775.9 9796.9 8279.5 9584.0 9702.9 9737.4 9752.7 39300.0 39746.6 39811.6 39827.8 39854.4 1900.7 3198.2 3372.8 3452.9 3503.0 27489.9 28355.6 28830.6 29128.1 29129.6 2749.8 2756.7 2856.0 2877.0 2887.0 355712.0 358368.0 360867.2 360900.0 361836.0 58645.7 59900.1 68400.0 69607.0 69670.3 51136.9 63915.7 64390.9 64488.4 64657.7 16319.2 16435.8 16667.5 16670.0 16672.0 12632.7 12683.3 12684.9 12809.4 12810.9 20855.9 21128.5 21144.6 21158.5 21188.9 6278.5 7894.2 8217.6 8239.4 8308.8 984.0 1016.9 1020.9 1063.2 1115.7 27917.9 27922.2 28088.9 28243.7 28588.7 958.7 1059.3 1094.4 1104.0 1150.2 14463.9 14621.1 14633.6 14699.1 14929.9 614287.0 617167.4 619786.0 620412.0 621663.0 61555.7 61838.7 61883.1 62017.4 62083.0 1271.8 1361.8 1379.2 1487.0 1515.0 26735.7 29170.6 29579.7 29848.4 30438.5 47558.8 56349.4 57263.4 57386.0 57571.7 409391.0 432226.0 454667.0 461893.0 464489.0 36848.9 37387.4 37503.2 37736.4 38554.0 43243.9 44030.8 44097.0 44542.0 45336.3 37255.0 39047.6 39535.2 39955.4 40659.4 35986.3 36043.5 36404.2 36530.8 36792.6 35412.5 35630.3 36133.3 36743.8 36816.1 24931.6 30628.0 32171.2 32282.4 33281.7 24468.5 24697.4 24698.8 25300.0 25374.5 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | [#2] jquery.html Cycles:180 Average:32611.30 Median:20785.48 stddev:94704.39 (455.6%) stddev-sans-first:94939.05 10:16:36 INFO - PROCESS | 2313 | Values: 336.6 361.0 366.6 370.5 375.8 19335.9 19446.2 19768.9 19804.2 19884.9 18119.7 19689.7 20907.6 20910.2 20951.3 5205.5 5400.9 5435.0 5446.8 5452.2 3984.3 4175.7 5379.8 5617.5 5861.3 5829.0 5835.8 5846.7 5850.2 5851.7 5688.4 5809.0 6020.3 6026.0 6026.1 5717.7 5727.6 5744.2 5747.1 5748.4 13460.6 23946.2 24736.9 24776.4 24976.5 2044.9 2122.7 2136.9 2308.8 2727.0 10075.0 10854.0 12519.1 13775.5 13924.4 1670.4 1754.3 1770.9 1773.2 1777.6 100514.0 103085.0 103800.5 104059.5 106292.0 11097.5 11267.0 11346.4 11350.4 11468.6 13664.8 13762.3 13763.5 13770.4 13779.7 6716.3 8502.2 8506.4 8608.3 8641.2 8564.4 8579.0 8580.4 8692.6 8701.5 4370.5 4445.2 4459.6 4515.2 4518.7 1715.9 1804.5 1818.3 1871.1 1944.6 929.9 944.4 1014.9 1019.4 1079.1 19475.4 20192.8 20370.1 20371.4 20663.4 750.7 994.4 1024.0 1035.9 1051.0 10717.2 10810.3 10858.1 10862.0 10862.3 550496.0 564359.9 572215.0 574992.0 594220.0 85038.6 108085.0 109685.4 111404.0 115280.0 923.6 1030.8 1031.2 1033.4 1042.4 15648.3 17957.6 17978.0 18036.9 18308.6 45873.0 46252.3 47011.5 48125.0 49559.8 68725.7 69358.0 69748.0 69859.0 71294.0 7271.1 7721.0 7733.6 7803.5 7874.4 11177.7 12054.6 12066.9 12420.5 12476.2 10469.3 10698.6 10776.9 10788.4 10868.5 10503.2 10563.6 10660.1 10785.7 10848.9 9680.9 9720.8 10063.2 10182.8 11096.6 7717.3 7735.7 7740.9 7785.5 7914.4 10346.5 10578.5 10840.4 10846.2 10856.9 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | [#3] mootools.html Cycles:180 Average:5979.19 Median:5413.03 stddev:3145.36 (58.1%) stddev-sans-first:3135.83 10:16:36 INFO - PROCESS | 2313 | Values: 1459.6 1479.5 1632.4 1891.1 2054.9 7851.2 8452.9 8631.9 8637.2 8648.7 8265.5 8527.9 8532.2 8533.5 8536.4 2163.7 2395.4 2449.9 2464.9 2475.6 2472.8 2477.2 2477.8 2478.4 2481.0 2424.8 2462.2 2489.3 2489.7 2493.7 2441.6 2451.1 2465.0 2479.3 2486.8 2437.8 2482.9 2485.9 2488.8 2495.2 8688.3 8738.6 8748.4 8750.0 8750.4 5343.4 5503.8 5508.2 5510.0 5523.7 3526.0 3622.3 3694.1 3698.3 3712.3 1007.1 1016.8 1032.3 1046.3 1062.7 11717.0 11732.2 11743.3 11745.8 11753.2 4805.8 4862.8 4944.3 4952.7 4962.7 10049.9 10070.3 10073.5 10092.7 10113.2 5482.6 5496.0 5496.5 5501.9 5520.8 4392.6 4561.9 4803.9 4846.6 4927.6 3353.5 3878.1 3966.1 3971.5 4015.4 1318.1 1320.4 1322.0 1328.2 1332.6 1346.2 1373.6 1376.1 1397.7 1400.9 8123.6 8173.8 8178.7 8185.8 8187.5 501.0 503.6 505.9 508.3 527.4 6202.0 6210.0 6258.3 6273.1 6274.3 10299.7 10574.9 10590.9 10699.6 10739.4 10142.4 10441.3 10467.5 10539.8 10554.8 7094.7 8275.0 8305.1 8314.7 8317.0 7718.5 7784.7 7812.6 7823.1 7864.7 9341.8 9383.9 9409.8 9428.1 9436.8 9490.9 9795.8 9838.7 9906.9 9937.3 6668.5 6890.9 7107.4 7393.3 7549.0 6645.2 8143.8 8188.6 8189.9 8204.1 7162.4 7271.0 7279.9 7399.6 7440.8 7053.2 7123.7 7205.8 7226.5 7259.7 7519.8 7575.2 7592.0 7595.8 7619.6 6836.7 6940.5 6944.4 6946.0 6955.3 6879.3 7004.1 7014.2 7030.0 7074.6 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | [#4] prototype.html Cycles:180 Average:5600.58 Median:6375.20 stddev:1779.92 (27.9%) stddev-sans-first:1740.24 10:16:36 INFO - PROCESS | 2313 | Values: 320.9 327.4 330.2 333.0 337.2 6376.4 6420.5 6424.6 6481.2 6530.6 5124.7 6349.7 6374.0 6404.4 6415.2 4498.1 4596.3 4654.2 4776.1 4785.0 4735.8 4746.8 4748.8 4750.7 4752.3 4693.5 4696.5 4697.0 4702.2 4704.2 4478.6 4596.3 4687.4 4716.4 4720.8 4040.6 4045.8 4057.7 4062.8 4063.9 6125.6 6135.6 6235.0 6243.6 6245.1 4922.0 5069.2 5079.5 5311.4 5588.8 5465.4 6827.8 6841.5 6841.8 6852.2 4031.5 4429.8 4436.4 4556.2 4638.1 7210.9 7244.5 7248.7 7251.7 7263.8 4663.9 4678.2 4684.6 4688.4 4701.2 4748.5 4749.9 4753.2 4753.7 4759.1 5562.6 5568.7 5585.9 5588.9 5593.2 5647.7 6666.2 6848.5 6898.4 6901.7 1626.4 1632.0 1645.2 1646.1 1650.0 1006.9 1046.8 1074.9 1078.7 1105.7 6319.7 6419.9 6452.0 6458.5 6477.0 7223.2 7227.5 7230.5 7240.8 7240.8 5216.5 6384.9 6413.9 6417.5 6428.3 3746.6 3794.9 3796.0 3796.1 3798.4 7148.1 7418.9 7452.6 7454.7 7469.8 7317.1 7367.6 7378.2 7384.2 7386.5 6104.7 7420.6 7428.3 7428.5 7433.2 6130.9 6599.9 7179.2 7183.3 7188.0 7013.5 7028.9 7039.1 7041.8 7046.9 7364.9 7418.4 7425.3 7429.6 7442.4 3849.7 4673.5 4679.1 4683.9 4688.3 5711.5 7120.9 7131.4 7150.6 7152.4 6668.5 6896.3 6937.9 6938.8 6941.2 6845.3 6891.4 6892.7 6905.0 6938.5 6750.5 6751.4 6755.0 6761.0 6770.6 6665.7 6876.3 6882.8 6895.4 6910.1 5464.8 6498.5 6616.4 6633.3 6758.5 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - PROCESS | 2313 | [#5] yui.html Cycles:180 Average:17477.32 Median:31616.82 stddev:24542.51 (77.6%) stddev-sans-first:24578.84 10:16:36 INFO - PROCESS | 2313 | Values: 651.5 776.7 777.1 785.7 787.3 14904.8 15056.2 15074.5 15086.8 15133.9 12090.8 13149.4 13424.5 13704.6 14473.9 770.2 776.4 936.1 940.2 942.3 952.2 952.2 954.6 955.5 955.8 1025.1 1030.3 1031.0 1033.9 1035.5 804.1 920.3 934.7 987.5 1022.6 742.1 743.4 744.8 745.7 747.7 15096.5 15136.0 15158.8 15166.0 15169.2 12518.2 12563.6 12567.5 12588.7 12968.5 9713.8 9912.7 9994.3 10232.2 10833.4 4025.9 4055.3 4162.9 4177.4 4189.8 77967.0 79257.6 80636.8 80813.0 81053.6 9094.1 9148.5 9193.0 9362.2 9369.6 20988.9 20991.2 21015.5 21017.7 21021.8 7283.8 7342.8 7368.0 7406.3 7434.2 4055.6 4088.8 4109.7 4125.8 4369.8 3354.3 3408.9 3411.2 3414.8 3421.6 464.7 626.9 645.7 652.3 669.4 502.3 532.5 551.2 589.1 591.1 7656.5 7881.1 8245.0 8578.3 8658.9 517.6 554.1 618.3 625.2 625.7 3126.9 3574.6 3866.2 3875.6 4033.8 83471.0 84674.2 91745.5 91827.5 92413.5 71937.6 71956.6 72483.6 73354.0 73764.0 65929.0 66197.3 66556.5 67359.7 68474.0 7781.5 7783.9 7800.6 7847.5 7948.1 34441.3 44800.8 45715.8 46123.0 46721.8 62606.7 64659.0 64907.4 65802.0 66085.3 9887.1 9931.2 9995.1 10018.4 10351.8 10834.5 10892.8 10970.1 11217.7 11377.8 10429.0 10443.0 10657.1 10722.5 10723.7 10366.8 10373.0 10479.4 10509.4 10732.7 9942.6 10128.7 10152.3 10418.2 10477.7 8728.4 8935.1 9029.3 9046.0 9172.9 8093.6 8605.6 8769.9 8852.6 8900.5 10:16:36 INFO - PROCESS | 2313 | -------- Summary: end -------- 10:16:36 INFO - PROCESS | 2313 | 10:16:36 INFO - TEST-INFO | 2313: exit 0 10:16:36 INFO - TEST-OK | dromaeo_css | took 1115516ms 10:16:36 INFO - TEST-START | kraken 10:16:36 INFO - operating with platform_type : mac_ 10:16:36 INFO - Initialising browser for kraken test... 10:16:36 INFO - TEST-INFO | started process 2316 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp7Z_gL8/profile http://localhost:49630/getInfo.html) 10:16:39 INFO - PROCESS | 2316 | __metrics Screen width/height:1600/1200 10:16:39 INFO - PROCESS | 2316 | colorDepth:24 10:16:39 INFO - PROCESS | 2316 | Browser inner width/height: 1024/689 10:16:39 INFO - PROCESS | 2316 | __metrics 10:16:39 INFO - PROCESS | 2316 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:39 ERROR - PROCESS | 2316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:16:39 INFO - TEST-INFO | 2316: exit 0 10:16:39 INFO - Browser initialized. 10:16:39 INFO - Running cycle 1/1 for kraken test... 10:16:39 INFO - TEST-INFO | started process 2318 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp7Z_gL8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:51 INFO - PROCESS | 2318 | RSS: Main: 246976512 10:16:51 INFO - PROCESS | 2318 | 10:16:54 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:54 INFO - PROCESS | 2318 | RSS: Main: 290627584 10:16:54 INFO - PROCESS | 2318 | 10:16:57 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-dft) 10:16:58 INFO - PROCESS | 2318 | RSS: Main: 302977024 10:16:58 INFO - PROCESS | 2318 | 10:17:01 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-fft) 10:17:02 INFO - PROCESS | 2318 | RSS: Main: 287756288 10:17:02 INFO - PROCESS | 2318 | 10:17:04 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-oscillator) 10:17:04 INFO - PROCESS | 2318 | RSS: Main: 290148352 10:17:04 INFO - PROCESS | 2318 | 10:17:06 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:07 INFO - PROCESS | 2318 | RSS: Main: 289837056 10:17:07 INFO - PROCESS | 2318 | 10:17:10 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:10 INFO - PROCESS | 2318 | RSS: Main: 291364864 10:17:10 INFO - PROCESS | 2318 | 10:17:13 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:14 INFO - PROCESS | 2318 | RSS: Main: 291450880 10:17:14 INFO - PROCESS | 2318 | 10:17:16 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49630/tests/kraken/driver.html?testName=json-parse-financial) 10:17:17 INFO - PROCESS | 2318 | RSS: Main: 290557952 10:17:17 INFO - PROCESS | 2318 | 10:17:19 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:19 INFO - PROCESS | 2318 | RSS: Main: 326799360 10:17:19 INFO - PROCESS | 2318 | 10:17:21 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:22 INFO - PROCESS | 2318 | RSS: Main: 326070272 10:17:22 INFO - PROCESS | 2318 | 10:17:24 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:24 INFO - PROCESS | 2318 | RSS: Main: 333328384 10:17:24 INFO - PROCESS | 2318 | 10:17:27 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:28 INFO - PROCESS | 2318 | RSS: Main: 334348288 10:17:28 INFO - PROCESS | 2318 | 10:17:30 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:31 INFO - PROCESS | 2318 | RSS: Main: 334782464 10:17:31 INFO - PROCESS | 2318 | 10:17:32 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49630/tests/kraken/driver.html?testName=ai-astar) 10:17:33 INFO - PROCESS | 2318 | RSS: Main: 394498048 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | __start_tp_report 10:17:33 INFO - PROCESS | 2318 | _x_x_mozilla_page_load 10:17:33 INFO - PROCESS | 2318 | _x_x_mozilla_page_load_details 10:17:33 INFO - PROCESS | 2318 | |i|pagename|runs| 10:17:33 INFO - PROCESS | 2318 | |0;ai-astar;110;109;107;110;108;110;117;110;107;108 10:17:33 INFO - PROCESS | 2318 | |1;audio-beat-detection;157;127;182;193;114;141;142;125;182;150 10:17:33 INFO - PROCESS | 2318 | |2;audio-dft;185;183;179;188;180;184;183;182;182;181 10:17:33 INFO - PROCESS | 2318 | |3;audio-fft;76;102;118;107;56;55;58;80;74;44 10:17:33 INFO - PROCESS | 2318 | |4;audio-oscillator;95;97;132;78;80;78;121;79;79;122 10:17:33 INFO - PROCESS | 2318 | |5;imaging-gaussian-blur;87;83;86;87;92;83;87;84;86;82 10:17:33 INFO - PROCESS | 2318 | |6;imaging-darkroom;95;91;93;92;93;91;93;93;92;92 10:17:33 INFO - PROCESS | 2318 | |7;imaging-desaturate;86;85;87;85;86;70;133;140;86;86 10:17:33 INFO - PROCESS | 2318 | |8;json-parse-financial;57;56;54;54;56;54;54;63;55;53 10:17:33 INFO - PROCESS | 2318 | |9;json-stringify-tinderbox;65;74;68;74;70;70;70;69;69;70 10:17:33 INFO - PROCESS | 2318 | |10;stanford-crypto-aes;83;83;82;82;82;81;82;83;84;83 10:17:33 INFO - PROCESS | 2318 | |11;stanford-crypto-ccm;122;122;124;124;128;129;126;120;122;124 10:17:33 INFO - PROCESS | 2318 | |12;stanford-crypto-pbkdf2;132;137;138;136;136;127;137;141;137;138 10:17:33 INFO - PROCESS | 2318 | |13;stanford-crypto-sha256-iterative;57;85;95;98;68;68;65;69;67;69 10:17:33 INFO - PROCESS | 2318 | __end_tp_report 10:17:33 INFO - PROCESS | 2318 | __start_cc_report 10:17:33 INFO - PROCESS | 2318 | _x_x_mozilla_cycle_collect,1277 10:17:33 INFO - PROCESS | 2318 | __end_cc_report 10:17:33 INFO - PROCESS | 2318 | __startTimestamp1458407853110__endTimestamp 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | ------- Summary: start ------- 10:17:33 INFO - PROCESS | 2318 | Number of tests: 14 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.88 (2.6%) stddev-sans-first:3.05 10:17:33 INFO - PROCESS | 2318 | Values: 110.0 109.0 107.0 110.0 108.0 110.0 117.0 110.0 107.0 108.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:153.50 stddev:26.92 (17.5%) stddev-sans-first:28.48 10:17:33 INFO - PROCESS | 2318 | Values: 157.0 127.0 182.0 193.0 114.0 141.0 142.0 125.0 182.0 150.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:2.58 (1.4%) stddev-sans-first:2.60 10:17:33 INFO - PROCESS | 2318 | Values: 185.0 183.0 179.0 188.0 180.0 184.0 183.0 182.0 182.0 181.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#3] audio-fft Cycles:10 Average:77.00 Median:57.00 stddev:24.94 (43.8%) stddev-sans-first:26.45 10:17:33 INFO - PROCESS | 2318 | Values: 76.0 102.0 118.0 107.0 56.0 55.0 58.0 80.0 74.0 44.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.00 stddev:21.29 (27.0%) stddev-sans-first:22.58 10:17:33 INFO - PROCESS | 2318 | Values: 95.0 97.0 132.0 78.0 80.0 78.0 121.0 79.0 79.0 122.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:2.91 (3.4%) stddev-sans-first:3.05 10:17:33 INFO - PROCESS | 2318 | Values: 87.0 83.0 86.0 87.0 92.0 83.0 87.0 84.0 86.0 82.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:93.00 stddev:1.18 (1.3%) stddev-sans-first:0.83 10:17:33 INFO - PROCESS | 2318 | Values: 95.0 91.0 93.0 92.0 93.0 91.0 93.0 93.0 92.0 92.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:86.00 stddev:22.80 (26.5%) stddev-sans-first:23.98 10:17:33 INFO - PROCESS | 2318 | Values: 86.0 85.0 87.0 85.0 86.0 70.0 133.0 140.0 86.0 86.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:2.88 (5.2%) stddev-sans-first:3.00 10:17:33 INFO - PROCESS | 2318 | Values: 57.0 56.0 54.0 54.0 56.0 54.0 54.0 63.0 55.0 53.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:2.64 (3.8%) stddev-sans-first:2.13 10:17:33 INFO - PROCESS | 2318 | Values: 65.0 74.0 68.0 74.0 70.0 70.0 70.0 69.0 69.0 70.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 10:17:33 INFO - PROCESS | 2318 | Values: 83.0 83.0 82.0 82.0 82.0 81.0 82.0 83.0 84.0 83.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:2.85 (2.3%) stddev-sans-first:2.92 10:17:33 INFO - PROCESS | 2318 | Values: 122.0 122.0 124.0 124.0 128.0 129.0 126.0 120.0 122.0 124.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:137.00 stddev:3.84 (2.8%) stddev-sans-first:3.81 10:17:33 INFO - PROCESS | 2318 | Values: 132.0 137.0 138.0 136.0 136.0 127.0 137.0 141.0 137.0 138.0 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - PROCESS | 2318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:69.00 stddev:13.66 (19.8%) stddev-sans-first:13.01 10:17:33 INFO - PROCESS | 2318 | Values: 57.0 85.0 95.0 98.0 68.0 68.0 65.0 69.0 67.0 69.0 10:17:33 INFO - PROCESS | 2318 | -------- Summary: end -------- 10:17:33 INFO - PROCESS | 2318 | 10:17:33 INFO - TEST-INFO | 2318: exit 0 10:17:33 INFO - TEST-OK | kraken | took 57045ms 10:17:33 INFO - SUITE-END | took 1172s 10:17:34 INFO - Completed test suite (00:19:32) 10:17:34 INFO - javascript benchmark 10:17:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3089.8918537851173, 3346.682065203805, 3349.2464195556004, 3389.491576263562, 3410.079278594781, 5486.725663716808, 5496.3953965063865, 5533.584981126416, 5566.443355664432, 5588.329400471939, 4731.503192164825, 5637.041702910505, 5651.7739290428435, 5661.179129026289, 5742.253507044089, 5051.469595692454, 5096.719680417585, 5106.183010718286, 5116.744162791864, 5200.843974680765, 4329.631981281595, 5191.5327620514145, 5221.112410890139, 5234.973825130869, 5246.239295302179, 5015.849524514252, 5026.547610715053, 5084.44071152173, 5089.41471730752, 5115.616328775357, 4257.382679511454, 4860.927086093711, 5095.79616815327, 5150.330457040598, 5157.871053223662, 4528.366028755977, 5042.873928151789, 5082.08522465956, 5099.08216521026, 5148.510891465342, 5375.6774593524515, 5541.695206763627, 5551.694656793875, 5665.433456654343, 5666.716664166775, 6125.693715314216, 6127.0561091552745, 6137.570370074097, 6146.508279337687, 6177.196964394645, 6178.7219575119225, 6197.4732147767045, 6197.907031394533, 6209.254889413254, 6223.066540018988, 5570.3315602127595, 5669.348024977139, 5699.74351154199, 5764.913526297109, 5800.7099645018425, 6205.441510264098, 6207.689615519296, 6213.068039793977, 6219.222597175353, 6230.0, 5976.252968378953, 6026.819195424145, 6028.3971602839365, 6058.4244496772735, 6077.817665470043, 6005.219321488178, 6032.698365081728, 6139.4781443577795, 6142.723577439026, 6194.721237544321, 5894.0, 6081.787137450168, 6084.421979911901, 6111.236095488064, 6124.326324104345, 5890.882182356415, 5894.793682221101, 6111.388861113853, 6112.724927378279, 6126.785562505291, 4628.305754136906, 4634.768261586974, 4640.350350950869, 4670.719756814602, 4682.906341873144, 3809.0, 4336.588024137702, 4348.065165989327, 4358.237308471068, 4361.084172323847, 5475.7262136893, 5501.14732216507, 5513.3108361454815, 5571.1086226203615, 5604.635698679573, 6213.471854892385, 6225.221847269091, 6244.875102497925, 6258.123862659231, 6260.060990851409, 5373.973130134403, 5463.31708536433, 5472.370677372073, 5568.136938774496, 5573.916391254134, 5252.816151434681, 5265.0, 5282.339707536558, 5296.205569164579, 5296.788128474895, 6264.436200741955, 6264.968675156595, 6265.592736472115, 6267.9373206267355, 6270.2475702915945, 6058.606190597597, 6216.72024758896, 6232.314445410911, 6237.500999919905, 6239.376062393906, 6197.5351848610635, 6246.500279977682, 6288.937110628835, 6417.03744438338, 6443.710033048618, 6079.513638908788, 6122.510199184144, 6123.14276001369, 6123.8469038272615, 6127.172831667846, 6016.759329626941, 6169.629822210682, 6194.659293738888, 6204.162438070803, 6236.594621349598, 5838.065909454467, 5862.12068189775, 5870.5010074144175, 5881.588288819741, 5903.0, 4686.742229177428, 5848.152017957287, 5849.444302791228, 5851.385604511635, 5856.502197313106, 5744.023516002373, 5750.223719797774, 5751.568632352507, 5757.65454072757, 5764.625299355528, 4557.612602928788, 5583.330000399978, 5865.3254875689845, 5867.794627188028, 5963.493103086113, 5842.38654941242, 5843.795467158629, 5850.502707269759, 5852.297724272944, 5924.703764811656], "unit": "score", "name": "dojo.html", "value": 5551.232436824622}, {"lowerIsBetter": false, "replicates": [487.1936944357088, 579.3511267380532, 597.6384287506062, 640.5740182778453, 644.2011905237506, 38222.0, 38302.80848595757, 38341.0, 39009.024774380654, 39027.804860975724, 39767.40348894769, 40420.19159616806, 40597.59402405975, 40613.0, 40667.0, 9365.969743328245, 9606.711798646016, 9640.0, 9640.80718385632, 9647.903520964806, 9436.197923176538, 9721.854172187388, 9728.367656102366, 9741.366811157288, 9744.658936937209, 9679.128878400943, 9749.707508774713, 9771.706848794547, 9772.218222542215, 9784.804303913954, 9675.032496750338, 9762.707118786448, 9767.023297670246, 9775.902240977606, 9796.90203097967, 8279.461834980768, 9583.952080239624, 9702.854457183148, 9737.367071140354, 9752.658656946973, 39300.017499562455, 39746.60886868975, 39811.60188398108, 39827.8008609958, 39854.402183967264, 1900.7148927660824, 3198.2164369729335, 3372.814495202763, 3452.9482057769155, 3502.964970350289, 27489.90040398382, 28355.574666379813, 28830.567541486893, 29128.126156215134, 29129.56305655417, 2749.793765467598, 2756.6691996960294, 2855.9857200714073, 2876.985615071932, 2886.9895536562244, 355712.0, 358368.0, 360867.19566402264, 360900.0, 361836.0, 58645.70677146587, 59900.10149847756, 68400.0, 69607.0, 69670.30329696638, 51136.886311368566, 63915.680421598525, 64390.91699913006, 64488.355116448234, 64657.67671161614, 16319.184040797913, 16435.753463698053, 16667.49997500077, 16669.99980001204, 16672.0, 12632.747345053047, 12683.302418367079, 12684.936575317064, 12809.423575939105, 12810.935945320214, 20855.8957205213, 21128.471788205417, 21144.577108457746, 21158.47103822386, 21188.894055529625, 6278.497720182466, 7894.21057894206, 8217.630206640715, 8239.382046346547, 8308.750737477885, 983.9901600983899, 1016.9491525423699, 1020.9234307426973, 1063.2344711807486, 1115.7489564847845, 27917.860410697816, 27922.155688622755, 28088.85955570209, 28243.71756282411, 28588.714112859023, 958.7171784323641, 1059.2902755154066, 1094.441834664327, 1103.9834402483968, 1150.1891166727437, 14463.92768036153, 14621.122732636077, 14633.560993170222, 14699.118052916645, 14929.925350373178, 614287.0, 617167.3690999348, 619786.0, 620412.0, 621663.0, 61555.6922215395, 61838.69080654568, 61883.07175392373, 62017.379826202065, 62083.0, 1271.8172099947137, 1361.8297712785902, 1379.165604809096, 1486.9851301487063, 1515.0455213215603, 26735.732642674102, 29170.562441562968, 29579.704202957695, 29848.403031938804, 30438.543421848248, 47558.81102972454, 56349.43650563442, 57263.42736572581, 57386.0, 57571.71214143903, 409391.0, 432226.0, 454667.0, 461893.0, 464489.0, 36848.89453316405, 37387.43918841165, 37503.249935001695, 37736.433953491265, 38554.0, 43243.918902027704, 44030.77984610185, 44097.0, 44542.0, 45336.31995520136, 37255.0, 39047.609523905536, 39535.2092958145, 39955.40066898941, 40659.390109148975, 35986.28027439489, 36043.459348109274, 36404.16565079553, 36530.8173459131, 36792.63207367892, 35412.46881296834, 35630.28739425249, 36133.27733445369, 36743.81628091842, 36816.07959801026, 24931.62602560927, 30628.0, 32171.195720107185, 32282.35435291234, 33281.66718332786, 24468.51062978766, 24697.382565436008, 24698.753012470363, 25300.0, 25374.492510150063], "unit": "score", "name": "ext.html", "value": 19756.10426608312}, {"lowerIsBetter": false, "replicates": [336.61650615968364, 361.0162307711486, 366.6260414377336, 370.5386793442165, 375.84778164843215, 19335.903320483394, 19446.222151113958, 19768.9011554942, 19804.207831686734, 19884.900575497137, 18119.72820407695, 19689.70465443016, 20907.581848363025, 20910.16359345628, 20951.266705665304, 5205.531502164814, 5400.864978375553, 5435.0, 5446.809361672343, 5452.182172674091, 3984.322665146932, 4175.749455032693, 5379.838604841861, 5617.494425501704, 5861.267341582302, 5829.038208695561, 5835.795747148851, 5846.678432686201, 5850.151727999459, 5851.7074146292725, 5688.374278829326, 5808.97095514524, 6020.2775666919815, 6026.03583426654, 6026.0659597762415, 5717.685527295997, 5727.627704199213, 5744.22452968848, 5747.137929310595, 5748.396418376052, 13460.596182114552, 23946.16188433414, 24736.876315618487, 24776.3805904852, 24976.50046999068, 2044.8875311857842, 2122.734658167729, 2136.8824714640687, 2308.8499247549025, 2727.0046433051793, 10074.99250074994, 10854.0, 12519.12366134371, 13775.522905267206, 13924.37340319688, 1670.4320531019512, 1754.280744894587, 1770.9380171694058, 1773.15775006872, 1777.5911540345664, 100514.0, 103084.96915030829, 103800.48099759528, 104059.479702601, 106292.0, 11097.500612472459, 11266.957921361187, 11346.432678366049, 11350.375729334966, 11468.598599048993, 13664.795028074586, 13762.311884405739, 13763.518276860263, 13770.449182032808, 13779.655508612364, 6716.261211266757, 8502.234798868132, 8506.447080939843, 8608.268297194683, 8641.222289993932, 8564.400491965502, 8579.0, 8580.356473264404, 8692.565371731389, 8701.520741473838, 4370.541093185233, 4445.177642136216, 4459.620932220798, 4515.209838278354, 4518.661100417482, 1715.9142042897806, 1804.49474147239, 1818.2636032406897, 1871.1392759330588, 1944.562473443464, 929.9442033478012, 944.4427787605208, 1014.8579198912158, 1019.3679918450608, 1079.0666073846066, 19475.41573752761, 20192.798072019094, 20370.083346249157, 20371.388858334274, 20663.380098597067, 750.6659536506312, 994.4381424495137, 1024.0322894864282, 1035.8756949165997, 1050.968470945873, 10717.249792514449, 10810.29733067348, 10858.13134949218, 10862.0, 10862.293950893167, 550496.0, 564359.89100272, 572215.0, 574992.0, 594220.0, 85038.57480712557, 108085.0, 109685.42347984476, 111404.0, 115280.0, 923.5520772425368, 1030.7680771826278, 1031.1647565471992, 1033.405791669793, 1042.3641578637025, 15648.295826688054, 17957.551061223574, 17978.01120938361, 18036.90981545084, 18308.633827323112, 45873.0, 46252.306215406126, 47011.52988470208, 48125.0, 49559.75220123876, 68725.65637171782, 69358.0, 69747.95378069434, 69859.0, 71294.0, 7271.127464704058, 7720.961395192988, 7733.574653394117, 7803.531788092732, 7874.409419293462, 11177.664670059587, 12054.578089766816, 12066.939665301617, 12420.51589682049, 12476.18904771187, 10469.31949423285, 10698.62554810578, 10776.892231077589, 10788.406637635006, 10868.456577171268, 10503.212259080752, 10563.577456901638, 10660.147188224768, 10785.676429707122, 10848.891511084788, 9680.903190968, 9720.805583888425, 10063.194944404577, 10182.79108306959, 11096.61161859331, 7717.3440257576485, 7735.6518956648215, 7740.92259077402, 7785.532868027936, 7914.366850652049, 10346.482675866328, 10578.523966421375, 10840.403777792297, 10846.186536009673, 10856.945715271373], "unit": "score", "name": "jquery.html", "value": 9213.192112661076}, {"lowerIsBetter": false, "replicates": [1459.5767227504025, 1479.4673917389741, 1632.4204907257922, 1891.1017266798272, 2054.928077517286, 7851.175626559208, 8452.8732069019, 8631.91368086319, 8637.179467950542, 8648.65405383784, 8265.462744921591, 8527.91472085279, 8532.23209911108, 8533.487990720561, 8536.359773017017, 2163.7078994335798, 2395.425097976482, 2449.926502204932, 2464.9137280195196, 2475.628655701641, 2472.8269021168435, 2477.2444404456633, 2477.838940468873, 2478.3556275368355, 2481.0323973650293, 2424.781769640732, 2462.1997850698503, 2489.3278814720106, 2489.65144879717, 2493.650888875559, 2441.645961335614, 2451.1298489036312, 2465.0263146057296, 2479.3429741118616, 2486.76375744304, 2437.768412000875, 2482.8510289382516, 2485.9186253979396, 2488.751124887515, 2495.2264797912526, 8688.304935605136, 8738.563071846445, 8748.387612867102, 8750.0, 8750.431221970552, 5343.438938911398, 5503.807366742145, 5508.228847961249, 5509.972450137764, 5523.6685798851795, 3526.0, 3622.3479773640734, 3694.113412780913, 3698.3158115748674, 3712.3317802795486, 1007.0885848307294, 1016.8423894296396, 1032.2928793776287, 1046.2519298701466, 1062.7024433158729, 11717.0, 11732.237404568676, 11743.295402275891, 11745.823812642817, 11753.177277590572, 4805.783739731721, 4862.82980095695, 4944.307796908436, 4952.653314267966, 4962.677425967373, 10049.949750251348, 10070.295079344522, 10073.546690398949, 10092.697219083439, 10113.19094472455, 5482.616216864861, 5496.038193316153, 5496.532794712414, 5501.889962200734, 5520.751566179531, 4392.604665580049, 4561.863144105682, 4803.855884323476, 4846.61227101831, 4927.581155601814, 3353.5472711184166, 3878.146807702301, 3966.1076257841755, 3971.5035620547433, 4015.437838702584, 1318.1432069154935, 1320.3794216718127, 1321.9933900330436, 1328.2362641481186, 1332.5535945458187, 1346.2461021827808, 1373.5604606526015, 1376.0986553807072, 1397.6925076483158, 1400.8949328800381, 8123.593820308961, 8173.754787356389, 8178.672853085929, 8185.754427367188, 8187.549684767395, 500.95992320614266, 503.59460634189827, 505.9443461219263, 508.27570711735626, 527.3855957809186, 6202.038684003986, 6210.037444196157, 6258.311585725566, 6273.12176295319, 6274.309825919146, 10299.74250643725, 10574.89425105739, 10590.947045264878, 10699.572017119228, 10739.409332486632, 10142.391456512632, 10441.321314114559, 10467.476626168662, 10539.789204215873, 10554.841677374845, 7094.68073936674, 8275.00699916026, 8305.086440491541, 8314.667413303521, 8317.043539992977, 7718.498297610638, 7784.727534536264, 7812.609369531614, 7823.100343460575, 7864.6854125834325, 9341.813163736822, 9383.859242111237, 9409.764755880884, 9428.057194280516, 9436.811263774824, 9490.905090949002, 9795.80408391814, 9838.655647052605, 9906.900930990887, 9937.304388692723, 6668.533202675766, 6890.8621827564175, 7107.431405487445, 7393.260673932564, 7549.0, 6645.169353830771, 8143.75568732939, 8188.631511582113, 8189.877151842847, 8204.138565450781, 7162.391196748335, 7270.9636451817405, 7279.8544029120185, 7399.630018499161, 7440.776776696708, 7053.153621565445, 7123.715051397886, 7205.819854503679, 7226.494145409771, 7259.745908893164, 7519.812004699927, 7575.204603516551, 7591.962040189764, 7595.848083038198, 7619.619019049136, 6836.692348844214, 6940.514164008471, 6944.444444444332, 6946.0, 6955.339242771928, 6879.346462086094, 7004.124484439445, 7014.228434872262, 7029.9648501757165, 7074.575525468488], "unit": "score", "name": "mootools.html", "value": 4814.3467829021}, {"lowerIsBetter": false, "replicates": [320.9165616939596, 327.4139290669701, 330.17456359102243, 332.96836800503957, 337.2210194450817, 6376.42612164905, 6420.486361091119, 6424.646644434554, 6481.189851268591, 6530.608163510181, 5124.666896651715, 6349.7142628581705, 6373.968130159343, 6404.42360187583, 6415.1981002374705, 4498.122866041123, 4596.287575425815, 4654.208784506625, 4776.116418462579, 4784.952150478494, 4735.834245801398, 4746.76266186691, 4748.7863046163, 4750.738709370983, 4752.263399173116, 4693.48371679115, 4696.459907110692, 4697.0, 4702.153612349775, 4704.176769065417, 4478.552144785528, 4596.264597664358, 4687.367205427292, 4716.434027916672, 4720.787564559603, 4040.6363427291685, 4045.7572545647354, 4057.736247143926, 4062.7968601569805, 4063.878083657495, 6125.601835880653, 6135.601185922946, 6234.968825155891, 6243.56295059346, 6245.094461303085, 4922.0, 5069.188929771219, 5079.542841144278, 5311.423959379697, 5588.776448942038, 5465.398806131322, 6827.795166145023, 6841.452683785285, 6841.828954276133, 6852.211995620518, 4031.5363733170475, 4429.756363400012, 4436.400121976427, 4556.157110934488, 4638.11875743611, 7210.927890721078, 7244.529105608171, 7248.746293879742, 7251.70993160273, 7263.782086537412, 4663.860084197479, 4678.157931572282, 4684.648651351163, 4688.4373875134515, 4701.247800351927, 4748.4539277982785, 4749.910039582573, 4753.168195565762, 4753.738544380023, 4759.143354196209, 5562.638428502134, 5568.665880047129, 5585.888282234414, 5588.944110558842, 5593.216949627055, 5647.745851436695, 6666.166729158856, 6848.452123830081, 6898.379145876896, 6901.689423975933, 1626.414490783317, 1631.9673606527804, 1645.2267434305857, 1646.102873933709, 1650.0347296831487, 1006.8791744990501, 1046.8482070099792, 1074.9247552671238, 1078.730317420645, 1105.690406686129, 6319.652419116901, 6419.871602567922, 6452.0, 6458.515611329169, 6477.0, 7223.2415596361625, 7227.5302105364035, 7230.493865429475, 7240.782776516713, 7240.818979525554, 5216.452272511332, 6384.936150638527, 6413.935860641427, 6417.518686098561, 6428.260750013808, 3746.6253374662315, 3794.886153415402, 3796.0130366105013, 3796.069962859062, 3798.3732684106812, 7148.142222933281, 7418.851622967511, 7452.621265065872, 7454.701811927463, 7469.813254668568, 7317.1219453664835, 7367.557946523226, 7378.151512576015, 7384.1877393486675, 7386.519876208029, 6104.725287362079, 7420.591867447342, 7428.294312040348, 7428.517146385468, 7433.1823499416105, 6130.877382452237, 6599.9010014848855, 7179.246179151114, 7183.281671832775, 7187.964060179875, 7013.509054366145, 7028.875379939185, 7039.084918960502, 7041.753538626123, 7046.859062818818, 7364.852702946018, 7418.443616728875, 7425.294597013275, 7429.5542267464125, 7442.367398771165, 3849.7305188637647, 4673.532646735299, 4679.064187162649, 4683.859484215479, 4688.320193571981, 5711.514521265739, 7120.893186602309, 7131.393831524379, 7150.6424678764815, 7152.356287933902, 6668.466522678271, 6896.27589103137, 6937.895931561132, 6938.757143499954, 6941.167059952636, 6845.349691779273, 6891.414229790524, 6892.689828957809, 6905.033295338757, 6938.548994315353, 6750.5274630775375, 6751.426128779109, 6754.966225168842, 6761.0, 6770.627615481196, 6665.666716664245, 6876.312368763083, 6882.793516194522, 6895.448364130757, 6910.067140935909, 5464.781408743765, 6498.512611554058, 6616.4045235929, 6633.336666333521, 6758.5269031167345], "unit": "score", "name": "prototype.html", "value": 5015.16514308982}, {"lowerIsBetter": false, "replicates": [651.4918363676331, 776.7242628866752, 777.090803759602, 785.6778720724502, 787.267840907956, 14904.776428353583, 15056.247187640629, 15074.547763567083, 15086.849131508681, 15133.924330378346, 12090.818637720418, 13149.408276627551, 13424.530141445051, 13704.588862334122, 14473.914456415758, 770.2451597434517, 776.4332037612546, 936.1434287626813, 940.2149205413488, 942.3215284994793, 952.1953948913157, 952.2477242978074, 954.6229239450413, 955.5270141280076, 955.8183945050453, 1025.0927928783005, 1030.3251370352432, 1031.0411317474745, 1033.8759348878145, 1035.4874337203096, 804.1315379390273, 920.2867777472445, 934.7429456899339, 987.5309228116658, 1022.6369638778239, 742.1057625561186, 743.4424181863602, 744.7616762635959, 745.7464462082918, 747.671024749114, 15096.471623493126, 15136.0, 15158.772618410732, 15166.0, 15169.24153792306, 12518.1863178894, 12563.623091307276, 12567.497300107985, 12588.68528286791, 12968.481260749559, 9713.757156071155, 9912.702618921372, 9994.300398972075, 10232.232582556338, 10833.404162771045, 4025.9194816103513, 4055.3105971984537, 4162.854300099482, 4177.352510360899, 4189.832406703728, 77967.0, 79257.60371198165, 80636.79044814332, 80813.0, 81053.59473202655, 9094.136057074567, 9148.496832674135, 9192.95403522978, 9362.157405833508, 9369.578368973413, 20988.895055524623, 20991.16035358599, 21015.474613134487, 21017.68473472899, 21021.789782101983, 7283.781486555412, 7342.816429589197, 7368.0, 7406.259374062658, 7434.1822399536, 4055.614716601918, 4088.795560221977, 4109.732867363612, 4125.814338354781, 4369.80335884886, 3354.2788300515017, 3408.880689175867, 3411.2324726936736, 3414.760966732305, 3421.5894092709036, 464.7420681521788, 626.9435750782452, 645.7352485480931, 652.2824892618177, 669.394198250584, 502.32186548159694, 532.5499952540098, 551.2117671729385, 589.0608630334665, 591.1428428778289, 7656.540607563453, 7881.0936742274225, 8245.0, 8578.313734901192, 8658.87011694825, 517.6066189695858, 554.1493807006226, 618.3476432363809, 625.2247213455373, 625.7465726380823, 3126.8592913318957, 3574.6246644102516, 3866.2074274773604, 3875.5930627284292, 4033.757974521538, 83471.0, 84674.15325846786, 91745.54127229321, 91827.54086229527, 92413.5379323099, 71937.64031179811, 71956.64021679858, 72483.63758181175, 73354.0, 73764.0, 65929.01106483406, 66197.33802662008, 66556.52937770776, 67359.66320168466, 68474.0, 7781.455298129076, 7783.922160778547, 7800.570968596781, 7847.450678452682, 7948.125706172201, 34441.311173776885, 44800.75996200112, 45715.77142114268, 46123.0, 46721.766391167825, 62606.68696656488, 64659.0, 64907.35092649013, 65802.0, 66085.33914660984, 9887.060729230712, 9931.205503559842, 9995.100440960348, 10018.39889606626, 10351.792964140524, 10834.458277085956, 10892.836607450736, 10970.067544258827, 11217.66347009591, 11377.772444551229, 10428.95710428951, 10443.0, 10657.14742820557, 10722.51748671296, 10723.731906702395, 10366.792664146524, 10373.014563616445, 10479.371237725762, 10509.369437833755, 10732.73168170802, 9942.602295908082, 10128.696139115838, 10152.289339746147, 10418.166546676097, 10477.738056548342, 8728.415687946639, 8935.106489351012, 9029.322800789836, 9045.954770226106, 9172.862407063765, 8093.5953202340825, 8605.612747426256, 8769.912300877164, 8852.64589416442, 8900.510471923848], "unit": "score", "name": "yui.html", "value": 6737.096218483916}], "name": "dromaeo_css", "value": 7401.256547436415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 107.0, 110.0, 108.0, 110.0, 117.0, 110.0, 107.0, 108.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 182.0, 193.0, 114.0, 141.0, 142.0, 125.0, 182.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 179.0, 188.0, 180.0, 184.0, 183.0, 182.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [76.0, 102.0, 118.0, 107.0, 56.0, 55.0, 58.0, 80.0, 74.0, 44.0], "unit": "score", "name": "audio-fft", "value": 77.0}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 132.0, 78.0, 80.0, 78.0, 121.0, 79.0, 79.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 86.0, 87.0, 92.0, 83.0, 87.0, 84.0, 86.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [95.0, 91.0, 93.0, 92.0, 93.0, 91.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 85.0, 86.0, 70.0, 133.0, 140.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 94.4}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 54.0, 54.0, 56.0, 54.0, 54.0, 63.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 74.0, 68.0, 74.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 82.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 124.0, 124.0, 128.0, 129.0, 126.0, 120.0, 122.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [132.0, 137.0, 138.0, 136.0, 136.0, 127.0, 137.0, 141.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [57.0, 85.0, 95.0, 98.0, 68.0, 68.0, 65.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.1}], "name": "kraken", "value": 1431.3999999999999}]} 10:17:34 INFO - Return code: 0 10:17:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:17:34 ERROR - # TBPL SUCCESS # 10:17:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:34 INFO - 2016-03-19 10:17:34.403 screenresolution[2322:17013] starting screenresolution argv=screenresolution get 10:17:34 INFO - 2016-03-19 10:17:34.405 screenresolution[2322:17013] Display 0: 1600x1200x32@60 10:17:34 INFO - 2016-03-19 10:17:34.411 screenresolution[2323:17016] starting screenresolution argv=screenresolution list 10:17:34 INFO - Available Modes on Display 0 10:17:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:34 INFO - Intel Iris: 10:17:34 INFO - Chipset Model: Intel Iris 10:17:34 INFO - Type: GPU 10:17:34 INFO - Bus: Built-In 10:17:34 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:34 INFO - Vendor: Intel (0x8086) 10:17:34 INFO - Device ID: 0x0a2e 10:17:34 INFO - Revision ID: 0x0009 10:17:34 INFO - Displays: 10:17:34 INFO - Display: 10:17:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:34 INFO - Display Serial Number: 1600x1200 60 10:17:34 INFO - Main Display: Yes 10:17:34 INFO - Mirror: Off 10:17:34 INFO - Online: Yes 10:17:34 INFO - Rotation: Supported 10:17:34 INFO - Return code: 0 10:17:34 INFO - Running post-action listener: _resource_record_post_action 10:17:34 INFO - Running post-run listener: _resource_record_post_run 10:17:35 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 192512; Write bytes: 703191552; Read time: 4; Write time: 1918 10:17:35 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399784448; Write bytes: 395308544; Read time: 30834; Write time: 807 10:17:35 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 192512; Write bytes: 296905728; Read time: 4; Write time: 1080 10:17:35 INFO - Running post-run listener: _upload_blobber_files 10:17:35 INFO - Blob upload gear active. 10:17:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:35 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 10:17:35 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'] 10:17:35 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 10:17:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:36 INFO - (blobuploader) - INFO - Done attempting. 10:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:17:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:38 INFO - (blobuploader) - INFO - Done attempting. 10:17:38 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:38 INFO - Return code: 0 10:17:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0007ca077ec799dd68bdc415fe322f19c542526b65aba8d5affe811a6709695d758d49d3414c0c043392dd3368e7087f726a7c3021aa491b6e87f5ce7af7df19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9d0b7bc0c56fe25bd92162c931ac0900b746907b934f09a2429a45df3cbdcf797165e584d2f0c99b2aa2a18cf9db305571640845529d7529e215395b17b1a2"} 10:17:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:38 INFO - Contents: 10:17:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0007ca077ec799dd68bdc415fe322f19c542526b65aba8d5affe811a6709695d758d49d3414c0c043392dd3368e7087f726a7c3021aa491b6e87f5ce7af7df19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9d0b7bc0c56fe25bd92162c931ac0900b746907b934f09a2429a45df3cbdcf797165e584d2f0c99b2aa2a18cf9db305571640845529d7529e215395b17b1a2"} 10:17:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:38 INFO - Copying logs to upload dir... 10:17:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.657176 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-03-19 10:17:38.170820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 10:17:38.174214) ========= 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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/0007ca077ec799dd68bdc415fe322f19c542526b65aba8d5affe811a6709695d758d49d3414c0c043392dd3368e7087f726a7c3021aa491b6e87f5ce7af7df19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9d0b7bc0c56fe25bd92162c931ac0900b746907b934f09a2429a45df3cbdcf797165e584d2f0c99b2aa2a18cf9db305571640845529d7529e215395b17b1a2"} build_url:https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/apgBUeN5RsGLUTXNIH9Ytw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0007ca077ec799dd68bdc415fe322f19c542526b65aba8d5affe811a6709695d758d49d3414c0c043392dd3368e7087f726a7c3021aa491b6e87f5ce7af7df19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9d0b7bc0c56fe25bd92162c931ac0900b746907b934f09a2429a45df3cbdcf797165e584d2f0c99b2aa2a18cf9db305571640845529d7529e215395b17b1a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 10:17:38.207428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 10:17:38.207724) ========= 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.utxwxP4P6q/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.R4NnyHRc1v/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005353 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 10:17:38.256383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 10:17:38.256659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 10:17:38.257005) ========= ========= Total master_lag: 0.26 =========