builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1454072863.13 results: success (0) buildid: 20160129030206 builduid: c6711eeb02994989ac086a7dab99fd0d revision: 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.125698) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.126040) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.126312) ========= 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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005899 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.157160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.157439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.174837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.175124) ========= 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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005343 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.236474) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.236734) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.237057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.237320) ========= 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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-01-29 05:07:43-- 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% 10.3M=0.001s 2016-01-29 05:07:43 (10.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.668849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.925371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.926160) ========= 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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.019790 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.980464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:43.981268) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 --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 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-01-29 05:07:44,056 truncating revision to first 12 chars 2016-01-29 05:07:44,056 Setting DEBUG logging. 2016-01-29 05:07:44,056 attempt 1/10 2016-01-29 05:07:44,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a3c5c9b1486?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 05:07:44,641 unpacking tar archive at: mozilla-central-8a3c5c9b1486/testing/mozharness/ program finished with exit code 0 elapsedTime=0.831593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:44.830514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:44.830952) ========= echo 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8a3c5c9b1486c3328bc4684d5ac5b3b849b09474'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 program finished with exit code 0 elapsedTime=0.005015 script_repo_revision: '8a3c5c9b1486c3328bc4684d5ac5b3b849b09474' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:44.880480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:44.880796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 05:07:44.894746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-29 05:07:44.895460) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:07:45 INFO - MultiFileLogger online at 20160129 05:07:45 in /builds/slave/test 05:07:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:07:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:45 INFO - {'append_to_log': False, 05:07:45 INFO - 'base_work_dir': '/builds/slave/test', 05:07:45 INFO - 'blob_upload_branch': 'Firefox', 05:07:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:45 INFO - 'branch': 'Firefox', 05:07:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:45 INFO - 'config_files': ('talos/mac_config.py',), 05:07:45 INFO - 'default_actions': ('clobber', 05:07:45 INFO - 'read-buildbot-config', 05:07:45 INFO - 'download-and-extract', 05:07:45 INFO - 'populate-webroot', 05:07:45 INFO - 'create-virtualenv', 05:07:45 INFO - 'install', 05:07:45 INFO - 'run-tests'), 05:07:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:45 INFO - 'download_minidump_stackwalk': True, 05:07:45 INFO - 'download_symbols': 'ondemand', 05:07:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:45 INFO - 'installer_path': 'installer.exe', 05:07:45 INFO - 'log_level': 'info', 05:07:45 INFO - 'log_name': 'talos', 05:07:45 INFO - 'log_to_console': True, 05:07:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:45 INFO - 'opt_config_files': (), 05:07:45 INFO - 'pip_index': False, 05:07:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:45 INFO - 'cmd': ('bash', 05:07:45 INFO - '-c', 05:07:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:45 INFO - 'enabled': True, 05:07:45 INFO - 'halt_on_failure': False, 05:07:45 INFO - 'name': 'check_screen_resolution'},), 05:07:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:45 INFO - 'cmd': ('bash', 05:07:45 INFO - '-c', 05:07:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:45 INFO - 'enabled': True, 05:07:45 INFO - 'halt_on_failure': False, 05:07:45 INFO - 'name': 'check_screen_resolution'},), 05:07:45 INFO - 'run_cmd_checks_enabled': True, 05:07:45 INFO - 'sps_profile': False, 05:07:45 INFO - 'sps_profile_interval': 0, 05:07:45 INFO - 'suite': 'dromaeojs-e10s', 05:07:45 INFO - 'system_bits': '32', 05:07:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:45 INFO - 'title': 't-yosemite-r7-0083', 05:07:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:45 INFO - 'use_talos_json': True, 05:07:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:45 INFO - 'work_dir': 'build'} 05:07:45 INFO - ##### 05:07:45 INFO - ##### Running clobber step. 05:07:45 INFO - ##### 05:07:45 INFO - Running pre-action listener: _resource_record_pre_action 05:07:45 INFO - Running main action method: clobber 05:07:45 INFO - rmtree: /builds/slave/test/build 05:07:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:45 INFO - Running post-action listener: _resource_record_post_action 05:07:45 INFO - ##### 05:07:45 INFO - ##### Running read-buildbot-config step. 05:07:45 INFO - ##### 05:07:45 INFO - Running pre-action listener: _resource_record_pre_action 05:07:45 INFO - Running main action method: read_buildbot_config 05:07:45 INFO - Using buildbot properties: 05:07:45 INFO - { 05:07:45 INFO - "project": "", 05:07:45 INFO - "product": "firefox", 05:07:45 INFO - "script_repo_revision": "production", 05:07:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:07:45 INFO - "repository": "", 05:07:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:07:45 INFO - "buildid": "20160129030206", 05:07:45 INFO - "stage_platform": "macosx64", 05:07:45 INFO - "basedir": "/builds/slave/test", 05:07:45 INFO - "nightly_build": "True", 05:07:45 INFO - "buildnumber": 111, 05:07:45 INFO - "slavename": "t-yosemite-r7-0083", 05:07:45 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:07:45 INFO - "platform": "yosemite_r7", 05:07:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:07:45 INFO - "branch": "mozilla-central", 05:07:45 INFO - "repo_path": "mozilla-central", 05:07:45 INFO - "revision": "8a3c5c9b1486c3328bc4684d5ac5b3b849b09474", 05:07:45 INFO - "pgo_build": "False", 05:07:45 INFO - "builduid": "c6711eeb02994989ac086a7dab99fd0d", 05:07:45 INFO - "slavebuilddir": "test" 05:07:45 INFO - } 05:07:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:07:45 INFO - Running post-action listener: _resource_record_post_action 05:07:45 INFO - ##### 05:07:45 INFO - ##### Running download-and-extract step. 05:07:45 INFO - ##### 05:07:45 INFO - Running pre-action listener: _resource_record_pre_action 05:07:45 INFO - Running main action method: download_and_extract 05:07:45 INFO - mkdir: /builds/slave/test/build/tests 05:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:45 INFO - https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/test_packages.json 05:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/test_packages.json 05:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:07:52 INFO - Downloaded 1277 bytes. 05:07:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:07:52 INFO - Using the following test package requirements: 05:07:52 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:07:52 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:52 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:07:52 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'jsshell-mac.zip'], 05:07:52 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:07:52 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:07:52 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:07:52 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:07:52 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:07:52 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:07:52 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:07:52 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:52 INFO - https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:07:56 INFO - Downloaded 16722356 bytes. 05:07:56 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'] 05:07:56 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 05:07:59 INFO - Return code: 0 05:07:59 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 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:07:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:07:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:08:18 INFO - Downloaded 16722356 bytes. 05:08:18 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'] 05:08:18 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 05:08:22 INFO - Return code: 0 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:08:23 INFO - Downloaded 10706582 bytes. 05:08:23 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'] 05:08:23 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 05:08:24 INFO - Return code: 0 05:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:24 INFO - https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAKs1odfQ76tZvjGNsb35w/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 05:08:32 INFO - Downloaded 111146742 bytes. 05:08:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:08:32 INFO - mkdir: /builds/slave/test/properties 05:08:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:32 INFO - Contents: 05:08:32 INFO - build_url:https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:08:32 INFO - Running post-action listener: _resource_record_post_action 05:08:32 INFO - Running post-action listener: set_extra_try_arguments 05:08:32 INFO - ##### 05:08:32 INFO - ##### Running populate-webroot step. 05:08:32 INFO - ##### 05:08:32 INFO - Running pre-action listener: _resource_record_pre_action 05:08:32 INFO - Running main action method: populate_webroot 05:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:32 INFO - '--tppagecycles', 05:08:32 INFO - '7'], 05:08:32 INFO - 'tests': ['tsvgm']}}, 05:08:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:08:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:08:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'tests': ['damp', 'tps']}, 05:08:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['damp', 'tps']}, 05:08:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:32 INFO - 'other': {'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore']}, 05:08:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore']}, 05:08:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore']}, 05:08:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore']}, 05:08:32 INFO - 'other_l64': {'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore']}, 05:08:32 INFO - 'other_nol64': {'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore']}, 05:08:32 INFO - 'svgr': {'tests': ['tsvgx', 05:08:32 INFO - 'tsvgr_opacity', 05:08:32 INFO - 'tart', 05:08:32 INFO - 'tscrollx', 05:08:32 INFO - 'cart']}, 05:08:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['tsvgx', 05:08:32 INFO - 'tsvgr_opacity', 05:08:32 INFO - 'tart', 05:08:32 INFO - 'tscrollx', 05:08:32 INFO - 'cart']}, 05:08:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'tests': ['tp5o']}, 05:08:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--e10s'], 05:08:32 INFO - 'tests': ['tp5o']}, 05:08:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--xperf_path', 05:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:32 INFO - 'tests': ['tp5n']}, 05:08:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--e10s', 05:08:32 INFO - '--xperf_path', 05:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:32 INFO - 'tests': ['tp5n']}}, 05:08:32 INFO - 'talos.zip': {'path': '', 05:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:32 INFO - Running post-action listener: _resource_record_post_action 05:08:32 INFO - ##### 05:08:32 INFO - ##### Running create-virtualenv step. 05:08:32 INFO - ##### 05:08:32 INFO - Running pre-action listener: _resource_record_pre_action 05:08:32 INFO - Running main action method: create_virtualenv 05:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:32 INFO - Using real prefix '/tools/python27' 05:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:36 INFO - Installing pip.................done. 05:08:36 INFO - Return code: 0 05:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:36 INFO - 'HOME': '/Users/cltbld', 05:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:36 INFO - 'LOGNAME': 'cltbld', 05:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:36 INFO - 'MOZ_NO_REMOTE': '1', 05:08:36 INFO - 'NO_EM_RESTART': '1', 05:08:36 INFO - 'PAGER': '/bin/cat', 05:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:36 INFO - 'PWD': '/builds/slave/test', 05:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:36 INFO - 'SHELL': '/bin/bash', 05:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:36 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:36 INFO - 'USER': 'cltbld', 05:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:36 INFO - 'XPC_FLAGS': '0x0', 05:08:36 INFO - 'XPC_SERVICE_NAME': '0', 05:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:08:36 INFO - Cleaning up... 05:08:36 INFO - Return code: 0 05:08:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:36 INFO - 'HOME': '/Users/cltbld', 05:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:36 INFO - 'LOGNAME': 'cltbld', 05:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:36 INFO - 'MOZ_NO_REMOTE': '1', 05:08:36 INFO - 'NO_EM_RESTART': '1', 05:08:36 INFO - 'PAGER': '/bin/cat', 05:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:36 INFO - 'PWD': '/builds/slave/test', 05:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:36 INFO - 'SHELL': '/bin/bash', 05:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:36 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:36 INFO - 'USER': 'cltbld', 05:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:36 INFO - 'XPC_FLAGS': '0x0', 05:08:36 INFO - 'XPC_SERVICE_NAME': '0', 05:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:36 INFO - Downloading/unpacking psutil>=0.7.1 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:39 INFO - Installing collected packages: psutil 05:08:39 INFO - Running setup.py install for psutil 05:08:39 INFO - building 'psutil._psutil_osx' extension 05:08:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:08:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:08:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:08:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:08:40 INFO - building 'psutil._psutil_posix' extension 05:08:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:08:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:40 INFO - ^ 05:08:40 INFO - 1 warning generated. 05:08:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:08:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:40 INFO - Successfully installed psutil 05:08:40 INFO - Cleaning up... 05:08:40 INFO - Return code: 0 05:08:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:40 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:40 INFO - 'HOME': '/Users/cltbld', 05:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:40 INFO - 'LOGNAME': 'cltbld', 05:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:40 INFO - 'MOZ_NO_REMOTE': '1', 05:08:40 INFO - 'NO_EM_RESTART': '1', 05:08:40 INFO - 'PAGER': '/bin/cat', 05:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:40 INFO - 'PWD': '/builds/slave/test', 05:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:40 INFO - 'SHELL': '/bin/bash', 05:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:40 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:40 INFO - 'USER': 'cltbld', 05:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:40 INFO - 'XPC_FLAGS': '0x0', 05:08:40 INFO - 'XPC_SERVICE_NAME': '0', 05:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:42 INFO - Installing collected packages: mozsystemmonitor 05:08:42 INFO - Running setup.py install for mozsystemmonitor 05:08:43 INFO - Successfully installed mozsystemmonitor 05:08:43 INFO - Cleaning up... 05:08:43 INFO - Return code: 0 05:08:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:43 INFO - 'HOME': '/Users/cltbld', 05:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:43 INFO - 'LOGNAME': 'cltbld', 05:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:43 INFO - 'MOZ_NO_REMOTE': '1', 05:08:43 INFO - 'NO_EM_RESTART': '1', 05:08:43 INFO - 'PAGER': '/bin/cat', 05:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:43 INFO - 'PWD': '/builds/slave/test', 05:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:43 INFO - 'SHELL': '/bin/bash', 05:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:43 INFO - 'USER': 'cltbld', 05:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:43 INFO - 'XPC_FLAGS': '0x0', 05:08:43 INFO - 'XPC_SERVICE_NAME': '0', 05:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:46 INFO - Downloading docopt-0.6.1.tar.gz 05:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:46 INFO - Running setup.py install for blobuploader 05:08:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:47 INFO - Running setup.py install for requests 05:08:47 INFO - Running setup.py install for docopt 05:08:47 INFO - Successfully installed blobuploader requests docopt 05:08:47 INFO - Cleaning up... 05:08:47 INFO - Return code: 0 05:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:48 INFO - 'HOME': '/Users/cltbld', 05:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PAGER': '/bin/cat', 05:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - 'XPC_FLAGS': '0x0', 05:08:48 INFO - 'XPC_SERVICE_NAME': '0', 05:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:48 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-4LsdTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:48 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-HzAR8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:48 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tdM4ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:48 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-2Ltbi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:48 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RQ8aHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:48 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-M89_nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-HvxFjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wdDU2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-S6gl8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-eTKnDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-sG1DWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-fZv2bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LHnbW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CWrMAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-56Gwlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:49 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AdCwcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:50 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-SO9U4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:50 INFO - Running setup.py install for manifestparser 05:08:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozcrash 05:08:50 INFO - Running setup.py install for mozdebug 05:08:50 INFO - Running setup.py install for mozdevice 05:08:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozfile 05:08:50 INFO - Running setup.py install for mozhttpd 05:08:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozinfo 05:08:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozInstall 05:08:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozleak 05:08:51 INFO - Running setup.py install for mozlog 05:08:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for moznetwork 05:08:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozprocess 05:08:51 INFO - Running setup.py install for mozprofile 05:08:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for mozrunner 05:08:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for mozscreenshot 05:08:52 INFO - Running setup.py install for moztest 05:08:52 INFO - Running setup.py install for mozversion 05:08:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:52 INFO - Cleaning up... 05:08:52 INFO - Return code: 0 05:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:52 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:52 INFO - 'HOME': '/Users/cltbld', 05:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:52 INFO - 'LOGNAME': 'cltbld', 05:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:52 INFO - 'MOZ_NO_REMOTE': '1', 05:08:52 INFO - 'NO_EM_RESTART': '1', 05:08:52 INFO - 'PAGER': '/bin/cat', 05:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:52 INFO - 'PWD': '/builds/slave/test', 05:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:52 INFO - 'SHELL': '/bin/bash', 05:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:52 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:52 INFO - 'USER': 'cltbld', 05:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:52 INFO - 'XPC_FLAGS': '0x0', 05:08:52 INFO - 'XPC_SERVICE_NAME': '0', 05:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:52 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VnybW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-xyG_d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 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)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-kh1Bqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-YKtP9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-73XCLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-K1urh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ENMvZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Vdoky0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oenTKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:53 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-rLkYBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-jRiFFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-D5lt_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-GwQQWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-0_o6qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Kgqa4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-TejroV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:54 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-2HAUbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:54 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)) 05:08:54 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)) 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:57 INFO - Downloading blessings-1.6.tar.gz 05:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:57 INFO - Installing collected packages: blessings 05:08:57 INFO - Running setup.py install for blessings 05:08:57 INFO - Successfully installed blessings 05:08:57 INFO - Cleaning up... 05:08:57 INFO - Return code: 0 05:08:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:58 INFO - Reading from file tmpfile_stdout 05:08:58 INFO - Current package versions: 05:08:58 INFO - blessings == 1.6 05:08:58 INFO - blobuploader == 1.2.4 05:08:58 INFO - docopt == 0.6.1 05:08:58 INFO - manifestparser == 1.1 05:08:58 INFO - mozInstall == 1.12 05:08:58 INFO - mozcrash == 0.16 05:08:58 INFO - mozdebug == 0.1 05:08:58 INFO - mozdevice == 0.48 05:08:58 INFO - mozfile == 1.2 05:08:58 INFO - mozhttpd == 0.7 05:08:58 INFO - mozinfo == 0.9 05:08:58 INFO - mozleak == 0.1 05:08:58 INFO - mozlog == 3.1 05:08:58 INFO - moznetwork == 0.27 05:08:58 INFO - mozprocess == 0.22 05:08:58 INFO - mozprofile == 0.28 05:08:58 INFO - mozrunner == 6.11 05:08:58 INFO - mozscreenshot == 0.1 05:08:58 INFO - mozsystemmonitor == 0.0 05:08:58 INFO - moztest == 0.7 05:08:58 INFO - mozversion == 1.4 05:08:58 INFO - psutil == 3.1.1 05:08:58 INFO - requests == 1.2.3 05:08:58 INFO - wsgiref == 0.1.2 05:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:58 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:58 INFO - 'HOME': '/Users/cltbld', 05:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:58 INFO - 'LOGNAME': 'cltbld', 05:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:58 INFO - 'MOZ_NO_REMOTE': '1', 05:08:58 INFO - 'NO_EM_RESTART': '1', 05:08:58 INFO - 'PAGER': '/bin/cat', 05:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:58 INFO - 'PWD': '/builds/slave/test', 05:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:58 INFO - 'SHELL': '/bin/bash', 05:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:58 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:58 INFO - 'USER': 'cltbld', 05:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:58 INFO - 'XPC_FLAGS': '0x0', 05:08:58 INFO - 'XPC_SERVICE_NAME': '0', 05:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:58 INFO - Cleaning up... 05:08:58 INFO - Return code: 0 05:08:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:58 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 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:58 INFO - 'HOME': '/Users/cltbld', 05:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:58 INFO - 'LOGNAME': 'cltbld', 05:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:58 INFO - 'MOZ_NO_REMOTE': '1', 05:08:58 INFO - 'NO_EM_RESTART': '1', 05:08:58 INFO - 'PAGER': '/bin/cat', 05:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:58 INFO - 'PWD': '/builds/slave/test', 05:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:58 INFO - 'SHELL': '/bin/bash', 05:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:08:58 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:58 INFO - 'USER': 'cltbld', 05:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:58 INFO - 'XPC_FLAGS': '0x0', 05:08:58 INFO - 'XPC_SERVICE_NAME': '0', 05:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:58 INFO - Downloading/unpacking jsonschema 05:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:01 INFO - warning: no files found matching '*.txt' 05:09:01 INFO - no previously-included directories found matching 'build' 05:09:01 INFO - no previously-included directories found matching 'dist' 05:09:01 INFO - no previously-included directories found matching '.git*' 05:09:01 INFO - Installing collected packages: jsonschema, functools32 05:09:01 INFO - Running setup.py install for functools32 05:09:01 INFO - warning: no files found matching '*.txt' 05:09:01 INFO - no previously-included directories found matching 'build' 05:09:01 INFO - no previously-included directories found matching 'dist' 05:09:01 INFO - no previously-included directories found matching '.git*' 05:09:01 INFO - Successfully installed jsonschema functools32 05:09:01 INFO - Cleaning up... 05:09:01 INFO - Return code: 0 05:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5ef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f1ad81dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:01 INFO - 'HOME': '/Users/cltbld', 05:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:01 INFO - 'LOGNAME': 'cltbld', 05:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:01 INFO - 'MOZ_NO_REMOTE': '1', 05:09:01 INFO - 'NO_EM_RESTART': '1', 05:09:01 INFO - 'PAGER': '/bin/cat', 05:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:01 INFO - 'PWD': '/builds/slave/test', 05:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:01 INFO - 'SHELL': '/bin/bash', 05:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:09:01 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:01 INFO - 'USER': 'cltbld', 05:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:01 INFO - 'XPC_FLAGS': '0x0', 05:09:01 INFO - 'XPC_SERVICE_NAME': '0', 05:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:01 INFO - Downloading/unpacking flake8 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:09:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:09:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:09:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:05 INFO - no previously-included directories found matching 'docs/_build' 05:09:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:09:05 INFO - Running setup.py install for pep8 05:09:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:05 INFO - no previously-included directories found matching 'docs/_build' 05:09:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:09:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:09:05 INFO - Cleaning up... 05:09:05 INFO - Return code: 0 05:09:05 INFO - Running post-action listener: _resource_record_post_action 05:09:05 INFO - Running post-action listener: _start_resource_monitoring 05:09:05 INFO - Starting resource monitoring. 05:09:05 INFO - ##### 05:09:05 INFO - ##### Running install step. 05:09:05 INFO - ##### 05:09:05 INFO - Running pre-action listener: _resource_record_pre_action 05:09:05 INFO - Running main action method: install 05:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:06 INFO - Reading from file tmpfile_stdout 05:09:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:06 INFO - Reading from file tmpfile_stdout 05:09:06 INFO - Output received: 05:09:06 INFO - Usage: mozinstall [options] installer 05:09:06 INFO - Options: 05:09:06 INFO - -h, --help show this help message and exit 05:09:06 INFO - -d DEST, --destination=DEST 05:09:06 INFO - Directory to install application into. [default: 05:09:06 INFO - "/builds/slave/test"] 05:09:06 INFO - --app=APP Application being installed. [default: firefox] 05:09:06 INFO - mkdir: /builds/slave/test/build/application 05:09:06 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'] 05:09:06 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 05:09:40 INFO - Reading from file tmpfile_stdout 05:09:40 INFO - Output received: 05:09:40 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:09:40 INFO - Running post-action listener: _resource_record_post_action 05:09:40 INFO - ##### 05:09:40 INFO - ##### Running run-tests step. 05:09:40 INFO - ##### 05:09:40 INFO - Running pre-action listener: _resource_record_pre_action 05:09:40 INFO - Running main action method: run_tests 05:09:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:40 INFO - 2016-01-29 05:09:40.077 screenresolution[2328:25799] starting screenresolution argv=screenresolution get 05:09:40 INFO - 2016-01-29 05:09:40.080 screenresolution[2328:25799] Display 0: 1600x1200x32@60 05:09:40 INFO - 2016-01-29 05:09:40.085 screenresolution[2329:25801] starting screenresolution argv=screenresolution list 05:09:40 INFO - Available Modes on Display 0 05:09:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:40 INFO - Intel Iris: 05:09:40 INFO - Chipset Model: Intel Iris 05:09:40 INFO - Type: GPU 05:09:40 INFO - Bus: Built-In 05:09:40 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:40 INFO - Vendor: Intel (0x8086) 05:09:40 INFO - Device ID: 0x0a2e 05:09:40 INFO - Revision ID: 0x0009 05:09:40 INFO - Displays: 05:09:40 INFO - Display: 05:09:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:40 INFO - Display Serial Number: 1600x1200 60 05:09:40 INFO - Main Display: Yes 05:09:40 INFO - Mirror: Off 05:09:40 INFO - Online: Yes 05:09:40 INFO - Rotation: Supported 05:09:40 INFO - Return code: 0 05:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:40 INFO - Python 2.7.3 05:09:40 INFO - Return code: 0 05:09:40 INFO - grabbing minidump binary from tooltool 05:09: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')]} 05:09:40 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 0x10e48dd30>, '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 0x10e2f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:09:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:09:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:40 INFO - Return code: 0 05:09:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:41 INFO - Return code: 0 05:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjYnkpPzN4/Render', 05:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:41 INFO - 'HOME': '/Users/cltbld', 05:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:41 INFO - 'LOGNAME': 'cltbld', 05:09:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:41 INFO - 'MOZ_NO_REMOTE': '1', 05:09:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:41 INFO - 'NO_EM_RESTART': '1', 05:09:41 INFO - 'PAGER': '/bin/cat', 05:09:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:41 INFO - 'PWD': '/builds/slave/test', 05:09:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:41 INFO - 'SHELL': '/bin/bash', 05:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ogAFM94Xm/Listeners', 05:09:41 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 05:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:41 INFO - 'USER': 'cltbld', 05:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:41 INFO - 'XPC_FLAGS': '0x0', 05:09:41 INFO - 'XPC_SERVICE_NAME': '0', 05:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:09:41 INFO - mozversion application_buildid: 20160129030206 05:09:41 INFO - mozversion application_changeset: 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 05:09:41 INFO - mozversion application_display_name: Nightly 05:09:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:41 INFO - mozversion application_name: Firefox 05:09:41 INFO - mozversion application_remotingname: firefox 05:09:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:09:41 INFO - mozversion application_vendor: Mozilla 05:09:41 INFO - mozversion application_version: 47.0a1 05:09:41 INFO - mozversion platform_buildid: 20160129030206 05:09:41 INFO - mozversion platform_changeset: 8a3c5c9b1486c3328bc4684d5ac5b3b849b09474 05:09:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:09:41 INFO - mozversion platform_version: 47.0a1 05:09:41 INFO - using testdate: 1454072981 05:09:41 INFO - actual date: 1454072981 05:09:42 INFO - starting webserver on 'localhost:57726' 05:09:42 INFO - SUITE-START | Running 2 tests 05:09:42 INFO - TEST-START | dromaeo_css 05:09:42 INFO - operating with platform_type : mac_ 05:09:42 INFO - Initialising browser for dromaeo_css test... 05:09:42 INFO - TEST-INFO | started process 2347 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpvtZ3cX/profile http://localhost:57726/getInfo.html) 05:09:45 INFO - PROCESS | 2347 | __metrics Screen width/height:1600/1200 05:09:45 INFO - PROCESS | 2347 | colorDepth:24 05:09:45 INFO - PROCESS | 2347 | Browser inner width/height: 1024/689 05:09:45 INFO - PROCESS | 2347 | __metrics 05:09:45 INFO - PROCESS | 2347 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:09:46 INFO - TEST-INFO | 2347: exit 0 05:09:46 INFO - Browser initialized. 05:09:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:46 INFO - TEST-INFO | started process 2352 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpvtZ3cX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:58 INFO - PROCESS | 2352 | RSS: Main: 255164416 05:09:58 INFO - PROCESS | 2352 | 05:10:48 INFO - PROCESS | 2352 | 1454073048168 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:12:58 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:57726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57726/tests/dromaeo/cssquery-ext.html) 05:13:00 INFO - PROCESS | 2352 | RSS: Main: 270659584 05:13:00 INFO - PROCESS | 2352 | 05:16:02 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:57726/tests/dromaeo/cssquery-ext.html (next: http://localhost:57726/tests/dromaeo/cssquery-jquery.html) 05:16:02 INFO - PROCESS | 2352 | RSS: Main: 282501120 05:16:02 INFO - PROCESS | 2352 | 05:19:04 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:57726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57726/tests/dromaeo/cssquery-mootools.html) 05:19:05 INFO - PROCESS | 2352 | RSS: Main: 283320320 05:19:05 INFO - PROCESS | 2352 | 05:22:06 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:57726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57726/tests/dromaeo/cssquery-prototype.html) 05:22:07 INFO - PROCESS | 2352 | RSS: Main: 285155328 05:22:07 INFO - PROCESS | 2352 | 05:25:10 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:57726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57726/tests/dromaeo/cssquery-yui.html) 05:25:10 INFO - PROCESS | 2352 | RSS: Main: 288903168 05:25:10 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:57726/tests/dromaeo/cssquery-yui.html (next: http://localhost:57726/tests/dromaeo/cssquery-dojo.html) 05:28:13 INFO - PROCESS | 2352 | RSS: Main: 290058240 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | __start_tp_report 05:28:13 INFO - PROCESS | 2352 | _x_x_mozilla_page_load 05:28:13 INFO - PROCESS | 2352 | _x_x_mozilla_page_load_details 05:28:13 INFO - PROCESS | 2352 | |i|pagename|runs| 05:28:13 INFO - PROCESS | 2352 | |0;dojo.html;2885.9567106493405;3182.8726850925964;3465.497502862085;3486.041338631877;3509.1051781795636;5552.91670624941;5567.9999999999945;5615.7472913718875;5621.522170615497;5640.576956728241;4654.674172807905;5547.500724934755;5704.942950570504;5734.283214598176;5772.653640781546;5105.259737338093;5176.5341119299255;5207.895842083156;5233.110371236899;5298.629095963284;5023.372078490189;5177.637565370425;5216.7913283468615;5253.080710875582;5299.814506492274;5074.974625126888;5102.693838369672;5145.691258524501;5170.017696637646;5185.403678576974;5128.820491282787;5135.948640513622;5136.332276804029;5159.458256883011;5176;4219.767912764797;5114.462981386975;5140.074786538422;5163.277141200235;5202.4277329493725;4639.280911458695;5331;5527;5572.136318870582;5671.574631902583;6177.876442471125;6183.752649893999;6191.690415479208;6194.876102477971;6195.163652906845;6158.815235542941;6162.630242185438;6177.907331390033;6191.195144631214;6194.194754681907;5677.091665333568;5787.768489260425;5817.214676018725;5892.410758924159;5923.7926672566255;6193.721282542297;6209.316975132731;6217.160683307786;6219.47134493564;6225.470834978987;5916.940830591725;6114.296855861633;6123.724432400552;6129.509639228851;6153.261608606996;6093.725782339805;6102.065131056412;6152.384761523901;6177.84555386119;6183.690815459299;6063.151158837766;6109.016487091993;6134.1119512865025;6144.2319710036245;6144.986077297285;6075.574709770273;6093.129299788002;6127.250613123855;6170.7223174957235;6215.689215539295;4821.614270858323;4872.171730805771;4906.215005599159;4927.137750893579;4942.481039490874;4377.146456440963;4390.209762242763;4411.514733379326;4420.403245561873;4468.039371535136;5579.972100139555;5732.77068917247;5753.993051216021;5775.740091695884;5802.4777770000055;6135.202423684892;6179.907301390483;6189.257289125334;6220.0047992321015;6225.190725205694;5737.85655358611;5791.305043394819;5803.6807975560905;5820.272465941757;5836.416358364129;4202.096549241866;4226.640735537452;4603;5335.439778823167;5479.342478902558;6281.7173227204885;6284.591501552384;6299.244090709144;6318.304986451487;6353.61878287295;6130.7241174146375;6152.692365381802;6214.347493513116;6225.875482490234;6231.906521402092;4955.281484184701;6145.324014358328;6212.347703491249;6322.936770632419;6324.873502530016;5807.970960145341;6054.66699331541;6068.059450785136;6086.908696369646;6100.694965251809;5644.294463192101;6084.787032453843;6199.194104766351;6203.596766210182;6212.192414986023;5953.434423729739;5992.520598352208;6005.939940600538;6031.819045428644;6057.939420605914;5879.2944846618675;6071.605345652519;6077.179580756541;6088;6088.756449742138;5612.579056570855;5846.035404158266;5971.462568368867;5981.970090149522;6010.609310394811;6036.849078773066;6073.787417440369;6080.69596520181;6100.883963092815;6131.816045518642;5905.202797622266;5919.6744179070565;5926.851828704317;5944;5978.432048955342 05:28:13 INFO - PROCESS | 2352 | |1;ext.html;472.22790737144777;495.39314339933577;568.5366426362514;568.907697221335;601.7893737191986;32174.35651286976;36414.27171456569;36480.81759591198;36545.90362289129;36657.45013824795;37535.62464375355;38042.61957380425;38059.04852378692;38135.046623834416;38293.042673933094;9227.123423274796;9429.057094290585;9437.716868493957;9452.385594936342;9452.43285402878;9273.07269273074;9521.28590355726;9528.666496672584;9530.237580993504;9559.95220023899;9456.905430945706;9573.377730447533;9576.904230957705;9592.760180995461;9604.327697061208;8297.917020829775;9483.099105584994;9545.761355966088;9594.280428967855;9635.807283854354;8262.843201951671;9316.8602470963;9329.953350233272;9463;9482.525873706287;30547.93082242133;30772.846135769178;37306.4404033937;37404.43893341602;37473.81263093694;2600.3759097816387;3086.2130156810094;3092.1651154188244;3351.1287065362935;3571.6606922342335;26220.344491387677;26491.940322387083;26695.932162713467;26926.19062992018;27369;2781.9304517387027;2806.7473927346637;2810.5081610718044;2827.5475923852086;2908.43285559316;325798;327220.36389818136;328582;328775.4928577512;328906;52201.47798522042;54836.90326193454;55127.44872551304;55154.44845551493;55165;49419.50580494221;52275;53190;64420.355796442374;64689.02966455507;15825.129617870898;15946.840531594535;16168.191590420667;16223.594410139605;16230.51308460748;12336.259824410565;12425.316607586488;12464.875351246554;12484.750304994031;12602.865742083257;18421.078946052643;18626.81373186251;18679.81320186808;18689.87860728361;18692;7047.54190977595;7279.818004549928;8656.999053171823;8683.913160868311;8716.43343182691;926.5043201886958;975.1418751498636;976.1409959235828;1014.5840205515703;1134.466800603715;29171.270718232216;29374.52946071214;29450.705492944795;29513.704862951527;29524.557131643043;1034.4672493665769;1068.3643232276784;1117.1565468071717;1130.796456637813;1209.4013463335705;15089.094654320776;15559.611009724847;15943.601409964844;15968.840311596967;16004.279807408695;489818;490219;493224;496831;496908;54703.72648136813;54999.72500137554;55292.723536382866;55329.723351382985;55361.72319138378;1414;1435.167602790379;1436.3249272841747;1453.600259928507;1563.679445713626;28814.991475298262;29307.560386593792;29610.703892960795;29634.962776302727;30530;48482.75758621185;53824.73087634537;54115.45884541104;54152.72923635357;54335.72832135814;339205;339236;340282;341005;341049;30191.698083018888;31076.68923310738;32910.34179316448;32963;33071.33857322888;39387.01532461711;39603.80198098991;40132.59867401289;40286.597134029456;40828.59171408367;33570.83214584009;35797.82101089478;35984.28031439409;36754.875835554274;36975.70585029511;33967.66032339744;34040.82979585185;34045.829770850985;34372.48441273433;35591.64408355987;33323.83366582158;33412.498812518315;33542.66457335493;33765;33958.83020584881;27416.588751169147;28092.71907280983;30407;30475.695243047285;30568.541471877495;19403.708944366128;21738;22319.995600197704;24202.51594968126;24211 05:28:13 INFO - PROCESS | 2352 | |2;jquery.html;308.5033096714291;313.40296734720357;357.9928401431973;364.5224755570203;365.0745360511105;15514.224288785572;15571.844281557182;16819.327226910926;18869.716954245698;19407.902960485197;16292.755608665879;17546;19544.902275488603;19604.215831366764;19682.311119110833;5361.812336568211;5646.322441307049;5903.616264942786;5903.970480147594;5916.852078698045;4169.166166766644;4370.257056300421;5811;5899.410058994109;5909.290885093795;6145.569810113294;6369.617822930616;6397.232332120152;6398.360163983611;6403.583767055126;6126.417990290915;6383.202099737533;6389.7763578274535;6394.488440924738;6414.166158399402;4748.19280722278;5482.753276102585;5509.696966666832;5522.475364840334;5538.224648549206;24138.155164569154;24618.261452156286;24676.13633522818;24976.37559061038;25188.622170667455;2243.450354663118;2263.7283525976823;2294.1626306398043;2371.1700904683394;2900.6374203224595;9105.954470227607;9205.447673139633;9783.0706082922;9845;12862.614121576367;1659.9004059756453;1717.467585048639;1735.0630659443884;1775.849052830511;1797.6854050541103;97075;102818.48590757074;102867.97132028658;103208.99999999924;103712;9099.408538444979;11187.216894817284;11208.27146235492;11302.135147700537;11377.43112844371;13480.25858577768;13532.661683457993;13536.390862411215;13566.728665426635;13582.932085339708;8533.701320453754;8534.573271336532;8553.828923421497;8574.914250857537;8578.828423431622;8639.395242332976;8669;8681.348898832613;8717.651293948298;8718.782030449289;4083.4079058536345;4323.092150648336;4413.073254616566;4449.466064072332;4475.1273501666865;1596.5609457399307;1813.4197056941916;1815.891046537212;1868.1873385077536;1898.933537326187;871.324723339417;888.2938064238946;891.0465801592363;919.94480331179;1049.6641074855972;11453.96914277719;18681.719774203397;19469.51326216856;19973.900130499256;20390.796092039185;432.7468430967856;439.18969501270107;442.7078128435217;450.3537423796862;458.90821835633005;6029.78895738647;6219.253689557282;8481.703140390056;8953.641854325884;11244.49399777012;358220;361658;362141;655823;695214;105802;107518.92481075246;107760.46119769351;109994;112651;504.2486694824685;505.524806681718;512.2955935588566;512.6385897941942;512.7666911555308;10854.728631784268;10860.891391085988;11653.47559359814;15673.68652626964;18581.16384762662;48208.758956205;48740.512594875014;48780.51219487902;49323.26015109704;50195;52761.153359632226;64039.679801600694;70366;70402.64798675974;73616;7540.9622951884885;7787.221277872394;7829.786383110627;7852.214778522102;7852.411069169721;11010.889891100986;11271.323720576791;11609.3614851184;11787.882121179022;12117.030637549151;9630.32587718881;10249.538770755484;10460.843087353544;10538.104261137889;10596.735081623021;10236.897631023594;10344.896551034695;10358.948205258925;10484.685459436228;10628.734281643021;9286.860697089414;10407.791844162923;10750.623728169476;10782.838257425989;10918.181136414642;7641.579713115832;7729.149793522821;7758.88361674564;7790.454668173174;7802.726904558313;9995.20038396941;10578.738623535466;10775.784484310114;10782.406967616542;10812.783744324912 05:28:13 INFO - PROCESS | 2352 | |3;mootools.html;1475.092817916981;1515.2499512741194;1705.9232334544945;1803.4950213940094;1831.2491878329888;7895.486793358427;8001.439899207044;8700.303975681945;8926.062763409846;8948.373613847034;8499.277561407287;8614.009388920276;8699.739007829776;8751.29989600832;8753.3872628916;2256.7066281383395;2506.586413241813;2509.498100379922;2510.57320255557;2516.3834860459215;2104.7474303083577;2173.9565208695817;2421.32202983165;2499.300195945138;2505.7243703192635;2471.9258422247362;2478.120267305108;2478.876056197192;2508.4732206236713;2510.8493490390633;2480.950380992379;2488.079410618083;2497.8126640501946;2498.375406148463;2506.636537702041;2472.7156377016513;2496.5631014572377;2499.0378704198833;2507.498500299929;2537.1500547316673;8903.397388470074;8905.955470222672;8932.151445612657;8937.50843703596;8953.283737301;5395.919061214085;5512.751926163332;5526.309211348582;5544.279243698334;5560.054790685593;3338.581103031202;3637.618050104754;3710.18375957289;3765.2281282337053;3777.5466943966626;1021.9131373833233;1074.2757873612895;1077.450500244873;1083.106437189322;1102.8676558812913;11838.881611183779;12008.159428839985;12016.038716902627;12047.156699031071;12120.515179392814;4924.335214745964;4939.925901111486;4986.8753281168265;4987.5760560352055;5000.224965130411;10185.796284074277;10368.533415996299;10375.896241037644;10384.32501887375;10386.740331491774;5499.092649712833;5544.22380866679;5548.361938377057;5550.111982082847;5553.722313884289;4472.195004899084;4611.700239484423;4871.537203965618;5009.7495125243595;5046.318746969186;3405.7615966882577;4019.83920643171;4065.8170382332864;4091.2635725569685;4111.8972025699595;1327.8008298755071;1339.4173534512518;1340.7787715026911;1343.6506508307714;1356.2947267420886;1113.821788513834;1139.9886001139882;1214.9149559530924;1244.0358721990349;1255.918365306252;8271.669133234724;8272.296854767412;8315.210055044761;8333.125021872738;8335.458195217292;513.2711549599578;522.190604562926;522.4592546714208;1225.2036176485356;1266.512392728806;5672.886542269214;6281.59169653971;6425.742970281136;6428.71070801815;6447.580907241015;9256.814863702823;10532.10477109439;10863.402512861869;10874.836877446845;10956.561737530568;10477.528511217013;10595.046445819913;10744.462776861126;10764.730881728019;10822.404767737693;8265.752027439186;8315.459495132796;8317.667293308321;8368.497890126611;8398.916010839936;7897.605119744105;7914.762557123296;8032.919670803217;8053.758387248392;8079.555624440713;8336.333093352396;9562.856557151787;9807.411555306704;9847.212223021997;9993.300468967103;9782.657606983721;9989.001099889952;10269.229807764297;10343.84484232722;10387.428691422045;6455.483561315177;6571.868562628625;6728.351553869334;7084.362407383154;7308.5614863108385;6953.548019378724;8261.876071859047;8288.461250018729;8306.460080094774;8312.33501319905;7581.241875812375;7714.4599878008;7716.344110750424;7838.725644602411;7839.216078392115;7495.700171993278;7573.734919277799;7734.8839767402405;7830.256125668053;7898.447108702336;7806.453548251568;7821.491603045783;7827.530348179127;7842.137364889972;7854.842903142019;6941.548799328028;7110.1112360954885;7118.28817118284;7136.857262854817;7158.463115266271;7234.131904171322;7273.563586184846;7280.417566594766;7286.744963926237;7299.598522081336 05:28:13 INFO - PROCESS | 2352 | |4;prototype.html;288.3900550336039;333.72134267886315;333.8697907815954;339.1707275710887;340.97954122752634;6650.368215019577;6848.246692863793;6862.142232220973;6889.173299204096;6949.548279361838;6502.15471988642;6757.5269731118715;6768.8307792305095;6786.355296246848;6811.761588344409;5013.047520971022;5039;5044.142495775709;5044.495550444963;5070.138076527;4792.784324705397;5057.57010654093;5071.797128114889;5072.1630930896545;5106.208537676666;4905.166121759292;4905.190643543811;4909.975450122744;4921.237208232729;4932.753362331869;4929.482404347564;4936.111499930011;4973.900521989576;4974.253861920723;4997.85006449807;4005.419214213952;4114.485689288839;4125.1749650070105;4205.306124489455;4209.726367786084;5676.489115979582;6548.345165483461;6582.144321238256;6595.3511622094475;6607.834804129935;5822.796202132905;5880.147378630118;5882.529397648178;5889.587728858939;5913.083472061838;7084.3269889360945;7347.375473084794;7355.816104597375;7365.705371785122;7398.741044063432;4737.715737055788;4740.762961851928;4750.406199225097;4755.5719985201495;4768.499307572724;7678.654460549289;7778.416618753616;7782.688692452295;7786.104597971249;7843.4901731387845;4426.782634775463;4441.378207051015;4664.55686709762;4789.544993225638;4793.808247670124;4900.779464924016;4904.411470623477;4913.656044076952;4927.630427717935;4930.359053323045;4425.468943726773;5752.913706294409;5856.828634273163;5865.706714664249;5873.412658734178;6280.780172693934;6711.993201019886;7382.963085184647;7405.629718514053;7431.85136297271;1425.978610320846;1633.681432120725;1700.4643537285715;1710.6065604910941;1713.5630414244288;1079.4818487126067;1086.223350304536;1098.522142867839;1098.6154845803906;1103.6413165721174;5053.5957123430035;5794.333651630032;6056.879477296714;6385.393387628168;6911.308869113149;6269.592476489013;7098.858022839514;7631.771046868603;7695.192004839523;7709.614519274126;6534.117894084237;6681.899771503431;6843.965780171067;6846.178458584902;6893.689783959633;3907.902302442462;3988.082740969593;3991.600839915985;4035.414864844581;4095.385692146202;7951.562664053533;8007.959960200162;8009.719659811995;8019.639116239783;8040.15578364275;7670.194629563927;7866.898634191103;7892.250236227549;7899.881501777363;7906.169852165554;8000.279974802295;8013;8060;8064.637091330904;8080.595970201466;7696.114946780968;7711.38308935295;7715.421343399155;7742.729004484816;7788.493747906368;7361.595112268877;7365.747822870232;7538.547687138789;7570.205128461433;7610.048743907012;7154.678039488132;8044.155363686963;8050.798730031796;8070.394720395876;8075.87886181696;4829.154897892784;4849.030193961151;4856.73287969151;4871.805127794849;4875.634327425386;6172.351903050295;7056.894146587702;7630.771076867481;7703.922960770321;7762.068551773823;6661.267260601427;6920.927256275286;7455.813604659927;7456.173237556834;7467.701291948261;7271.636418178964;7401.037865077506;7432.777016689508;7449.068866391701;7460;7233.059702238886;7240.131184257712;7246.094238220223;7254.310840470147;7288.708451662086;5633.605647604629;6305.779297724557;7425.071866016748;7471.92528074734;7492.587907664913;7037.120359955005;7263.6005019724425;7272.96363518179;7293.030881662027;7336.96331518339 05:28:13 INFO - PROCESS | 2352 | |5;yui.html;635.98410039749;684.442179623607;690.9550879192856;695.1033167214293;749.0823740917377;14102.435902563899;14184.43262269508;14278.286085695725;14293;14313.713725725493;13339.333033348343;13419.463221471155;13420;13435.596932092052;13461.528846490375;689.8758223519765;701.5615240474704;846.3483117999137;848.4909054567256;852.8336974290016;850.6682393866397;851.429542206723;859.9398042137021;859.9957000215021;860.0625318402939;914.0585197246813;915.4278575890069;918.1231923513029;919.5678031325266;919.6137622198659;895.8790563273973;903.4443817052531;911.0752586125055;911.3939230411768;915.8168366326728;650.1255810934285;657.9473642108668;673.2896793882452;677.420805211542;679.1510611735331;12045.915867571874;13080.215187088805;13568.660783480393;13572.796408053888;13620.046596738232;12604;12668.303243321614;12685.556005539855;12760.936195318964;12850;8154.75535733923;10020.59917603295;10328.070473657406;10346.896531034668;10817.567297308098;3163.5254711793414;3375.8649654014057;3540.91147721309;3554.022643772983;3574.4995700601935;73832.63083684548;74970;76249.85625215626;76503;76746.61626691831;7822.8435431291055;9371.127172501405;9479.33644644882;9629.807403851884;10020.498975051218;20703.79296207049;21021.579568408546;21038.89480552618;21059.894700526707;21106.78893211079;7273.527220730635;7411.295926886937;7434.36807871337;7450.403967682681;7454.776356709307;3928;4176.206520761046;4207.76857272853;4216.852410165629;4276.144771045803;3472.392331342005;3473.583170019614;3502.9124271893406;3503.3168532136497;3523.4714792780774;654.9345065493412;663.7477758451757;665.2449469851753;690.7444245629149;703.2440126863642;534.7272890825707;577.4927439383207;613.8373331067271;625.4058644287853;634.952378571609;8296.419250652518;8591.828163436696;8594;8700.08649091849;8727.04002559718;611.9877602447926;617.8980468222693;620.1689735754111;622.9813105606839;632.3549979021373;4046.4132700758223;4362.738235705868;4437.36136368175;4444.377787109807;4518.938867834698;81424;86186.70719939205;86971.56514217389;87975.56012220026;88216;78220.60889695628;78424;78621.60689196632;79390.6030469844;79463.8080428794;57938.710306449044;68344;68563;68755.31244687489;68830.65584672044;8485.448445851247;8701.216890479634;8807.119288071142;8819.955900220459;8961;48263.75868120637;48278.7498130693;48752.58840395121;48792.29226977181;49052.50947490622;46807.595772125525;49373.75313123555;61717.691411542655;64771.67614161899;67373;9247.445153290824;10753.462326883468;10838.187135964676;10919.617813376493;11849.585264515701;11113.499892504695;11370.488328025092;12190.878091218974;12293.262404255773;12386.442610082748;11368.943155284502;11602.47788849487;11822.11334149925;12016.63950081499;12024.338661373358;11353.318800871974;11487.48306326234;11540.134489913122;12064.276143431422;12271.26372417622;10857.511411986638;11381.260218085798;11417.659379827282;11665.24175928562;11710.355930423908;9153.86269205949;9246.260299175916;9363.531823408666;9595.891471706396;10191.468855260744;9042.864357034781;9343.345965782602;9364.672236471692;10060.798784024424;10104.292699510963 05:28:13 INFO - PROCESS | 2352 | __end_tp_report 05:28:13 INFO - PROCESS | 2352 | __start_cc_report 05:28:13 INFO - PROCESS | 2352 | _x_x_mozilla_cycle_collect,358 05:28:13 INFO - PROCESS | 2352 | __end_cc_report 05:28:13 INFO - PROCESS | 2352 | __startTimestamp1454074093259__endTimestamp 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | ------- Summary: start ------- 05:28:13 INFO - PROCESS | 2352 | Number of tests: 6 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | [#0] dojo.html Cycles:165 Average:5654.54 Median:5919.67 stddev:676.01 (11.4%) stddev-sans-first:642.25 05:28:13 INFO - PROCESS | 2352 | Values: 2886.0 3182.9 3465.5 3486.0 3509.1 5552.9 5568.0 5615.7 5621.5 5640.6 4654.7 5547.5 5704.9 5734.3 5772.7 5105.3 5176.5 5207.9 5233.1 5298.6 5023.4 5177.6 5216.8 5253.1 5299.8 5075.0 5102.7 5145.7 5170.0 5185.4 5128.8 5135.9 5136.3 5159.5 5176.0 4219.8 5114.5 5140.1 5163.3 5202.4 4639.3 5331.0 5527.0 5572.1 5671.6 6177.9 6183.8 6191.7 6194.9 6195.2 6158.8 6162.6 6177.9 6191.2 6194.2 5677.1 5787.8 5817.2 5892.4 5923.8 6193.7 6209.3 6217.2 6219.5 6225.5 5916.9 6114.3 6123.7 6129.5 6153.3 6093.7 6102.1 6152.4 6177.8 6183.7 6063.2 6109.0 6134.1 6144.2 6145.0 6075.6 6093.1 6127.3 6170.7 6215.7 4821.6 4872.2 4906.2 4927.1 4942.5 4377.1 4390.2 4411.5 4420.4 4468.0 5580.0 5732.8 5754.0 5775.7 5802.5 6135.2 6179.9 6189.3 6220.0 6225.2 5737.9 5791.3 5803.7 5820.3 5836.4 4202.1 4226.6 4603.0 5335.4 5479.3 6281.7 6284.6 6299.2 6318.3 6353.6 6130.7 6152.7 6214.3 6225.9 6231.9 4955.3 6145.3 6212.3 6322.9 6324.9 5808.0 6054.7 6068.1 6086.9 6100.7 5644.3 6084.8 6199.2 6203.6 6212.2 5953.4 5992.5 6005.9 6031.8 6057.9 5879.3 6071.6 6077.2 6088.0 6088.8 5612.6 5846.0 5971.5 5982.0 6010.6 6036.8 6073.8 6080.7 6100.9 6131.8 5905.2 5919.7 5926.9 5944.0 5978.4 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | [#1] ext.html Cycles:180 Average:53626.88 Median:187525.41 stddev:104472.28 (55.7%) stddev-sans-first:104689.12 05:28:13 INFO - PROCESS | 2352 | Values: 472.2 495.4 568.5 568.9 601.8 32174.4 36414.3 36480.8 36545.9 36657.5 37535.6 38042.6 38059.0 38135.0 38293.0 9227.1 9429.1 9437.7 9452.4 9452.4 9273.1 9521.3 9528.7 9530.2 9560.0 9456.9 9573.4 9576.9 9592.8 9604.3 8297.9 9483.1 9545.8 9594.3 9635.8 8262.8 9316.9 9330.0 9463.0 9482.5 30547.9 30772.8 37306.4 37404.4 37473.8 2600.4 3086.2 3092.2 3351.1 3571.7 26220.3 26491.9 26695.9 26926.2 27369.0 2781.9 2806.7 2810.5 2827.5 2908.4 325798.0 327220.4 328582.0 328775.5 328906.0 52201.5 54836.9 55127.4 55154.4 55165.0 49419.5 52275.0 53190.0 64420.4 64689.0 15825.1 15946.8 16168.2 16223.6 16230.5 12336.3 12425.3 12464.9 12484.8 12602.9 18421.1 18626.8 18679.8 18689.9 18692.0 7047.5 7279.8 8657.0 8683.9 8716.4 926.5 975.1 976.1 1014.6 1134.5 29171.3 29374.5 29450.7 29513.7 29524.6 1034.5 1068.4 1117.2 1130.8 1209.4 15089.1 15559.6 15943.6 15968.8 16004.3 489818.0 490219.0 493224.0 496831.0 496908.0 54703.7 54999.7 55292.7 55329.7 55361.7 1414.0 1435.2 1436.3 1453.6 1563.7 28815.0 29307.6 29610.7 29635.0 30530.0 48482.8 53824.7 54115.5 54152.7 54335.7 339205.0 339236.0 340282.0 341005.0 341049.0 30191.7 31076.7 32910.3 32963.0 33071.3 39387.0 39603.8 40132.6 40286.6 40828.6 33570.8 35797.8 35984.3 36754.9 36975.7 33967.7 34040.8 34045.8 34372.5 35591.6 33323.8 33412.5 33542.7 33765.0 33958.8 27416.6 28092.7 30407.0 30475.7 30568.5 19403.7 21738.0 22320.0 24202.5 24211.0 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | [#2] jquery.html Cycles:180 Average:29858.14 Median:2224.24 stddev:85388.24 (3839.0%) stddev-sans-first:85598.95 05:28:13 INFO - PROCESS | 2352 | Values: 308.5 313.4 358.0 364.5 365.1 15514.2 15571.8 16819.3 18869.7 19407.9 16292.8 17546.0 19544.9 19604.2 19682.3 5361.8 5646.3 5903.6 5904.0 5916.9 4169.2 4370.3 5811.0 5899.4 5909.3 6145.6 6369.6 6397.2 6398.4 6403.6 6126.4 6383.2 6389.8 6394.5 6414.2 4748.2 5482.8 5509.7 5522.5 5538.2 24138.2 24618.3 24676.1 24976.4 25188.6 2243.5 2263.7 2294.2 2371.2 2900.6 9106.0 9205.4 9783.1 9845.0 12862.6 1659.9 1717.5 1735.1 1775.8 1797.7 97075.0 102818.5 102868.0 103209.0 103712.0 9099.4 11187.2 11208.3 11302.1 11377.4 13480.3 13532.7 13536.4 13566.7 13582.9 8533.7 8534.6 8553.8 8574.9 8578.8 8639.4 8669.0 8681.3 8717.7 8718.8 4083.4 4323.1 4413.1 4449.5 4475.1 1596.6 1813.4 1815.9 1868.2 1898.9 871.3 888.3 891.0 919.9 1049.7 11454.0 18681.7 19469.5 19973.9 20390.8 432.7 439.2 442.7 450.4 458.9 6029.8 6219.3 8481.7 8953.6 11244.5 358220.0 361658.0 362141.0 655823.0 695214.0 105802.0 107518.9 107760.5 109994.0 112651.0 504.2 505.5 512.3 512.6 512.8 10854.7 10860.9 11653.5 15673.7 18581.2 48208.8 48740.5 48780.5 49323.3 50195.0 52761.2 64039.7 70366.0 70402.6 73616.0 7541.0 7787.2 7829.8 7852.2 7852.4 11010.9 11271.3 11609.4 11787.9 12117.0 9630.3 10249.5 10460.8 10538.1 10596.7 10236.9 10344.9 10358.9 10484.7 10628.7 9286.9 10407.8 10750.6 10782.8 10918.2 7641.6 7729.1 7758.9 7790.5 7802.7 9995.2 10578.7 10775.8 10782.4 10812.8 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | [#3] mootools.html Cycles:180 Average:6095.22 Median:522.32 stddev:3224.05 (617.2%) stddev-sans-first:3214.39 05:28:13 INFO - PROCESS | 2352 | Values: 1475.1 1515.2 1705.9 1803.5 1831.2 7895.5 8001.4 8700.3 8926.1 8948.4 8499.3 8614.0 8699.7 8751.3 8753.4 2256.7 2506.6 2509.5 2510.6 2516.4 2104.7 2174.0 2421.3 2499.3 2505.7 2471.9 2478.1 2478.9 2508.5 2510.8 2481.0 2488.1 2497.8 2498.4 2506.6 2472.7 2496.6 2499.0 2507.5 2537.2 8903.4 8906.0 8932.2 8937.5 8953.3 5395.9 5512.8 5526.3 5544.3 5560.1 3338.6 3637.6 3710.2 3765.2 3777.5 1021.9 1074.3 1077.5 1083.1 1102.9 11838.9 12008.2 12016.0 12047.2 12120.5 4924.3 4939.9 4986.9 4987.6 5000.2 10185.8 10368.5 10375.9 10384.3 10386.7 5499.1 5544.2 5548.4 5550.1 5553.7 4472.2 4611.7 4871.5 5009.7 5046.3 3405.8 4019.8 4065.8 4091.3 4111.9 1327.8 1339.4 1340.8 1343.7 1356.3 1113.8 1140.0 1214.9 1244.0 1255.9 8271.7 8272.3 8315.2 8333.1 8335.5 513.3 522.2 522.5 1225.2 1266.5 5672.9 6281.6 6425.7 6428.7 6447.6 9256.8 10532.1 10863.4 10874.8 10956.6 10477.5 10595.0 10744.5 10764.7 10822.4 8265.8 8315.5 8317.7 8368.5 8398.9 7897.6 7914.8 8032.9 8053.8 8079.6 8336.3 9562.9 9807.4 9847.2 9993.3 9782.7 9989.0 10269.2 10343.8 10387.4 6455.5 6571.9 6728.4 7084.4 7308.6 6953.5 8261.9 8288.5 8306.5 8312.3 7581.2 7714.5 7716.3 7838.7 7839.2 7495.7 7573.7 7734.9 7830.3 7898.4 7806.5 7821.5 7827.5 7842.1 7854.8 6941.5 7110.1 7118.3 7136.9 7158.5 7234.1 7273.6 7280.4 7286.7 7299.6 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | [#4] prototype.html Cycles:180 Average:5947.26 Median:6629.10 stddev:1937.78 (29.2%) stddev-sans-first:1896.10 05:28:13 INFO - PROCESS | 2352 | Values: 288.4 333.7 333.9 339.2 341.0 6650.4 6848.2 6862.1 6889.2 6949.5 6502.2 6757.5 6768.8 6786.4 6811.8 5013.0 5039.0 5044.1 5044.5 5070.1 4792.8 5057.6 5071.8 5072.2 5106.2 4905.2 4905.2 4910.0 4921.2 4932.8 4929.5 4936.1 4973.9 4974.3 4997.9 4005.4 4114.5 4125.2 4205.3 4209.7 5676.5 6548.3 6582.1 6595.4 6607.8 5822.8 5880.1 5882.5 5889.6 5913.1 7084.3 7347.4 7355.8 7365.7 7398.7 4737.7 4740.8 4750.4 4755.6 4768.5 7678.7 7778.4 7782.7 7786.1 7843.5 4426.8 4441.4 4664.6 4789.5 4793.8 4900.8 4904.4 4913.7 4927.6 4930.4 4425.5 5752.9 5856.8 5865.7 5873.4 6280.8 6712.0 7383.0 7405.6 7431.9 1426.0 1633.7 1700.5 1710.6 1713.6 1079.5 1086.2 1098.5 1098.6 1103.6 5053.6 5794.3 6056.9 6385.4 6911.3 6269.6 7098.9 7631.8 7695.2 7709.6 6534.1 6681.9 6844.0 6846.2 6893.7 3907.9 3988.1 3991.6 4035.4 4095.4 7951.6 8008.0 8009.7 8019.6 8040.2 7670.2 7866.9 7892.3 7899.9 7906.2 8000.3 8013.0 8060.0 8064.6 8080.6 7696.1 7711.4 7715.4 7742.7 7788.5 7361.6 7365.7 7538.5 7570.2 7610.0 7154.7 8044.2 8050.8 8070.4 8075.9 4829.2 4849.0 4856.7 4871.8 4875.6 6172.4 7056.9 7630.8 7703.9 7762.1 6661.3 6920.9 7455.8 7456.2 7467.7 7271.6 7401.0 7432.8 7449.1 7460.0 7233.1 7240.1 7246.1 7254.3 7288.7 5633.6 6305.8 7425.1 7471.9 7492.6 7037.1 7263.6 7273.0 7293.0 7337.0 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - PROCESS | 2352 | [#5] yui.html Cycles:180 Average:17528.16 Median:31168.93 stddev:24223.73 (77.7%) stddev-sans-first:24258.48 05:28:13 INFO - PROCESS | 2352 | Values: 636.0 684.4 691.0 695.1 749.1 14102.4 14184.4 14278.3 14293.0 14313.7 13339.3 13419.5 13420.0 13435.6 13461.5 689.9 701.6 846.3 848.5 852.8 850.7 851.4 859.9 860.0 860.1 914.1 915.4 918.1 919.6 919.6 895.9 903.4 911.1 911.4 915.8 650.1 657.9 673.3 677.4 679.2 12045.9 13080.2 13568.7 13572.8 13620.0 12604.0 12668.3 12685.6 12760.9 12850.0 8154.8 10020.6 10328.1 10346.9 10817.6 3163.5 3375.9 3540.9 3554.0 3574.5 73832.6 74970.0 76249.9 76503.0 76746.6 7822.8 9371.1 9479.3 9629.8 10020.5 20703.8 21021.6 21038.9 21059.9 21106.8 7273.5 7411.3 7434.4 7450.4 7454.8 3928.0 4176.2 4207.8 4216.9 4276.1 3472.4 3473.6 3502.9 3503.3 3523.5 654.9 663.7 665.2 690.7 703.2 534.7 577.5 613.8 625.4 635.0 8296.4 8591.8 8594.0 8700.1 8727.0 612.0 617.9 620.2 623.0 632.4 4046.4 4362.7 4437.4 4444.4 4518.9 81424.0 86186.7 86971.6 87975.6 88216.0 78220.6 78424.0 78621.6 79390.6 79463.8 57938.7 68344.0 68563.0 68755.3 68830.7 8485.4 8701.2 8807.1 8820.0 8961.0 48263.8 48278.7 48752.6 48792.3 49052.5 46807.6 49373.8 61717.7 64771.7 67373.0 9247.4 10753.5 10838.2 10919.6 11849.6 11113.5 11370.5 12190.9 12293.3 12386.4 11368.9 11602.5 11822.1 12016.6 12024.3 11353.3 11487.5 11540.1 12064.3 12271.3 10857.5 11381.3 11417.7 11665.2 11710.4 9153.9 9246.3 9363.5 9595.9 10191.5 9042.9 9343.3 9364.7 10060.8 10104.3 05:28:13 INFO - PROCESS | 2352 | -------- Summary: end -------- 05:28:13 INFO - PROCESS | 2352 | 05:28:13 INFO - TEST-INFO | 2352: exit 0 05:28:13 INFO - TEST-OK | dromaeo_css | took 1111557ms 05:28:13 INFO - TEST-START | kraken 05:28:13 INFO - operating with platform_type : mac_ 05:28:13 INFO - Initialising browser for kraken test... 05:28:13 INFO - TEST-INFO | started process 2357 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp0ejBen/profile http://localhost:57726/getInfo.html) 05:28:16 INFO - PROCESS | 2357 | __metrics Screen width/height:1600/1200 05:28:16 INFO - PROCESS | 2357 | colorDepth:24 05:28:16 INFO - PROCESS | 2357 | Browser inner width/height: 1024/689 05:28:16 INFO - PROCESS | 2357 | __metrics 05:28:16 INFO - PROCESS | 2357 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:28:17 INFO - TEST-INFO | 2357: exit 0 05:28:17 INFO - Browser initialized. 05:28:17 INFO - Running cycle 1/1 for kraken test... 05:28:17 INFO - TEST-INFO | started process 2361 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp0ejBen/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:29 INFO - PROCESS | 2361 | RSS: Main: 256626688 05:28:29 INFO - PROCESS | 2361 | 05:28:32 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57726/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:32 INFO - PROCESS | 2361 | RSS: Main: 270282752 05:28:32 INFO - PROCESS | 2361 | 05:28:35 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57726/tests/kraken/driver.html?testName=audio-dft) 05:28:36 INFO - PROCESS | 2361 | RSS: Main: 277544960 05:28:36 INFO - PROCESS | 2361 | 05:28:39 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57726/tests/kraken/driver.html?testName=audio-fft) 05:28:39 INFO - PROCESS | 2361 | RSS: Main: 281587712 05:28:39 INFO - PROCESS | 2361 | 05:28:41 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57726/tests/kraken/driver.html?testName=audio-oscillator) 05:28:42 INFO - PROCESS | 2361 | RSS: Main: 283725824 05:28:42 INFO - PROCESS | 2361 | 05:28:44 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:45 INFO - PROCESS | 2361 | RSS: Main: 284557312 05:28:45 INFO - PROCESS | 2361 | 05:28:47 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57726/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:48 INFO - PROCESS | 2361 | RSS: Main: 284180480 05:28:48 INFO - PROCESS | 2361 | 05:28:51 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57726/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:52 INFO - PROCESS | 2361 | RSS: Main: 284028928 05:28:52 INFO - PROCESS | 2361 | 05:28:54 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57726/tests/kraken/driver.html?testName=json-parse-financial) 05:28:55 INFO - PROCESS | 2361 | RSS: Main: 284786688 05:28:55 INFO - PROCESS | 2361 | 05:28:57 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:57 INFO - PROCESS | 2361 | RSS: Main: 284405760 05:28:57 INFO - PROCESS | 2361 | 05:28:59 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:00 INFO - PROCESS | 2361 | RSS: Main: 283066368 05:29:00 INFO - PROCESS | 2361 | 05:29:02 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:02 INFO - PROCESS | 2361 | RSS: Main: 284233728 05:29:02 INFO - PROCESS | 2361 | 05:29:05 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:06 INFO - PROCESS | 2361 | RSS: Main: 283140096 05:29:06 INFO - PROCESS | 2361 | 05:29:08 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:09 INFO - PROCESS | 2361 | RSS: Main: 284827648 05:29:09 INFO - PROCESS | 2361 | 05:29:10 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:57726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57726/tests/kraken/driver.html?testName=ai-astar) 05:29:11 INFO - PROCESS | 2361 | RSS: Main: 286269440 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | __start_tp_report 05:29:11 INFO - PROCESS | 2361 | _x_x_mozilla_page_load 05:29:11 INFO - PROCESS | 2361 | _x_x_mozilla_page_load_details 05:29:11 INFO - PROCESS | 2361 | |i|pagename|runs| 05:29:11 INFO - PROCESS | 2361 | |0;ai-astar;113;104;112;113;115;126;119;148;100;101 05:29:11 INFO - PROCESS | 2361 | |1;audio-beat-detection;156;132;174;164;108;169;171;151;176;144 05:29:11 INFO - PROCESS | 2361 | |2;audio-dft;194;197;196;211;209;247;253;206;200;199 05:29:11 INFO - PROCESS | 2361 | |3;audio-fft;74;101;104;112;54;56;57;60;115;55 05:29:11 INFO - PROCESS | 2361 | |4;audio-oscillator;81;88;118;78;79;85;119;81;80;118 05:29:11 INFO - PROCESS | 2361 | |5;imaging-gaussian-blur;128;131;86;94;88;92;85;94;88;93 05:29:11 INFO - PROCESS | 2361 | |6;imaging-darkroom;95;138;96;104;129;95;95;95;95;96 05:29:11 INFO - PROCESS | 2361 | |7;imaging-desaturate;77;145;149;92;90;98;109;93;93;95 05:29:11 INFO - PROCESS | 2361 | |8;json-parse-financial;56;54;56;53;57;53;56;62;54;54 05:29:11 INFO - PROCESS | 2361 | |9;json-stringify-tinderbox;64;72;66;71;68;68;66;67;68;70 05:29:11 INFO - PROCESS | 2361 | |10;stanford-crypto-aes;93;108;112;111;87;84;85;86;85;83 05:29:11 INFO - PROCESS | 2361 | |11;stanford-crypto-ccm;125;126;124;133;125;130;140;114;124;136 05:29:11 INFO - PROCESS | 2361 | |12;stanford-crypto-pbkdf2;143;144;141;134;127;144;139;178;141;127 05:29:11 INFO - PROCESS | 2361 | |13;stanford-crypto-sha256-iterative;66;68;67;68;66;74;79;97;99;99 05:29:11 INFO - PROCESS | 2361 | __end_tp_report 05:29:11 INFO - PROCESS | 2361 | __start_cc_report 05:29:11 INFO - PROCESS | 2361 | _x_x_mozilla_cycle_collect,870 05:29:11 INFO - PROCESS | 2361 | __end_cc_report 05:29:11 INFO - PROCESS | 2361 | __startTimestamp1454074151153__endTimestamp 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | ------- Summary: start ------- 05:29:11 INFO - PROCESS | 2361 | Number of tests: 14 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#0] ai-astar Cycles:10 Average:115.10 Median:114.00 stddev:14.08 (12.4%) stddev-sans-first:14.92 05:29:11 INFO - PROCESS | 2361 | Values: 113.0 104.0 112.0 113.0 115.0 126.0 119.0 148.0 100.0 101.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:166.50 stddev:21.62 (13.0%) stddev-sans-first:22.93 05:29:11 INFO - PROCESS | 2361 | Values: 156.0 132.0 174.0 164.0 108.0 169.0 171.0 151.0 176.0 144.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#2] audio-dft Cycles:10 Average:211.20 Median:207.50 stddev:21.25 (10.2%) stddev-sans-first:21.61 05:29:11 INFO - PROCESS | 2361 | Values: 194.0 197.0 196.0 211.0 209.0 247.0 253.0 206.0 200.0 199.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#3] audio-fft Cycles:10 Average:78.80 Median:55.50 stddev:26.02 (46.9%) stddev-sans-first:27.54 05:29:11 INFO - PROCESS | 2361 | Values: 74.0 101.0 104.0 112.0 54.0 56.0 57.0 60.0 115.0 55.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.50 stddev:17.93 (22.3%) stddev-sans-first:18.51 05:29:11 INFO - PROCESS | 2361 | Values: 81.0 88.0 118.0 78.0 79.0 85.0 119.0 81.0 80.0 118.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:90.00 stddev:16.98 (18.9%) stddev-sans-first:14.09 05:29:11 INFO - PROCESS | 2361 | Values: 128.0 131.0 86.0 94.0 88.0 92.0 85.0 94.0 88.0 93.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:95.00 stddev:16.03 (16.9%) stddev-sans-first:16.69 05:29:11 INFO - PROCESS | 2361 | Values: 95.0 138.0 96.0 104.0 129.0 95.0 95.0 95.0 95.0 96.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:92.50 stddev:23.94 (25.9%) stddev-sans-first:23.30 05:29:11 INFO - PROCESS | 2361 | Values: 77.0 145.0 149.0 92.0 90.0 98.0 109.0 93.0 93.0 95.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:2.68 (4.8%) stddev-sans-first:2.83 05:29:11 INFO - PROCESS | 2361 | Values: 56.0 54.0 56.0 53.0 57.0 53.0 56.0 62.0 54.0 54.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:2.45 (3.6%) stddev-sans-first:2.13 05:29:11 INFO - PROCESS | 2361 | Values: 64.0 72.0 66.0 71.0 68.0 68.0 66.0 67.0 68.0 70.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:85.00 stddev:12.03 (14.2%) stddev-sans-first:12.76 05:29:11 INFO - PROCESS | 2361 | Values: 93.0 108.0 112.0 111.0 87.0 84.0 85.0 86.0 85.0 83.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.00 stddev:7.35 (5.7%) stddev-sans-first:7.73 05:29:11 INFO - PROCESS | 2361 | Values: 125.0 126.0 124.0 133.0 125.0 130.0 140.0 114.0 124.0 136.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:142.00 stddev:14.26 (10.0%) stddev-sans-first:15.12 05:29:11 INFO - PROCESS | 2361 | Values: 143.0 144.0 141.0 134.0 127.0 144.0 139.0 178.0 141.0 127.0 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - PROCESS | 2361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:76.50 stddev:14.41 (18.8%) stddev-sans-first:14.58 05:29:11 INFO - PROCESS | 2361 | Values: 66.0 68.0 67.0 68.0 66.0 74.0 79.0 97.0 99.0 99.0 05:29:11 INFO - PROCESS | 2361 | -------- Summary: end -------- 05:29:11 INFO - PROCESS | 2361 | 05:29:11 INFO - TEST-INFO | 2361: exit 0 05:29:11 INFO - TEST-OK | kraken | took 58053ms 05:29:11 INFO - SUITE-END | took 1169s 05:29:12 INFO - Completed test suite (00:19:30) 05:29:12 INFO - Working with test: dromaeo_css 05:29:12 INFO - Generating results file: dromaeo_css 05:29:12 INFO - Working with test: kraken 05:29:12 INFO - Generating results file: kraken 05:29:12 INFO - javascript benchmark 05:29:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:29:12 INFO - process_Request line: dromaeo_css 7357.27 graph.html#tests=[[72,1,61]] 05:29:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:12 INFO - process_Request line: kraken 1522.80 graph.html#tests=[[232,1,61]] 05:29:12 INFO - RETURN: dromaeo_css: 7357.27 05:29:12 INFO - RETURN: kraken: 1522.80 05:29:12 INFO - javascript benchmark 05:29:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2885.9567106493405, 3182.8726850925964, 3465.497502862085, 3486.041338631877, 3509.1051781795636, 5552.91670624941, 5567.9999999999945, 5615.7472913718875, 5621.522170615497, 5640.576956728241, 4654.674172807905, 5547.500724934755, 5704.942950570504, 5734.283214598176, 5772.653640781546, 5105.259737338093, 5176.5341119299255, 5207.895842083156, 5233.110371236899, 5298.629095963284, 5023.372078490189, 5177.637565370425, 5216.7913283468615, 5253.080710875582, 5299.814506492274, 5074.974625126888, 5102.693838369672, 5145.691258524501, 5170.017696637646, 5185.403678576974, 5128.820491282787, 5135.948640513622, 5136.332276804029, 5159.458256883011, 5176.0, 4219.767912764797, 5114.462981386975, 5140.074786538422, 5163.277141200235, 5202.4277329493725, 4639.280911458695, 5331.0, 5527.0, 5572.136318870582, 5671.574631902583, 6177.876442471125, 6183.752649893999, 6191.690415479208, 6194.876102477971, 6195.163652906845, 6158.815235542941, 6162.630242185438, 6177.907331390033, 6191.195144631214, 6194.194754681907, 5677.091665333568, 5787.768489260425, 5817.214676018725, 5892.410758924159, 5923.7926672566255, 6193.721282542297, 6209.316975132731, 6217.160683307786, 6219.47134493564, 6225.470834978987, 5916.940830591725, 6114.296855861633, 6123.724432400552, 6129.509639228851, 6153.261608606996, 6093.725782339805, 6102.065131056412, 6152.384761523901, 6177.84555386119, 6183.690815459299, 6063.151158837766, 6109.016487091993, 6134.1119512865025, 6144.2319710036245, 6144.986077297285, 6075.574709770273, 6093.129299788002, 6127.250613123855, 6170.7223174957235, 6215.689215539295, 4821.614270858323, 4872.171730805771, 4906.215005599159, 4927.137750893579, 4942.481039490874, 4377.146456440963, 4390.209762242763, 4411.514733379326, 4420.403245561873, 4468.039371535136, 5579.972100139555, 5732.77068917247, 5753.993051216021, 5775.740091695884, 5802.4777770000055, 6135.202423684892, 6179.907301390483, 6189.257289125334, 6220.0047992321015, 6225.190725205694, 5737.85655358611, 5791.305043394819, 5803.6807975560905, 5820.272465941757, 5836.416358364129, 4202.096549241866, 4226.640735537452, 4603.0, 5335.439778823167, 5479.342478902558, 6281.7173227204885, 6284.591501552384, 6299.244090709144, 6318.304986451487, 6353.61878287295, 6130.7241174146375, 6152.692365381802, 6214.347493513116, 6225.875482490234, 6231.906521402092, 4955.281484184701, 6145.324014358328, 6212.347703491249, 6322.936770632419, 6324.873502530016, 5807.970960145341, 6054.66699331541, 6068.059450785136, 6086.908696369646, 6100.694965251809, 5644.294463192101, 6084.787032453843, 6199.194104766351, 6203.596766210182, 6212.192414986023, 5953.434423729739, 5992.520598352208, 6005.939940600538, 6031.819045428644, 6057.939420605914, 5879.2944846618675, 6071.605345652519, 6077.179580756541, 6088.0, 6088.756449742138, 5612.579056570855, 5846.035404158266, 5971.462568368867, 5981.970090149522, 6010.609310394811, 6036.849078773066, 6073.787417440369, 6080.69596520181, 6100.883963092815, 6131.816045518642, 5905.202797622266, 5919.6744179070565, 5926.851828704317, 5944.0, 5978.432048955342], "unit": "score", "name": "dojo.html", "value": 5610.944035090483}, {"lowerIsBetter": false, "replicates": [472.22790737144777, 495.39314339933577, 568.5366426362514, 568.907697221335, 601.7893737191986, 32174.35651286976, 36414.27171456569, 36480.81759591198, 36545.90362289129, 36657.45013824795, 37535.62464375355, 38042.61957380425, 38059.04852378692, 38135.046623834416, 38293.042673933094, 9227.123423274796, 9429.057094290585, 9437.716868493957, 9452.385594936342, 9452.43285402878, 9273.07269273074, 9521.28590355726, 9528.666496672584, 9530.237580993504, 9559.95220023899, 9456.905430945706, 9573.377730447533, 9576.904230957705, 9592.760180995461, 9604.327697061208, 8297.917020829775, 9483.099105584994, 9545.761355966088, 9594.280428967855, 9635.807283854354, 8262.843201951671, 9316.8602470963, 9329.953350233272, 9463.0, 9482.525873706287, 30547.93082242133, 30772.846135769178, 37306.4404033937, 37404.43893341602, 37473.81263093694, 2600.3759097816387, 3086.2130156810094, 3092.1651154188244, 3351.1287065362935, 3571.6606922342335, 26220.344491387677, 26491.940322387083, 26695.932162713467, 26926.19062992018, 27369.0, 2781.9304517387027, 2806.7473927346637, 2810.5081610718044, 2827.5475923852086, 2908.43285559316, 325798.0, 327220.36389818136, 328582.0, 328775.4928577512, 328906.0, 52201.47798522042, 54836.90326193454, 55127.44872551304, 55154.44845551493, 55165.0, 49419.50580494221, 52275.0, 53190.0, 64420.355796442374, 64689.02966455507, 15825.129617870898, 15946.840531594535, 16168.191590420667, 16223.594410139605, 16230.51308460748, 12336.259824410565, 12425.316607586488, 12464.875351246554, 12484.750304994031, 12602.865742083257, 18421.078946052643, 18626.81373186251, 18679.81320186808, 18689.87860728361, 18692.0, 7047.54190977595, 7279.818004549928, 8656.999053171823, 8683.913160868311, 8716.43343182691, 926.5043201886958, 975.1418751498636, 976.1409959235828, 1014.5840205515703, 1134.466800603715, 29171.270718232216, 29374.52946071214, 29450.705492944795, 29513.704862951527, 29524.557131643043, 1034.4672493665769, 1068.3643232276784, 1117.1565468071717, 1130.796456637813, 1209.4013463335705, 15089.094654320776, 15559.611009724847, 15943.601409964844, 15968.840311596967, 16004.279807408695, 489818.0, 490219.0, 493224.0, 496831.0, 496908.0, 54703.72648136813, 54999.72500137554, 55292.723536382866, 55329.723351382985, 55361.72319138378, 1414.0, 1435.167602790379, 1436.3249272841747, 1453.600259928507, 1563.679445713626, 28814.991475298262, 29307.560386593792, 29610.703892960795, 29634.962776302727, 30530.0, 48482.75758621185, 53824.73087634537, 54115.45884541104, 54152.72923635357, 54335.72832135814, 339205.0, 339236.0, 340282.0, 341005.0, 341049.0, 30191.698083018888, 31076.68923310738, 32910.34179316448, 32963.0, 33071.33857322888, 39387.01532461711, 39603.80198098991, 40132.59867401289, 40286.597134029456, 40828.59171408367, 33570.83214584009, 35797.82101089478, 35984.28031439409, 36754.875835554274, 36975.70585029511, 33967.66032339744, 34040.82979585185, 34045.829770850985, 34372.48441273433, 35591.64408355987, 33323.83366582158, 33412.498812518315, 33542.66457335493, 33765.0, 33958.83020584881, 27416.588751169147, 28092.71907280983, 30407.0, 30475.695243047285, 30568.541471877495, 19403.708944366128, 21738.0, 22319.995600197704, 24202.51594968126, 24211.0], "unit": "score", "name": "ext.html", "value": 18612.91331065758}, {"lowerIsBetter": false, "replicates": [308.5033096714291, 313.40296734720357, 357.9928401431973, 364.5224755570203, 365.0745360511105, 15514.224288785572, 15571.844281557182, 16819.327226910926, 18869.716954245698, 19407.902960485197, 16292.755608665879, 17546.0, 19544.902275488603, 19604.215831366764, 19682.311119110833, 5361.812336568211, 5646.322441307049, 5903.616264942786, 5903.970480147594, 5916.852078698045, 4169.166166766644, 4370.257056300421, 5811.0, 5899.410058994109, 5909.290885093795, 6145.569810113294, 6369.617822930616, 6397.232332120152, 6398.360163983611, 6403.583767055126, 6126.417990290915, 6383.202099737533, 6389.7763578274535, 6394.488440924738, 6414.166158399402, 4748.19280722278, 5482.753276102585, 5509.696966666832, 5522.475364840334, 5538.224648549206, 24138.155164569154, 24618.261452156286, 24676.13633522818, 24976.37559061038, 25188.622170667455, 2243.450354663118, 2263.7283525976823, 2294.1626306398043, 2371.1700904683394, 2900.6374203224595, 9105.954470227607, 9205.447673139633, 9783.0706082922, 9845.0, 12862.614121576367, 1659.9004059756453, 1717.467585048639, 1735.0630659443884, 1775.849052830511, 1797.6854050541103, 97075.0, 102818.48590757074, 102867.97132028658, 103208.99999999924, 103712.0, 9099.408538444979, 11187.216894817284, 11208.27146235492, 11302.135147700537, 11377.43112844371, 13480.25858577768, 13532.661683457993, 13536.390862411215, 13566.728665426635, 13582.932085339708, 8533.701320453754, 8534.573271336532, 8553.828923421497, 8574.914250857537, 8578.828423431622, 8639.395242332976, 8669.0, 8681.348898832613, 8717.651293948298, 8718.782030449289, 4083.4079058536345, 4323.092150648336, 4413.073254616566, 4449.466064072332, 4475.1273501666865, 1596.5609457399307, 1813.4197056941916, 1815.891046537212, 1868.1873385077536, 1898.933537326187, 871.324723339417, 888.2938064238946, 891.0465801592363, 919.94480331179, 1049.6641074855972, 11453.96914277719, 18681.719774203397, 19469.51326216856, 19973.900130499256, 20390.796092039185, 432.7468430967856, 439.18969501270107, 442.7078128435217, 450.3537423796862, 458.90821835633005, 6029.78895738647, 6219.253689557282, 8481.703140390056, 8953.641854325884, 11244.49399777012, 358220.0, 361658.0, 362141.0, 655823.0, 695214.0, 105802.0, 107518.92481075246, 107760.46119769351, 109994.0, 112651.0, 504.2486694824685, 505.524806681718, 512.2955935588566, 512.6385897941942, 512.7666911555308, 10854.728631784268, 10860.891391085988, 11653.47559359814, 15673.68652626964, 18581.16384762662, 48208.758956205, 48740.512594875014, 48780.51219487902, 49323.26015109704, 50195.0, 52761.153359632226, 64039.679801600694, 70366.0, 70402.64798675974, 73616.0, 7540.9622951884885, 7787.221277872394, 7829.786383110627, 7852.214778522102, 7852.411069169721, 11010.889891100986, 11271.323720576791, 11609.3614851184, 11787.882121179022, 12117.030637549151, 9630.32587718881, 10249.538770755484, 10460.843087353544, 10538.104261137889, 10596.735081623021, 10236.897631023594, 10344.896551034695, 10358.948205258925, 10484.685459436228, 10628.734281643021, 9286.860697089414, 10407.791844162923, 10750.623728169476, 10782.838257425989, 10918.181136414642, 7641.579713115832, 7729.149793522821, 7758.88361674564, 7790.454668173174, 7802.726904558313, 9995.20038396941, 10578.738623535466, 10775.784484310114, 10782.406967616542, 10812.783744324912], "unit": "score", "name": "jquery.html", "value": 8569.69233791492}, {"lowerIsBetter": false, "replicates": [1475.092817916981, 1515.2499512741194, 1705.9232334544945, 1803.4950213940094, 1831.2491878329888, 7895.486793358427, 8001.439899207044, 8700.303975681945, 8926.062763409846, 8948.373613847034, 8499.277561407287, 8614.009388920276, 8699.739007829776, 8751.29989600832, 8753.3872628916, 2256.7066281383395, 2506.586413241813, 2509.498100379922, 2510.57320255557, 2516.3834860459215, 2104.7474303083577, 2173.9565208695817, 2421.32202983165, 2499.300195945138, 2505.7243703192635, 2471.9258422247362, 2478.120267305108, 2478.876056197192, 2508.4732206236713, 2510.8493490390633, 2480.950380992379, 2488.079410618083, 2497.8126640501946, 2498.375406148463, 2506.636537702041, 2472.7156377016513, 2496.5631014572377, 2499.0378704198833, 2507.498500299929, 2537.1500547316673, 8903.397388470074, 8905.955470222672, 8932.151445612657, 8937.50843703596, 8953.283737301, 5395.919061214085, 5512.751926163332, 5526.309211348582, 5544.279243698334, 5560.054790685593, 3338.581103031202, 3637.618050104754, 3710.18375957289, 3765.2281282337053, 3777.5466943966626, 1021.9131373833233, 1074.2757873612895, 1077.450500244873, 1083.106437189322, 1102.8676558812913, 11838.881611183779, 12008.159428839985, 12016.038716902627, 12047.156699031071, 12120.515179392814, 4924.335214745964, 4939.925901111486, 4986.8753281168265, 4987.5760560352055, 5000.224965130411, 10185.796284074277, 10368.533415996299, 10375.896241037644, 10384.32501887375, 10386.740331491774, 5499.092649712833, 5544.22380866679, 5548.361938377057, 5550.111982082847, 5553.722313884289, 4472.195004899084, 4611.700239484423, 4871.537203965618, 5009.7495125243595, 5046.318746969186, 3405.7615966882577, 4019.83920643171, 4065.8170382332864, 4091.2635725569685, 4111.8972025699595, 1327.8008298755071, 1339.4173534512518, 1340.7787715026911, 1343.6506508307714, 1356.2947267420886, 1113.821788513834, 1139.9886001139882, 1214.9149559530924, 1244.0358721990349, 1255.918365306252, 8271.669133234724, 8272.296854767412, 8315.210055044761, 8333.125021872738, 8335.458195217292, 513.2711549599578, 522.190604562926, 522.4592546714208, 1225.2036176485356, 1266.512392728806, 5672.886542269214, 6281.59169653971, 6425.742970281136, 6428.71070801815, 6447.580907241015, 9256.814863702823, 10532.10477109439, 10863.402512861869, 10874.836877446845, 10956.561737530568, 10477.528511217013, 10595.046445819913, 10744.462776861126, 10764.730881728019, 10822.404767737693, 8265.752027439186, 8315.459495132796, 8317.667293308321, 8368.497890126611, 8398.916010839936, 7897.605119744105, 7914.762557123296, 8032.919670803217, 8053.758387248392, 8079.555624440713, 8336.333093352396, 9562.856557151787, 9807.411555306704, 9847.212223021997, 9993.300468967103, 9782.657606983721, 9989.001099889952, 10269.229807764297, 10343.84484232722, 10387.428691422045, 6455.483561315177, 6571.868562628625, 6728.351553869334, 7084.362407383154, 7308.5614863108385, 6953.548019378724, 8261.876071859047, 8288.461250018729, 8306.460080094774, 8312.33501319905, 7581.241875812375, 7714.4599878008, 7716.344110750424, 7838.725644602411, 7839.216078392115, 7495.700171993278, 7573.734919277799, 7734.8839767402405, 7830.256125668053, 7898.447108702336, 7806.453548251568, 7821.491603045783, 7827.530348179127, 7842.137364889972, 7854.842903142019, 6941.548799328028, 7110.1112360954885, 7118.28817118284, 7136.857262854817, 7158.463115266271, 7234.131904171322, 7273.563586184846, 7280.417566594766, 7286.744963926237, 7299.598522081336], "unit": "score", "name": "mootools.html", "value": 4930.090177250104}, {"lowerIsBetter": false, "replicates": [288.3900550336039, 333.72134267886315, 333.8697907815954, 339.1707275710887, 340.97954122752634, 6650.368215019577, 6848.246692863793, 6862.142232220973, 6889.173299204096, 6949.548279361838, 6502.15471988642, 6757.5269731118715, 6768.8307792305095, 6786.355296246848, 6811.761588344409, 5013.047520971022, 5039.0, 5044.142495775709, 5044.495550444963, 5070.138076527, 4792.784324705397, 5057.57010654093, 5071.797128114889, 5072.1630930896545, 5106.208537676666, 4905.166121759292, 4905.190643543811, 4909.975450122744, 4921.237208232729, 4932.753362331869, 4929.482404347564, 4936.111499930011, 4973.900521989576, 4974.253861920723, 4997.85006449807, 4005.419214213952, 4114.485689288839, 4125.1749650070105, 4205.306124489455, 4209.726367786084, 5676.489115979582, 6548.345165483461, 6582.144321238256, 6595.3511622094475, 6607.834804129935, 5822.796202132905, 5880.147378630118, 5882.529397648178, 5889.587728858939, 5913.083472061838, 7084.3269889360945, 7347.375473084794, 7355.816104597375, 7365.705371785122, 7398.741044063432, 4737.715737055788, 4740.762961851928, 4750.406199225097, 4755.5719985201495, 4768.499307572724, 7678.654460549289, 7778.416618753616, 7782.688692452295, 7786.104597971249, 7843.4901731387845, 4426.782634775463, 4441.378207051015, 4664.55686709762, 4789.544993225638, 4793.808247670124, 4900.779464924016, 4904.411470623477, 4913.656044076952, 4927.630427717935, 4930.359053323045, 4425.468943726773, 5752.913706294409, 5856.828634273163, 5865.706714664249, 5873.412658734178, 6280.780172693934, 6711.993201019886, 7382.963085184647, 7405.629718514053, 7431.85136297271, 1425.978610320846, 1633.681432120725, 1700.4643537285715, 1710.6065604910941, 1713.5630414244288, 1079.4818487126067, 1086.223350304536, 1098.522142867839, 1098.6154845803906, 1103.6413165721174, 5053.5957123430035, 5794.333651630032, 6056.879477296714, 6385.393387628168, 6911.308869113149, 6269.592476489013, 7098.858022839514, 7631.771046868603, 7695.192004839523, 7709.614519274126, 6534.117894084237, 6681.899771503431, 6843.965780171067, 6846.178458584902, 6893.689783959633, 3907.902302442462, 3988.082740969593, 3991.600839915985, 4035.414864844581, 4095.385692146202, 7951.562664053533, 8007.959960200162, 8009.719659811995, 8019.639116239783, 8040.15578364275, 7670.194629563927, 7866.898634191103, 7892.250236227549, 7899.881501777363, 7906.169852165554, 8000.279974802295, 8013.0, 8060.0, 8064.637091330904, 8080.595970201466, 7696.114946780968, 7711.38308935295, 7715.421343399155, 7742.729004484816, 7788.493747906368, 7361.595112268877, 7365.747822870232, 7538.547687138789, 7570.205128461433, 7610.048743907012, 7154.678039488132, 8044.155363686963, 8050.798730031796, 8070.394720395876, 8075.87886181696, 4829.154897892784, 4849.030193961151, 4856.73287969151, 4871.805127794849, 4875.634327425386, 6172.351903050295, 7056.894146587702, 7630.771076867481, 7703.922960770321, 7762.068551773823, 6661.267260601427, 6920.927256275286, 7455.813604659927, 7456.173237556834, 7467.701291948261, 7271.636418178964, 7401.037865077506, 7432.777016689508, 7449.068866391701, 7460.0, 7233.059702238886, 7240.131184257712, 7246.094238220223, 7254.310840470147, 7288.708451662086, 5633.605647604629, 6305.779297724557, 7425.071866016748, 7471.92528074734, 7492.587907664913, 7037.120359955005, 7263.6005019724425, 7272.96363518179, 7293.030881662027, 7336.96331518339], "unit": "score", "name": "prototype.html", "value": 5296.414147467181}, {"lowerIsBetter": false, "replicates": [635.98410039749, 684.442179623607, 690.9550879192856, 695.1033167214293, 749.0823740917377, 14102.435902563899, 14184.43262269508, 14278.286085695725, 14293.0, 14313.713725725493, 13339.333033348343, 13419.463221471155, 13420.0, 13435.596932092052, 13461.528846490375, 689.8758223519765, 701.5615240474704, 846.3483117999137, 848.4909054567256, 852.8336974290016, 850.6682393866397, 851.429542206723, 859.9398042137021, 859.9957000215021, 860.0625318402939, 914.0585197246813, 915.4278575890069, 918.1231923513029, 919.5678031325266, 919.6137622198659, 895.8790563273973, 903.4443817052531, 911.0752586125055, 911.3939230411768, 915.8168366326728, 650.1255810934285, 657.9473642108668, 673.2896793882452, 677.420805211542, 679.1510611735331, 12045.915867571874, 13080.215187088805, 13568.660783480393, 13572.796408053888, 13620.046596738232, 12604.0, 12668.303243321614, 12685.556005539855, 12760.936195318964, 12850.0, 8154.75535733923, 10020.59917603295, 10328.070473657406, 10346.896531034668, 10817.567297308098, 3163.5254711793414, 3375.8649654014057, 3540.91147721309, 3554.022643772983, 3574.4995700601935, 73832.63083684548, 74970.0, 76249.85625215626, 76503.0, 76746.61626691831, 7822.8435431291055, 9371.127172501405, 9479.33644644882, 9629.807403851884, 10020.498975051218, 20703.79296207049, 21021.579568408546, 21038.89480552618, 21059.894700526707, 21106.78893211079, 7273.527220730635, 7411.295926886937, 7434.36807871337, 7450.403967682681, 7454.776356709307, 3928.0, 4176.206520761046, 4207.76857272853, 4216.852410165629, 4276.144771045803, 3472.392331342005, 3473.583170019614, 3502.9124271893406, 3503.3168532136497, 3523.4714792780774, 654.9345065493412, 663.7477758451757, 665.2449469851753, 690.7444245629149, 703.2440126863642, 534.7272890825707, 577.4927439383207, 613.8373331067271, 625.4058644287853, 634.952378571609, 8296.419250652518, 8591.828163436696, 8594.0, 8700.08649091849, 8727.04002559718, 611.9877602447926, 617.8980468222693, 620.1689735754111, 622.9813105606839, 632.3549979021373, 4046.4132700758223, 4362.738235705868, 4437.36136368175, 4444.377787109807, 4518.938867834698, 81424.0, 86186.70719939205, 86971.56514217389, 87975.56012220026, 88216.0, 78220.60889695628, 78424.0, 78621.60689196632, 79390.6030469844, 79463.8080428794, 57938.710306449044, 68344.0, 68563.0, 68755.31244687489, 68830.65584672044, 8485.448445851247, 8701.216890479634, 8807.119288071142, 8819.955900220459, 8961.0, 48263.75868120637, 48278.7498130693, 48752.58840395121, 48792.29226977181, 49052.50947490622, 46807.595772125525, 49373.75313123555, 61717.691411542655, 64771.67614161899, 67373.0, 9247.445153290824, 10753.462326883468, 10838.187135964676, 10919.617813376493, 11849.585264515701, 11113.499892504695, 11370.488328025092, 12190.878091218974, 12293.262404255773, 12386.442610082748, 11368.943155284502, 11602.47788849487, 11822.11334149925, 12016.63950081499, 12024.338661373358, 11353.318800871974, 11487.48306326234, 11540.134489913122, 12064.276143431422, 12271.26372417622, 10857.511411986638, 11381.260218085798, 11417.659379827282, 11665.24175928562, 11710.355930423908, 9153.86269205949, 9246.260299175916, 9363.531823408666, 9595.891471706396, 10191.468855260744, 9042.864357034781, 9343.345965782602, 9364.672236471692, 10060.798784024424, 10104.292699510963], "unit": "score", "name": "yui.html", "value": 6786.025231169742}], "name": "dromaeo_css", "value": 7357.267012950822}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 104.0, 112.0, 113.0, 115.0, 126.0, 119.0, 148.0, 100.0, 101.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [156.0, 132.0, 174.0, 164.0, 108.0, 169.0, 171.0, 151.0, 176.0, 144.0], "unit": "score", "name": "audio-beat-detection", "value": 154.5}, {"lowerIsBetter": true, "replicates": [194.0, 197.0, 196.0, 211.0, 209.0, 247.0, 253.0, 206.0, 200.0, 199.0], "unit": "score", "name": "audio-dft", "value": 211.2}, {"lowerIsBetter": true, "replicates": [74.0, 101.0, 104.0, 112.0, 54.0, 56.0, 57.0, 60.0, 115.0, 55.0], "unit": "score", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [81.0, 88.0, 118.0, 78.0, 79.0, 85.0, 119.0, 81.0, 80.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [128.0, 131.0, 86.0, 94.0, 88.0, 92.0, 85.0, 94.0, 88.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.9}, {"lowerIsBetter": true, "replicates": [95.0, 138.0, 96.0, 104.0, 129.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 103.8}, {"lowerIsBetter": true, "replicates": [77.0, 145.0, 149.0, 92.0, 90.0, 98.0, 109.0, 93.0, 93.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 104.1}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 56.0, 53.0, 57.0, 53.0, 56.0, 62.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [64.0, 72.0, 66.0, 71.0, 68.0, 68.0, 66.0, 67.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [93.0, 108.0, 112.0, 111.0, 87.0, 84.0, 85.0, 86.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.4}, {"lowerIsBetter": true, "replicates": [125.0, 126.0, 124.0, 133.0, 125.0, 130.0, 140.0, 114.0, 124.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 141.0, 134.0, 127.0, 144.0, 139.0, 178.0, 141.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 68.0, 66.0, 74.0, 79.0, 97.0, 99.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.3}], "name": "kraken", "value": 1522.8}]} 05:29:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1522.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7357.27"}}} 05:29:12 INFO - Return code: 0 05:29:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:29:12 INFO - # TBPL SUCCESS # 05:29:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:12 INFO - 2016-01-29 05:29:12.869 screenresolution[2366:28659] starting screenresolution argv=screenresolution get 05:29:12 INFO - 2016-01-29 05:29:12.871 screenresolution[2366:28659] Display 0: 1600x1200x32@60 05:29:12 INFO - 2016-01-29 05:29:12.877 screenresolution[2367:28662] starting screenresolution argv=screenresolution list 05:29:12 INFO - Available Modes on Display 0 05:29:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:13 INFO - Intel Iris: 05:29:13 INFO - Chipset Model: Intel Iris 05:29:13 INFO - Type: GPU 05:29:13 INFO - Bus: Built-In 05:29:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:13 INFO - Vendor: Intel (0x8086) 05:29:13 INFO - Device ID: 0x0a2e 05:29:13 INFO - Revision ID: 0x0009 05:29:13 INFO - Displays: 05:29:13 INFO - Display: 05:29:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:13 INFO - Display Serial Number: 1600x1200 60 05:29:13 INFO - Main Display: Yes 05:29:13 INFO - Mirror: Off 05:29:13 INFO - Online: Yes 05:29:13 INFO - Rotation: Supported 05:29:13 INFO - Return code: 0 05:29:13 INFO - Running post-action listener: _resource_record_post_action 05:29:13 INFO - Running post-run listener: _resource_record_post_run 05:29:14 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 1007616; Write bytes: 715903488; Read time: 11; Write time: 2101 05:29:14 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403665408; Write bytes: 409353728; Read time: 30344; Write time: 784 05:29:14 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 1007616; Write bytes: 305050624; Read time: 11; Write time: 1313 05:29:14 INFO - Running post-run listener: _upload_blobber_files 05:29:14 INFO - Blob upload gear active. 05:29:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:15 INFO - (blobuploader) - INFO - Done attempting. 05:29:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:16 INFO - (blobuploader) - INFO - Done attempting. 05:29:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:16 INFO - Return code: 0 05:29:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d71d91841fe79417cbcea33b3c924b1f6b919d3aceb6fd3bf6adaa80f6a62f9ce09e9286aa9630b7552764502553165421fa458c60e26f3bb35681c3ec4050", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ce517fcf24a5ff31ad6bcfb3d3305b7c0fc730dfb008aa712ea8e4561980a0e5484482e1a545777f3baffb3cd883ef561581e160adacf63273aae8c8d9d9d32"} 05:29:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:16 INFO - Contents: 05:29:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d71d91841fe79417cbcea33b3c924b1f6b919d3aceb6fd3bf6adaa80f6a62f9ce09e9286aa9630b7552764502553165421fa458c60e26f3bb35681c3ec4050", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ce517fcf24a5ff31ad6bcfb3d3305b7c0fc730dfb008aa712ea8e4561980a0e5484482e1a545777f3baffb3cd883ef561581e160adacf63273aae8c8d9d9d32"} 05:29:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:16 INFO - Copying logs to upload dir... 05:29:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.917811 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-29 05:29:16.845374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 05:29:16.848865) ========= 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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d71d91841fe79417cbcea33b3c924b1f6b919d3aceb6fd3bf6adaa80f6a62f9ce09e9286aa9630b7552764502553165421fa458c60e26f3bb35681c3ec4050", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ce517fcf24a5ff31ad6bcfb3d3305b7c0fc730dfb008aa712ea8e4561980a0e5484482e1a545777f3baffb3cd883ef561581e160adacf63273aae8c8d9d9d32"} build_url:https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/FAKs1odfQ76tZvjGNsb35w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d71d91841fe79417cbcea33b3c924b1f6b919d3aceb6fd3bf6adaa80f6a62f9ce09e9286aa9630b7552764502553165421fa458c60e26f3bb35681c3ec4050", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ce517fcf24a5ff31ad6bcfb3d3305b7c0fc730dfb008aa712ea8e4561980a0e5484482e1a545777f3baffb3cd883ef561581e160adacf63273aae8c8d9d9d32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 05:29:16.876601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:29:16.877038) ========= 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.QjYnkpPzN4/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.2ogAFM94Xm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005265 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 05:29:16.926450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 05:29:16.926747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 05:29:16.927119) ========= ========= Total master_lag: 0.29 =========