builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0054 starttime: 1456251634.94 results: success (0) buildid: 20160223030304 builduid: d32a9238d9644683b7ce63ab094970b9 revision: 789a12291942763bc1e3a89f97e0b82dc1c9d00b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.940194) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.943540) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.943876) ========= 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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005141 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.966900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.967227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.983898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:34.984250) ========= 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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005318 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:35.032608) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:35.032922) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:35.033296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:20:35.033567) ========= 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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-02-23 10:20:35-- 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% 154M=0s 2016-02-23 10:20:35 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.677372 ========= master_lag: 0.65 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:20:36.357633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:36.357968) ========= 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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.019320 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:36.393491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:36.393842) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --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 789a12291942763bc1e3a89f97e0b82dc1c9d00b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-02-23 10:20:36,475 truncating revision to first 12 chars 2016-02-23 10:20:36,475 Setting DEBUG logging. 2016-02-23 10:20:36,475 attempt 1/10 2016-02-23 10:20:36,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/789a12291942?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 10:20:37,089 unpacking tar archive at: mozilla-central-789a12291942/testing/mozharness/ program finished with exit code 0 elapsedTime=0.872025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:37.282271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:37.282610) ========= echo 789a12291942763bc1e3a89f97e0b82dc1c9d00b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'789a12291942763bc1e3a89f97e0b82dc1c9d00b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 789a12291942763bc1e3a89f97e0b82dc1c9d00b program finished with exit code 0 elapsedTime=0.005500 script_repo_revision: '789a12291942763bc1e3a89f97e0b82dc1c9d00b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:37.331545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:37.331851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:20:37.351643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-23 10:20:37.352043) ========= /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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:20:37 INFO - MultiFileLogger online at 20160223 10:20:37 in /builds/slave/test 10:20:37 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 10:20:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:37 INFO - {'append_to_log': False, 10:20:37 INFO - 'base_work_dir': '/builds/slave/test', 10:20:37 INFO - 'blob_upload_branch': 'Firefox', 10:20:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:37 INFO - 'branch': 'Firefox', 10:20:37 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:37 INFO - 'config_files': ('talos/mac_config.py',), 10:20:37 INFO - 'default_actions': ('clobber', 10:20:37 INFO - 'read-buildbot-config', 10:20:37 INFO - 'download-and-extract', 10:20:37 INFO - 'populate-webroot', 10:20:37 INFO - 'create-virtualenv', 10:20:37 INFO - 'install', 10:20:37 INFO - 'run-tests'), 10:20:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:37 INFO - 'download_minidump_stackwalk': True, 10:20:37 INFO - 'download_symbols': 'ondemand', 10:20:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:37 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:37 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:37 INFO - 'installer_path': 'installer.exe', 10:20:37 INFO - 'log_level': 'info', 10:20:37 INFO - 'log_name': 'talos', 10:20:37 INFO - 'log_to_console': True, 10:20:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:20:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:20:37 INFO - 'opt_config_files': (), 10:20:37 INFO - 'pip_index': False, 10:20:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:20:37 INFO - 'cmd': ('bash', 10:20:37 INFO - '-c', 10:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:20:37 INFO - 'enabled': True, 10:20:37 INFO - 'halt_on_failure': False, 10:20:37 INFO - 'name': 'check_screen_resolution'},), 10:20:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:20:37 INFO - 'cmd': ('bash', 10:20:37 INFO - '-c', 10:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:20:37 INFO - 'enabled': True, 10:20:37 INFO - 'halt_on_failure': False, 10:20:37 INFO - 'name': 'check_screen_resolution'},), 10:20:37 INFO - 'run_cmd_checks_enabled': True, 10:20:37 INFO - 'sps_profile': False, 10:20:37 INFO - 'sps_profile_interval': 0, 10:20:37 INFO - 'suite': 'dromaeojs', 10:20:37 INFO - 'system_bits': '32', 10:20:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:37 INFO - 'title': 't-yosemite-r7-0054', 10:20:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:37 INFO - 'use_talos_json': True, 10:20:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:37 INFO - 'work_dir': 'build'} 10:20:37 INFO - ##### 10:20:37 INFO - ##### Running clobber step. 10:20:37 INFO - ##### 10:20:37 INFO - Running pre-action listener: _resource_record_pre_action 10:20:37 INFO - Running main action method: clobber 10:20:37 INFO - rmtree: /builds/slave/test/build 10:20:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:39 INFO - Running post-action listener: _resource_record_post_action 10:20:39 INFO - ##### 10:20:39 INFO - ##### Running read-buildbot-config step. 10:20:39 INFO - ##### 10:20:39 INFO - Running pre-action listener: _resource_record_pre_action 10:20:39 INFO - Running main action method: read_buildbot_config 10:20:39 INFO - Using buildbot properties: 10:20:39 INFO - { 10:20:39 INFO - "project": "", 10:20:39 INFO - "product": "firefox", 10:20:39 INFO - "script_repo_revision": "production", 10:20:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:20:39 INFO - "repository": "", 10:20:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:20:39 INFO - "buildid": "20160223030304", 10:20:39 INFO - "stage_platform": "macosx64", 10:20:39 INFO - "basedir": "/builds/slave/test", 10:20:39 INFO - "nightly_build": "True", 10:20:39 INFO - "buildnumber": 152, 10:20:39 INFO - "slavename": "t-yosemite-r7-0054", 10:20:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:20:39 INFO - "platform": "yosemite_r7", 10:20:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:20:39 INFO - "branch": "mozilla-central", 10:20:39 INFO - "repo_path": "mozilla-central", 10:20:39 INFO - "revision": "789a12291942763bc1e3a89f97e0b82dc1c9d00b", 10:20:39 INFO - "pgo_build": "False", 10:20:39 INFO - "builduid": "d32a9238d9644683b7ce63ab094970b9", 10:20:39 INFO - "slavebuilddir": "test" 10:20:39 INFO - } 10:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:20:39 INFO - Running post-action listener: _resource_record_post_action 10:20:39 INFO - ##### 10:20:39 INFO - ##### Running download-and-extract step. 10:20:39 INFO - ##### 10:20:39 INFO - Running pre-action listener: _resource_record_pre_action 10:20:39 INFO - Running main action method: download_and_extract 10:20:39 INFO - mkdir: /builds/slave/test/build/tests 10:20:39 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')]} 10:20:39 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json 10:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json 10:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:20:40 INFO - Downloaded 1277 bytes. 10:20:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:20:40 INFO - Using the following test package requirements: 10:20:40 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:20:40 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:20:40 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:20:40 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'jsshell-mac.zip'], 10:20:40 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:20:40 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:20:40 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:20:40 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:20:40 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:20:40 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:20:40 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:20:40 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:20:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:20:40 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')]} 10:20:40 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:20:41 INFO - Downloaded 17825545 bytes. 10:20:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:20:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:20:44 INFO - Return code: 0 10:20:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:20: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')]} 10:20:44 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:20:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:20:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:20:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:20:45 INFO - Downloaded 17825545 bytes. 10:20:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:20:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:20:48 INFO - Return code: 0 10:20:48 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')]} 10:20:48 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:20:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:20:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:20:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:20:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:20:49 INFO - Downloaded 10707015 bytes. 10:20:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:20:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:20:50 INFO - Return code: 0 10:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:50 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:20:54 INFO - Downloaded 111375537 bytes. 10:20:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:20:54 INFO - mkdir: /builds/slave/test/properties 10:20:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:20:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:20:54 INFO - Contents: 10:20:54 INFO - build_url:https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:20:55 INFO - Running post-action listener: _resource_record_post_action 10:20:55 INFO - Running post-action listener: set_extra_try_arguments 10:20:55 INFO - ##### 10:20:55 INFO - ##### Running populate-webroot step. 10:20:55 INFO - ##### 10:20:55 INFO - Running pre-action listener: _resource_record_pre_action 10:20:55 INFO - Running main action method: populate_webroot 10:20:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:20:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:20:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:20:55 INFO - '--tppagecycles', 10:20:55 INFO - '7'], 10:20:55 INFO - 'tests': ['tsvgm']}}, 10:20:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:20:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:20:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:20:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:20:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'tests': ['damp', 'tps']}, 10:20:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['damp', 'tps']}, 10:20:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:20:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:20:55 INFO - 'other': {'tests': ['a11yr', 10:20:55 INFO - 'ts_paint', 10:20:55 INFO - 'tpaint', 10:20:55 INFO - 'sessionrestore', 10:20:55 INFO - 'sessionrestore_no_auto_restore']}, 10:20:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['a11yr', 10:20:55 INFO - 'ts_paint', 10:20:55 INFO - 'tpaint', 10:20:55 INFO - 'sessionrestore', 10:20:55 INFO - 'sessionrestore_no_auto_restore']}, 10:20:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['a11yr', 10:20:55 INFO - 'ts_paint', 10:20:55 INFO - 'tpaint', 10:20:55 INFO - 'sessionrestore', 10:20:55 INFO - 'sessionrestore_no_auto_restore']}, 10:20:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['a11yr', 10:20:55 INFO - 'ts_paint', 10:20:55 INFO - 'tpaint', 10:20:55 INFO - 'sessionrestore', 10:20:55 INFO - 'sessionrestore_no_auto_restore']}, 10:20:55 INFO - 'other_l64': {'tests': ['a11yr', 10:20:55 INFO - 'ts_paint', 10:20:55 INFO - 'tpaint', 10:20:55 INFO - 'sessionrestore', 10:20:55 INFO - 'sessionrestore_no_auto_restore']}, 10:20:55 INFO - 'other_nol64': {'tests': ['a11yr', 10:20:55 INFO - 'ts_paint', 10:20:55 INFO - 'tpaint', 10:20:55 INFO - 'sessionrestore', 10:20:55 INFO - 'sessionrestore_no_auto_restore']}, 10:20:55 INFO - 'svgr': {'tests': ['tsvgx', 10:20:55 INFO - 'tsvgr_opacity', 10:20:55 INFO - 'tart', 10:20:55 INFO - 'tscrollx', 10:20:55 INFO - 'cart']}, 10:20:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['tsvgx', 10:20:55 INFO - 'tsvgr_opacity', 10:20:55 INFO - 'tart', 10:20:55 INFO - 'tscrollx', 10:20:55 INFO - 'cart']}, 10:20:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'tests': ['tp5o']}, 10:20:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'talos_options': ['--e10s'], 10:20:55 INFO - 'tests': ['tp5o']}, 10:20:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'talos_options': ['--xperf_path', 10:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:55 INFO - 'tests': ['tp5n']}, 10:20:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:55 INFO - 'talos_options': ['--e10s', 10:20:55 INFO - '--xperf_path', 10:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:55 INFO - 'tests': ['tp5n']}}, 10:20:55 INFO - 'talos.zip': {'path': '', 10:20:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:20:55 INFO - Running post-action listener: _resource_record_post_action 10:20:55 INFO - ##### 10:20:55 INFO - ##### Running create-virtualenv step. 10:20:55 INFO - ##### 10:20:55 INFO - Running pre-action listener: _resource_record_pre_action 10:20:55 INFO - Running main action method: create_virtualenv 10:20:55 INFO - Creating virtualenv /builds/slave/test/build/venv 10:20:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:20:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:20:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:20:55 INFO - Using real prefix '/tools/python27' 10:20:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:20:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:20:59 INFO - Installing pip.................done. 10:20:59 INFO - Return code: 0 10:20:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:20:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:20:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:59 INFO - 'HOME': '/Users/cltbld', 10:20:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:59 INFO - 'LOGNAME': 'cltbld', 10:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:59 INFO - 'MOZ_NO_REMOTE': '1', 10:20:59 INFO - 'NO_EM_RESTART': '1', 10:20:59 INFO - 'PAGER': '/bin/cat', 10:20:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:59 INFO - 'PWD': '/builds/slave/test', 10:20:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:59 INFO - 'SHELL': '/bin/bash', 10:20:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:20:59 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:20:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:59 INFO - 'USER': 'cltbld', 10:20:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:59 INFO - 'XPC_FLAGS': '0x0', 10:20:59 INFO - 'XPC_SERVICE_NAME': '0', 10:20:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:20:59 INFO - Cleaning up... 10:20:59 INFO - Return code: 0 10:20:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:20:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:20:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:59 INFO - 'HOME': '/Users/cltbld', 10:20:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:59 INFO - 'LOGNAME': 'cltbld', 10:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:59 INFO - 'MOZ_NO_REMOTE': '1', 10:20:59 INFO - 'NO_EM_RESTART': '1', 10:20:59 INFO - 'PAGER': '/bin/cat', 10:20:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:59 INFO - 'PWD': '/builds/slave/test', 10:20:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:59 INFO - 'SHELL': '/bin/bash', 10:20:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:20:59 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:20:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:59 INFO - 'USER': 'cltbld', 10:20:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:59 INFO - 'XPC_FLAGS': '0x0', 10:20:59 INFO - 'XPC_SERVICE_NAME': '0', 10:20:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:59 INFO - Downloading/unpacking psutil>=0.7.1 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:02 INFO - Installing collected packages: psutil 10:21:02 INFO - Running setup.py install for psutil 10:21:02 INFO - building 'psutil._psutil_osx' extension 10:21:02 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 10:21:02 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 10:21:02 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 10:21:03 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 10:21:03 INFO - building 'psutil._psutil_posix' extension 10:21:03 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 10:21:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:21:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:21:03 INFO - ^ 10:21:03 INFO - 1 warning generated. 10:21:03 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 10:21:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:03 INFO - Successfully installed psutil 10:21:03 INFO - Cleaning up... 10:21:03 INFO - Return code: 0 10:21:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:03 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:03 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 10:21:03 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 10:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:03 INFO - 'HOME': '/Users/cltbld', 10:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:03 INFO - 'LOGNAME': 'cltbld', 10:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:03 INFO - 'MOZ_NO_REMOTE': '1', 10:21:03 INFO - 'NO_EM_RESTART': '1', 10:21:03 INFO - 'PAGER': '/bin/cat', 10:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:03 INFO - 'PWD': '/builds/slave/test', 10:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:03 INFO - 'SHELL': '/bin/bash', 10:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:03 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:03 INFO - 'USER': 'cltbld', 10:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:03 INFO - 'XPC_FLAGS': '0x0', 10:21:03 INFO - 'XPC_SERVICE_NAME': '0', 10:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 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 10:21:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:21:06 INFO - Installing collected packages: mozsystemmonitor 10:21:06 INFO - Running setup.py install for mozsystemmonitor 10:21:06 INFO - Successfully installed mozsystemmonitor 10:21:06 INFO - Cleaning up... 10:21:06 INFO - Return code: 0 10:21:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:21:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:06 INFO - 'HOME': '/Users/cltbld', 10:21:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:06 INFO - 'LOGNAME': 'cltbld', 10:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:06 INFO - 'MOZ_NO_REMOTE': '1', 10:21:06 INFO - 'NO_EM_RESTART': '1', 10:21:06 INFO - 'PAGER': '/bin/cat', 10:21:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:06 INFO - 'PWD': '/builds/slave/test', 10:21:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:06 INFO - 'SHELL': '/bin/bash', 10:21:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:06 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:06 INFO - 'USER': 'cltbld', 10:21:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:06 INFO - 'XPC_FLAGS': '0x0', 10:21:06 INFO - 'XPC_SERVICE_NAME': '0', 10:21:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:06 INFO - Downloading/unpacking blobuploader==1.2.4 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:08 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - Downloading docopt-0.6.1.tar.gz 10:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:10 INFO - Running setup.py install for blobuploader 10:21:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:10 INFO - Running setup.py install for requests 10:21:10 INFO - Running setup.py install for docopt 10:21:10 INFO - Successfully installed blobuploader requests docopt 10:21:10 INFO - Cleaning up... 10:21:10 INFO - Return code: 0 10:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:10 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')]} 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:10 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')]} 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:10 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:10 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 10:21:10 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 10:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:11 INFO - 'HOME': '/Users/cltbld', 10:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:11 INFO - 'LOGNAME': 'cltbld', 10:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:11 INFO - 'MOZ_NO_REMOTE': '1', 10:21:11 INFO - 'NO_EM_RESTART': '1', 10:21:11 INFO - 'PAGER': '/bin/cat', 10:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:11 INFO - 'PWD': '/builds/slave/test', 10:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:11 INFO - 'SHELL': '/bin/bash', 10:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:11 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:11 INFO - 'USER': 'cltbld', 10:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:11 INFO - 'XPC_FLAGS': '0x0', 10:21:11 INFO - 'XPC_SERVICE_NAME': '0', 10:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-58ORdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-MZe0p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8H2oCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-wCcvLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-fpKPRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-lkHIgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-w7MRrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-93bCbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-5Y67AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-KqrEcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SO5UHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-I4nxD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zzhqlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-WKksWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zud8n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-wqdW_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-iWIOIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:13 INFO - Running setup.py install for manifestparser 10:21:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:13 INFO - Running setup.py install for mozcrash 10:21:13 INFO - Running setup.py install for mozdebug 10:21:13 INFO - Running setup.py install for mozdevice 10:21:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:13 INFO - Running setup.py install for mozfile 10:21:13 INFO - Running setup.py install for mozhttpd 10:21:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:13 INFO - Running setup.py install for mozinfo 10:21:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Running setup.py install for mozInstall 10:21:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Running setup.py install for mozleak 10:21:14 INFO - Running setup.py install for mozlog 10:21:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Running setup.py install for moznetwork 10:21:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Running setup.py install for mozprocess 10:21:14 INFO - Running setup.py install for mozprofile 10:21:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:14 INFO - Running setup.py install for mozrunner 10:21:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:15 INFO - Running setup.py install for mozscreenshot 10:21:15 INFO - Running setup.py install for moztest 10:21:15 INFO - Running setup.py install for mozversion 10:21:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:15 INFO - Cleaning up... 10:21:15 INFO - Return code: 0 10:21:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:15 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:15 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 10:21:15 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 10:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:15 INFO - 'HOME': '/Users/cltbld', 10:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:15 INFO - 'LOGNAME': 'cltbld', 10:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:15 INFO - 'MOZ_NO_REMOTE': '1', 10:21:15 INFO - 'NO_EM_RESTART': '1', 10:21:15 INFO - 'PAGER': '/bin/cat', 10:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:15 INFO - 'PWD': '/builds/slave/test', 10:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:15 INFO - 'SHELL': '/bin/bash', 10:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:15 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:15 INFO - 'USER': 'cltbld', 10:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:15 INFO - 'XPC_FLAGS': '0x0', 10:21:15 INFO - 'XPC_SERVICE_NAME': '0', 10:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:15 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-IDkZlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:15 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)) 10:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:15 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-k7M6UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-WAr_d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-oPvlO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-o3VQyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-cMmtci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-oMA2A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4x7aa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-frMARS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-g1vm0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-KqrEU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:16 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)) 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-fGSE6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:17 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)) 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-6NsxYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:17 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)) 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-gjU2eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:17 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)) 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-jwsAhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:17 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)) 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-eUEHPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:17 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)) 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-RKMhZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:17 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)) 10:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:17 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)) 10:21:17 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)) 10:21:17 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)) 10:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:19 INFO - Downloading blessings-1.6.tar.gz 10:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:20 INFO - Installing collected packages: blessings 10:21:20 INFO - Running setup.py install for blessings 10:21:20 INFO - Successfully installed blessings 10:21:20 INFO - Cleaning up... 10:21:20 INFO - Return code: 0 10:21:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:20 INFO - Reading from file tmpfile_stdout 10:21:20 INFO - Current package versions: 10:21:20 INFO - blessings == 1.6 10:21:20 INFO - blobuploader == 1.2.4 10:21:20 INFO - docopt == 0.6.1 10:21:20 INFO - manifestparser == 1.1 10:21:20 INFO - mozInstall == 1.12 10:21:20 INFO - mozcrash == 0.16 10:21:20 INFO - mozdebug == 0.1 10:21:20 INFO - mozdevice == 0.48 10:21:20 INFO - mozfile == 1.2 10:21:20 INFO - mozhttpd == 0.7 10:21:20 INFO - mozinfo == 0.9 10:21:20 INFO - mozleak == 0.1 10:21:20 INFO - mozlog == 3.1 10:21:20 INFO - moznetwork == 0.27 10:21:20 INFO - mozprocess == 0.22 10:21:20 INFO - mozprofile == 0.28 10:21:20 INFO - mozrunner == 6.11 10:21:20 INFO - mozscreenshot == 0.1 10:21:20 INFO - mozsystemmonitor == 0.0 10:21:20 INFO - moztest == 0.7 10:21:20 INFO - mozversion == 1.4 10:21:20 INFO - psutil == 3.1.1 10:21:20 INFO - requests == 1.2.3 10:21:20 INFO - wsgiref == 0.1.2 10:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:20 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')]} 10:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:20 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')]} 10:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:20 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:20 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 10:21:20 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 10:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:20 INFO - 'HOME': '/Users/cltbld', 10:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:20 INFO - 'LOGNAME': 'cltbld', 10:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:20 INFO - 'MOZ_NO_REMOTE': '1', 10:21:20 INFO - 'NO_EM_RESTART': '1', 10:21:20 INFO - 'PAGER': '/bin/cat', 10:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:20 INFO - 'PWD': '/builds/slave/test', 10:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:20 INFO - 'SHELL': '/bin/bash', 10:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:20 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:20 INFO - 'USER': 'cltbld', 10:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:20 INFO - 'XPC_FLAGS': '0x0', 10:21:20 INFO - 'XPC_SERVICE_NAME': '0', 10:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 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)) 10:21:20 INFO - Cleaning up... 10:21:20 INFO - Return code: 0 10:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21:20 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')]} 10:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:20 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')]} 10:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:20 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:20 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 10:21:20 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 10:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:20 INFO - 'HOME': '/Users/cltbld', 10:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:20 INFO - 'LOGNAME': 'cltbld', 10:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:20 INFO - 'MOZ_NO_REMOTE': '1', 10:21:20 INFO - 'NO_EM_RESTART': '1', 10:21:20 INFO - 'PAGER': '/bin/cat', 10:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:20 INFO - 'PWD': '/builds/slave/test', 10:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:20 INFO - 'SHELL': '/bin/bash', 10:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:20 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:20 INFO - 'USER': 'cltbld', 10:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:20 INFO - 'XPC_FLAGS': '0x0', 10:21:20 INFO - 'XPC_SERVICE_NAME': '0', 10:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:21 INFO - Downloading/unpacking jsonschema 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:23 INFO - Downloading/unpacking functools32 (from jsonschema) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:23 INFO - warning: no files found matching '*.txt' 10:21:23 INFO - no previously-included directories found matching 'build' 10:21:23 INFO - no previously-included directories found matching 'dist' 10:21:23 INFO - no previously-included directories found matching '.git*' 10:21:23 INFO - Installing collected packages: jsonschema, functools32 10:21:24 INFO - Running setup.py install for functools32 10:21:24 INFO - warning: no files found matching '*.txt' 10:21:24 INFO - no previously-included directories found matching 'build' 10:21:24 INFO - no previously-included directories found matching 'dist' 10:21:24 INFO - no previously-included directories found matching '.git*' 10:21:24 INFO - Successfully installed jsonschema functools32 10:21:24 INFO - Cleaning up... 10:21:24 INFO - Return code: 0 10:21:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:24 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd6a6abd30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, '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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:21:24 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 10:21:24 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 10:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:24 INFO - 'HOME': '/Users/cltbld', 10:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:24 INFO - 'LOGNAME': 'cltbld', 10:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:24 INFO - 'MOZ_NO_REMOTE': '1', 10:21:24 INFO - 'NO_EM_RESTART': '1', 10:21:24 INFO - 'PAGER': '/bin/cat', 10:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:24 INFO - 'PWD': '/builds/slave/test', 10:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:24 INFO - 'SHELL': '/bin/bash', 10:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:21:24 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:24 INFO - 'USER': 'cltbld', 10:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:24 INFO - 'XPC_FLAGS': '0x0', 10:21:24 INFO - 'XPC_SERVICE_NAME': '0', 10:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:24 INFO - Downloading/unpacking flake8 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:21:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:21:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:27 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 10:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:21:28 INFO - no previously-included directories found matching 'docs/_build' 10:21:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:21:28 INFO - Running setup.py install for pep8 10:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:21:28 INFO - no previously-included directories found matching 'docs/_build' 10:21:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:21:28 INFO - Cleaning up... 10:21:28 INFO - Return code: 0 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - Running post-action listener: _start_resource_monitoring 10:21:28 INFO - Starting resource monitoring. 10:21:28 INFO - ##### 10:21:28 INFO - ##### Running install step. 10:21:28 INFO - ##### 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: install 10:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:28 INFO - Reading from file tmpfile_stdout 10:21:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:28 INFO - Reading from file tmpfile_stdout 10:21:28 INFO - Output received: 10:21:28 INFO - Usage: mozinstall [options] installer 10:21:28 INFO - Options: 10:21:28 INFO - -h, --help show this help message and exit 10:21:28 INFO - -d DEST, --destination=DEST 10:21:28 INFO - Directory to install application into. [default: 10:21:28 INFO - "/builds/slave/test"] 10:21:28 INFO - --app=APP Application being installed. [default: firefox] 10:21:28 INFO - mkdir: /builds/slave/test/build/application 10:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:22:02 INFO - Reading from file tmpfile_stdout 10:22:02 INFO - Output received: 10:22:02 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 10:22:02 INFO - Running post-action listener: _resource_record_post_action 10:22:02 INFO - ##### 10:22:02 INFO - ##### Running run-tests step. 10:22:02 INFO - ##### 10:22:02 INFO - Running pre-action listener: _resource_record_pre_action 10:22:02 INFO - Running main action method: run_tests 10:22:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:22:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:22:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:22:02 INFO - 2016-02-23 10:22:02.808 screenresolution[1949:11532] starting screenresolution argv=screenresolution get 10:22:02 INFO - 2016-02-23 10:22:02.811 screenresolution[1949:11532] Display 0: 1600x1200x32@60 10:22:02 INFO - 2016-02-23 10:22:02.816 screenresolution[1950:11534] starting screenresolution argv=screenresolution list 10:22:02 INFO - Available Modes on Display 0 10:22:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:22:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:22:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:22:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:22:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:22:03 INFO - Intel Iris: 10:22:03 INFO - Chipset Model: Intel Iris 10:22:03 INFO - Type: GPU 10:22:03 INFO - Bus: Built-In 10:22:03 INFO - VRAM (Dynamic, Max): 1536 MB 10:22:03 INFO - Vendor: Intel (0x8086) 10:22:03 INFO - Device ID: 0x0a2e 10:22:03 INFO - Revision ID: 0x0009 10:22:03 INFO - Displays: 10:22:03 INFO - Display: 10:22:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:22:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:22:03 INFO - Display Serial Number: 1600x1200 60 10:22:03 INFO - Main Display: Yes 10:22:03 INFO - Mirror: Off 10:22:03 INFO - Online: Yes 10:22:03 INFO - Rotation: Supported 10:22:03 INFO - Return code: 0 10:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:03 INFO - Python 2.7.3 10:22:03 INFO - Return code: 0 10:22:03 INFO - grabbing minidump binary from tooltool 10:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105015d30>, '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 0x104e39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:22:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:22:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:03 INFO - Return code: 0 10:22:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:22:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:22:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:22:04 INFO - Return code: 0 10:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 10:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --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 10:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8UGSUmC1lq/Render', 10:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:04 INFO - 'HOME': '/Users/cltbld', 10:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:04 INFO - 'LOGNAME': 'cltbld', 10:22:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:04 INFO - 'MOZ_NO_REMOTE': '1', 10:22:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:04 INFO - 'NO_EM_RESTART': '1', 10:22:04 INFO - 'PAGER': '/bin/cat', 10:22:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:04 INFO - 'PWD': '/builds/slave/test', 10:22:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:04 INFO - 'SHELL': '/bin/bash', 10:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ReAKDJ0cwr/Listeners', 10:22:04 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:04 INFO - 'USER': 'cltbld', 10:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:04 INFO - 'XPC_FLAGS': '0x0', 10:22:04 INFO - 'XPC_SERVICE_NAME': '0', 10:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 10:22:04 INFO - mozversion application_buildid: 20160223030304 10:22:04 INFO - mozversion application_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 10:22:04 INFO - mozversion application_display_name: Nightly 10:22:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:04 INFO - mozversion application_name: Firefox 10:22:04 INFO - mozversion application_remotingname: firefox 10:22:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:22:04 INFO - mozversion application_vendor: Mozilla 10:22:04 INFO - mozversion application_version: 47.0a1 10:22:04 INFO - mozversion platform_buildid: 20160223030304 10:22:04 INFO - mozversion platform_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 10:22:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:22:04 INFO - mozversion platform_version: 47.0a1 10:22:04 INFO - using testdate: 1456251724 10:22:04 INFO - actual date: 1456251724 10:22:04 INFO - starting webserver on 'localhost:49580' 10:22:04 INFO - SUITE-START | Running 2 tests 10:22:04 INFO - TEST-START | dromaeo_css 10:22:04 INFO - operating with platform_type : mac_ 10:22:04 INFO - Initialising browser for dromaeo_css test... 10:22:05 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpizZuBU/profile http://localhost:49580/getInfo.html) 10:22:07 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 10:22:07 INFO - PROCESS | 1968 | colorDepth:24 10:22:07 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 10:22:07 INFO - PROCESS | 1968 | __metrics 10:22:07 INFO - PROCESS | 1968 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:22:07 INFO - PROCESS | 1968 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:22:07 INFO - TEST-INFO | 1968: exit 0 10:22:07 INFO - Browser initialized. 10:22:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:07 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpizZuBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:19 INFO - PROCESS | 1972 | RSS: Main: 244600832 10:22:19 INFO - PROCESS | 1972 | 10:23:11 INFO - PROCESS | 1972 | 1456251791124 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:25:21 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49580/tests/dromaeo/cssquery-ext.html) 10:25:23 INFO - PROCESS | 1972 | RSS: Main: 345350144 10:25:23 INFO - PROCESS | 1972 | 10:28:25 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-ext.html (next: http://localhost:49580/tests/dromaeo/cssquery-jquery.html) 10:28:26 INFO - PROCESS | 1972 | RSS: Main: 377344000 10:28:26 INFO - PROCESS | 1972 | 10:31:28 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49580/tests/dromaeo/cssquery-mootools.html) 10:31:29 INFO - PROCESS | 1972 | RSS: Main: 377831424 10:31:29 INFO - PROCESS | 1972 | 10:34:31 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49580/tests/dromaeo/cssquery-prototype.html) 10:34:31 INFO - PROCESS | 1972 | RSS: Main: 336801792 10:34:31 INFO - PROCESS | 1972 | 10:37:34 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49580/tests/dromaeo/cssquery-yui.html) 10:37:35 INFO - PROCESS | 1972 | RSS: Main: 338739200 10:37:35 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-yui.html (next: http://localhost:49580/tests/dromaeo/cssquery-dojo.html) 10:40:38 INFO - PROCESS | 1972 | RSS: Main: 392355840 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | __start_tp_report 10:40:38 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 10:40:38 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 10:40:38 INFO - PROCESS | 1972 | |i|pagename|runs| 10:40:38 INFO - PROCESS | 1972 | |0;dojo.html;3425.588929328481;3468.236987862669;3478.06092355064;3497.9475307870384;3558.893233203005;5560.388357280706;5673.546116310696;5693.28833895763;5727.083666613348;5771.36514983352;5616.466435688613;5679.801206957757;5693.117566777156;5724.4561766632105;5774.105013722869;4618.445786505624;4843.982763619644;5086.898262034757;5114.411842638097;5240.161574148137;5239.21411788231;5269.499397557226;5278.709670968095;5284.867878303035;5336.9733151334185;5134.486551344854;5135.3324067870935;5212.296339994109;5235.502627250443;5259.579233661336;5182.974085129588;5206.401263854667;5222.1905604630965;5229.137192363255;5229.607779416559;5139.306193663845;5176.534111929906;5184.066867963765;5220;5221.660592061504;5462.0987537056335;5510.283663123809;5589.720513974285;5610.943890561083;5613.691246981414;6153.353897840751;6166.722497487579;6185.226846644169;6190.504759619264;6201;6160.630362178284;6174.814755557296;6191.102290167945;6195.349488303708;6203.751849925998;5593.636413633141;5677.602567820213;5739.13912913058;5762.538996880281;5770.990076736596;6234.37656234382;6240.00159974402;6242.282137554149;6244.562880598405;6270.905936410957;6060.848478787977;6068.605540639845;6134.2332208473945;6141.324454310023;6151.753929842756;5843.620164689281;6085.391460853879;6162;6189.35011823761;6199.597026193283;6140.263168419729;6147.631142131487;6163.660998645118;6166.969165154145;6170.753169873155;6182.938170618326;6183.258009038944;6189.319174890758;6190.628562286187;6201.441870231701;4793.448753393334;4890.926636100461;4893.192623217201;4898.975505122452;4900.26496025599;3951.4665520154413;4369.563043695605;4471.642268618502;4474.865754027384;4474.910501789946;5563;5660;5714.457126572969;5724.971375143097;5734.483896449339;6095.377886651403;6116.311491734732;6150.138980542728;6165.537584681167;6180.721867515973;5758.712064396764;5759.827205183851;5766.509846663081;5775.653460792366;5788.5369170466265;5362.597805164628;5366.221897824794;5366.409694933554;5373.596980226499;5374.3013408256675;6208.410201030895;6317.652529110943;6345.524085693592;6382.872342553216;6383.2978372378075;6163.876722465615;6172.4136207060255;6177.351378105414;6191.504679625709;6205.317415084427;6154.661493617894;6296.716647750771;6356.237251529846;6382.042693595998;6393.424591786761;6124.228368151265;6129.938700612936;6159;6171.537134715004;6175.59858609189;6165.691715414301;6170.876582468415;6171.722272497658;6178.567500275118;6188.44304012641;5980.252468441445;6049.18336024631;6086.573939824169;6098.553255670888;6104.186323682738;6085.087236914498;6088.939110609014;6099.451049405575;6104.38956104386;6125.693715314127;5765.56758243125;5822.854428639318;5912.408759124225;5967.76128954837;5981.7308221131025;5988.940110598838;6018.638881667114;6027.758889644365;6029.51763858899;6042.667653279112;5919.4080591940465;5927.377625349449;5963.165156877953;5966.433188847052;6012.518998480198 10:40:38 INFO - PROCESS | 1972 | |1;ext.html;453;487.87071426072094;493.5434722881334;557.5288880895642;577.9885200898425;28831.423371532557;30131.84934075329;37753.81123094387;38047.42928856069;38283.234335313275;40898.79550602243;41215;41264.58735412645;41293.58706412935;41390;9499.002604726507;9693.854592181124;9725.756856078584;9726.367786093917;9731.756706082333;9516.666916657918;9668.274879384038;9670.371425857333;9695;9695.70912872615;9813.264005199602;9850.655227067055;9862;9875.1112399884;9891;9749.902500974971;9807.950960245153;9812.264080193943;9812.901870981306;9815;9366.391184573049;9481.810363792754;9491.38306010107;9507.809843803154;9508.90491095087;39253.01867453336;39666.40500392496;39676.60323396758;39701.60298397008;39772;3176.8093914365213;3321.7342612590933;3471.9652803471895;3550.7336949728615;3810.923781524382;28733.281667958257;29128.271793205127;29331.706682933112;29641.110766677033;29876;2206.3380985704225;2809.115128734442;2840.1763488588285;2851.0734011446157;2864.6992065833206;496015;497573.9999999964;497585;499443;538699.6130038688;62320;62466.375336246965;63046;63076;63184.10447686577;63697.68151159307;63929.68035159887;63953.36046639474;64006;64038;15655.295511702001;15793.921030395004;15863.920680396755;15866.206689665702;15873.761893571605;11976.88023119775;12224.694382640506;12416.875831241752;12441.129120961446;12443.75112497763;20543.691844622343;20750;20776.857272849837;20783.376498705064;20849.58300833975;8791.780205494786;9031;9081.59132839024;9092.954535227414;9128.863067053999;933.5145724223502;939.145377706284;970.898055704155;1031.7781676939494;1080.3355936099242;27576.353453640324;28547;28849.85575072111;28990.710092899222;29112.417751644847;856.738694698123;1020.2705065877933;1078.045929352513;1095.3537412926253;1114.9442527873573;15119.470818521298;15754.842451575567;15782.60543486399;15823.841761582467;15917.602059948595;728337;733755;741362;882357;908302;58274.41725582775;59023;59190;59272.70363648154;59567.702161488916;1293.4502836294348;1435.095889589552;1449.0943160524673;1453.9200343980972;1567.2868844675645;24992.756446762032;29808.956686515867;29836.552451712807;30495;30800.22999424943;51747.22379164391;52437.737811312225;52856.73571632117;52909.7354513225;52975;412637;480548;483028;484134;487955;31516.842415787774;31893.36213275768;32274;32280;32385;42523.787381062895;42810.785946071315;43382;43599;43699;29164.7083529162;29846;35126.824365878005;35376.823115884254;35427.93716188519;35108.946731598095;35421.291574168885;35691.46462803112;35823.104422389646;35823.82088089543;37058.814705927376;37239.6276037247;38138;38227.61772382352;38349.808250958566;29420.11739647814;31553.89561365341;31834.522482162323;32353.514697280032;32834.67165328412;22509;24727.38181545404;24790;25007.499850002536;25009.834041218848 10:40:38 INFO - PROCESS | 1972 | |2;jquery.html;364.855881926639;367.51488035792755;368.16977715252085;375.11847159175954;375.35626400722754;15180.696386072272;15752.921235393807;19360.515987100312;19534;20475.488112797168;19111.13999870006;19334.709979350286;19536.70694939577;19564;19797.812131272134;5504.256925315071;5798.82603521895;5826.6212696174825;5830.4169583041785;6453;4155.231282212785;4349.369341445488;5302.469753024686;5408.296921400212;6314.968425157867;5398.082326004589;5421.647592906468;5424.294841670578;5436.048691478995;5446.591505637093;5327.786888524454;5404.891902161954;6389.584676996027;6405.263394709575;6407.935920640827;5503.229547863302;5515.917261241045;5521.944780552183;5531.059719847635;5531.170324451365;24768.628470572956;25108;25266.242012739647;25387.984480620755;25438.618420723706;2125.9370314842577;2136.3163787587823;2141.4646338415396;2414.09028321232;2921.0238024101227;13611.11527750703;14010.369533371022;14352.712945741132;14440.711185776225;14908;1707.8292170782822;1750.8599312055005;1758.2439550993067;1783.3669047488215;1785.3840425053336;87530;97827.53258701126;101903;109828.90171098347;114517;10236.948815256024;10686.358818470917;11073.889261107286;11077.833832492519;11185.832212516818;13283.667908302177;13342.19946803195;13358.198508089352;13391.799123013163;13400.93299533496;8249.752507424666;8349.874751878726;8364.958175209085;8427.32581393487;8436.578171091543;8451.45065570736;8458.28104611115;8482.533460659723;8533.232009119209;8562.229399353964;4323.416338794285;4395.230834603932;4402.669799765031;4428.18444437779;4447.866564003085;1739.2955852879604;1788.8926664400178;1796.9371072012677;1833.3125078095713;1860.2373027059111;856.5545916123581;888.1739981816843;916.8212198621338;991.2218908157062;1033.4419413516616;15643.374265029272;18479.181404246447;19421;19961.800381995996;20538;860.617025423693;869.8956125265008;894.9373543851868;931.3899395895563;938.7465384346189;9832.01679832011;10055.547500362502;10056.899431005597;10073.29486935922;10224.846627300596;500833;614619;615378;650866.7456662781;653367;102845.97154028364;117876;117959;118853;122566.3871680636;952.1668540027476;981.0532835813474;990.4255531791543;993.1855878179967;1001.7095042437611;16984.745228821826;17537.860039097417;17582;17790.822091778915;17925.014124223293;51451.228231577305;52155.47844521506;52617;52905.59321694889;52968;73380.63309683418;73845.6307718458;76708.7205734893;77324;79049.60475197587;7916.920830791849;7927.960360198162;7940.960295198487;7969.24292192264;8011.278984891154;11287.661370158909;12752.171108877894;13006.414711338202;13042.347882606022;13076.280804555841;7897.960510197412;7945.682172713026;10812.024000119438;11005.009549140615;11377.374244416636;9369.765755856159;9709.640650309104;11009.449527523431;11162.107031437628;11405.828912566483;11638.149084957662;11777.823332650189;11850;11967.461464234304;11977.820332695192;6502.544821862424;6796.320367963164;7768.805779855323;7910.367170626221;8127.3091787198755;10691.30506517074;10951.83572246401;11127.499262533367;11247.775044499227;11516.654500365003 10:40:38 INFO - PROCESS | 1972 | |3;mootools.html;1384.1072508232185;1528.5567185516202;1552.4178433087595;1736.426979096898;1810.131137054214;7112.288771122891;8728.825423491526;8877.51173685447;8882.689105881296;8882.77793055173;7380.704771809134;8488.23605875471;8807.603657835412;8817.162369574897;8824.073472285414;2214.413180507167;2439.109724950389;2490.9750902491014;2507.2728908616477;2522.092046863128;2455.5812524663193;2527.3428908483743;2537.8350407223566;2541.07250853439;2542.1610868413472;2111.42991392324;2477.7398373170736;2483.7640424159677;2487.328421326241;2495.7753802157804;2170.2729585588845;2414.7102347718387;2471.1351027140536;2478.479519300949;2479.1818699829014;2442.1452491627965;2474.5174690935273;2476.3561474016706;2485.179890636086;2489.9004039838383;8857.11428857109;8931.508767017876;8947.373683842134;8949.686760963401;8952.820943581157;5430.484104010113;5510.752016159283;5581.888362232773;5585.748641311151;5592.86017849557;3684.9815750921343;3713.275911197318;3785.6782173515285;3791.9810400948095;3814.694824414068;882.5631312500353;1063.0379506546587;1063.3141623652778;1096.7970925378831;1100.301308669001;12051.638450846402;12204.633860984184;12222.961048310905;12223.205491643015;12230.938845305805;4943.5797957174045;4945.085159245551;4992.500749925051;5024.296598476216;5026.924596131061;10373;10392.584296628202;10400.583976641;10403.635872744419;10405.115565176893;5056.292119103328;5552.167174923794;5560.999020176326;5563.193336966117;5573.108302671634;4631.212693842055;4826.517348265145;4924.261360795909;4979.05397974391;4992.301077849104;3983.322835118037;3984.7609143451486;3994.08136128692;4034.6483927884487;4039.7980100994832;1099.2580008494394;1314.3559655768604;1326.9137506062075;1327.8008298755071;1331.10150648312;1034.8344264917578;1048.6906362623045;1173.8826117388194;1366.3031853754658;1367.3368416318078;8120.878186827203;8281.95859020701;8284.337253019745;8286.627101780434;8287.419880608299;505.38595606338475;509.76041260607457;515.1782906264502;520.9348831396076;524.1822756499796;6242.75028998844;6259.906101408483;6295.842603934847;6318.557700960889;6319.368063193644;10653.84019239712;11044.447777611087;11127.499262533205;11130.833037504444;11143.164262680331;10565.894341056492;10927.344359338465;10980.694054248697;10988.560457581607;10995;8421.70524031656;8431.789205269917;8486.915130848736;8487.872681909776;8498.53258070812;7827.139014708264;7976.641051152828;8022.9598852005365;8187.83624327522;8189.590520474072;9425.57584908667;9659.613615455584;9714.3199976001;9870.753231169278;9958.15355694774;9993.700188994342;10206.438645874252;10394.532246048795;10426.426546540013;10432.478376081013;7661.080670319598;7700.268474495138;7709.614519274126;7754.108277548155;7754.883676744967;8342.499450033018;8350.248477637042;8417.242448179693;8435.83128337442;8437.873431898404;7439.888401673871;7588.127365352834;7644.961775191088;7665.156832748505;7684.193159718373;7216.061911951413;7341.963290183515;7444.702211911463;7477.476576639583;7559.433042521723;7893.36853051743;7921.683132674629;7970.40221983342;7977.843212734238;7982.121966583787;7130.465215108784;7147.428205743632;7202.099737532809;7207.747728829466;7229.204787473269;7275.963620181865;7280.745173918887;7335.8532829344185;7342.743003994835;7347.7795666130105 10:40:38 INFO - PROCESS | 1972 | |4;prototype.html;318.6351627386642;321.93078488125064;330.38548300161705;330.46629693045736;333.53638442564824;5220.608454365919;6374.968125159379;6524.543281970264;6552.180977377828;6594.802155935324;6328.462080723132;6398.9040164397575;6461.095446637462;6463.450606698425;6467.320931302216;4863.367762190928;4866.707997520151;4874.390701162355;4883.804647814083;4895.388076490439;4056.797160141996;4676.555727205927;4866.416030076378;4886.877828054292;4915.803367865281;4832;4855.5872750816225;4861.586765124968;4864.173090574611;4867.415910090794;4845.0552142332435;4847.44254410742;4853.369062021915;4856.223004319328;4867.464578896319;3363.512290717832;4152;4164.12553363794;4166.854160104382;4189.748615083105;6141.232345956755;6233.376662333776;6233.875322493524;6236.43872051513;6246.437820596168;4319.870403887857;4983.651144419892;5557.638753481011;5663.348714897798;5674.914876276859;6162.291336496271;6397.392247736458;6938.236793952711;6948;7000;4533.387992620987;4534.59188673021;4540.954590454086;4548.067646132535;4549.954500454986;5906.557008224358;7170.928290717078;7323.926760732431;7340.853182936311;7349.412047036224;4529.68292219548;4551.749653769075;4577.977110114428;4580;4589.541045895384;4645.74448405341;4670.486246512881;4674.252119660906;4679.227927391942;4679.766011699401;5565.16522521625;5570.916436253459;5582.358028826737;5585.776568937278;5586.050371436865;6511.023346497968;6738.898916516257;7049.647517624098;7054.788356349215;7057.258987806206;1600.815906170782;1612.0972255536938;1627.7232870411822;1628.8778341624425;1629.5681644364254;1022.1669339488293;1031.5718976624767;1038.7143535527791;1044.738815296176;1050.8528805967171;6588.670566471753;6592.769253076215;6599.934000660028;6607.636579988147;6634.772567075107;7304.853902921912;7315.561066336037;7320.1581818090535;7325.2674732527385;7337.633118344062;5369.919451208235;5606.803761868397;6610.471162307004;6614.04096406028;6619.3380661933425;3733.3466643337306;3828.9234215316096;3870.4581358609817;3873.8837834865;3887.2225554889137;5978.953683105439;6190.350013248634;7156.964215178995;7638.770836874903;7647.197044310267;7387.9261207387235;7466.066741657293;7468.215837337001;7469.925300746923;7479.439042071866;6808.795736127924;7581.583012934341;7588.27911348421;7607.505512141693;7615.771526854203;7162.46281528877;7275.199728030018;7276.745313913988;7286.562806231643;7294.562326260441;7251.818704532217;7293.52592081513;7313;7314.926850731425;7337.559746415232;7758.3017528422715;7767.92232077672;7778.533288002738;7783.649735761791;7793.454458187873;4637.9332753466215;4683.648726345606;4688.038952014897;4692.155412025868;4693.671442998957;6668.799936001928;7038.612876291853;7387.2243414442855;7392.039034925425;7407.481476296607;7053.717851285891;7147.82130446743;7150.7497237596435;7154.892676609959;7159.8568028640175;7061.717531298896;7092.219855815959;7134.108236470442;7137.393321567517;7137.821554460972;6939.4795390346935;6954.3045695430055;6960.512764106464;6963.268856770169;6968.95465680152;6905.861882762417;7127.8574428512175;7128.322809333105;7129.964350178216;7140.46446516503;6932.44540436774;6963.09479767627;6972.302769722987;6981.965090174516;6983 10:40:38 INFO - PROCESS | 1972 | |5;yui.html;566.297790739483;632.8702615963725;634.9174607301051;726.8618962397144;742.3430264216167;14263.78604320936;14602.19687917164;15455.381784728597;15536.990095643776;15543.300551475182;14977.101373917572;15271.312790924407;15282.312295946682;15286.31211595478;15306.923465382657;702.8137543550963;718.7268837841626;796.8804679298094;846.1538461538462;892.5180402582598;872.9650813967434;878.7188099808064;879.6085741844881;879.8152387998528;882.1795729971125;943.1323182671958;943.2312665177858;945.5461378538306;945.7115579748174;947.1759569174827;901.8737376767258;937.70931011386;937.9624815007392;940.9790377440486;944.8677185194078;692.4910191009604;692.7817737412698;693.4729605499806;694.2190036209265;696.4880812602732;15278.923605381902;15316.923415382964;15356.308966096552;15356.846431535654;15364.154971476564;12997.15518491295;13073.346332683328;13074;13317.53388631403;13586.660333491644;10158.695239142837;10173.79652406955;10298.485075746257;10712;10834.241603087787;3525.2596954639557;3617.6744093031753;3795.1460921292487;3802.201537677091;3806.1245913440066;74749.25250747532;75713;77737.61131194365;77938;78154.21845781583;9172.587233574504;9304.302177336727;9326.347155699172;9398.389104708172;9961.950190249147;20178.697319540217;20179.899100504404;20205.29281475171;20206.89896550508;20266;6522.282548919615;7247.782566523013;7403.259674032553;7535.623218839146;7666.923330766621;4146.274401979642;4149.668026557868;4150.8339666413;4156.418101465797;4181.017460896687;3465.653434656514;3510.7717998330027;3512.5258090157504;3513.2622149348413;3517.261375111204;652.4291245160484;655.2955572759303;655.9508036897251;687.1994126842272;689.1489011071423;559.7760895641776;595.3599880128879;603.4508597176548;625.956183067181;628.9905651415232;8463.957680211559;8503.532305723245;8694;8725.912740872636;8774.824503510023;551.9834404967858;582.3215953414309;600.8107446154447;616.2512547255106;622.1010639625697;3267.2975310307925;3454.378211921828;3940.0937784309767;4092.0997380576227;4175.937360939588;95682;98335.50832245935;98516.52225216628;98577;98883;72075.91886121713;72909;74279.62860185665;74443.62778186183;74907.62546187235;67765;67862.3213767856;71822;72366.63816680883;72534;8856.64573417082;8904.643814247358;8913.275963739228;8927.419717718327;9034.638614455349;48183.31194094658;48848.778780530774;49043;49205.75397122991;50831.983360333325;58346;65721;69310.65344673244;70132.64933675299;70875;10698.946505267424;10795.784084318428;10971.23201375928;11039.116870650168;11543.767745031404;11833.881661183277;11956.10329225329;12236.082293828176;12488.937555312164;12722.61832145037;11724.70688232801;11855.466504007169;11927.0458363329;12040.157188996685;12078.456469459072;11141.164412669244;11474.4262786862;11770;11835.230710003822;12406.069544783997;11337.319760814378;11406.144539159763;11631.941840290745;11672.066234701033;12324.137310388545;8673.522956237468;8953.955230223808;9087.454752714859;9125.17873391398;9183;8093.312068474245;8386.412951093365;8595.65617375298;8938.374313798231;8992.685256016008 10:40:38 INFO - PROCESS | 1972 | __end_tp_report 10:40:38 INFO - PROCESS | 1972 | __start_cc_report 10:40:38 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,917 10:40:38 INFO - PROCESS | 1972 | __end_cc_report 10:40:38 INFO - PROCESS | 1972 | __startTimestamp1456252838730__endTimestamp 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | ------- Summary: start ------- 10:40:38 INFO - PROCESS | 1972 | Number of tests: 6 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | [#0] dojo.html Cycles:165 Average:5713.07 Median:5966.43 stddev:625.10 (10.5%) stddev-sans-first:600.71 10:40:38 INFO - PROCESS | 1972 | Values: 3425.6 3468.2 3478.1 3497.9 3558.9 5560.4 5673.5 5693.3 5727.1 5771.4 5616.5 5679.8 5693.1 5724.5 5774.1 4618.4 4844.0 5086.9 5114.4 5240.2 5239.2 5269.5 5278.7 5284.9 5337.0 5134.5 5135.3 5212.3 5235.5 5259.6 5183.0 5206.4 5222.2 5229.1 5229.6 5139.3 5176.5 5184.1 5220.0 5221.7 5462.1 5510.3 5589.7 5610.9 5613.7 6153.4 6166.7 6185.2 6190.5 6201.0 6160.6 6174.8 6191.1 6195.3 6203.8 5593.6 5677.6 5739.1 5762.5 5771.0 6234.4 6240.0 6242.3 6244.6 6270.9 6060.8 6068.6 6134.2 6141.3 6151.8 5843.6 6085.4 6162.0 6189.4 6199.6 6140.3 6147.6 6163.7 6167.0 6170.8 6182.9 6183.3 6189.3 6190.6 6201.4 4793.4 4890.9 4893.2 4899.0 4900.3 3951.5 4369.6 4471.6 4474.9 4474.9 5563.0 5660.0 5714.5 5725.0 5734.5 6095.4 6116.3 6150.1 6165.5 6180.7 5758.7 5759.8 5766.5 5775.7 5788.5 5362.6 5366.2 5366.4 5373.6 5374.3 6208.4 6317.7 6345.5 6382.9 6383.3 6163.9 6172.4 6177.4 6191.5 6205.3 6154.7 6296.7 6356.2 6382.0 6393.4 6124.2 6129.9 6159.0 6171.5 6175.6 6165.7 6170.9 6171.7 6178.6 6188.4 5980.3 6049.2 6086.6 6098.6 6104.2 6085.1 6088.9 6099.5 6104.4 6125.7 5765.6 5822.9 5912.4 5967.8 5981.7 5988.9 6018.6 6027.8 6029.5 6042.7 5919.4 5927.4 5963.2 5966.4 6012.5 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | [#1] ext.html Cycles:180 Average:71809.33 Median:38801.41 stddev:164400.45 (423.7%) stddev-sans-first:164774.34 10:40:38 INFO - PROCESS | 1972 | Values: 453.0 487.9 493.5 557.5 578.0 28831.4 30131.8 37753.8 38047.4 38283.2 40898.8 41215.0 41264.6 41293.6 41390.0 9499.0 9693.9 9725.8 9726.4 9731.8 9516.7 9668.3 9670.4 9695.0 9695.7 9813.3 9850.7 9862.0 9875.1 9891.0 9749.9 9808.0 9812.3 9812.9 9815.0 9366.4 9481.8 9491.4 9507.8 9508.9 39253.0 39666.4 39676.6 39701.6 39772.0 3176.8 3321.7 3472.0 3550.7 3810.9 28733.3 29128.3 29331.7 29641.1 29876.0 2206.3 2809.1 2840.2 2851.1 2864.7 496015.0 497574.0 497585.0 499443.0 538699.6 62320.0 62466.4 63046.0 63076.0 63184.1 63697.7 63929.7 63953.4 64006.0 64038.0 15655.3 15793.9 15863.9 15866.2 15873.8 11976.9 12224.7 12416.9 12441.1 12443.8 20543.7 20750.0 20776.9 20783.4 20849.6 8791.8 9031.0 9081.6 9093.0 9128.9 933.5 939.1 970.9 1031.8 1080.3 27576.4 28547.0 28849.9 28990.7 29112.4 856.7 1020.3 1078.0 1095.4 1114.9 15119.5 15754.8 15782.6 15823.8 15917.6 728337.0 733755.0 741362.0 882357.0 908302.0 58274.4 59023.0 59190.0 59272.7 59567.7 1293.5 1435.1 1449.1 1453.9 1567.3 24992.8 29809.0 29836.6 30495.0 30800.2 51747.2 52437.7 52856.7 52909.7 52975.0 412637.0 480548.0 483028.0 484134.0 487955.0 31516.8 31893.4 32274.0 32280.0 32385.0 42523.8 42810.8 43382.0 43599.0 43699.0 29164.7 29846.0 35126.8 35376.8 35427.9 35108.9 35421.3 35691.5 35823.1 35823.8 37058.8 37239.6 38138.0 38227.6 38349.8 29420.1 31553.9 31834.5 32353.5 32834.7 22509.0 24727.4 24790.0 25007.5 25009.8 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | [#2] jquery.html Cycles:180 Average:34195.31 Median:366.19 stddev:101078.64 (27603.1%) stddev-sans-first:101330.27 10:40:38 INFO - PROCESS | 1972 | Values: 364.9 367.5 368.2 375.1 375.4 15180.7 15752.9 19360.5 19534.0 20475.5 19111.1 19334.7 19536.7 19564.0 19797.8 5504.3 5798.8 5826.6 5830.4 6453.0 4155.2 4349.4 5302.5 5408.3 6315.0 5398.1 5421.6 5424.3 5436.0 5446.6 5327.8 5404.9 6389.6 6405.3 6407.9 5503.2 5515.9 5521.9 5531.1 5531.2 24768.6 25108.0 25266.2 25388.0 25438.6 2125.9 2136.3 2141.5 2414.1 2921.0 13611.1 14010.4 14352.7 14440.7 14908.0 1707.8 1750.9 1758.2 1783.4 1785.4 87530.0 97827.5 101903.0 109828.9 114517.0 10236.9 10686.4 11073.9 11077.8 11185.8 13283.7 13342.2 13358.2 13391.8 13400.9 8249.8 8349.9 8365.0 8427.3 8436.6 8451.5 8458.3 8482.5 8533.2 8562.2 4323.4 4395.2 4402.7 4428.2 4447.9 1739.3 1788.9 1796.9 1833.3 1860.2 856.6 888.2 916.8 991.2 1033.4 15643.4 18479.2 19421.0 19961.8 20538.0 860.6 869.9 894.9 931.4 938.7 9832.0 10055.5 10056.9 10073.3 10224.8 500833.0 614619.0 615378.0 650866.7 653367.0 102846.0 117876.0 117959.0 118853.0 122566.4 952.2 981.1 990.4 993.2 1001.7 16984.7 17537.9 17582.0 17790.8 17925.0 51451.2 52155.5 52617.0 52905.6 52968.0 73380.6 73845.6 76708.7 77324.0 79049.6 7916.9 7928.0 7941.0 7969.2 8011.3 11287.7 12752.2 13006.4 13042.3 13076.3 7898.0 7945.7 10812.0 11005.0 11377.4 9369.8 9709.6 11009.4 11162.1 11405.8 11638.1 11777.8 11850.0 11967.5 11977.8 6502.5 6796.3 7768.8 7910.4 8127.3 10691.3 10951.8 11127.5 11247.8 11516.7 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | [#3] mootools.html Cycles:180 Average:6153.37 Median:512.47 stddev:3300.53 (644.0%) stddev-sans-first:3290.32 10:40:38 INFO - PROCESS | 1972 | Values: 1384.1 1528.6 1552.4 1736.4 1810.1 7112.3 8728.8 8877.5 8882.7 8882.8 7380.7 8488.2 8807.6 8817.2 8824.1 2214.4 2439.1 2491.0 2507.3 2522.1 2455.6 2527.3 2537.8 2541.1 2542.2 2111.4 2477.7 2483.8 2487.3 2495.8 2170.3 2414.7 2471.1 2478.5 2479.2 2442.1 2474.5 2476.4 2485.2 2489.9 8857.1 8931.5 8947.4 8949.7 8952.8 5430.5 5510.8 5581.9 5585.7 5592.9 3685.0 3713.3 3785.7 3792.0 3814.7 882.6 1063.0 1063.3 1096.8 1100.3 12051.6 12204.6 12223.0 12223.2 12230.9 4943.6 4945.1 4992.5 5024.3 5026.9 10373.0 10392.6 10400.6 10403.6 10405.1 5056.3 5552.2 5561.0 5563.2 5573.1 4631.2 4826.5 4924.3 4979.1 4992.3 3983.3 3984.8 3994.1 4034.6 4039.8 1099.3 1314.4 1326.9 1327.8 1331.1 1034.8 1048.7 1173.9 1366.3 1367.3 8120.9 8282.0 8284.3 8286.6 8287.4 505.4 509.8 515.2 520.9 524.2 6242.8 6259.9 6295.8 6318.6 6319.4 10653.8 11044.4 11127.5 11130.8 11143.2 10565.9 10927.3 10980.7 10988.6 10995.0 8421.7 8431.8 8486.9 8487.9 8498.5 7827.1 7976.6 8023.0 8187.8 8189.6 9425.6 9659.6 9714.3 9870.8 9958.2 9993.7 10206.4 10394.5 10426.4 10432.5 7661.1 7700.3 7709.6 7754.1 7754.9 8342.5 8350.2 8417.2 8435.8 8437.9 7439.9 7588.1 7645.0 7665.2 7684.2 7216.1 7342.0 7444.7 7477.5 7559.4 7893.4 7921.7 7970.4 7977.8 7982.1 7130.5 7147.4 7202.1 7207.7 7229.2 7276.0 7280.7 7335.9 7342.7 7347.8 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | [#4] prototype.html Cycles:180 Average:5709.36 Median:6430.00 stddev:1839.01 (28.6%) stddev-sans-first:1799.11 10:40:38 INFO - PROCESS | 1972 | Values: 318.6 321.9 330.4 330.5 333.5 5220.6 6375.0 6524.5 6552.2 6594.8 6328.5 6398.9 6461.1 6463.5 6467.3 4863.4 4866.7 4874.4 4883.8 4895.4 4056.8 4676.6 4866.4 4886.9 4915.8 4832.0 4855.6 4861.6 4864.2 4867.4 4845.1 4847.4 4853.4 4856.2 4867.5 3363.5 4152.0 4164.1 4166.9 4189.7 6141.2 6233.4 6233.9 6236.4 6246.4 4319.9 4983.7 5557.6 5663.3 5674.9 6162.3 6397.4 6938.2 6948.0 7000.0 4533.4 4534.6 4541.0 4548.1 4550.0 5906.6 7170.9 7323.9 7340.9 7349.4 4529.7 4551.7 4578.0 4580.0 4589.5 4645.7 4670.5 4674.3 4679.2 4679.8 5565.2 5570.9 5582.4 5585.8 5586.1 6511.0 6738.9 7049.6 7054.8 7057.3 1600.8 1612.1 1627.7 1628.9 1629.6 1022.2 1031.6 1038.7 1044.7 1050.9 6588.7 6592.8 6599.9 6607.6 6634.8 7304.9 7315.6 7320.2 7325.3 7337.6 5369.9 5606.8 6610.5 6614.0 6619.3 3733.3 3828.9 3870.5 3873.9 3887.2 5979.0 6190.4 7157.0 7638.8 7647.2 7387.9 7466.1 7468.2 7469.9 7479.4 6808.8 7581.6 7588.3 7607.5 7615.8 7162.5 7275.2 7276.7 7286.6 7294.6 7251.8 7293.5 7313.0 7314.9 7337.6 7758.3 7767.9 7778.5 7783.6 7793.5 4637.9 4683.6 4688.0 4692.2 4693.7 6668.8 7038.6 7387.2 7392.0 7407.5 7053.7 7147.8 7150.7 7154.9 7159.9 7061.7 7092.2 7134.1 7137.4 7137.8 6939.5 6954.3 6960.5 6963.3 6969.0 6905.9 7127.9 7128.3 7130.0 7140.5 6932.4 6963.1 6972.3 6982.0 6983.0 10:40:38 INFO - PROCESS | 1972 | 10:40:38 INFO - PROCESS | 1972 | [#5] yui.html Cycles:180 Average:18250.60 Median:627.47 stddev:25586.18 (4077.7%) stddev-sans-first:25623.50 10:40:38 INFO - PROCESS | 1972 | Values: 566.3 632.9 634.9 726.9 742.3 14263.8 14602.2 15455.4 15537.0 15543.3 14977.1 15271.3 15282.3 15286.3 15306.9 702.8 718.7 796.9 846.2 892.5 873.0 878.7 879.6 879.8 882.2 943.1 943.2 945.5 945.7 947.2 901.9 937.7 938.0 941.0 944.9 692.5 692.8 693.5 694.2 696.5 15278.9 15316.9 15356.3 15356.8 15364.2 12997.2 13073.3 13074.0 13317.5 13586.7 10158.7 10173.8 10298.5 10712.0 10834.2 3525.3 3617.7 3795.1 3802.2 3806.1 74749.3 75713.0 77737.6 77938.0 78154.2 9172.6 9304.3 9326.3 9398.4 9962.0 20178.7 20179.9 20205.3 20206.9 20266.0 6522.3 7247.8 7403.3 7535.6 7666.9 4146.3 4149.7 4150.8 4156.4 4181.0 3465.7 3510.8 3512.5 3513.3 3517.3 652.4 655.3 656.0 687.2 689.1 559.8 595.4 603.5 626.0 629.0 8464.0 8503.5 8694.0 8725.9 8774.8 552.0 582.3 600.8 616.3 622.1 3267.3 3454.4 3940.1 4092.1 4175.9 95682.0 98335.5 98516.5 98577.0 98883.0 72075.9 72909.0 74279.6 74443.6 74907.6 67765.0 67862.3 71822.0 72366.6 72534.0 8856.6 8904.6 8913.3 8927.4 9034.6 48183.3 48848.8 49043.0 49205.8 50832.0 58346.0 65721.0 69310.7 70132.6 70875.0 10698.9 10795.8 10971.2 11039.1 11543.8 11833.9 11956.1 12236.1 12488.9 12722.6 11724.7 11855.5 11927.0 12040.2 12078.5 11141.2 11474.4 11770.0 11835.2 12406.1 11337.3 11406.1 11631.9 11672.1 12324.1 8673.5 8954.0 9087.5 9125.2 9183.0 8093.3 8386.4 8595.7 8938.4 8992.7 10:40:38 INFO - PROCESS | 1972 | -------- Summary: end -------- 10:40:38 INFO - PROCESS | 1972 | 10:40:39 INFO - TEST-INFO | 1972: exit 0 10:40:39 INFO - TEST-OK | dromaeo_css | took 1114279ms 10:40:39 INFO - TEST-START | kraken 10:40:39 INFO - operating with platform_type : mac_ 10:40:39 INFO - Initialising browser for kraken test... 10:40:39 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpCNAUMQ/profile http://localhost:49580/getInfo.html) 10:40:41 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 10:40:41 INFO - PROCESS | 1976 | colorDepth:24 10:40:41 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 10:40:41 INFO - PROCESS | 1976 | __metrics 10:40:41 INFO - PROCESS | 1976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:40:41 INFO - PROCESS | 1976 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:42 INFO - TEST-INFO | 1976: exit 0 10:40:42 INFO - Browser initialized. 10:40:42 INFO - Running cycle 1/1 for kraken test... 10:40:42 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpCNAUMQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:54 INFO - PROCESS | 1979 | RSS: Main: 243101696 10:40:54 INFO - PROCESS | 1979 | 10:40:56 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:57 INFO - PROCESS | 1979 | RSS: Main: 289804288 10:40:57 INFO - PROCESS | 1979 | 10:40:59 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-dft) 10:41:00 INFO - PROCESS | 1979 | RSS: Main: 301445120 10:41:00 INFO - PROCESS | 1979 | 10:41:03 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-fft) 10:41:04 INFO - PROCESS | 1979 | RSS: Main: 284004352 10:41:04 INFO - PROCESS | 1979 | 10:41:06 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-oscillator) 10:41:06 INFO - PROCESS | 1979 | RSS: Main: 287051776 10:41:06 INFO - PROCESS | 1979 | 10:41:08 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:09 INFO - PROCESS | 1979 | RSS: Main: 287903744 10:41:09 INFO - PROCESS | 1979 | 10:41:12 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49580/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:13 INFO - PROCESS | 1979 | RSS: Main: 289439744 10:41:13 INFO - PROCESS | 1979 | 10:41:15 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49580/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:16 INFO - PROCESS | 1979 | RSS: Main: 287514624 10:41:16 INFO - PROCESS | 1979 | 10:41:19 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49580/tests/kraken/driver.html?testName=json-parse-financial) 10:41:19 INFO - PROCESS | 1979 | RSS: Main: 289816576 10:41:19 INFO - PROCESS | 1979 | 10:41:21 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:21 INFO - PROCESS | 1979 | RSS: Main: 324984832 10:41:21 INFO - PROCESS | 1979 | 10:41:23 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:24 INFO - PROCESS | 1979 | RSS: Main: 323481600 10:41:24 INFO - PROCESS | 1979 | 10:41:26 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:26 INFO - PROCESS | 1979 | RSS: Main: 332148736 10:41:26 INFO - PROCESS | 1979 | 10:41:29 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:29 INFO - PROCESS | 1979 | RSS: Main: 332709888 10:41:29 INFO - PROCESS | 1979 | 10:41:32 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:33 INFO - PROCESS | 1979 | RSS: Main: 333901824 10:41:33 INFO - PROCESS | 1979 | 10:41:34 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49580/tests/kraken/driver.html?testName=ai-astar) 10:41:35 INFO - PROCESS | 1979 | RSS: Main: 393760768 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | __start_tp_report 10:41:35 INFO - PROCESS | 1979 | _x_x_mozilla_page_load 10:41:35 INFO - PROCESS | 1979 | _x_x_mozilla_page_load_details 10:41:35 INFO - PROCESS | 1979 | |i|pagename|runs| 10:41:35 INFO - PROCESS | 1979 | |0;ai-astar;111;109;111;110;111;112;115;110;109;108 10:41:35 INFO - PROCESS | 1979 | |1;audio-beat-detection;160;119;146;154;117;141;139;118;152;120 10:41:35 INFO - PROCESS | 1979 | |2;audio-dft;184;187;186;186;186;186;186;184;181;183 10:41:35 INFO - PROCESS | 1979 | |3;audio-fft;76;81;105;107;81;62;58;79;74;55 10:41:35 INFO - PROCESS | 1979 | |4;audio-oscillator;95;94;125;79;79;81;112;78;77;115 10:41:35 INFO - PROCESS | 1979 | |5;imaging-gaussian-blur;87;91;85;92;93;140;130;93;86;94 10:41:35 INFO - PROCESS | 1979 | |6;imaging-darkroom;95;95;94;95;94;95;96;93;95;94 10:41:35 INFO - PROCESS | 1979 | |7;imaging-desaturate;88;87;87;85;87;85;86;86;86;85 10:41:35 INFO - PROCESS | 1979 | |8;json-parse-financial;57;72;76;58;55;53;53;64;52;55 10:41:35 INFO - PROCESS | 1979 | |9;json-stringify-tinderbox;66;69;76;73;69;67;66;68;67;66 10:41:35 INFO - PROCESS | 1979 | |10;stanford-crypto-aes;83;81;83;80;82;81;83;84;83;84 10:41:35 INFO - PROCESS | 1979 | |11;stanford-crypto-ccm;122;115;124;109;128;125;126;116;123;124 10:41:35 INFO - PROCESS | 1979 | |12;stanford-crypto-pbkdf2;137;138;139;137;137;123;132;138;147;166 10:41:35 INFO - PROCESS | 1979 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;66;66;68;67;65 10:41:35 INFO - PROCESS | 1979 | __end_tp_report 10:41:35 INFO - PROCESS | 1979 | __start_cc_report 10:41:35 INFO - PROCESS | 1979 | _x_x_mozilla_cycle_collect,1129 10:41:35 INFO - PROCESS | 1979 | __end_cc_report 10:41:35 INFO - PROCESS | 1979 | __startTimestamp1456252894995__endTimestamp 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | ------- Summary: start ------- 10:41:35 INFO - PROCESS | 1979 | Number of tests: 14 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:2.07 10:41:35 INFO - PROCESS | 1979 | Values: 111.0 109.0 111.0 110.0 111.0 112.0 115.0 110.0 109.0 108.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:143.50 stddev:16.72 (11.7%) stddev-sans-first:15.44 10:41:35 INFO - PROCESS | 1979 | Values: 160.0 119.0 146.0 154.0 117.0 141.0 139.0 118.0 152.0 120.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#2] audio-dft Cycles:10 Average:184.90 Median:186.00 stddev:1.85 (1.0%) stddev-sans-first:1.94 10:41:35 INFO - PROCESS | 1979 | Values: 184.0 187.0 186.0 186.0 186.0 186.0 186.0 184.0 181.0 183.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#3] audio-fft Cycles:10 Average:77.80 Median:75.00 stddev:17.62 (23.5%) stddev-sans-first:18.67 10:41:35 INFO - PROCESS | 1979 | Values: 76.0 81.0 105.0 107.0 81.0 62.0 58.0 79.0 74.0 55.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:79.00 stddev:17.91 (22.7%) stddev-sans-first:18.99 10:41:35 INFO - PROCESS | 1979 | Values: 95.0 94.0 125.0 79.0 79.0 81.0 112.0 78.0 77.0 115.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#5] imaging-gaussian-blur Cycles:10 Average:99.10 Median:91.50 stddev:19.32 (21.1%) stddev-sans-first:19.99 10:41:35 INFO - PROCESS | 1979 | Values: 87.0 91.0 85.0 92.0 93.0 140.0 130.0 93.0 86.0 94.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 10:41:35 INFO - PROCESS | 1979 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 96.0 93.0 95.0 94.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.03 (1.2%) stddev-sans-first:0.87 10:41:35 INFO - PROCESS | 1979 | Values: 88.0 87.0 87.0 85.0 87.0 85.0 86.0 86.0 86.0 85.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:57.50 stddev:8.42 (14.6%) stddev-sans-first:8.89 10:41:35 INFO - PROCESS | 1979 | Values: 57.0 72.0 76.0 58.0 55.0 53.0 53.0 64.0 52.0 55.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:3.33 (4.9%) stddev-sans-first:3.39 10:41:35 INFO - PROCESS | 1979 | Values: 66.0 69.0 76.0 73.0 69.0 67.0 66.0 68.0 67.0 66.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 10:41:35 INFO - PROCESS | 1979 | Values: 83.0 81.0 83.0 80.0 82.0 81.0 83.0 84.0 83.0 84.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:124.00 stddev:5.94 (4.8%) stddev-sans-first:6.29 10:41:35 INFO - PROCESS | 1979 | Values: 122.0 115.0 124.0 109.0 128.0 125.0 126.0 116.0 123.0 124.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.40 Median:138.00 stddev:11.11 (8.0%) stddev-sans-first:11.75 10:41:35 INFO - PROCESS | 1979 | Values: 137.0 138.0 139.0 137.0 137.0 123.0 132.0 138.0 147.0 166.0 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - PROCESS | 1979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 10:41:35 INFO - PROCESS | 1979 | Values: 66.0 66.0 68.0 67.0 67.0 66.0 66.0 68.0 67.0 65.0 10:41:35 INFO - PROCESS | 1979 | -------- Summary: end -------- 10:41:35 INFO - PROCESS | 1979 | 10:41:35 INFO - TEST-INFO | 1979: exit 0 10:41:35 INFO - TEST-OK | kraken | took 56507ms 10:41:35 INFO - SUITE-END | took 1170s 10:41:36 INFO - Completed test suite (00:19:31) 10:41:36 INFO - Working with test: dromaeo_css 10:41:36 INFO - Generating results file: dromaeo_css 10:41:36 INFO - Working with test: kraken 10:41:36 INFO - Generating results file: kraken 10:41:36 INFO - javascript benchmark 10:41:36 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:41:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 10:41:36 INFO - process_Request line: dromaeo_css 7514.96 graph.html#tests=[[72,1,59]] 10:41:36 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:41:36 INFO - process_Request line: kraken 1421.10 graph.html#tests=[[232,1,59]] 10:41:36 INFO - RETURN: dromaeo_css: 7514.96 10:41:36 INFO - RETURN: kraken: 1421.10 10:41:36 INFO - javascript benchmark 10:41:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3425.588929328481, 3468.236987862669, 3478.06092355064, 3497.9475307870384, 3558.893233203005, 5560.388357280706, 5673.546116310696, 5693.28833895763, 5727.083666613348, 5771.36514983352, 5616.466435688613, 5679.801206957757, 5693.117566777156, 5724.4561766632105, 5774.105013722869, 4618.445786505624, 4843.982763619644, 5086.898262034757, 5114.411842638097, 5240.161574148137, 5239.21411788231, 5269.499397557226, 5278.709670968095, 5284.867878303035, 5336.9733151334185, 5134.486551344854, 5135.3324067870935, 5212.296339994109, 5235.502627250443, 5259.579233661336, 5182.974085129588, 5206.401263854667, 5222.1905604630965, 5229.137192363255, 5229.607779416559, 5139.306193663845, 5176.534111929906, 5184.066867963765, 5220.0, 5221.660592061504, 5462.0987537056335, 5510.283663123809, 5589.720513974285, 5610.943890561083, 5613.691246981414, 6153.353897840751, 6166.722497487579, 6185.226846644169, 6190.504759619264, 6201.0, 6160.630362178284, 6174.814755557296, 6191.102290167945, 6195.349488303708, 6203.751849925998, 5593.636413633141, 5677.602567820213, 5739.13912913058, 5762.538996880281, 5770.990076736596, 6234.37656234382, 6240.00159974402, 6242.282137554149, 6244.562880598405, 6270.905936410957, 6060.848478787977, 6068.605540639845, 6134.2332208473945, 6141.324454310023, 6151.753929842756, 5843.620164689281, 6085.391460853879, 6162.0, 6189.35011823761, 6199.597026193283, 6140.263168419729, 6147.631142131487, 6163.660998645118, 6166.969165154145, 6170.753169873155, 6182.938170618326, 6183.258009038944, 6189.319174890758, 6190.628562286187, 6201.441870231701, 4793.448753393334, 4890.926636100461, 4893.192623217201, 4898.975505122452, 4900.26496025599, 3951.4665520154413, 4369.563043695605, 4471.642268618502, 4474.865754027384, 4474.910501789946, 5563.0, 5660.0, 5714.457126572969, 5724.971375143097, 5734.483896449339, 6095.377886651403, 6116.311491734732, 6150.138980542728, 6165.537584681167, 6180.721867515973, 5758.712064396764, 5759.827205183851, 5766.509846663081, 5775.653460792366, 5788.5369170466265, 5362.597805164628, 5366.221897824794, 5366.409694933554, 5373.596980226499, 5374.3013408256675, 6208.410201030895, 6317.652529110943, 6345.524085693592, 6382.872342553216, 6383.2978372378075, 6163.876722465615, 6172.4136207060255, 6177.351378105414, 6191.504679625709, 6205.317415084427, 6154.661493617894, 6296.716647750771, 6356.237251529846, 6382.042693595998, 6393.424591786761, 6124.228368151265, 6129.938700612936, 6159.0, 6171.537134715004, 6175.59858609189, 6165.691715414301, 6170.876582468415, 6171.722272497658, 6178.567500275118, 6188.44304012641, 5980.252468441445, 6049.18336024631, 6086.573939824169, 6098.553255670888, 6104.186323682738, 6085.087236914498, 6088.939110609014, 6099.451049405575, 6104.38956104386, 6125.693715314127, 5765.56758243125, 5822.854428639318, 5912.408759124225, 5967.76128954837, 5981.7308221131025, 5988.940110598838, 6018.638881667114, 6027.758889644365, 6029.51763858899, 6042.667653279112, 5919.4080591940465, 5927.377625349449, 5963.165156877953, 5966.433188847052, 6012.518998480198], "unit": "score", "name": "dojo.html", "value": 5673.769372968538}, {"lowerIsBetter": false, "replicates": [453.0, 487.87071426072094, 493.5434722881334, 557.5288880895642, 577.9885200898425, 28831.423371532557, 30131.84934075329, 37753.81123094387, 38047.42928856069, 38283.234335313275, 40898.79550602243, 41215.0, 41264.58735412645, 41293.58706412935, 41390.0, 9499.002604726507, 9693.854592181124, 9725.756856078584, 9726.367786093917, 9731.756706082333, 9516.666916657918, 9668.274879384038, 9670.371425857333, 9695.0, 9695.70912872615, 9813.264005199602, 9850.655227067055, 9862.0, 9875.1112399884, 9891.0, 9749.902500974971, 9807.950960245153, 9812.264080193943, 9812.901870981306, 9815.0, 9366.391184573049, 9481.810363792754, 9491.38306010107, 9507.809843803154, 9508.90491095087, 39253.01867453336, 39666.40500392496, 39676.60323396758, 39701.60298397008, 39772.0, 3176.8093914365213, 3321.7342612590933, 3471.9652803471895, 3550.7336949728615, 3810.923781524382, 28733.281667958257, 29128.271793205127, 29331.706682933112, 29641.110766677033, 29876.0, 2206.3380985704225, 2809.115128734442, 2840.1763488588285, 2851.0734011446157, 2864.6992065833206, 496015.0, 497573.9999999964, 497585.0, 499443.0, 538699.6130038688, 62320.0, 62466.375336246965, 63046.0, 63076.0, 63184.10447686577, 63697.68151159307, 63929.68035159887, 63953.36046639474, 64006.0, 64038.0, 15655.295511702001, 15793.921030395004, 15863.920680396755, 15866.206689665702, 15873.761893571605, 11976.88023119775, 12224.694382640506, 12416.875831241752, 12441.129120961446, 12443.75112497763, 20543.691844622343, 20750.0, 20776.857272849837, 20783.376498705064, 20849.58300833975, 8791.780205494786, 9031.0, 9081.59132839024, 9092.954535227414, 9128.863067053999, 933.5145724223502, 939.145377706284, 970.898055704155, 1031.7781676939494, 1080.3355936099242, 27576.353453640324, 28547.0, 28849.85575072111, 28990.710092899222, 29112.417751644847, 856.738694698123, 1020.2705065877933, 1078.045929352513, 1095.3537412926253, 1114.9442527873573, 15119.470818521298, 15754.842451575567, 15782.60543486399, 15823.841761582467, 15917.602059948595, 728337.0, 733755.0, 741362.0, 882357.0, 908302.0, 58274.41725582775, 59023.0, 59190.0, 59272.70363648154, 59567.702161488916, 1293.4502836294348, 1435.095889589552, 1449.0943160524673, 1453.9200343980972, 1567.2868844675645, 24992.756446762032, 29808.956686515867, 29836.552451712807, 30495.0, 30800.22999424943, 51747.22379164391, 52437.737811312225, 52856.73571632117, 52909.7354513225, 52975.0, 412637.0, 480548.0, 483028.0, 484134.0, 487955.0, 31516.842415787774, 31893.36213275768, 32274.0, 32280.0, 32385.0, 42523.787381062895, 42810.785946071315, 43382.0, 43599.0, 43699.0, 29164.7083529162, 29846.0, 35126.824365878005, 35376.823115884254, 35427.93716188519, 35108.946731598095, 35421.291574168885, 35691.46462803112, 35823.104422389646, 35823.82088089543, 37058.814705927376, 37239.6276037247, 38138.0, 38227.61772382352, 38349.808250958566, 29420.11739647814, 31553.89561365341, 31834.522482162323, 32353.514697280032, 32834.67165328412, 22509.0, 24727.38181545404, 24790.0, 25007.499850002536, 25009.834041218848], "unit": "score", "name": "ext.html", "value": 19869.371109997897}, {"lowerIsBetter": false, "replicates": [364.855881926639, 367.51488035792755, 368.16977715252085, 375.11847159175954, 375.35626400722754, 15180.696386072272, 15752.921235393807, 19360.515987100312, 19534.0, 20475.488112797168, 19111.13999870006, 19334.709979350286, 19536.70694939577, 19564.0, 19797.812131272134, 5504.256925315071, 5798.82603521895, 5826.6212696174825, 5830.4169583041785, 6453.0, 4155.231282212785, 4349.369341445488, 5302.469753024686, 5408.296921400212, 6314.968425157867, 5398.082326004589, 5421.647592906468, 5424.294841670578, 5436.048691478995, 5446.591505637093, 5327.786888524454, 5404.891902161954, 6389.584676996027, 6405.263394709575, 6407.935920640827, 5503.229547863302, 5515.917261241045, 5521.944780552183, 5531.059719847635, 5531.170324451365, 24768.628470572956, 25108.0, 25266.242012739647, 25387.984480620755, 25438.618420723706, 2125.9370314842577, 2136.3163787587823, 2141.4646338415396, 2414.09028321232, 2921.0238024101227, 13611.11527750703, 14010.369533371022, 14352.712945741132, 14440.711185776225, 14908.0, 1707.8292170782822, 1750.8599312055005, 1758.2439550993067, 1783.3669047488215, 1785.3840425053336, 87530.0, 97827.53258701126, 101903.0, 109828.90171098347, 114517.0, 10236.948815256024, 10686.358818470917, 11073.889261107286, 11077.833832492519, 11185.832212516818, 13283.667908302177, 13342.19946803195, 13358.198508089352, 13391.799123013163, 13400.93299533496, 8249.752507424666, 8349.874751878726, 8364.958175209085, 8427.32581393487, 8436.578171091543, 8451.45065570736, 8458.28104611115, 8482.533460659723, 8533.232009119209, 8562.229399353964, 4323.416338794285, 4395.230834603932, 4402.669799765031, 4428.18444437779, 4447.866564003085, 1739.2955852879604, 1788.8926664400178, 1796.9371072012677, 1833.3125078095713, 1860.2373027059111, 856.5545916123581, 888.1739981816843, 916.8212198621338, 991.2218908157062, 1033.4419413516616, 15643.374265029272, 18479.181404246447, 19421.0, 19961.800381995996, 20538.0, 860.617025423693, 869.8956125265008, 894.9373543851868, 931.3899395895563, 938.7465384346189, 9832.01679832011, 10055.547500362502, 10056.899431005597, 10073.29486935922, 10224.846627300596, 500833.0, 614619.0, 615378.0, 650866.7456662781, 653367.0, 102845.97154028364, 117876.0, 117959.0, 118853.0, 122566.3871680636, 952.1668540027476, 981.0532835813474, 990.4255531791543, 993.1855878179967, 1001.7095042437611, 16984.745228821826, 17537.860039097417, 17582.0, 17790.822091778915, 17925.014124223293, 51451.228231577305, 52155.47844521506, 52617.0, 52905.59321694889, 52968.0, 73380.63309683418, 73845.6307718458, 76708.7205734893, 77324.0, 79049.60475197587, 7916.920830791849, 7927.960360198162, 7940.960295198487, 7969.24292192264, 8011.278984891154, 11287.661370158909, 12752.171108877894, 13006.414711338202, 13042.347882606022, 13076.280804555841, 7897.960510197412, 7945.682172713026, 10812.024000119438, 11005.009549140615, 11377.374244416636, 9369.765755856159, 9709.640650309104, 11009.449527523431, 11162.107031437628, 11405.828912566483, 11638.149084957662, 11777.823332650189, 11850.0, 11967.461464234304, 11977.820332695192, 6502.544821862424, 6796.320367963164, 7768.805779855323, 7910.367170626221, 8127.3091787198755, 10691.30506517074, 10951.83572246401, 11127.499262533367, 11247.775044499227, 11516.654500365003], "unit": "score", "name": "jquery.html", "value": 9282.337623284477}, {"lowerIsBetter": false, "replicates": [1384.1072508232185, 1528.5567185516202, 1552.4178433087595, 1736.426979096898, 1810.131137054214, 7112.288771122891, 8728.825423491526, 8877.51173685447, 8882.689105881296, 8882.77793055173, 7380.704771809134, 8488.23605875471, 8807.603657835412, 8817.162369574897, 8824.073472285414, 2214.413180507167, 2439.109724950389, 2490.9750902491014, 2507.2728908616477, 2522.092046863128, 2455.5812524663193, 2527.3428908483743, 2537.8350407223566, 2541.07250853439, 2542.1610868413472, 2111.42991392324, 2477.7398373170736, 2483.7640424159677, 2487.328421326241, 2495.7753802157804, 2170.2729585588845, 2414.7102347718387, 2471.1351027140536, 2478.479519300949, 2479.1818699829014, 2442.1452491627965, 2474.5174690935273, 2476.3561474016706, 2485.179890636086, 2489.9004039838383, 8857.11428857109, 8931.508767017876, 8947.373683842134, 8949.686760963401, 8952.820943581157, 5430.484104010113, 5510.752016159283, 5581.888362232773, 5585.748641311151, 5592.86017849557, 3684.9815750921343, 3713.275911197318, 3785.6782173515285, 3791.9810400948095, 3814.694824414068, 882.5631312500353, 1063.0379506546587, 1063.3141623652778, 1096.7970925378831, 1100.301308669001, 12051.638450846402, 12204.633860984184, 12222.961048310905, 12223.205491643015, 12230.938845305805, 4943.5797957174045, 4945.085159245551, 4992.500749925051, 5024.296598476216, 5026.924596131061, 10373.0, 10392.584296628202, 10400.583976641, 10403.635872744419, 10405.115565176893, 5056.292119103328, 5552.167174923794, 5560.999020176326, 5563.193336966117, 5573.108302671634, 4631.212693842055, 4826.517348265145, 4924.261360795909, 4979.05397974391, 4992.301077849104, 3983.322835118037, 3984.7609143451486, 3994.08136128692, 4034.6483927884487, 4039.7980100994832, 1099.2580008494394, 1314.3559655768604, 1326.9137506062075, 1327.8008298755071, 1331.10150648312, 1034.8344264917578, 1048.6906362623045, 1173.8826117388194, 1366.3031853754658, 1367.3368416318078, 8120.878186827203, 8281.95859020701, 8284.337253019745, 8286.627101780434, 8287.419880608299, 505.38595606338475, 509.76041260607457, 515.1782906264502, 520.9348831396076, 524.1822756499796, 6242.75028998844, 6259.906101408483, 6295.842603934847, 6318.557700960889, 6319.368063193644, 10653.84019239712, 11044.447777611087, 11127.499262533205, 11130.833037504444, 11143.164262680331, 10565.894341056492, 10927.344359338465, 10980.694054248697, 10988.560457581607, 10995.0, 8421.70524031656, 8431.789205269917, 8486.915130848736, 8487.872681909776, 8498.53258070812, 7827.139014708264, 7976.641051152828, 8022.9598852005365, 8187.83624327522, 8189.590520474072, 9425.57584908667, 9659.613615455584, 9714.3199976001, 9870.753231169278, 9958.15355694774, 9993.700188994342, 10206.438645874252, 10394.532246048795, 10426.426546540013, 10432.478376081013, 7661.080670319598, 7700.268474495138, 7709.614519274126, 7754.108277548155, 7754.883676744967, 8342.499450033018, 8350.248477637042, 8417.242448179693, 8435.83128337442, 8437.873431898404, 7439.888401673871, 7588.127365352834, 7644.961775191088, 7665.156832748505, 7684.193159718373, 7216.061911951413, 7341.963290183515, 7444.702211911463, 7477.476576639583, 7559.433042521723, 7893.36853051743, 7921.683132674629, 7970.40221983342, 7977.843212734238, 7982.121966583787, 7130.465215108784, 7147.428205743632, 7202.099737532809, 7207.747728829466, 7229.204787473269, 7275.963620181865, 7280.745173918887, 7335.8532829344185, 7342.743003994835, 7347.7795666130105], "unit": "score", "name": "mootools.html", "value": 4894.899296045871}, {"lowerIsBetter": false, "replicates": [318.6351627386642, 321.93078488125064, 330.38548300161705, 330.46629693045736, 333.53638442564824, 5220.608454365919, 6374.968125159379, 6524.543281970264, 6552.180977377828, 6594.802155935324, 6328.462080723132, 6398.9040164397575, 6461.095446637462, 6463.450606698425, 6467.320931302216, 4863.367762190928, 4866.707997520151, 4874.390701162355, 4883.804647814083, 4895.388076490439, 4056.797160141996, 4676.555727205927, 4866.416030076378, 4886.877828054292, 4915.803367865281, 4832.0, 4855.5872750816225, 4861.586765124968, 4864.173090574611, 4867.415910090794, 4845.0552142332435, 4847.44254410742, 4853.369062021915, 4856.223004319328, 4867.464578896319, 3363.512290717832, 4152.0, 4164.12553363794, 4166.854160104382, 4189.748615083105, 6141.232345956755, 6233.376662333776, 6233.875322493524, 6236.43872051513, 6246.437820596168, 4319.870403887857, 4983.651144419892, 5557.638753481011, 5663.348714897798, 5674.914876276859, 6162.291336496271, 6397.392247736458, 6938.236793952711, 6948.0, 7000.0, 4533.387992620987, 4534.59188673021, 4540.954590454086, 4548.067646132535, 4549.954500454986, 5906.557008224358, 7170.928290717078, 7323.926760732431, 7340.853182936311, 7349.412047036224, 4529.68292219548, 4551.749653769075, 4577.977110114428, 4580.0, 4589.541045895384, 4645.74448405341, 4670.486246512881, 4674.252119660906, 4679.227927391942, 4679.766011699401, 5565.16522521625, 5570.916436253459, 5582.358028826737, 5585.776568937278, 5586.050371436865, 6511.023346497968, 6738.898916516257, 7049.647517624098, 7054.788356349215, 7057.258987806206, 1600.815906170782, 1612.0972255536938, 1627.7232870411822, 1628.8778341624425, 1629.5681644364254, 1022.1669339488293, 1031.5718976624767, 1038.7143535527791, 1044.738815296176, 1050.8528805967171, 6588.670566471753, 6592.769253076215, 6599.934000660028, 6607.636579988147, 6634.772567075107, 7304.853902921912, 7315.561066336037, 7320.1581818090535, 7325.2674732527385, 7337.633118344062, 5369.919451208235, 5606.803761868397, 6610.471162307004, 6614.04096406028, 6619.3380661933425, 3733.3466643337306, 3828.9234215316096, 3870.4581358609817, 3873.8837834865, 3887.2225554889137, 5978.953683105439, 6190.350013248634, 7156.964215178995, 7638.770836874903, 7647.197044310267, 7387.9261207387235, 7466.066741657293, 7468.215837337001, 7469.925300746923, 7479.439042071866, 6808.795736127924, 7581.583012934341, 7588.27911348421, 7607.505512141693, 7615.771526854203, 7162.46281528877, 7275.199728030018, 7276.745313913988, 7286.562806231643, 7294.562326260441, 7251.818704532217, 7293.52592081513, 7313.0, 7314.926850731425, 7337.559746415232, 7758.3017528422715, 7767.92232077672, 7778.533288002738, 7783.649735761791, 7793.454458187873, 4637.9332753466215, 4683.648726345606, 4688.038952014897, 4692.155412025868, 4693.671442998957, 6668.799936001928, 7038.612876291853, 7387.2243414442855, 7392.039034925425, 7407.481476296607, 7053.717851285891, 7147.82130446743, 7150.7497237596435, 7154.892676609959, 7159.8568028640175, 7061.717531298896, 7092.219855815959, 7134.108236470442, 7137.393321567517, 7137.821554460972, 6939.4795390346935, 6954.3045695430055, 6960.512764106464, 6963.268856770169, 6968.95465680152, 6905.861882762417, 7127.8574428512175, 7128.322809333105, 7129.964350178216, 7140.46446516503, 6932.44540436774, 6963.09479767627, 6972.302769722987, 6981.965090174516, 6983.0], "unit": "score", "name": "prototype.html", "value": 5095.618054730748}, {"lowerIsBetter": false, "replicates": [566.297790739483, 632.8702615963725, 634.9174607301051, 726.8618962397144, 742.3430264216167, 14263.78604320936, 14602.19687917164, 15455.381784728597, 15536.990095643776, 15543.300551475182, 14977.101373917572, 15271.312790924407, 15282.312295946682, 15286.31211595478, 15306.923465382657, 702.8137543550963, 718.7268837841626, 796.8804679298094, 846.1538461538462, 892.5180402582598, 872.9650813967434, 878.7188099808064, 879.6085741844881, 879.8152387998528, 882.1795729971125, 943.1323182671958, 943.2312665177858, 945.5461378538306, 945.7115579748174, 947.1759569174827, 901.8737376767258, 937.70931011386, 937.9624815007392, 940.9790377440486, 944.8677185194078, 692.4910191009604, 692.7817737412698, 693.4729605499806, 694.2190036209265, 696.4880812602732, 15278.923605381902, 15316.923415382964, 15356.308966096552, 15356.846431535654, 15364.154971476564, 12997.15518491295, 13073.346332683328, 13074.0, 13317.53388631403, 13586.660333491644, 10158.695239142837, 10173.79652406955, 10298.485075746257, 10712.0, 10834.241603087787, 3525.2596954639557, 3617.6744093031753, 3795.1460921292487, 3802.201537677091, 3806.1245913440066, 74749.25250747532, 75713.0, 77737.61131194365, 77938.0, 78154.21845781583, 9172.587233574504, 9304.302177336727, 9326.347155699172, 9398.389104708172, 9961.950190249147, 20178.697319540217, 20179.899100504404, 20205.29281475171, 20206.89896550508, 20266.0, 6522.282548919615, 7247.782566523013, 7403.259674032553, 7535.623218839146, 7666.923330766621, 4146.274401979642, 4149.668026557868, 4150.8339666413, 4156.418101465797, 4181.017460896687, 3465.653434656514, 3510.7717998330027, 3512.5258090157504, 3513.2622149348413, 3517.261375111204, 652.4291245160484, 655.2955572759303, 655.9508036897251, 687.1994126842272, 689.1489011071423, 559.7760895641776, 595.3599880128879, 603.4508597176548, 625.956183067181, 628.9905651415232, 8463.957680211559, 8503.532305723245, 8694.0, 8725.912740872636, 8774.824503510023, 551.9834404967858, 582.3215953414309, 600.8107446154447, 616.2512547255106, 622.1010639625697, 3267.2975310307925, 3454.378211921828, 3940.0937784309767, 4092.0997380576227, 4175.937360939588, 95682.0, 98335.50832245935, 98516.52225216628, 98577.0, 98883.0, 72075.91886121713, 72909.0, 74279.62860185665, 74443.62778186183, 74907.62546187235, 67765.0, 67862.3213767856, 71822.0, 72366.63816680883, 72534.0, 8856.64573417082, 8904.643814247358, 8913.275963739228, 8927.419717718327, 9034.638614455349, 48183.31194094658, 48848.778780530774, 49043.0, 49205.75397122991, 50831.983360333325, 58346.0, 65721.0, 69310.65344673244, 70132.64933675299, 70875.0, 10698.946505267424, 10795.784084318428, 10971.23201375928, 11039.116870650168, 11543.767745031404, 11833.881661183277, 11956.10329225329, 12236.082293828176, 12488.937555312164, 12722.61832145037, 11724.70688232801, 11855.466504007169, 11927.0458363329, 12040.157188996685, 12078.456469459072, 11141.164412669244, 11474.4262786862, 11770.0, 11835.230710003822, 12406.069544783997, 11337.319760814378, 11406.144539159763, 11631.941840290745, 11672.066234701033, 12324.137310388545, 8673.522956237468, 8953.955230223808, 9087.454752714859, 9125.17873391398, 9183.0, 8093.312068474245, 8386.412951093365, 8595.65617375298, 8938.374313798231, 8992.685256016008], "unit": "score", "name": "yui.html", "value": 6900.356661195071}], "name": "dromaeo_css", "value": 7514.961777078225}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 110.0, 111.0, 112.0, 115.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [160.0, 119.0, 146.0, 154.0, 117.0, 141.0, 139.0, 118.0, 152.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 136.6}, {"lowerIsBetter": true, "replicates": [184.0, 187.0, 186.0, 186.0, 186.0, 186.0, 186.0, 184.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [76.0, 81.0, 105.0, 107.0, 81.0, 62.0, 58.0, 79.0, 74.0, 55.0], "unit": "score", "name": "audio-fft", "value": 77.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 125.0, 79.0, 79.0, 81.0, 112.0, 78.0, 77.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [87.0, 91.0, 85.0, 92.0, 93.0, 140.0, 130.0, 93.0, 86.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 93.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.6}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 87.0, 85.0, 87.0, 85.0, 86.0, 86.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [57.0, 72.0, 76.0, 58.0, 55.0, 53.0, 53.0, 64.0, 52.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 76.0, 73.0, 69.0, 67.0, 66.0, 68.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 83.0, 80.0, 82.0, 81.0, 83.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [122.0, 115.0, 124.0, 109.0, 128.0, 125.0, 126.0, 116.0, 123.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [137.0, 138.0, 139.0, 137.0, 137.0, 123.0, 132.0, 138.0, 147.0, 166.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 66.0, 66.0, 68.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1421.1000000000004}]} 10:41:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1421.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7514.96"}}} 10:41:36 INFO - Return code: 0 10:41:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:41:36 INFO - # TBPL SUCCESS # 10:41:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:41:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:41:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:41:36 INFO - 2016-02-23 10:41:36.362 screenresolution[1983:13400] starting screenresolution argv=screenresolution get 10:41:36 INFO - 2016-02-23 10:41:36.365 screenresolution[1983:13400] Display 0: 1600x1200x32@60 10:41:36 INFO - 2016-02-23 10:41:36.371 screenresolution[1984:13403] starting screenresolution argv=screenresolution list 10:41:36 INFO - Available Modes on Display 0 10:41:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:41:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:41:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:41:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:41:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:41:36 INFO - Intel Iris: 10:41:36 INFO - Chipset Model: Intel Iris 10:41:36 INFO - Type: GPU 10:41:36 INFO - Bus: Built-In 10:41:36 INFO - VRAM (Dynamic, Max): 1536 MB 10:41:36 INFO - Vendor: Intel (0x8086) 10:41:36 INFO - Device ID: 0x0a2e 10:41:36 INFO - Revision ID: 0x0009 10:41:36 INFO - Displays: 10:41:36 INFO - Display: 10:41:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:41:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:41:36 INFO - Display Serial Number: 1600x1200 60 10:41:36 INFO - Main Display: Yes 10:41:36 INFO - Mirror: Off 10:41:36 INFO - Online: Yes 10:41:36 INFO - Rotation: Supported 10:41:36 INFO - Return code: 0 10:41:36 INFO - Running post-action listener: _resource_record_post_action 10:41:36 INFO - Running post-run listener: _resource_record_post_run 10:41:37 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2502656; Write bytes: 708220416; Read time: 42; Write time: 1890 10:41:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403362304; Write bytes: 398562816; Read time: 30188; Write time: 703 10:41:37 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2502656; Write bytes: 300195840; Read time: 42; Write time: 1145 10:41:37 INFO - Running post-run listener: _upload_blobber_files 10:41:37 INFO - Blob upload gear active. 10:41:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:37 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:41:37 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:41:37 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:41:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:39 INFO - (blobuploader) - INFO - Done attempting. 10:41:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:41:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:41:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:40 INFO - (blobuploader) - INFO - Done attempting. 10:41:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:40 INFO - Return code: 0 10:41:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e33f8edda0305fc821ab8875d6f6619b6e0c6231e8dde6953dc3a33b8be3b2c955b63d46b1dcb6905ffa4fb103dd1be2a5cb3022e5c8210025042b1294238173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2256bc53ddfba16b0407a516cb6d48e639ba9db54ffbbe1597221a35f303a105bd0ec95cd324a097e690cc0921c91406293301df38ae672daaf2d4c43f7872ae"} 10:41:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:40 INFO - Contents: 10:41:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e33f8edda0305fc821ab8875d6f6619b6e0c6231e8dde6953dc3a33b8be3b2c955b63d46b1dcb6905ffa4fb103dd1be2a5cb3022e5c8210025042b1294238173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2256bc53ddfba16b0407a516cb6d48e639ba9db54ffbbe1597221a35f303a105bd0ec95cd324a097e690cc0921c91406293301df38ae672daaf2d4c43f7872ae"} 10:41:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:40 INFO - Copying logs to upload dir... 10:41:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.953104 ========= master_lag: 1.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-23 10:41:41.542194) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 20 secs) (at 2016-02-23 10:41:41.546440) ========= 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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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/e33f8edda0305fc821ab8875d6f6619b6e0c6231e8dde6953dc3a33b8be3b2c955b63d46b1dcb6905ffa4fb103dd1be2a5cb3022e5c8210025042b1294238173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2256bc53ddfba16b0407a516cb6d48e639ba9db54ffbbe1597221a35f303a105bd0ec95cd324a097e690cc0921c91406293301df38ae672daaf2d4c43f7872ae"} build_url:https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e33f8edda0305fc821ab8875d6f6619b6e0c6231e8dde6953dc3a33b8be3b2c955b63d46b1dcb6905ffa4fb103dd1be2a5cb3022e5c8210025042b1294238173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2256bc53ddfba16b0407a516cb6d48e639ba9db54ffbbe1597221a35f303a105bd0ec95cd324a097e690cc0921c91406293301df38ae672daaf2d4c43f7872ae"}' ========= master_lag: 20.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 20 secs) (at 2016-02-23 10:42:01.603994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-02-23 10:42:01.604377) ========= 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.8UGSUmC1lq/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.ReAKDJ0cwr/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005358 ========= master_lag: 2.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-02-23 10:42:04.063486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:42:04.063771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:42:04.101551) ========= ========= Total master_lag: 24.52 =========