builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0032 starttime: 1448025482.42 results: success (0) buildid: 20151120030227 builduid: 5a10f9ad2c234d3696596db9ce2d60d8 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.420593) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.421084) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.421417) ========= 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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005476 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.449295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.449691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.470259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.470685) ========= 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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.006179 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.522064) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.522419) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.522852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.523181) ========= 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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 --2015-11-20 05:18:02-- 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% 26.3M=0s 2015-11-20 05:18:02 (26.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184131 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.724081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.724465) ========= 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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026131 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:02.773165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-20 05:18:02.773593) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 2015-11-20 05:18:02,853 truncating revision to first 12 chars 2015-11-20 05:18:02,853 Setting DEBUG logging. 2015-11-20 05:18:02,853 attempt 1/10 2015-11-20 05:18:02,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 05:18:04,596 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.984479 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-20 05:18:04.778687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:04.779080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:04.794312) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:04.794725) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:18:04.795248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-20 05:18:04.795577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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', '--system-bits', '64', '--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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:04 INFO - MultiFileLogger online at 20151120 05:18:04 in /builds/slave/test 05:18:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:18:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:04 INFO - {'append_to_log': False, 05:18:04 INFO - 'base_work_dir': '/builds/slave/test', 05:18:04 INFO - 'blob_upload_branch': 'Firefox', 05:18:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:04 INFO - 'branch': 'Firefox', 05:18:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:04 INFO - 'config_files': ('talos/mac_config.py',), 05:18:04 INFO - 'default_actions': ('clobber', 05:18:04 INFO - 'read-buildbot-config', 05:18:04 INFO - 'download-and-extract', 05:18:04 INFO - 'populate-webroot', 05:18:04 INFO - 'create-virtualenv', 05:18:04 INFO - 'install', 05:18:04 INFO - 'run-tests'), 05:18:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:04 INFO - 'download_minidump_stackwalk': True, 05:18:04 INFO - 'download_symbols': 'ondemand', 05:18:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:04 INFO - 'installer_path': 'installer.exe', 05:18:04 INFO - 'log_level': 'info', 05:18:04 INFO - 'log_name': 'talos', 05:18:04 INFO - 'log_to_console': True, 05:18:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:18:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:18:04 INFO - 'opt_config_files': (), 05:18:04 INFO - 'pip_index': False, 05:18:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:04 INFO - 'cmd': ('bash', 05:18:04 INFO - '-c', 05:18:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:04 INFO - 'enabled': True, 05:18:04 INFO - 'halt_on_failure': False, 05:18:04 INFO - 'name': 'check_screen_resolution'},), 05:18:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:04 INFO - 'cmd': ('bash', 05:18:04 INFO - '-c', 05:18:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:04 INFO - 'enabled': True, 05:18:04 INFO - 'halt_on_failure': False, 05:18:04 INFO - 'name': 'check_screen_resolution'},), 05:18:04 INFO - 'run_cmd_checks_enabled': True, 05:18:04 INFO - 'sps_profile': False, 05:18:04 INFO - 'sps_profile_interval': 0, 05:18:04 INFO - 'suite': 'dromaeojs-e10s', 05:18:04 INFO - 'system_bits': '64', 05:18:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:04 INFO - 'title': 't-yosemite-r7-0032', 05:18:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:04 INFO - 'use_talos_json': True, 05:18:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:04 INFO - 'work_dir': 'build'} 05:18:04 INFO - ##### 05:18:04 INFO - ##### Running clobber step. 05:18:04 INFO - ##### 05:18:04 INFO - Running pre-action listener: _resource_record_pre_action 05:18:04 INFO - Running main action method: clobber 05:18:04 INFO - rmtree: /builds/slave/test/build 05:18:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:06 INFO - Running post-action listener: _resource_record_post_action 05:18:06 INFO - ##### 05:18:06 INFO - ##### Running read-buildbot-config step. 05:18:06 INFO - ##### 05:18:06 INFO - Running pre-action listener: _resource_record_pre_action 05:18:06 INFO - Running main action method: read_buildbot_config 05:18:06 INFO - Using buildbot properties: 05:18:06 INFO - { 05:18:06 INFO - "properties": { 05:18:06 INFO - "buildnumber": 2, 05:18:06 INFO - "product": "firefox", 05:18:06 INFO - "script_repo_revision": "production", 05:18:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:18:06 INFO - "repository": "", 05:18:06 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:18:06 INFO - "buildid": "20151120030227", 05:18:06 INFO - "slavename": "t-yosemite-r7-0032", 05:18:06 INFO - "stage_platform": "macosx64", 05:18:06 INFO - "basedir": "/builds/slave/test", 05:18:06 INFO - "nightly_build": "True", 05:18:06 INFO - "project": "", 05:18:06 INFO - "platform": "yosemite_r7", 05:18:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:18:06 INFO - "slavebuilddir": "test", 05:18:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:18:06 INFO - "branch": "mozilla-central", 05:18:06 INFO - "repo_path": "mozilla-central", 05:18:06 INFO - "pgo_build": "False", 05:18:06 INFO - "builduid": "5a10f9ad2c234d3696596db9ce2d60d8", 05:18:06 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:18:06 INFO - }, 05:18:06 INFO - "sourcestamp": { 05:18:06 INFO - "repository": "", 05:18:06 INFO - "hasPatch": false, 05:18:06 INFO - "project": "", 05:18:06 INFO - "branch": "mozilla-central-macosx64-talos", 05:18:06 INFO - "changes": [ 05:18:06 INFO - { 05:18:06 INFO - "category": null, 05:18:06 INFO - "files": [ 05:18:06 INFO - { 05:18:06 INFO - "url": null, 05:18:06 INFO - "name": "https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:18:06 INFO - } 05:18:06 INFO - ], 05:18:06 INFO - "repository": "", 05:18:06 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 05:18:06 INFO - "who": "sendchange", 05:18:06 INFO - "when": 1448024493, 05:18:06 INFO - "number": 6688302, 05:18:06 INFO - "comments": "", 05:18:06 INFO - "project": "", 05:18:06 INFO - "at": "Fri 20 Nov 2015 05:01:33", 05:18:06 INFO - "branch": "mozilla-central-macosx64-talos", 05:18:06 INFO - "revlink": "", 05:18:06 INFO - "properties": [ 05:18:06 INFO - [ 05:18:06 INFO - "buildid", 05:18:06 INFO - "20151120030227", 05:18:06 INFO - "Change" 05:18:06 INFO - ], 05:18:06 INFO - [ 05:18:06 INFO - "builduid", 05:18:06 INFO - "5a10f9ad2c234d3696596db9ce2d60d8", 05:18:06 INFO - "Change" 05:18:06 INFO - ], 05:18:06 INFO - [ 05:18:06 INFO - "nightly_build", 05:18:06 INFO - "True", 05:18:06 INFO - "Change" 05:18:06 INFO - ], 05:18:06 INFO - [ 05:18:06 INFO - "pgo_build", 05:18:06 INFO - "False", 05:18:06 INFO - "Change" 05:18:06 INFO - ] 05:18:06 INFO - ], 05:18:06 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:18:06 INFO - } 05:18:06 INFO - ], 05:18:06 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:18:06 INFO - } 05:18:06 INFO - } 05:18:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:18:06 INFO - Running post-action listener: _resource_record_post_action 05:18:06 INFO - ##### 05:18:06 INFO - ##### Running download-and-extract step. 05:18:06 INFO - ##### 05:18:06 INFO - Running pre-action listener: _resource_record_pre_action 05:18:06 INFO - Running main action method: download_and_extract 05:18:06 INFO - mkdir: /builds/slave/test/build/tests 05:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:06 INFO - https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/test_packages.json 05:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/test_packages.json 05:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:18:07 INFO - Downloaded 1149 bytes. 05:18:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:18:07 INFO - Using the following test package requirements: 05:18:07 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:18:07 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:18:07 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'jsshell-mac.zip'], 05:18:07 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:18:07 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:18:07 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:18:07 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:18:07 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:18:07 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:18:07 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:07 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:18:07 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:07 INFO - https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:18:08 INFO - Downloaded 17522605 bytes. 05:18:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:18:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:18:11 INFO - Return code: 0 05:18:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:11 INFO - https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:18:12 INFO - Downloaded 17522605 bytes. 05:18:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:18:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:18:15 INFO - Return code: 0 05:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:15 INFO - https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:18:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:18:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:18:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:18:16 INFO - Downloaded 11130997 bytes. 05:18:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:18:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:18:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:18:16 INFO - Return code: 0 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:18:19 INFO - Downloaded 109534945 bytes. 05:18:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:18:19 INFO - mkdir: /builds/slave/test/properties 05:18:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:19 INFO - Contents: 05:18:19 INFO - build_url:https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:18:19 INFO - Running post-action listener: _resource_record_post_action 05:18:19 INFO - Running post-action listener: set_extra_try_arguments 05:18:19 INFO - ##### 05:18:19 INFO - ##### Running populate-webroot step. 05:18:19 INFO - ##### 05:18:19 INFO - Running pre-action listener: _resource_record_pre_action 05:18:19 INFO - Running main action method: populate_webroot 05:18:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:18:19 INFO - '../fennec_ids.txt'], 05:18:19 INFO - 'tests': ['tcheck2']}, 05:18:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:19 INFO - '--tppagecycles', 05:18:19 INFO - '7'], 05:18:19 INFO - 'tests': ['tsvgm']}}, 05:18:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:18:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:18:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:18:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'tests': ['damp', 'tps']}, 05:18:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['damp', 'tps']}, 05:18:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:18:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:19 INFO - 'other': {'tests': ['a11yr', 05:18:19 INFO - 'ts_paint', 05:18:19 INFO - 'tpaint', 05:18:19 INFO - 'sessionrestore', 05:18:19 INFO - 'sessionrestore_no_auto_restore']}, 05:18:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['a11yr', 05:18:19 INFO - 'ts_paint', 05:18:19 INFO - 'tpaint', 05:18:19 INFO - 'sessionrestore', 05:18:19 INFO - 'sessionrestore_no_auto_restore']}, 05:18:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['a11yr', 05:18:19 INFO - 'ts_paint', 05:18:19 INFO - 'tpaint', 05:18:19 INFO - 'sessionrestore', 05:18:19 INFO - 'sessionrestore_no_auto_restore']}, 05:18:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['a11yr', 05:18:19 INFO - 'ts_paint', 05:18:19 INFO - 'tpaint', 05:18:19 INFO - 'sessionrestore', 05:18:19 INFO - 'sessionrestore_no_auto_restore']}, 05:18:19 INFO - 'other_l64': {'tests': ['a11yr', 05:18:19 INFO - 'ts_paint', 05:18:19 INFO - 'tpaint', 05:18:19 INFO - 'sessionrestore', 05:18:19 INFO - 'sessionrestore_no_auto_restore']}, 05:18:19 INFO - 'other_nol64': {'tests': ['a11yr', 05:18:19 INFO - 'ts_paint', 05:18:19 INFO - 'tpaint', 05:18:19 INFO - 'sessionrestore', 05:18:19 INFO - 'sessionrestore_no_auto_restore']}, 05:18:19 INFO - 'svgr': {'tests': ['tsvgx', 05:18:19 INFO - 'tsvgr_opacity', 05:18:19 INFO - 'tart', 05:18:19 INFO - 'tscrollx', 05:18:19 INFO - 'cart']}, 05:18:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['tsvgx', 05:18:19 INFO - 'tsvgr_opacity', 05:18:19 INFO - 'tart', 05:18:19 INFO - 'tscrollx', 05:18:19 INFO - 'cart']}, 05:18:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'tests': ['tp5o']}, 05:18:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'talos_options': ['--e10s'], 05:18:19 INFO - 'tests': ['tp5o']}, 05:18:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'talos_options': ['--xperf_path', 05:18:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:19 INFO - 'tests': ['tp5n']}, 05:18:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:19 INFO - 'talos_options': ['--e10s', 05:18:19 INFO - '--xperf_path', 05:18:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:19 INFO - 'tests': ['tp5n']}}, 05:18:19 INFO - 'talos.zip': {'path': '', 05:18:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:19 INFO - Running post-action listener: _resource_record_post_action 05:18:19 INFO - ##### 05:18:19 INFO - ##### Running create-virtualenv step. 05:18:19 INFO - ##### 05:18:19 INFO - Running pre-action listener: _resource_record_pre_action 05:18:19 INFO - Running main action method: create_virtualenv 05:18:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:19 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:18:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:19 INFO - Using real prefix '/tools/python27' 05:18:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:23 INFO - Installing pip.................done. 05:18:23 INFO - Return code: 0 05:18:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:23 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:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:23 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:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:23 INFO - 'HOME': '/Users/cltbld', 05:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:23 INFO - 'LOGNAME': 'cltbld', 05:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:23 INFO - 'MOZ_NO_REMOTE': '1', 05:18:23 INFO - 'NO_EM_RESTART': '1', 05:18:23 INFO - 'PAGER': '/bin/cat', 05:18:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:23 INFO - 'PWD': '/builds/slave/test', 05:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:23 INFO - 'SHELL': '/bin/bash', 05:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:23 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:23 INFO - 'USER': 'cltbld', 05:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:23 INFO - 'XPC_FLAGS': '0x0', 05:18:23 INFO - 'XPC_SERVICE_NAME': '0', 05:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:23 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:18:23 INFO - Cleaning up... 05:18:23 INFO - Return code: 0 05:18:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:18:23 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:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:23 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:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:23 INFO - 'HOME': '/Users/cltbld', 05:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:23 INFO - 'LOGNAME': 'cltbld', 05:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:23 INFO - 'MOZ_NO_REMOTE': '1', 05:18:23 INFO - 'NO_EM_RESTART': '1', 05:18:23 INFO - 'PAGER': '/bin/cat', 05:18:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:23 INFO - 'PWD': '/builds/slave/test', 05:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:23 INFO - 'SHELL': '/bin/bash', 05:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:23 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:23 INFO - 'USER': 'cltbld', 05:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:23 INFO - 'XPC_FLAGS': '0x0', 05:18:23 INFO - 'XPC_SERVICE_NAME': '0', 05:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:24 INFO - Downloading/unpacking psutil>=0.7.1 05:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:18:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:26 INFO - Installing collected packages: psutil 05:18:26 INFO - Running setup.py install for psutil 05:18:26 INFO - building 'psutil._psutil_osx' extension 05:18:26 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:18:27 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:18:27 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:18:27 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:18:27 INFO - building 'psutil._psutil_posix' extension 05:18:27 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:18:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:18:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:18:27 INFO - ^ 05:18:27 INFO - 1 warning generated. 05:18:27 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:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:27 INFO - Successfully installed psutil 05:18:27 INFO - Cleaning up... 05:18:27 INFO - Return code: 0 05:18:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:18:27 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:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:27 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:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:27 INFO - 'HOME': '/Users/cltbld', 05:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:27 INFO - 'LOGNAME': 'cltbld', 05:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:27 INFO - 'MOZ_NO_REMOTE': '1', 05:18:27 INFO - 'NO_EM_RESTART': '1', 05:18:27 INFO - 'PAGER': '/bin/cat', 05:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:27 INFO - 'PWD': '/builds/slave/test', 05:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:27 INFO - 'SHELL': '/bin/bash', 05:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:27 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:27 INFO - 'USER': 'cltbld', 05:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:27 INFO - 'XPC_FLAGS': '0x0', 05:18:27 INFO - 'XPC_SERVICE_NAME': '0', 05:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:30 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:18:30 INFO - Installing collected packages: mozsystemmonitor 05:18:30 INFO - Running setup.py install for mozsystemmonitor 05:18:30 INFO - Successfully installed mozsystemmonitor 05:18:30 INFO - Cleaning up... 05:18:30 INFO - Return code: 0 05:18:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:30 INFO - 'HOME': '/Users/cltbld', 05:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:30 INFO - 'LOGNAME': 'cltbld', 05:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:30 INFO - 'MOZ_NO_REMOTE': '1', 05:18:30 INFO - 'NO_EM_RESTART': '1', 05:18:30 INFO - 'PAGER': '/bin/cat', 05:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:30 INFO - 'PWD': '/builds/slave/test', 05:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:30 INFO - 'SHELL': '/bin/bash', 05:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:30 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:30 INFO - 'USER': 'cltbld', 05:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:30 INFO - 'XPC_FLAGS': '0x0', 05:18:30 INFO - 'XPC_SERVICE_NAME': '0', 05:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:34 INFO - Downloading docopt-0.6.1.tar.gz 05:18:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:34 INFO - Running setup.py install for blobuploader 05:18:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:34 INFO - Running setup.py install for requests 05:18:34 INFO - Running setup.py install for docopt 05:18:35 INFO - Successfully installed blobuploader requests docopt 05:18:35 INFO - Cleaning up... 05:18:35 INFO - Return code: 0 05:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:35 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:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 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:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:35 INFO - 'HOME': '/Users/cltbld', 05:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:35 INFO - 'LOGNAME': 'cltbld', 05:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:35 INFO - 'MOZ_NO_REMOTE': '1', 05:18:35 INFO - 'NO_EM_RESTART': '1', 05:18:35 INFO - 'PAGER': '/bin/cat', 05:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:35 INFO - 'PWD': '/builds/slave/test', 05:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:35 INFO - 'SHELL': '/bin/bash', 05:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:35 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:35 INFO - 'USER': 'cltbld', 05:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:35 INFO - 'XPC_FLAGS': '0x0', 05:18:35 INFO - 'XPC_SERVICE_NAME': '0', 05:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-aUag4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wpwo95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lONp1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YMwuUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-O_0PWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-muLFuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-U6h3Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zQfD1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-F7kYja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-niRSuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cJXZUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6SDB5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DPMmFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ed5knX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-KOLxUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zURSgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pEr86_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:37 INFO - Running setup.py install for manifestparser 05:18:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:37 INFO - Running setup.py install for mozcrash 05:18:37 INFO - Running setup.py install for mozdebug 05:18:37 INFO - Running setup.py install for mozdevice 05:18:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:37 INFO - Running setup.py install for mozfile 05:18:37 INFO - Running setup.py install for mozhttpd 05:18:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:37 INFO - Running setup.py install for mozinfo 05:18:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Running setup.py install for mozInstall 05:18:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Running setup.py install for mozleak 05:18:38 INFO - Running setup.py install for mozlog 05:18:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Running setup.py install for moznetwork 05:18:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:38 INFO - Running setup.py install for mozprocess 05:18:38 INFO - Running setup.py install for mozprofile 05:18:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:39 INFO - Running setup.py install for mozrunner 05:18:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:39 INFO - Running setup.py install for mozscreenshot 05:18:39 INFO - Running setup.py install for moztest 05:18:39 INFO - Running setup.py install for mozversion 05:18:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:39 INFO - Cleaning up... 05:18:39 INFO - Return code: 0 05:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:39 INFO - 'HOME': '/Users/cltbld', 05:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:39 INFO - 'LOGNAME': 'cltbld', 05:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:39 INFO - 'MOZ_NO_REMOTE': '1', 05:18:39 INFO - 'NO_EM_RESTART': '1', 05:18:39 INFO - 'PAGER': '/bin/cat', 05:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:39 INFO - 'PWD': '/builds/slave/test', 05:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:39 INFO - 'SHELL': '/bin/bash', 05:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:39 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:39 INFO - 'USER': 'cltbld', 05:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:39 INFO - 'XPC_FLAGS': '0x0', 05:18:39 INFO - 'XPC_SERVICE_NAME': '0', 05:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SYq0m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6qIn08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Phu6dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ufvOMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2ntQHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-dOJf0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-JSkG2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-AWJaD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-eJsVZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:40 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gOO6oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3KV1Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:41 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:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YDn9mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:41 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:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-31Jdu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-o_hxWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:41 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:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-0oELhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:41 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:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PP9aHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:41 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:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:41 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ITk_WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:41 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:18:41 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:18:41 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:18:41 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:18:41 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:41 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:41 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:18:41 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:18:41 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:18:41 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:18:41 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:18:41 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:18:43 INFO - Downloading blessings-1.5.1.tar.gz 05:18:43 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:43 INFO - Installing collected packages: blessings 05:18:43 INFO - Running setup.py install for blessings 05:18:44 INFO - Successfully installed blessings 05:18:44 INFO - Cleaning up... 05:18:44 INFO - Return code: 0 05:18:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:44 INFO - Reading from file tmpfile_stdout 05:18:44 INFO - Current package versions: 05:18:44 INFO - blessings == 1.5.1 05:18:44 INFO - blobuploader == 1.2.4 05:18:44 INFO - docopt == 0.6.1 05:18:44 INFO - manifestparser == 1.1 05:18:44 INFO - mozInstall == 1.12 05:18:44 INFO - mozcrash == 0.16 05:18:44 INFO - mozdebug == 0.1 05:18:44 INFO - mozdevice == 0.47 05:18:44 INFO - mozfile == 1.2 05:18:44 INFO - mozhttpd == 0.7 05:18:44 INFO - mozinfo == 0.9 05:18:44 INFO - mozleak == 0.1 05:18:44 INFO - mozlog == 3.0 05:18:44 INFO - moznetwork == 0.27 05:18:44 INFO - mozprocess == 0.22 05:18:44 INFO - mozprofile == 0.27 05:18:44 INFO - mozrunner == 6.11 05:18:44 INFO - mozscreenshot == 0.1 05:18:44 INFO - mozsystemmonitor == 0.0 05:18:44 INFO - moztest == 0.7 05:18:44 INFO - mozversion == 1.4 05:18:44 INFO - psutil == 3.1.1 05:18:44 INFO - requests == 1.2.3 05:18:44 INFO - wsgiref == 0.1.2 05:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108928228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a85ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, '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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:44 INFO - 'HOME': '/Users/cltbld', 05:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:44 INFO - 'LOGNAME': 'cltbld', 05:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:44 INFO - 'MOZ_NO_REMOTE': '1', 05:18:44 INFO - 'NO_EM_RESTART': '1', 05:18:44 INFO - 'PAGER': '/bin/cat', 05:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:44 INFO - 'PWD': '/builds/slave/test', 05:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:44 INFO - 'SHELL': '/bin/bash', 05:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:18:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:44 INFO - 'USER': 'cltbld', 05:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:44 INFO - 'XPC_FLAGS': '0x0', 05:18:44 INFO - 'XPC_SERVICE_NAME': '0', 05:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:44 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 1)) 05:18:44 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 2)) 05:18:44 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 3)) 05:18:44 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 4)) 05:18:44 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 5)) 05:18:44 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 6)) 05:18:44 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 7)) 05:18:44 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 8)) 05:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:18:44 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 3)) 05:18:44 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:18:44 INFO - Cleaning up... 05:18:44 INFO - Return code: 0 05:18:44 INFO - Running post-action listener: _resource_record_post_action 05:18:44 INFO - Running post-action listener: _start_resource_monitoring 05:18:44 INFO - Starting resource monitoring. 05:18:44 INFO - ##### 05:18:44 INFO - ##### Running install step. 05:18:44 INFO - ##### 05:18:44 INFO - Running pre-action listener: _resource_record_pre_action 05:18:44 INFO - Running main action method: install 05:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:44 INFO - Reading from file tmpfile_stdout 05:18:44 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:45 INFO - Reading from file tmpfile_stdout 05:18:45 INFO - Output received: 05:18:45 INFO - Usage: mozinstall [options] installer 05:18:45 INFO - Options: 05:18:45 INFO - -h, --help show this help message and exit 05:18:45 INFO - -d DEST, --destination=DEST 05:18:45 INFO - Directory to install application into. [default: 05:18:45 INFO - "/builds/slave/test"] 05:18:45 INFO - --app=APP Application being installed. [default: firefox] 05:18:45 INFO - mkdir: /builds/slave/test/build/application 05:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:19:15 INFO - Reading from file tmpfile_stdout 05:19:15 INFO - Output received: 05:19:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:19:15 INFO - Running post-action listener: _resource_record_post_action 05:19:15 INFO - ##### 05:19:15 INFO - ##### Running run-tests step. 05:19:15 INFO - ##### 05:19:15 INFO - Running pre-action listener: _resource_record_pre_action 05:19:15 INFO - Running main action method: run_tests 05:19:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:19:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:19:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:19:15 INFO - 2015-11-20 05:19:15.500 screenresolution[1640:7566] starting screenresolution argv=screenresolution get 05:19:15 INFO - 2015-11-20 05:19:15.503 screenresolution[1640:7566] Display 0: 1600x1200x32@60 05:19:15 INFO - 2015-11-20 05:19:15.508 screenresolution[1641:7568] starting screenresolution argv=screenresolution list 05:19:15 INFO - Available Modes on Display 0 05:19:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:19:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:19:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:19:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:19:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:19:15 INFO - Intel Iris: 05:19:15 INFO - Chipset Model: Intel Iris 05:19:15 INFO - Type: GPU 05:19:15 INFO - Bus: Built-In 05:19:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:19:15 INFO - Vendor: Intel (0x8086) 05:19:15 INFO - Device ID: 0x0a2e 05:19:15 INFO - Revision ID: 0x0009 05:19:15 INFO - Displays: 05:19:15 INFO - Display: 05:19:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:19:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:19:15 INFO - Display Serial Number: 1600x1200 60 05:19:15 INFO - Main Display: Yes 05:19:15 INFO - Mirror: Off 05:19:15 INFO - Online: Yes 05:19:15 INFO - Rotation: Supported 05:19:15 INFO - Return code: 0 05:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:15 INFO - Python 2.7.3 05:19:15 INFO - Return code: 0 05:19:15 INFO - grabbing minidump binary from tooltool 05:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:15 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 0x10886f9f0>, '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 0x1085cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088628c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:15 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:19:15 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:19:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:15 INFO - Return code: 0 05:19:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:19:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:19:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost'] in /builds/slave/test/build 05:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost 05:19:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YN9dGKG3JF/Render', 05:19:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:15 INFO - 'HOME': '/Users/cltbld', 05:19:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:15 INFO - 'LOGNAME': 'cltbld', 05:19:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:15 INFO - 'MOZ_NO_REMOTE': '1', 05:19:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:15 INFO - 'NO_EM_RESTART': '1', 05:19:15 INFO - 'PAGER': '/bin/cat', 05:19:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:15 INFO - 'PWD': '/builds/slave/test', 05:19:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:15 INFO - 'SHELL': '/bin/bash', 05:19:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJkAIn43Ns/Listeners', 05:19:15 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:19:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:15 INFO - 'USER': 'cltbld', 05:19:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:15 INFO - 'XPC_FLAGS': '0x0', 05:19:15 INFO - 'XPC_SERVICE_NAME': '0', 05:19:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost'] with output_timeout 3600 05:19:16 INFO - mozversion INFO | application_buildid: 20151120030227 05:19:16 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 05:19:16 INFO - mozversion INFO | application_display_name: Nightly 05:19:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:16 INFO - mozversion INFO | application_name: Firefox 05:19:16 INFO - mozversion INFO | application_remotingname: firefox 05:19:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:19:16 INFO - mozversion INFO | application_vendor: Mozilla 05:19:16 INFO - mozversion INFO | application_version: 45.0a1 05:19:16 INFO - mozversion INFO | platform_buildid: 20151120030227 05:19:16 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 05:19:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:19:16 INFO - mozversion INFO | platform_version: 45.0a1 05:19:16 INFO - 2015-11-20 05:19:16,070 DEBUG : using testdate: 1448025556 05:19:16 INFO - 2015-11-20 05:19:16,070 DEBUG : actual date: 1448025556 05:19:16 INFO - 2015-11-20 05:19:16,080 INFO : starting webserver on 'localhost:49270' 05:19:16 INFO - 2015-11-20 05:19:16,081 INFO : Starting test suite t-yosemite-r7-0032.e 05:19:16 INFO - 2015-11-20 05:19:16,081 INFO : Starting test dromaeo_css 05:19:16 INFO - 2015-11-20 05:19:16,081 DEBUG : operating with platform_type : mac_ 05:19:16 INFO - 2015-11-20 05:19:16,082 INFO : Initialising browser for dromaeo_css test... 05:19:16 INFO - 2015-11-20 05:19:16,094 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp9eRhs1/profile http://localhost:49270/getInfo.html 05:19:19 INFO - 2015-11-20 05:19:19,087 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:19:19 INFO - 2015-11-20 05:19:19,087 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:19:19 INFO - 2015-11-20 05:19:19,087 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:19:19 INFO - 2015-11-20 05:19:19,087 DEBUG : BROWSER_OUTPUT: __metrics 05:19:19 INFO - 2015-11-20 05:19:19,662 INFO : Browser initialized. 05:19:19 INFO - 2015-11-20 05:19:19,662 INFO : Running cycle 1/1 for dromaeo_css test... 05:19:19 INFO - 2015-11-20 05:19:19,662 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp9eRhs1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:19:31 INFO - 2015-11-20 05:19:31,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 235683840 05:19:31 INFO - 2015-11-20 05:19:31,604 DEBUG : BROWSER_OUTPUT: 05:20:21 INFO - 2015-11-20 05:20:21,322 DEBUG : BROWSER_OUTPUT: 1448025621316 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:22:32 INFO - 2015-11-20 05:22:32,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:22:33 INFO - 2015-11-20 05:22:33,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 253128704 05:22:33 INFO - 2015-11-20 05:22:33,674 DEBUG : BROWSER_OUTPUT: 05:25:35 INFO - 2015-11-20 05:25:35,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:25:36 INFO - 2015-11-20 05:25:36,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 262766592 05:25:36 INFO - 2015-11-20 05:25:36,183 DEBUG : BROWSER_OUTPUT: 05:28:37 INFO - 2015-11-20 05:28:37,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:28:38 INFO - 2015-11-20 05:28:38,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 262705152 05:28:38 INFO - 2015-11-20 05:28:38,376 DEBUG : BROWSER_OUTPUT: 05:31:39 INFO - 2015-11-20 05:31:39,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:31:40 INFO - 2015-11-20 05:31:40,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 266170368 05:31:40 INFO - 2015-11-20 05:31:40,593 DEBUG : BROWSER_OUTPUT: 05:34:43 INFO - 2015-11-20 05:34:43,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:34:43 INFO - 2015-11-20 05:34:43,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 268890112 05:34:43 INFO - 2015-11-20 05:34:43,628 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:37:45 INFO - 2015-11-20 05:37:45,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 271028224 05:37:45 INFO - 2015-11-20 05:37:45,981 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,982 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:37:45 INFO - 2015-11-20 05:37:45,982 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:37:45 INFO - 2015-11-20 05:37:45,982 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:37:45 INFO - 2015-11-20 05:37:45,982 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:37:45 INFO - 2015-11-20 05:37:45,982 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3475.183331917;3528;3550.520679708242;3556.804375759333;3560.448130539767;5967.134765459011;5972.552058595601;5989.071693887444;6030.87938241236;6031;5710.71446427678;5890.381509941459;5898.616589921652;5961.88076238475;6028.367021462749;5321.973390133063;5345.732713364336;5377.569794416438;5379.757910894019;5446.373667028283;4928.482509336522;5470.234167216593;5537.8061767838135;5543.750531226085;5550.056490396622;5094.694318340911;5178.093833579109;5215.50452706996;5293.153095504701;5445.455454454543;5324;5344.198370244456;5383.67697938125;5389.622726409153;5428.728563571845;5356.330458692663;5358.142697168473;5362.785488580491;5366.382865970424;5393.097551032566;4887.975560122177;5226.876221612333;5490.3411590608985;5827.766889324422;5947.553933454965;6322.367763223687;6322.4942004639515;6344.619322840645;6351.142595749607;6361.650109243989;6289.213848268966;6350.491960643184;6365.045243213509;6367.681615919232;6378.712957916905;4864.683795553313;5858.091995740667;5969.253843269591;6056.636601803906;6108.3280839107665;6320.525960552977;6448.645324507197;6449;6451.903221451682;6461.709223084878;5959.910601340984;6288.182536270256;6312.873742525124;6319.557630965788;6339.651319177397;6262.718177682015;6339.746410143543;6345.8730825384155;6419.293877673452;6440.388163124496;6320.905186422207;6345.714442850082;6361.173047503795;6369.458596019297;6380.680965951684;6175.814725558241;6332.366763323631;6345.270293916166;6367.7452901884335;6380.744770209232;4267.338562522814;5004.749762511859;5046.041252162077;5053.5957123430035;5098.260752190911;4516.661250406232;4569.817207311737;4571.428571428572;4586.312053191981;4599.701019433726;5676.602637815396;5853.209816674779;5866.530677545786;5889.793857214977;6008;6330.335314791881;6350.825097357004;6356.968215158895;6358.809235722843;6363.949948258485;5847.122931560215;5851.239338885917;5879;5897.67562784051;5899.602212475249;4087;4855.8057677693205;5424.511793938565;5521.696306703089;5544.168374743821;6425.453836423862;6463.574305617936;6512.902306465312;6522.5760325578685;6533.934660653523;6283.717232724447;6344.1118243445035;6362.331955144643;6362.395572420613;6370.649614271259;5094.898102038012;6290.402411770874;6318.96689589009;6395.16862807832;6430.3891130342545;5927.940720592911;6289.465395441439;6330.430261276507;6348.555601107878;6352.237731472253;5213.426523082534;6108.159949115189;6345.016522439029;6364.96817515928;6376.936230637634;6163.414475624809;6202.41077097675;6286.339934307015;6292.590981586365;6293.748250069946;6211.782587609412;6226.159468471698;6235.251769787655;6264.624122552661;6265.655388953652;4514.345419914029;5730.598858079894;6204.534659900435;6238.126662267196;6247.250329960434;5130.79476820923;6111.98679349419;6145.064304743992;6241.095041218907;6245.219347581552;5391.81128660495;6184.412480814315;6223.097650840512;6233.844153896189;6234.127222188807 05:37:45 INFO - 2015-11-20 05:37:45,985 DEBUG : BROWSER_OUTPUT: |1;ext.html;533.2275265404082;537.1486194381904;559.0998492427192;596.269569777023;659.9736010559578;40098.59901400985;40535.99999999996;40552.79723601378;40637.59362406379;40735.79632101835;43276.134477310436;43283.78358108213;43620.12759744803;43742.343864841976;43920;9738.269629777777;9913.405195688281;9936.950315248414;9940.20478361733;9972.551235194398;9716.271279654055;9837.901620983806;9842.753931151707;9854.655087071955;9860.654877079303;9747.415155090683;9779.21766258701;9819.950900245489;9827.606895724162;9846.40921544706;9723.367981081243;9792.804143917081;9818.754531136707;9836.31145819793;9839.704808855746;9654.662086826998;9741.65904193357;9753.902460975441;9769.90230097697;9773.462459564722;40466;40517;40670;40775;41276.587234127874;3208.246062175387;3226.6450690424035;3253.186703324169;3344.0302312329395;3574.7855128692104;28051.018214362604;28195.01317453879;28617.427651446855;29144.125676229745;29747.256318591993;2780.824376333593;2792.1204820481485;2830.731080547345;2833.7449629533235;2965.288330800614;430911;514327;516126;517934;519923;58209.70895145497;59288.703556482804;62336.37663623306;62580.68709656422;62765.68617156885;70271;70523.29476705269;70884.64557677179;71085.2891471089;71221.64389178022;16244.187790610658;16484;16532.256048477848;16618.58453538647;16643.167841607872;9693.885203201722;10480.947595261974;11633.709157271136;12540.122191446693;12627.747445051047;15102.773458398133;18449.7232541512;19593.314234002028;19848.50378740543;19878.90060549688;7121.537100088478;8063.4355595108955;8065.717699880476;8183.099859015503;8949.060348663426;892.6786356911507;938.0291398402757;953.618552578974;983.5475681186734;1061.4321338084087;26610.334741631614;30520.084397468112;30589;30712.84643576768;31202.751889924602;951.8905325887612;1047.586203449633;1060.7083052160563;1064.3347907557777;1070.175964507325;14960.326785294688;15616.141112238936;15668.921655391878;15698.92150539263;15896.76154857678;561382;562455;565220;567285;568030;58220.7088964561;58292;59001;59160.7041964796;59447;1399.2723783632455;1401.2153194211273;1419.531554586984;1422.7581311177125;1444.1263035863362;23463.178788742312;29556.704432956256;29718.554221687125;29911.102666920026;30433.543496847124;54772;56079.15881261866;56275.87448251094;56371.71814140903;56602.71698641645;476147;479125;482240;482765;484837;31423.37153256968;32539;33391.33217335591;33605.83197083999;33649.822256221894;42307.3653895198;42475.787621061696;42499.362509563;42599.36100958426;43149.352759708;34467.310653786284;35530.934071977885;36064;36278.8186059068;36566;35099.122521937155;35369.469457958665;35517.11207219737;35724.92825215248;35858.46212306766;35746;36193.45709814302;36211.637883620824;36404.27191456209;36505;31184.532232016085;33156;33312;33516;33836.830815845766;24626.97377951621;24687.38281542976;24872.751272487767;25110;25279 05:37:45 INFO - 2015-11-20 05:37:45,986 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.59737905340273;358.36406802944555;365.4992660055722;369.9001269657192;370.692325369943;15832.129232892186;19625.214991400346;19682;20069.698954515676;20558.177672893067;19830.305939292128;20288.89855550724;20492.487687807814;20544.07551660175;20910;5584.581156413265;5699.116636921273;5848.210491583624;5856.121581762727;5874.295084589855;5657.660540367591;5795.681237531955;5800.506956908668;5804.564657650672;5839.941600584004;5664.688442135681;5803.071508558632;5813.505852002585;6417.422431981144;6444.162258906335;6414.647194404306;6420.133282006916;6443.967780161092;6500.674966251716;6515.869682606345;5617.241672374259;5636.633618814764;5696.3733989261145;5727.627704199213;5740.6268592541355;12788.296643684595;13149.53976610814;15906;25285.482871027798;25804.74195258042;1862.134107639954;1985.0868600443814;2067.514134178467;2090.4251330883976;2108;9803.607855685765;9829.90170098297;9834.360766550222;9985.301028927977;11161.83257251142;1766.6819972404962;1770.139677408164;1780.1722199177445;1785.8303461171297;1849.4913898677837;99693;108162;108648.4567577157;109204.4539777296;111029;10982.835257471144;11036.834447483294;11041.171912106623;11090.611828585961;11107.333559986266;10763.892361076445;12997.15518491295;13078.2806945617;13089.607311780663;13112.147710398793;8068.152843951418;8149.103598604149;8232.62953167109;8288.254057134765;8308.086110527836;8387.790305242417;8502.489850608983;8601.956990215009;8649;8718.43330183536;4276.700630955866;4375;4392.516823149451;4401.779911004437;4422.977885110618;1829.990850045768;1860.1908169946116;1863.7390765292869;1872.1762424533163;1874.709420039896;879.5294517433142;988.0909563201728;1014.1430491234895;1016.6492560066765;1019.8827134879435;16199.028058316539;18812.81187188138;19609.31367402134;19692.40922772319;20784.79215207859;963.3786207895868;973.4743238651191;976.6288810252058;994.438731192036;1047.994760026195;11031.951964563354;11288.2662626929;11310.773784524263;11320;11817.409129543488;754874;759967;761553;769637;776407;99886;124611;125821.37089314495;127119.72880271263;127275;1058.4337379502083;1208.8851559101872;1262.9706788966962;1284.9614511564669;1304.1327517201146;18798.436046918614;18835;18860.339888103852;19331.806681933;19527.70708439403;49357.50642493673;49943;50784;50966.49033509766;51355.22967155421;72754.27245727475;75053.62473187599;75253;75698;75770.86343704739;9469.66856160031;9734;9878.4566848824;9878.950605246928;9948.502574871083;17785.55536111556;19572.412827615193;19767.80232197717;20043.398698039084;20487.38537843867;15734.370625174864;15792.526224213292;15835.841641583898;16044.278007489924;16123.75814362762;12591.937040315106;14772.261386930826;15292.847071529142;15502.457413990456;15536.766948495555;16025.839741602435;16080.517584472485;16465.530170474045;16558;16559.751603726196;9940.801183976135;10009.299349045497;10038.196944244297;10066.44634545107;10104.191664666661;15491.84508154904;15908.045517269002;15953.8404615957;15999.760003600188;16574.585635359213 05:37:45 INFO - 2015-11-20 05:37:45,988 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1285.338050903784;1516.7573188289869;1749.4664127441129;1755.3505203074849;1877.6150889067742;6733.696983635736;7217.061781968337;8327.958360208198;8638.438501497407;8657.567121643917;8213.876791848126;8327.500349978991;8397.622107005183;8420.957895210515;8430.28342590879;2226.3988723044768;2368.6091794853874;2400.567897778399;2408.8313818032743;2410.0118951229997;2389.808815294772;2420.540097381501;2445.8532488050773;2455.631655251718;2456.299954512964;2380.2264264114146;2397.832151749378;2410.626352915292;2427.757224277576;2434.0993832281993;1988.5724569217543;2011.7083022961663;2392.7128744550764;2407.5184963007296;2412.4813165169485;2385.9045638174453;2407.3981504623844;2425.8301918865686;2432.6351047342864;2442.1818690738623;7716.537007779495;8429.873551896726;8433.28317093048;8497.702580409717;8513.361497887683;4710.9764451177525;4962.057209130254;5057.165567681365;5243.239730239094;5285.735713214324;3527.3474407234744;3529.1177205698577;3578.320119177348;3604.855805767766;3645.2891686121216;1046.7592453735608;1054.6150655010943;1066.5627092891878;1068.7969285835666;1081.1783044885865;11203.327800332007;11214.10287177024;11239.775204495945;11251.099912007101;11271.43642817864;4690.554397332248;4703.529647035269;4742.668013239109;4745.928811067837;4754.857354279377;9567.995360487048;9655.324127311162;9673.22614190863;9706.854397184048;9721;5207.140821764442;5221.686698798084;5233.188855727369;5257.132573125392;5273.604479664041;4178.791060447026;4232.343986682069;4670.556297151765;4749.905001899942;4761.309610106515;3876.651101400831;3931.8230679619487;3937.8818635440985;3937.9606203938165;3964.801759911993;1178.9823152652716;1290.6966862787237;1292.476546998467;1296.3453456004656;1297.6885547468728;1369.5959691890916;1382.5506710319187;1395.5045958684723;1408.3169662713576;1417.3834382043844;7816.101148367897;7827.569483678452;7966.960165199137;7970.1631328709655;7998.840168175582;503.91937290033417;511.4297558222555;513.2378418049194;513.4249640402699;513.7020528093772;6045.576809623372;6083.695815209222;6135.509159267248;6167.506599472032;6187.969060154671;9945.751356216007;10132.594696212069;10135.239857010754;10175.440350780778;10232.488375581192;9763.804723905481;10004.099631033241;10046.598136074475;10088.646897358558;10171.389716617026;7938.444308898437;7938.6427610757655;7939.285464308125;7947.483413578099;7958;7481.962590187014;7558.962205188939;7570.772876813704;7571.507851989603;7579.848403032019;8865.290776737716;8997.190252877272;9011.783409239668;9135.817283654156;9156.679516217167;9038.09619038091;9337.066293370608;9405.388649737744;9456.196223321094;9458.006909274702;6464.709088090953;6706.362895524917;7170.354668079898;7416.44376671741;7487.775366739006;7996.600169991593;8011.959940200261;8032.59837008159;8058.758237252891;8083.6766529338165;7303.488755787256;7439.62801859894;7574.280443358092;7663.808404789925;7698.538087714755;7431.40548756109;7466.738664146729;7472.925270747223;7509.136449308399;7577.318041376303;7246.492745507764;7607.429442791702;7618.69525218985;7627.313541781266;7634.122075961113;6848.520603557703;6892.104026476526;6937.340952609494;6939.583624982517;6980.965095174492;6961.512694111364;6971.51199416036;6973.12835895513;7021.68402421882;7046.859062818818 05:37:45 INFO - 2015-11-20 05:37:45,991 DEBUG : BROWSER_OUTPUT: |4;prototype.html;326.76146413118425;329.97525185611084;333.28344060270433;339.38063034961203;339.947308167234;6947;6961.338672826079;6972.860542789142;7020.9297907020855;7104.786856394304;6865.382115609594;6958.617276049815;7010.369066783988;7025.613591252479;7031.542949708265;5074.8731281718065;5106.106431374513;5107.7956881724685;5108.565771909373;5137;4935.161022626162;5117.002184574009;5117.2068329409;5122.052420302256;5134.358205224347;4093.6111069448357;5048.873778155539;5048.924266136011;5050.974745126269;5054.469280725526;5038.748062596892;5044.243363495469;5046.7476626168545;5050.3434553508;5089.694618322913;4126.8761937141935;4226.704130710851;4230.957690423087;4238.279492486285;4243.511996120455;5833.212516310286;6577.473802095821;6590.209174898995;6615.239247486553;6634.601923884582;4741.478437371887;5249.792547714047;5830.5044071254;5840.007198776176;5884.235049443588;7163.964180179066;7282.927170728278;7346.302101300368;7346.853062938765;7357.448191385667;4681.344611754357;4681.368015317957;4696.131215725068;4711.882202944919;4719.905601887977;7794.103678077037;7875.133735289113;7886.447948643598;7914.960425197837;7938.325242354407;4067.9796601016806;4633.86098417048;4705.082508910729;4795.616350692006;4820.204666230103;4838.854834354975;4839.056384005155;4854.344663470457;4855.951440485621;4863.294822250754;5842.678652674143;5881.470667639847;5881.470667639933;5909.409059094056;5934.732937017759;7467.402607791364;7480.289372509603;7488;7488.063992001;7488.288612581796;1657.1382880901863;1699.1079683166436;1700.9829901701073;1703.2335449047978;1710.4099085815374;1031.489412740698;1069.9197560183018;1082.0910435234441;1083.7832433513329;1089.6785448292774;6963.234044255128;6980.022796808451;6988.965055174692;6991.720331186797;6993.615351155735;7700.807479813049;7745.419093567893;7755.1469338372735;7755.72854950074;7804.765857024298;6713.060171575983;6791.3548212919695;6928.61892595902;6944.826379340557;6955.478339124586;3250.3336815953144;3724.571674257441;3742.7461800297206;3997.320455522568;4064.8577299794365;5750.482456578844;7465.738699145504;8053.194680532017;8058.516489010678;8105.027396712432;8014.759557213293;8049.034115906129;8061.395395345256;8064.395170362129;8090.919090809134;6475;6796.388325050769;7812.1016083150025;7858.371330293563;8064.153263907323;7825.295723384695;7830.177831327628;7843.647035883285;7851.489653172525;7857.174996625272;6574.8356291093105;7471.88792168107;7672.539647621161;7697.922290879169;7719.807004824925;6421;8106;8109.270165685117;8128.63421146038;8131.593420329078;4814.20565606671;4815.133276010211;4817.8313759018265;4821.662483626253;4832.589229915356;7597.392208623407;7751.108622508484;7793.9220607793195;7810.492317999312;7844.764657060297;7484.962575187307;7503.7748867534065;7510.361619262206;7511.549307041377;7529.435292353205;7289.669223394064;7484.0063974408495;7489.475736698597;7518.248175182438;7520.09758828944;7250.984862119413;7286.890696639661;7320.487565870338;7329.120505539369;7334.669939852826;7464.925350746423;7471.290227428385;7474.177840437656;7479.663415146223;7503.287187717158;5899.256845566661;6976.302369762983;7153;7251.456140789567;7347.632618369167 05:37:45 INFO - 2015-11-20 05:37:45,992 DEBUG : BROWSER_OUTPUT: |5;yui.html;761.7219714804096;786.7010535996324;816.9019717633881;827.1108558299827;843.9873401898968;13551;14049.648758781035;14064.578062658136;14092;14111.647208819784;11693.415329233525;14249.501267455642;14256.643583910407;14257.287135643228;14289.571312860604;747.7270796159418;761.0448886647278;942.9104235097672;954.2175416158752;965.1072757699135;724.5000949344961;866.4931015356025;949.9002604726508;951.0109486134412;960.582146766159;867.657275376226;987.5506644476745;1007.1791489935715;1024.923130765192;1025.6307729217476;1004.3672486333636;1006.9899301007006;1008.4000019988132;1011.0950699124243;1016.8627235323247;748.356413484403;749.0262658543871;752.7704050264667;753.051155544013;753.4838635534676;13810.65473363164;13814.825739812028;13823.723525529535;13925.512607058805;13945.930270348583;11323.81099984498;11349.659510214708;11610.955014048775;13019.218846869218;13126.86873131266;9127.589258483384;9313.953430232874;9610.327277090606;10311.948440257751;10396.324238924446;3529.4882242075014;3577.499150118985;3579.731520136;3581.9641803582153;3582.0865679251624;82267.17732822715;82416.17583824146;82966;83710.58144709238;84073.57963210206;9713.174380177623;9733.075357840993;9858.676993093473;10004.54979525923;10225.181985441146;21552.13791448356;22129.225477108546;22563.323100307018;22629.88685056597;22826.885865570897;6718.798436046926;7444.925550744423;7535;7755.495892766952;7841;3993.1614360984518;4077.91844163121;4089.284375234322;4092.856750013735;4100.774457404871;3549.432090865501;3569.464580312974;3571.2678900825267;3585.4801053847045;3594.1733401317842;685.0409426802516;692.2005084127841;696.9756058537927;709.2127738210582;709.8651256261294;487.5636305506552;494.0908727940535;494.3523983581448;535.8124656370317;579.4408395897894;8692.956535217283;8734.82530349402;8768.07935166811;8821.558922053871;8908.955455222682;488.38707422184933;508.73291521950534;543.2774410034644;555.677269015511;558.2380051230123;4032.697547683935;4172.874813755592;4208.116295577963;4254.957450425456;4259.7231179973205;101693.49153254334;102738.45892311621;103089;105027;105840;86610;86901.69647455293;86968;86997.56501217453;87982.24035519382;58488.4151158483;78015;78737.60631196808;79460.60269698614;79591.60204198942;9032.774180645536;9111.772205694911;9240.584173712065;9247.213986811197;9252.334579775705;52885;53084.73457632687;53793;53853.19220211622;54345.72827135839;70638.64680676769;73810.63094684492;74683.25316746763;75884;76867.8469822942;10879.945600272265;10997.560097596006;11296.887031129583;11607.825882611598;11686.298822070703;9637.71086867395;11972.401379930794;12032.578859739868;12577.119601628165;12848.935755321163;8789;11520.82718759236;11692.14827656629;11894.524219031142;12140.696482587653;9175.357724959189;11278.266912650652;11303.491342889754;11859.822102668639;12430.564930227398;11051.447427628425;11088.944555277172;11152.442377881236;11562.19064665499;12191.695207619881;8232.62953167097;9548.61805527799;9781.510924453607;9983.60065597368;10036.49817509107;7272.89090663651;9100.721019974637;9384.29617778683;10124.493775311057;10227.590896364061 05:37:45 INFO - 2015-11-20 05:37:45,992 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: __startTimestamp1448026665978__endTimestamp 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,993 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5819.89 Median:6108.16 stddev:682.98 (11.2%) stddev-sans-first:659.84 05:37:45 INFO - 2015-11-20 05:37:45,995 DEBUG : BROWSER_OUTPUT: Values: 3475.2 3528.0 3550.5 3556.8 3560.4 5967.1 5972.6 5989.1 6030.9 6031.0 5710.7 5890.4 5898.6 5961.9 6028.4 5322.0 5345.7 5377.6 5379.8 5446.4 4928.5 5470.2 5537.8 5543.8 5550.1 5094.7 5178.1 5215.5 5293.2 5445.5 5324.0 5344.2 5383.7 5389.6 5428.7 5356.3 5358.1 5362.8 5366.4 5393.1 4888.0 5226.9 5490.3 5827.8 5947.6 6322.4 6322.5 6344.6 6351.1 6361.7 6289.2 6350.5 6365.0 6367.7 6378.7 4864.7 5858.1 5969.3 6056.6 6108.3 6320.5 6448.6 6449.0 6451.9 6461.7 5959.9 6288.2 6312.9 6319.6 6339.7 6262.7 6339.7 6345.9 6419.3 6440.4 6320.9 6345.7 6361.2 6369.5 6380.7 6175.8 6332.4 6345.3 6367.7 6380.7 4267.3 5004.7 5046.0 5053.6 5098.3 4516.7 4569.8 4571.4 4586.3 4599.7 5676.6 5853.2 5866.5 5889.8 6008.0 6330.3 6350.8 6357.0 6358.8 6363.9 5847.1 5851.2 5879.0 5897.7 5899.6 4087.0 4855.8 5424.5 5521.7 5544.2 6425.5 6463.6 6512.9 6522.6 6533.9 6283.7 6344.1 6362.3 6362.4 6370.6 5094.9 6290.4 6319.0 6395.2 6430.4 5927.9 6289.5 6330.4 6348.6 6352.2 5213.4 6108.2 6345.0 6365.0 6376.9 6163.4 6202.4 6286.3 6292.6 6293.7 6211.8 6226.2 6235.3 6264.6 6265.7 4514.3 5730.6 6204.5 6238.1 6247.3 5130.8 6112.0 6145.1 6241.1 6245.2 5391.8 6184.4 6223.1 6233.8 6234.1 05:37:45 INFO - 2015-11-20 05:37:45,995 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,995 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65967.65 Median:40702.90 stddev:137614.94 (338.1%) stddev-sans-first:137913.29 05:37:45 INFO - 2015-11-20 05:37:45,995 DEBUG : BROWSER_OUTPUT: Values: 533.2 537.1 559.1 596.3 660.0 40098.6 40536.0 40552.8 40637.6 40735.8 43276.1 43283.8 43620.1 43742.3 43920.0 9738.3 9913.4 9937.0 9940.2 9972.6 9716.3 9837.9 9842.8 9854.7 9860.7 9747.4 9779.2 9820.0 9827.6 9846.4 9723.4 9792.8 9818.8 9836.3 9839.7 9654.7 9741.7 9753.9 9769.9 9773.5 40466.0 40517.0 40670.0 40775.0 41276.6 3208.2 3226.6 3253.2 3344.0 3574.8 28051.0 28195.0 28617.4 29144.1 29747.3 2780.8 2792.1 2830.7 2833.7 2965.3 430911.0 514327.0 516126.0 517934.0 519923.0 58209.7 59288.7 62336.4 62580.7 62765.7 70271.0 70523.3 70884.6 71085.3 71221.6 16244.2 16484.0 16532.3 16618.6 16643.2 9693.9 10480.9 11633.7 12540.1 12627.7 15102.8 18449.7 19593.3 19848.5 19878.9 7121.5 8063.4 8065.7 8183.1 8949.1 892.7 938.0 953.6 983.5 1061.4 26610.3 30520.1 30589.0 30712.8 31202.8 951.9 1047.6 1060.7 1064.3 1070.2 14960.3 15616.1 15668.9 15698.9 15896.8 561382.0 562455.0 565220.0 567285.0 568030.0 58220.7 58292.0 59001.0 59160.7 59447.0 1399.3 1401.2 1419.5 1422.8 1444.1 23463.2 29556.7 29718.6 29911.1 30433.5 54772.0 56079.2 56275.9 56371.7 56602.7 476147.0 479125.0 482240.0 482765.0 484837.0 31423.4 32539.0 33391.3 33605.8 33649.8 42307.4 42475.8 42499.4 42599.4 43149.4 34467.3 35530.9 36064.0 36278.8 36566.0 35099.1 35369.5 35517.1 35724.9 35858.5 35746.0 36193.5 36211.6 36404.3 36505.0 31184.5 33156.0 33312.0 33516.0 33836.8 24627.0 24687.4 24872.8 25110.0 25279.0 05:37:45 INFO - 2015-11-20 05:37:45,995 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,996 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39499.21 Median:20388.14 stddev:125860.50 (617.3%) stddev-sans-first:126179.24 05:37:45 INFO - 2015-11-20 05:37:45,997 DEBUG : BROWSER_OUTPUT: Values: 345.6 358.4 365.5 369.9 370.7 15832.1 19625.2 19682.0 20069.7 20558.2 19830.3 20288.9 20492.5 20544.1 20910.0 5584.6 5699.1 5848.2 5856.1 5874.3 5657.7 5795.7 5800.5 5804.6 5839.9 5664.7 5803.1 5813.5 6417.4 6444.2 6414.6 6420.1 6444.0 6500.7 6515.9 5617.2 5636.6 5696.4 5727.6 5740.6 12788.3 13149.5 15906.0 25285.5 25804.7 1862.1 1985.1 2067.5 2090.4 2108.0 9803.6 9829.9 9834.4 9985.3 11161.8 1766.7 1770.1 1780.2 1785.8 1849.5 99693.0 108162.0 108648.5 109204.5 111029.0 10982.8 11036.8 11041.2 11090.6 11107.3 10763.9 12997.2 13078.3 13089.6 13112.1 8068.2 8149.1 8232.6 8288.3 8308.1 8387.8 8502.5 8602.0 8649.0 8718.4 4276.7 4375.0 4392.5 4401.8 4423.0 1830.0 1860.2 1863.7 1872.2 1874.7 879.5 988.1 1014.1 1016.6 1019.9 16199.0 18812.8 19609.3 19692.4 20784.8 963.4 973.5 976.6 994.4 1048.0 11032.0 11288.3 11310.8 11320.0 11817.4 754874.0 759967.0 761553.0 769637.0 776407.0 99886.0 124611.0 125821.4 127119.7 127275.0 1058.4 1208.9 1263.0 1285.0 1304.1 18798.4 18835.0 18860.3 19331.8 19527.7 49357.5 49943.0 50784.0 50966.5 51355.2 72754.3 75053.6 75253.0 75698.0 75770.9 9469.7 9734.0 9878.5 9879.0 9948.5 17785.6 19572.4 19767.8 20043.4 20487.4 15734.4 15792.5 15835.8 16044.3 16123.8 12591.9 14772.3 15292.8 15502.5 15536.8 16025.8 16080.5 16465.5 16558.0 16559.8 9940.8 10009.3 10038.2 10066.4 10104.2 15491.8 15908.0 15953.8 15999.8 16574.6 05:37:45 INFO - 2015-11-20 05:37:45,997 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,997 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5830.67 Median:5265.37 stddev:3042.44 (57.8%) stddev-sans-first:3031.79 05:37:45 INFO - 2015-11-20 05:37:45,998 DEBUG : BROWSER_OUTPUT: Values: 1285.3 1516.8 1749.5 1755.4 1877.6 6733.7 7217.1 8328.0 8638.4 8657.6 8213.9 8327.5 8397.6 8421.0 8430.3 2226.4 2368.6 2400.6 2408.8 2410.0 2389.8 2420.5 2445.9 2455.6 2456.3 2380.2 2397.8 2410.6 2427.8 2434.1 1988.6 2011.7 2392.7 2407.5 2412.5 2385.9 2407.4 2425.8 2432.6 2442.2 7716.5 8429.9 8433.3 8497.7 8513.4 4711.0 4962.1 5057.2 5243.2 5285.7 3527.3 3529.1 3578.3 3604.9 3645.3 1046.8 1054.6 1066.6 1068.8 1081.2 11203.3 11214.1 11239.8 11251.1 11271.4 4690.6 4703.5 4742.7 4745.9 4754.9 9568.0 9655.3 9673.2 9706.9 9721.0 5207.1 5221.7 5233.2 5257.1 5273.6 4178.8 4232.3 4670.6 4749.9 4761.3 3876.7 3931.8 3937.9 3938.0 3964.8 1179.0 1290.7 1292.5 1296.3 1297.7 1369.6 1382.6 1395.5 1408.3 1417.4 7816.1 7827.6 7967.0 7970.2 7998.8 503.9 511.4 513.2 513.4 513.7 6045.6 6083.7 6135.5 6167.5 6188.0 9945.8 10132.6 10135.2 10175.4 10232.5 9763.8 10004.1 10046.6 10088.6 10171.4 7938.4 7938.6 7939.3 7947.5 7958.0 7482.0 7559.0 7570.8 7571.5 7579.8 8865.3 8997.2 9011.8 9135.8 9156.7 9038.1 9337.1 9405.4 9456.2 9458.0 6464.7 6706.4 7170.4 7416.4 7487.8 7996.6 8012.0 8032.6 8058.8 8083.7 7303.5 7439.6 7574.3 7663.8 7698.5 7431.4 7466.7 7472.9 7509.1 7577.3 7246.5 7607.4 7618.7 7627.3 7634.1 6848.5 6892.1 6937.3 6939.6 6981.0 6961.5 6971.5 6973.1 7021.7 7046.9 05:37:45 INFO - 2015-11-20 05:37:45,999 DEBUG : BROWSER_OUTPUT: 05:37:45 INFO - 2015-11-20 05:37:45,999 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6018.64 Median:6945.91 stddev:1977.64 (28.5%) stddev-sans-first:1936.49 05:37:46 INFO - 2015-11-20 05:37:46,000 DEBUG : BROWSER_OUTPUT: Values: 326.8 330.0 333.3 339.4 339.9 6947.0 6961.3 6972.9 7020.9 7104.8 6865.4 6958.6 7010.4 7025.6 7031.5 5074.9 5106.1 5107.8 5108.6 5137.0 4935.2 5117.0 5117.2 5122.1 5134.4 4093.6 5048.9 5048.9 5051.0 5054.5 5038.7 5044.2 5046.7 5050.3 5089.7 4126.9 4226.7 4231.0 4238.3 4243.5 5833.2 6577.5 6590.2 6615.2 6634.6 4741.5 5249.8 5830.5 5840.0 5884.2 7164.0 7282.9 7346.3 7346.9 7357.4 4681.3 4681.4 4696.1 4711.9 4719.9 7794.1 7875.1 7886.4 7915.0 7938.3 4068.0 4633.9 4705.1 4795.6 4820.2 4838.9 4839.1 4854.3 4856.0 4863.3 5842.7 5881.5 5881.5 5909.4 5934.7 7467.4 7480.3 7488.0 7488.1 7488.3 1657.1 1699.1 1701.0 1703.2 1710.4 1031.5 1069.9 1082.1 1083.8 1089.7 6963.2 6980.0 6989.0 6991.7 6993.6 7700.8 7745.4 7755.1 7755.7 7804.8 6713.1 6791.4 6928.6 6944.8 6955.5 3250.3 3724.6 3742.7 3997.3 4064.9 5750.5 7465.7 8053.2 8058.5 8105.0 8014.8 8049.0 8061.4 8064.4 8090.9 6475.0 6796.4 7812.1 7858.4 8064.2 7825.3 7830.2 7843.6 7851.5 7857.2 6574.8 7471.9 7672.5 7697.9 7719.8 6421.0 8106.0 8109.3 8128.6 8131.6 4814.2 4815.1 4817.8 4821.7 4832.6 7597.4 7751.1 7793.9 7810.5 7844.8 7485.0 7503.8 7510.4 7511.5 7529.4 7289.7 7484.0 7489.5 7518.2 7520.1 7251.0 7286.9 7320.5 7329.1 7334.7 7464.9 7471.3 7474.2 7479.7 7503.3 5899.3 6976.3 7153.0 7251.5 7347.6 05:37:46 INFO - 2015-11-20 05:37:46,000 DEBUG : BROWSER_OUTPUT: 05:37:46 INFO - 2015-11-20 05:37:46,000 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19330.94 Median:501.54 stddev:28164.40 (5615.6%) stddev-sans-first:28208.89 05:37:46 INFO - 2015-11-20 05:37:46,000 DEBUG : BROWSER_OUTPUT: Values: 761.7 786.7 816.9 827.1 844.0 13551.0 14049.6 14064.6 14092.0 14111.6 11693.4 14249.5 14256.6 14257.3 14289.6 747.7 761.0 942.9 954.2 965.1 724.5 866.5 949.9 951.0 960.6 867.7 987.6 1007.2 1024.9 1025.6 1004.4 1007.0 1008.4 1011.1 1016.9 748.4 749.0 752.8 753.1 753.5 13810.7 13814.8 13823.7 13925.5 13945.9 11323.8 11349.7 11611.0 13019.2 13126.9 9127.6 9314.0 9610.3 10311.9 10396.3 3529.5 3577.5 3579.7 3582.0 3582.1 82267.2 82416.2 82966.0 83710.6 84073.6 9713.2 9733.1 9858.7 10004.5 10225.2 21552.1 22129.2 22563.3 22629.9 22826.9 6718.8 7444.9 7535.0 7755.5 7841.0 3993.2 4077.9 4089.3 4092.9 4100.8 3549.4 3569.5 3571.3 3585.5 3594.2 685.0 692.2 697.0 709.2 709.9 487.6 494.1 494.4 535.8 579.4 8693.0 8734.8 8768.1 8821.6 8909.0 488.4 508.7 543.3 555.7 558.2 4032.7 4172.9 4208.1 4255.0 4259.7 101693.5 102738.5 103089.0 105027.0 105840.0 86610.0 86901.7 86968.0 86997.6 87982.2 58488.4 78015.0 78737.6 79460.6 79591.6 9032.8 9111.8 9240.6 9247.2 9252.3 52885.0 53084.7 53793.0 53853.2 54345.7 70638.6 73810.6 74683.3 75884.0 76867.8 10879.9 10997.6 11296.9 11607.8 11686.3 9637.7 11972.4 12032.6 12577.1 12848.9 8789.0 11520.8 11692.1 11894.5 12140.7 9175.4 11278.3 11303.5 11859.8 12430.6 11051.4 11088.9 11152.4 11562.2 12191.7 8232.6 9548.6 9781.5 9983.6 10036.5 7272.9 9100.7 9384.3 10124.5 10227.6 05:37:46 INFO - 2015-11-20 05:37:46,000 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:37:46 INFO - 2015-11-20 05:37:46,000 DEBUG : BROWSER_OUTPUT: 05:37:46 INFO - 2015-11-20 05:37:46,402 INFO : Browser exited with error code: 0 05:37:46 INFO - 2015-11-20 05:37:46,424 INFO : Completed test dromaeo_css (00:18:30) 05:37:46 INFO - 2015-11-20 05:37:46,424 INFO : Starting test kraken 05:37:46 INFO - 2015-11-20 05:37:46,424 DEBUG : operating with platform_type : mac_ 05:37:46 INFO - 2015-11-20 05:37:46,424 INFO : Initialising browser for kraken test... 05:37:46 INFO - 2015-11-20 05:37:46,436 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpGMLzbn/profile http://localhost:49270/getInfo.html 05:37:49 INFO - 2015-11-20 05:37:49,152 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:37:49 INFO - 2015-11-20 05:37:49,152 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:37:49 INFO - 2015-11-20 05:37:49,152 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:37:49 INFO - 2015-11-20 05:37:49,152 DEBUG : BROWSER_OUTPUT: __metrics 05:37:49 INFO - 2015-11-20 05:37:49,772 INFO : Browser initialized. 05:37:49 INFO - 2015-11-20 05:37:49,773 INFO : Running cycle 1/1 for kraken test... 05:37:49 INFO - 2015-11-20 05:37:49,773 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpGMLzbn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:38:01 INFO - 2015-11-20 05:38:01,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 236998656 05:38:01 INFO - 2015-11-20 05:38:01,795 DEBUG : BROWSER_OUTPUT: 05:38:04 INFO - 2015-11-20 05:38:04,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:05 INFO - 2015-11-20 05:38:05,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 249188352 05:38:05 INFO - 2015-11-20 05:38:05,032 DEBUG : BROWSER_OUTPUT: 05:38:07 INFO - 2015-11-20 05:38:07,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:38:08 INFO - 2015-11-20 05:38:08,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 259133440 05:38:08 INFO - 2015-11-20 05:38:08,172 DEBUG : BROWSER_OUTPUT: 05:38:11 INFO - 2015-11-20 05:38:11,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:38:11 INFO - 2015-11-20 05:38:11,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 261480448 05:38:11 INFO - 2015-11-20 05:38:11,982 DEBUG : BROWSER_OUTPUT: 05:38:13 INFO - 2015-11-20 05:38:13,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:38:14 INFO - 2015-11-20 05:38:14,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 263467008 05:38:14 INFO - 2015-11-20 05:38:14,472 DEBUG : BROWSER_OUTPUT: 05:38:16 INFO - 2015-11-20 05:38:16,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:16 INFO - 2015-11-20 05:38:16,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 264249344 05:38:16 INFO - 2015-11-20 05:38:16,968 DEBUG : BROWSER_OUTPUT: 05:38:19 INFO - 2015-11-20 05:38:19,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:20 INFO - 2015-11-20 05:38:20,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 265383936 05:38:20 INFO - 2015-11-20 05:38:20,212 DEBUG : BROWSER_OUTPUT: 05:38:22 INFO - 2015-11-20 05:38:22,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:23 INFO - 2015-11-20 05:38:23,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 263192576 05:38:23 INFO - 2015-11-20 05:38:23,505 DEBUG : BROWSER_OUTPUT: 05:38:26 INFO - 2015-11-20 05:38:26,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:38:26 INFO - 2015-11-20 05:38:26,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 264024064 05:38:26 INFO - 2015-11-20 05:38:26,945 DEBUG : BROWSER_OUTPUT: 05:38:28 INFO - 2015-11-20 05:38:28,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:29 INFO - 2015-11-20 05:38:29,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 264802304 05:38:29 INFO - 2015-11-20 05:38:29,091 DEBUG : BROWSER_OUTPUT: 05:38:30 INFO - 2015-11-20 05:38:30,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:31 INFO - 2015-11-20 05:38:31,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 264413184 05:38:31 INFO - 2015-11-20 05:38:31,479 DEBUG : BROWSER_OUTPUT: 05:38:33 INFO - 2015-11-20 05:38:33,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:34 INFO - 2015-11-20 05:38:34,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 264589312 05:38:34 INFO - 2015-11-20 05:38:34,090 DEBUG : BROWSER_OUTPUT: 05:38:36 INFO - 2015-11-20 05:38:36,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:37 INFO - 2015-11-20 05:38:37,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 264278016 05:38:37 INFO - 2015-11-20 05:38:37,204 DEBUG : BROWSER_OUTPUT: 05:38:39 INFO - 2015-11-20 05:38:39,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:40 INFO - 2015-11-20 05:38:40,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 264687616 05:38:40 INFO - 2015-11-20 05:38:40,195 DEBUG : BROWSER_OUTPUT: 05:38:41 INFO - 2015-11-20 05:38:41,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:38:42 INFO - 2015-11-20 05:38:42,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 263770112 05:38:42 INFO - 2015-11-20 05:38:42,047 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,047 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:38:42 INFO - 2015-11-20 05:38:42,047 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:38:42 INFO - 2015-11-20 05:38:42,047 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:38:42 INFO - 2015-11-20 05:38:42,047 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;118;166;130;112;125;113;114;116;112 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;153;139;153;119;143;144;116;155;121 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;194;191;190;203;205;264;195;194;195 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |3;audio-fft;62;64;54;58;61;59;100;56;56;58 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;76;78;107;74;78;76;108;74;77;107 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;88;86;87;88;91;87;87;88;87 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;95;94;94;95;94;94;94;95;95 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;92;91;93;92;93;92;99;142;144 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;59;61;59;60;60;67;68;94 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;65;67;67;66;68;68;69 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;86;83;87;84;84;82;85;81 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;125;129;129;130;122;131;121;123;120 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;138;140;139;140;135;140;134;133;138 05:38:42 INFO - 2015-11-20 05:38:42,048 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;66;66;67;66;65;65;66 05:38:42 INFO - 2015-11-20 05:38:42,049 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:38:42 INFO - 2015-11-20 05:38:42,049 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:38:42 INFO - 2015-11-20 05:38:42,049 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,820 05:38:42 INFO - 2015-11-20 05:38:42,049 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:38:42 INFO - 2015-11-20 05:38:42,049 DEBUG : BROWSER_OUTPUT: __startTimestamp1448026722045__endTimestamp 05:38:42 INFO - 2015-11-20 05:38:42,049 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.00 Median:117.00 stddev:16.57 (14.2%) stddev-sans-first:17.32 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: Values: 114.0 118.0 166.0 130.0 112.0 125.0 113.0 114.0 116.0 112.0 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:148.50 stddev:16.49 (11.1%) stddev-sans-first:15.55 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: Values: 162.0 153.0 139.0 153.0 119.0 143.0 144.0 116.0 155.0 121.0 05:38:42 INFO - 2015-11-20 05:38:42,051 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:202.20 Median:195.00 stddev:22.28 (11.4%) stddev-sans-first:23.25 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: Values: 191.0 194.0 191.0 190.0 203.0 205.0 264.0 195.0 194.0 195.0 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:62.80 Median:58.50 stddev:13.41 (22.9%) stddev-sans-first:14.23 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 54.0 58.0 61.0 59.0 100.0 56.0 56.0 58.0 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,052 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:85.50 Median:76.00 stddev:15.13 (19.9%) stddev-sans-first:15.65 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: Values: 76.0 78.0 107.0 74.0 78.0 76.0 108.0 74.0 77.0 107.0 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:87.50 stddev:1.35 (1.5%) stddev-sans-first:1.41 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 86.0 87.0 88.0 91.0 87.0 87.0 88.0 87.0 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.10 Median:92.00 stddev:21.03 (22.9%) stddev-sans-first:22.11 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: Values: 113.0 92.0 91.0 93.0 92.0 93.0 92.0 99.0 142.0 144.0 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.70 Median:60.50 stddev:10.81 (17.9%) stddev-sans-first:11.27 05:38:42 INFO - 2015-11-20 05:38:42,053 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 59.0 61.0 59.0 60.0 60.0 67.0 68.0 94.0 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 65.0 67.0 67.0 66.0 68.0 68.0 69.0 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:1.89 (2.2%) stddev-sans-first:1.90 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 86.0 83.0 87.0 84.0 84.0 82.0 85.0 81.0 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:129.00 stddev:4.49 (3.5%) stddev-sans-first:4.25 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: Values: 132.0 125.0 129.0 129.0 130.0 122.0 131.0 121.0 123.0 120.0 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.80 Median:139.50 stddev:2.82 (2.0%) stddev-sans-first:2.74 05:38:42 INFO - 2015-11-20 05:38:42,054 DEBUG : BROWSER_OUTPUT: Values: 141.0 138.0 140.0 139.0 140.0 135.0 140.0 134.0 133.0 138.0 05:38:42 INFO - 2015-11-20 05:38:42,055 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,055 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:38:42 INFO - 2015-11-20 05:38:42,055 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 66.0 66.0 67.0 66.0 65.0 65.0 66.0 05:38:42 INFO - 2015-11-20 05:38:42,055 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:38:42 INFO - 2015-11-20 05:38:42,055 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-20 05:38:42,653 INFO : Browser exited with error code: 0 05:38:42 INFO - 2015-11-20 05:38:42,697 INFO : Completed test kraken (00:00:56) 05:38:42 INFO - 2015-11-20 05:38:42,697 INFO : Starting test v8_7 05:38:42 INFO - 2015-11-20 05:38:42,697 DEBUG : operating with platform_type : mac_ 05:38:42 INFO - 2015-11-20 05:38:42,697 INFO : Initialising browser for v8_7 test... 05:38:42 INFO - 2015-11-20 05:38:42,708 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpt4MghR/profile http://localhost:49270/getInfo.html 05:38:45 INFO - 2015-11-20 05:38:45,422 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:38:45 INFO - 2015-11-20 05:38:45,423 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:38:45 INFO - 2015-11-20 05:38:45,423 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:38:45 INFO - 2015-11-20 05:38:45,423 DEBUG : BROWSER_OUTPUT: __metrics 05:38:46 INFO - 2015-11-20 05:38:46,059 INFO : Browser initialized. 05:38:46 INFO - 2015-11-20 05:38:46,059 INFO : Running cycle 1/1 for v8_7 test... 05:38:46 INFO - 2015-11-20 05:38:46,059 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpt4MghR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:38:58 INFO - 2015-11-20 05:38:58,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 236617728 05:38:58 INFO - 2015-11-20 05:38:58,032 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 05:39:19 INFO - 2015-11-20 05:39:19,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 250851328 05:39:19 INFO - 2015-11-20 05:39:19,697 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,697 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:39:19 INFO - 2015-11-20 05:39:19,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:39:19 INFO - 2015-11-20 05:39:19,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:39:19 INFO - 2015-11-20 05:39:19,697 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |0;Richards;632.1112515802781 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;156.49452269170578 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |2;Encrypt;290.4443799012489 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4868.9320388349515 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |4;RayTrace;956.9377990430622 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |5;Earley;732.0644216691069 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |8;Splay;616.1429451632779 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: __startTimestamp1448026759694__endTimestamp 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,698 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:632.11 Median:632.11 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: Values: 632.1 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:156.49 Median:156.49 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: Values: 156.5 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:290.44 Median:290.44 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: Values: 290.4 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: Values: 4868.9 05:39:19 INFO - 2015-11-20 05:39:19,699 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:956.94 Median:956.94 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: Values: 956.9 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:732.06 Median:732.06 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: Values: 732.1 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: Values: 12512.5 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: Values: 26763.2 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.14 Median:616.14 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,700 DEBUG : BROWSER_OUTPUT: Values: 616.1 05:39:19 INFO - 2015-11-20 05:39:19,701 DEBUG : BROWSER_OUTPUT: 05:39:19 INFO - 2015-11-20 05:39:19,701 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 05:39:19 INFO - 2015-11-20 05:39:19,701 DEBUG : BROWSER_OUTPUT: Values: 4509.0 05:39:19 INFO - 2015-11-20 05:39:19,701 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:39:19 INFO - 2015-11-20 05:39:19,701 DEBUG : BROWSER_OUTPUT: 05:39:20 INFO - 2015-11-20 05:39:20,312 INFO : Browser exited with error code: 0 05:39:20 INFO - 2015-11-20 05:39:20,330 INFO : Completed test v8_7 (00:00:37) 05:39:20 INFO - 2015-11-20 05:39:20,775 INFO : Completed test suite (00:20:04) 05:39:20 INFO - 2015-11-20 05:39:20,775 DEBUG : Working with test: dromaeo_css 05:39:20 INFO - 2015-11-20 05:39:20,775 DEBUG : Generating results file: dromaeo_css 05:39:20 INFO - 2015-11-20 05:39:20,776 DEBUG : Working with test: kraken 05:39:20 INFO - 2015-11-20 05:39:20,776 DEBUG : Generating results file: kraken 05:39:20 INFO - 2015-11-20 05:39:20,776 INFO : javascript benchmark 05:39:20 INFO - 2015-11-20 05:39:20,776 DEBUG : Working with test: v8_7 05:39:20 INFO - 2015-11-20 05:39:20,776 DEBUG : Generating results file: v8_7 05:39:20 INFO - 2015-11-20 05:39:20,777 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:21 INFO - 2015-11-20 05:39:21,163 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:39:21 INFO - 2015-11-20 05:39:21,163 DEBUG : process_Request line: dromaeo_css 7677.71 graph.html#tests=[[72,1,61]] 05:39:21 INFO - 2015-11-20 05:39:21,163 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:21 INFO - 2015-11-20 05:39:21,188 DEBUG : process_Request line: kraken 1445.80 graph.html#tests=[[232,1,61]] 05:39:21 INFO - 2015-11-20 05:39:21,188 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:21 INFO - 2015-11-20 05:39:21,217 DEBUG : process_Request line: v8_7 19223.24 graph.html#tests=[[230,1,61]] 05:39:21 INFO - 2015-11-20 05:39:21,218 INFO : javascript benchmark 05:39:21 INFO - 2015-11-20 05:39:21,220 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3475.183331917, 3528.0, 3550.520679708242, 3556.804375759333, 3560.448130539767, 5967.134765459011, 5972.552058595601, 5989.071693887444, 6030.87938241236, 6031.0, 5710.71446427678, 5890.381509941459, 5898.616589921652, 5961.88076238475, 6028.367021462749, 5321.973390133063, 5345.732713364336, 5377.569794416438, 5379.757910894019, 5446.373667028283, 4928.482509336522, 5470.234167216593, 5537.8061767838135, 5543.750531226085, 5550.056490396622, 5094.694318340911, 5178.093833579109, 5215.50452706996, 5293.153095504701, 5445.455454454543, 5324.0, 5344.198370244456, 5383.67697938125, 5389.622726409153, 5428.728563571845, 5356.330458692663, 5358.142697168473, 5362.785488580491, 5366.382865970424, 5393.097551032566, 4887.975560122177, 5226.876221612333, 5490.3411590608985, 5827.766889324422, 5947.553933454965, 6322.367763223687, 6322.4942004639515, 6344.619322840645, 6351.142595749607, 6361.650109243989, 6289.213848268966, 6350.491960643184, 6365.045243213509, 6367.681615919232, 6378.712957916905, 4864.683795553313, 5858.091995740667, 5969.253843269591, 6056.636601803906, 6108.3280839107665, 6320.525960552977, 6448.645324507197, 6449.0, 6451.903221451682, 6461.709223084878, 5959.910601340984, 6288.182536270256, 6312.873742525124, 6319.557630965788, 6339.651319177397, 6262.718177682015, 6339.746410143543, 6345.8730825384155, 6419.293877673452, 6440.388163124496, 6320.905186422207, 6345.714442850082, 6361.173047503795, 6369.458596019297, 6380.680965951684, 6175.814725558241, 6332.366763323631, 6345.270293916166, 6367.7452901884335, 6380.744770209232, 4267.338562522814, 5004.749762511859, 5046.041252162077, 5053.5957123430035, 5098.260752190911, 4516.661250406232, 4569.817207311737, 4571.428571428572, 4586.312053191981, 4599.701019433726, 5676.602637815396, 5853.209816674779, 5866.530677545786, 5889.793857214977, 6008.0, 6330.335314791881, 6350.825097357004, 6356.968215158895, 6358.809235722843, 6363.949948258485, 5847.122931560215, 5851.239338885917, 5879.0, 5897.67562784051, 5899.602212475249, 4087.0, 4855.8057677693205, 5424.511793938565, 5521.696306703089, 5544.168374743821, 6425.453836423862, 6463.574305617936, 6512.902306465312, 6522.5760325578685, 6533.934660653523, 6283.717232724447, 6344.1118243445035, 6362.331955144643, 6362.395572420613, 6370.649614271259, 5094.898102038012, 6290.402411770874, 6318.96689589009, 6395.16862807832, 6430.3891130342545, 5927.940720592911, 6289.465395441439, 6330.430261276507, 6348.555601107878, 6352.237731472253, 5213.426523082534, 6108.159949115189, 6345.016522439029, 6364.96817515928, 6376.936230637634, 6163.414475624809, 6202.41077097675, 6286.339934307015, 6292.590981586365, 6293.748250069946, 6211.782587609412, 6226.159468471698, 6235.251769787655, 6264.624122552661, 6265.655388953652, 4514.345419914029, 5730.598858079894, 6204.534659900435, 6238.126662267196, 6247.250329960434, 5130.79476820923, 6111.98679349419, 6145.064304743992, 6241.095041218907, 6245.219347581552, 5391.81128660495, 6184.412480814315, 6223.097650840512, 6233.844153896189, 6234.127222188807], "unit": "ms", "name": "dojo.html", "value": 5779.911270172018}, {"lowerIsBetter": false, "replicates": [533.2275265404082, 537.1486194381904, 559.0998492427192, 596.269569777023, 659.9736010559578, 40098.59901400985, 40535.99999999996, 40552.79723601378, 40637.59362406379, 40735.79632101835, 43276.134477310436, 43283.78358108213, 43620.12759744803, 43742.343864841976, 43920.0, 9738.269629777777, 9913.405195688281, 9936.950315248414, 9940.20478361733, 9972.551235194398, 9716.271279654055, 9837.901620983806, 9842.753931151707, 9854.655087071955, 9860.654877079303, 9747.415155090683, 9779.21766258701, 9819.950900245489, 9827.606895724162, 9846.40921544706, 9723.367981081243, 9792.804143917081, 9818.754531136707, 9836.31145819793, 9839.704808855746, 9654.662086826998, 9741.65904193357, 9753.902460975441, 9769.90230097697, 9773.462459564722, 40466.0, 40517.0, 40670.0, 40775.0, 41276.587234127874, 3208.246062175387, 3226.6450690424035, 3253.186703324169, 3344.0302312329395, 3574.7855128692104, 28051.018214362604, 28195.01317453879, 28617.427651446855, 29144.125676229745, 29747.256318591993, 2780.824376333593, 2792.1204820481485, 2830.731080547345, 2833.7449629533235, 2965.288330800614, 430911.0, 514327.0, 516126.0, 517934.0, 519923.0, 58209.70895145497, 59288.703556482804, 62336.37663623306, 62580.68709656422, 62765.68617156885, 70271.0, 70523.29476705269, 70884.64557677179, 71085.2891471089, 71221.64389178022, 16244.187790610658, 16484.0, 16532.256048477848, 16618.58453538647, 16643.167841607872, 9693.885203201722, 10480.947595261974, 11633.709157271136, 12540.122191446693, 12627.747445051047, 15102.773458398133, 18449.7232541512, 19593.314234002028, 19848.50378740543, 19878.90060549688, 7121.537100088478, 8063.4355595108955, 8065.717699880476, 8183.099859015503, 8949.060348663426, 892.6786356911507, 938.0291398402757, 953.618552578974, 983.5475681186734, 1061.4321338084087, 26610.334741631614, 30520.084397468112, 30589.0, 30712.84643576768, 31202.751889924602, 951.8905325887612, 1047.586203449633, 1060.7083052160563, 1064.3347907557777, 1070.175964507325, 14960.326785294688, 15616.141112238936, 15668.921655391878, 15698.92150539263, 15896.76154857678, 561382.0, 562455.0, 565220.0, 567285.0, 568030.0, 58220.7088964561, 58292.0, 59001.0, 59160.7041964796, 59447.0, 1399.2723783632455, 1401.2153194211273, 1419.531554586984, 1422.7581311177125, 1444.1263035863362, 23463.178788742312, 29556.704432956256, 29718.554221687125, 29911.102666920026, 30433.543496847124, 54772.0, 56079.15881261866, 56275.87448251094, 56371.71814140903, 56602.71698641645, 476147.0, 479125.0, 482240.0, 482765.0, 484837.0, 31423.37153256968, 32539.0, 33391.33217335591, 33605.83197083999, 33649.822256221894, 42307.3653895198, 42475.787621061696, 42499.362509563, 42599.36100958426, 43149.352759708, 34467.310653786284, 35530.934071977885, 36064.0, 36278.8186059068, 36566.0, 35099.122521937155, 35369.469457958665, 35517.11207219737, 35724.92825215248, 35858.46212306766, 35746.0, 36193.45709814302, 36211.637883620824, 36404.27191456209, 36505.0, 31184.532232016085, 33156.0, 33312.0, 33516.0, 33836.830815845766, 24626.97377951621, 24687.38281542976, 24872.751272487767, 25110.0, 25279.0], "unit": "ms", "name": "ext.html", "value": 19891.788539796864}, {"lowerIsBetter": false, "replicates": [345.59737905340273, 358.36406802944555, 365.4992660055722, 369.9001269657192, 370.692325369943, 15832.129232892186, 19625.214991400346, 19682.0, 20069.698954515676, 20558.177672893067, 19830.305939292128, 20288.89855550724, 20492.487687807814, 20544.07551660175, 20910.0, 5584.581156413265, 5699.116636921273, 5848.210491583624, 5856.121581762727, 5874.295084589855, 5657.660540367591, 5795.681237531955, 5800.506956908668, 5804.564657650672, 5839.941600584004, 5664.688442135681, 5803.071508558632, 5813.505852002585, 6417.422431981144, 6444.162258906335, 6414.647194404306, 6420.133282006916, 6443.967780161092, 6500.674966251716, 6515.869682606345, 5617.241672374259, 5636.633618814764, 5696.3733989261145, 5727.627704199213, 5740.6268592541355, 12788.296643684595, 13149.53976610814, 15906.0, 25285.482871027798, 25804.74195258042, 1862.134107639954, 1985.0868600443814, 2067.514134178467, 2090.4251330883976, 2108.0, 9803.607855685765, 9829.90170098297, 9834.360766550222, 9985.301028927977, 11161.83257251142, 1766.6819972404962, 1770.139677408164, 1780.1722199177445, 1785.8303461171297, 1849.4913898677837, 99693.0, 108162.0, 108648.4567577157, 109204.4539777296, 111029.0, 10982.835257471144, 11036.834447483294, 11041.171912106623, 11090.611828585961, 11107.333559986266, 10763.892361076445, 12997.15518491295, 13078.2806945617, 13089.607311780663, 13112.147710398793, 8068.152843951418, 8149.103598604149, 8232.62953167109, 8288.254057134765, 8308.086110527836, 8387.790305242417, 8502.489850608983, 8601.956990215009, 8649.0, 8718.43330183536, 4276.700630955866, 4375.0, 4392.516823149451, 4401.779911004437, 4422.977885110618, 1829.990850045768, 1860.1908169946116, 1863.7390765292869, 1872.1762424533163, 1874.709420039896, 879.5294517433142, 988.0909563201728, 1014.1430491234895, 1016.6492560066765, 1019.8827134879435, 16199.028058316539, 18812.81187188138, 19609.31367402134, 19692.40922772319, 20784.79215207859, 963.3786207895868, 973.4743238651191, 976.6288810252058, 994.438731192036, 1047.994760026195, 11031.951964563354, 11288.2662626929, 11310.773784524263, 11320.0, 11817.409129543488, 754874.0, 759967.0, 761553.0, 769637.0, 776407.0, 99886.0, 124611.0, 125821.37089314495, 127119.72880271263, 127275.0, 1058.4337379502083, 1208.8851559101872, 1262.9706788966962, 1284.9614511564669, 1304.1327517201146, 18798.436046918614, 18835.0, 18860.339888103852, 19331.806681933, 19527.70708439403, 49357.50642493673, 49943.0, 50784.0, 50966.49033509766, 51355.22967155421, 72754.27245727475, 75053.62473187599, 75253.0, 75698.0, 75770.86343704739, 9469.66856160031, 9734.0, 9878.4566848824, 9878.950605246928, 9948.502574871083, 17785.55536111556, 19572.412827615193, 19767.80232197717, 20043.398698039084, 20487.38537843867, 15734.370625174864, 15792.526224213292, 15835.841641583898, 16044.278007489924, 16123.75814362762, 12591.937040315106, 14772.261386930826, 15292.847071529142, 15502.457413990456, 15536.766948495555, 16025.839741602435, 16080.517584472485, 16465.530170474045, 16558.0, 16559.751603726196, 9940.801183976135, 10009.299349045497, 10038.196944244297, 10066.44634545107, 10104.191664666661, 15491.84508154904, 15908.045517269002, 15953.8404615957, 15999.760003600188, 16574.585635359213], "unit": "ms", "name": "jquery.html", "value": 10059.279749006197}, {"lowerIsBetter": false, "replicates": [1285.338050903784, 1516.7573188289869, 1749.4664127441129, 1755.3505203074849, 1877.6150889067742, 6733.696983635736, 7217.061781968337, 8327.958360208198, 8638.438501497407, 8657.567121643917, 8213.876791848126, 8327.500349978991, 8397.622107005183, 8420.957895210515, 8430.28342590879, 2226.3988723044768, 2368.6091794853874, 2400.567897778399, 2408.8313818032743, 2410.0118951229997, 2389.808815294772, 2420.540097381501, 2445.8532488050773, 2455.631655251718, 2456.299954512964, 2380.2264264114146, 2397.832151749378, 2410.626352915292, 2427.757224277576, 2434.0993832281993, 1988.5724569217543, 2011.7083022961663, 2392.7128744550764, 2407.5184963007296, 2412.4813165169485, 2385.9045638174453, 2407.3981504623844, 2425.8301918865686, 2432.6351047342864, 2442.1818690738623, 7716.537007779495, 8429.873551896726, 8433.28317093048, 8497.702580409717, 8513.361497887683, 4710.9764451177525, 4962.057209130254, 5057.165567681365, 5243.239730239094, 5285.735713214324, 3527.3474407234744, 3529.1177205698577, 3578.320119177348, 3604.855805767766, 3645.2891686121216, 1046.7592453735608, 1054.6150655010943, 1066.5627092891878, 1068.7969285835666, 1081.1783044885865, 11203.327800332007, 11214.10287177024, 11239.775204495945, 11251.099912007101, 11271.43642817864, 4690.554397332248, 4703.529647035269, 4742.668013239109, 4745.928811067837, 4754.857354279377, 9567.995360487048, 9655.324127311162, 9673.22614190863, 9706.854397184048, 9721.0, 5207.140821764442, 5221.686698798084, 5233.188855727369, 5257.132573125392, 5273.604479664041, 4178.791060447026, 4232.343986682069, 4670.556297151765, 4749.905001899942, 4761.309610106515, 3876.651101400831, 3931.8230679619487, 3937.8818635440985, 3937.9606203938165, 3964.801759911993, 1178.9823152652716, 1290.6966862787237, 1292.476546998467, 1296.3453456004656, 1297.6885547468728, 1369.5959691890916, 1382.5506710319187, 1395.5045958684723, 1408.3169662713576, 1417.3834382043844, 7816.101148367897, 7827.569483678452, 7966.960165199137, 7970.1631328709655, 7998.840168175582, 503.91937290033417, 511.4297558222555, 513.2378418049194, 513.4249640402699, 513.7020528093772, 6045.576809623372, 6083.695815209222, 6135.509159267248, 6167.506599472032, 6187.969060154671, 9945.751356216007, 10132.594696212069, 10135.239857010754, 10175.440350780778, 10232.488375581192, 9763.804723905481, 10004.099631033241, 10046.598136074475, 10088.646897358558, 10171.389716617026, 7938.444308898437, 7938.6427610757655, 7939.285464308125, 7947.483413578099, 7958.0, 7481.962590187014, 7558.962205188939, 7570.772876813704, 7571.507851989603, 7579.848403032019, 8865.290776737716, 8997.190252877272, 9011.783409239668, 9135.817283654156, 9156.679516217167, 9038.09619038091, 9337.066293370608, 9405.388649737744, 9456.196223321094, 9458.006909274702, 6464.709088090953, 6706.362895524917, 7170.354668079898, 7416.44376671741, 7487.775366739006, 7996.600169991593, 8011.959940200261, 8032.59837008159, 8058.758237252891, 8083.6766529338165, 7303.488755787256, 7439.62801859894, 7574.280443358092, 7663.808404789925, 7698.538087714755, 7431.40548756109, 7466.738664146729, 7472.925270747223, 7509.136449308399, 7577.318041376303, 7246.492745507764, 7607.429442791702, 7618.69525218985, 7627.313541781266, 7634.122075961113, 6848.520603557703, 6892.104026476526, 6937.340952609494, 6939.583624982517, 6980.965095174492, 6961.512694111364, 6971.51199416036, 6973.12835895513, 7021.68402421882, 7046.859062818818], "unit": "ms", "name": "mootools.html", "value": 4706.019325933469}, {"lowerIsBetter": false, "replicates": [326.76146413118425, 329.97525185611084, 333.28344060270433, 339.38063034961203, 339.947308167234, 6947.0, 6961.338672826079, 6972.860542789142, 7020.9297907020855, 7104.786856394304, 6865.382115609594, 6958.617276049815, 7010.369066783988, 7025.613591252479, 7031.542949708265, 5074.8731281718065, 5106.106431374513, 5107.7956881724685, 5108.565771909373, 5137.0, 4935.161022626162, 5117.002184574009, 5117.2068329409, 5122.052420302256, 5134.358205224347, 4093.6111069448357, 5048.873778155539, 5048.924266136011, 5050.974745126269, 5054.469280725526, 5038.748062596892, 5044.243363495469, 5046.7476626168545, 5050.3434553508, 5089.694618322913, 4126.8761937141935, 4226.704130710851, 4230.957690423087, 4238.279492486285, 4243.511996120455, 5833.212516310286, 6577.473802095821, 6590.209174898995, 6615.239247486553, 6634.601923884582, 4741.478437371887, 5249.792547714047, 5830.5044071254, 5840.007198776176, 5884.235049443588, 7163.964180179066, 7282.927170728278, 7346.302101300368, 7346.853062938765, 7357.448191385667, 4681.344611754357, 4681.368015317957, 4696.131215725068, 4711.882202944919, 4719.905601887977, 7794.103678077037, 7875.133735289113, 7886.447948643598, 7914.960425197837, 7938.325242354407, 4067.9796601016806, 4633.86098417048, 4705.082508910729, 4795.616350692006, 4820.204666230103, 4838.854834354975, 4839.056384005155, 4854.344663470457, 4855.951440485621, 4863.294822250754, 5842.678652674143, 5881.470667639847, 5881.470667639933, 5909.409059094056, 5934.732937017759, 7467.402607791364, 7480.289372509603, 7488.0, 7488.063992001, 7488.288612581796, 1657.1382880901863, 1699.1079683166436, 1700.9829901701073, 1703.2335449047978, 1710.4099085815374, 1031.489412740698, 1069.9197560183018, 1082.0910435234441, 1083.7832433513329, 1089.6785448292774, 6963.234044255128, 6980.022796808451, 6988.965055174692, 6991.720331186797, 6993.615351155735, 7700.807479813049, 7745.419093567893, 7755.1469338372735, 7755.72854950074, 7804.765857024298, 6713.060171575983, 6791.3548212919695, 6928.61892595902, 6944.826379340557, 6955.478339124586, 3250.3336815953144, 3724.571674257441, 3742.7461800297206, 3997.320455522568, 4064.8577299794365, 5750.482456578844, 7465.738699145504, 8053.194680532017, 8058.516489010678, 8105.027396712432, 8014.759557213293, 8049.034115906129, 8061.395395345256, 8064.395170362129, 8090.919090809134, 6475.0, 6796.388325050769, 7812.1016083150025, 7858.371330293563, 8064.153263907323, 7825.295723384695, 7830.177831327628, 7843.647035883285, 7851.489653172525, 7857.174996625272, 6574.8356291093105, 7471.88792168107, 7672.539647621161, 7697.922290879169, 7719.807004824925, 6421.0, 8106.0, 8109.270165685117, 8128.63421146038, 8131.593420329078, 4814.20565606671, 4815.133276010211, 4817.8313759018265, 4821.662483626253, 4832.589229915356, 7597.392208623407, 7751.108622508484, 7793.9220607793195, 7810.492317999312, 7844.764657060297, 7484.962575187307, 7503.7748867534065, 7510.361619262206, 7511.549307041377, 7529.435292353205, 7289.669223394064, 7484.0063974408495, 7489.475736698597, 7518.248175182438, 7520.09758828944, 7250.984862119413, 7286.890696639661, 7320.487565870338, 7329.120505539369, 7334.669939852826, 7464.925350746423, 7471.290227428385, 7474.177840437656, 7479.663415146223, 7503.287187717158, 5899.256845566661, 6976.302369762983, 7153.0, 7251.456140789567, 7347.632618369167], "unit": "ms", "name": "prototype.html", "value": 5352.348738540996}, {"lowerIsBetter": false, "replicates": [761.7219714804096, 786.7010535996324, 816.9019717633881, 827.1108558299827, 843.9873401898968, 13551.0, 14049.648758781035, 14064.578062658136, 14092.0, 14111.647208819784, 11693.415329233525, 14249.501267455642, 14256.643583910407, 14257.287135643228, 14289.571312860604, 747.7270796159418, 761.0448886647278, 942.9104235097672, 954.2175416158752, 965.1072757699135, 724.5000949344961, 866.4931015356025, 949.9002604726508, 951.0109486134412, 960.582146766159, 867.657275376226, 987.5506644476745, 1007.1791489935715, 1024.923130765192, 1025.6307729217476, 1004.3672486333636, 1006.9899301007006, 1008.4000019988132, 1011.0950699124243, 1016.8627235323247, 748.356413484403, 749.0262658543871, 752.7704050264667, 753.051155544013, 753.4838635534676, 13810.65473363164, 13814.825739812028, 13823.723525529535, 13925.512607058805, 13945.930270348583, 11323.81099984498, 11349.659510214708, 11610.955014048775, 13019.218846869218, 13126.86873131266, 9127.589258483384, 9313.953430232874, 9610.327277090606, 10311.948440257751, 10396.324238924446, 3529.4882242075014, 3577.499150118985, 3579.731520136, 3581.9641803582153, 3582.0865679251624, 82267.17732822715, 82416.17583824146, 82966.0, 83710.58144709238, 84073.57963210206, 9713.174380177623, 9733.075357840993, 9858.676993093473, 10004.54979525923, 10225.181985441146, 21552.13791448356, 22129.225477108546, 22563.323100307018, 22629.88685056597, 22826.885865570897, 6718.798436046926, 7444.925550744423, 7535.0, 7755.495892766952, 7841.0, 3993.1614360984518, 4077.91844163121, 4089.284375234322, 4092.856750013735, 4100.774457404871, 3549.432090865501, 3569.464580312974, 3571.2678900825267, 3585.4801053847045, 3594.1733401317842, 685.0409426802516, 692.2005084127841, 696.9756058537927, 709.2127738210582, 709.8651256261294, 487.5636305506552, 494.0908727940535, 494.3523983581448, 535.8124656370317, 579.4408395897894, 8692.956535217283, 8734.82530349402, 8768.07935166811, 8821.558922053871, 8908.955455222682, 488.38707422184933, 508.73291521950534, 543.2774410034644, 555.677269015511, 558.2380051230123, 4032.697547683935, 4172.874813755592, 4208.116295577963, 4254.957450425456, 4259.7231179973205, 101693.49153254334, 102738.45892311621, 103089.0, 105027.0, 105840.0, 86610.0, 86901.69647455293, 86968.0, 86997.56501217453, 87982.24035519382, 58488.4151158483, 78015.0, 78737.60631196808, 79460.60269698614, 79591.60204198942, 9032.774180645536, 9111.772205694911, 9240.584173712065, 9247.213986811197, 9252.334579775705, 52885.0, 53084.73457632687, 53793.0, 53853.19220211622, 54345.72827135839, 70638.64680676769, 73810.63094684492, 74683.25316746763, 75884.0, 76867.8469822942, 10879.945600272265, 10997.560097596006, 11296.887031129583, 11607.825882611598, 11686.298822070703, 9637.71086867395, 11972.401379930794, 12032.578859739868, 12577.119601628165, 12848.935755321163, 8789.0, 11520.82718759236, 11692.14827656629, 11894.524219031142, 12140.696482587653, 9175.357724959189, 11278.266912650652, 11303.491342889754, 11859.822102668639, 12430.564930227398, 11051.447427628425, 11088.944555277172, 11152.442377881236, 11562.19064665499, 12191.695207619881, 8232.62953167097, 9548.61805527799, 9781.510924453607, 9983.60065597368, 10036.49817509107, 7272.89090663651, 9100.721019974637, 9384.29617778683, 10124.493775311057, 10227.590896364061], "unit": "ms", "name": "yui.html", "value": 7030.611375103717}], "name": "dromaeo_css", "value": 7677.706488893845}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 118.0, 166.0, 130.0, 112.0, 125.0, 113.0, 114.0, 116.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 122.0}, {"lowerIsBetter": true, "replicates": [162.0, 153.0, 139.0, 153.0, 119.0, 143.0, 144.0, 116.0, 155.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.5}, {"lowerIsBetter": true, "replicates": [191.0, 194.0, 191.0, 190.0, 203.0, 205.0, 264.0, 195.0, 194.0, 195.0], "unit": "ms", "name": "audio-dft", "value": 202.2}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 54.0, 58.0, 61.0, 59.0, 100.0, 56.0, 56.0, 58.0], "unit": "ms", "name": "audio-fft", "value": 62.8}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 107.0, 74.0, 78.0, 76.0, 108.0, 74.0, 77.0, 107.0], "unit": "ms", "name": "audio-oscillator", "value": 85.5}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 86.0, 87.0, 88.0, 91.0, 87.0, 87.0, 88.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 87.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [113.0, 92.0, 91.0, 93.0, 92.0, 93.0, 92.0, 99.0, 142.0, 144.0], "unit": "ms", "name": "imaging-desaturate", "value": 105.1}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0, 67.0, 68.0, 94.0], "unit": "ms", "name": "json-parse-financial", "value": 64.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 67.0, 66.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 83.0, 87.0, 84.0, 84.0, 82.0, 85.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [132.0, 125.0, 129.0, 129.0, 130.0, 122.0, 131.0, 121.0, 123.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [141.0, 138.0, 140.0, 139.0, 140.0, 135.0, 140.0, 134.0, 133.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1445.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [632.1112515802781], "unit": "score", "name": "Richards", "value": 55.84776399999999}, {"lowerIsBetter": false, "replicates": [156.49452269170578], "unit": "score", "name": "DeltaBlue", "value": 422.49401999999986}, {"lowerIsBetter": false, "replicates": [290.4443799012489], "unit": "score", "name": "Encrypt", "value": 916.4611830000002}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "Decrypt", "value": 54.669278165503506}, {"lowerIsBetter": false, "replicates": [956.9377990430622], "unit": "score", "name": "RayTrace", "value": 773.2885049999996}, {"lowerIsBetter": false, "replicates": [732.0644216691069], "unit": "score", "name": "Earley", "value": 910.388458}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [616.1429451632779], "unit": "score", "name": "Splay", "value": 132.25989299999998}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 19223.237845551866}]} 05:39:21 INFO - RETURN: dromaeo_css: 7677.71 05:39:21 INFO - RETURN: kraken: 1445.80 05:39:21 INFO - RETURN: v8_7: 19223.24 05:39:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "19223.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1445.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7677.71"}}} 05:39:21 INFO - Return code: 0 05:39:21 INFO - # TBPL SUCCESS # 05:39:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:21 INFO - 2015-11-20 05:39:21.332 screenresolution[1683:11173] starting screenresolution argv=screenresolution get 05:39:21 INFO - 2015-11-20 05:39:21.334 screenresolution[1683:11173] Display 0: 1600x1200x32@60 05:39:21 INFO - 2015-11-20 05:39:21.340 screenresolution[1684:11176] starting screenresolution argv=screenresolution list 05:39:21 INFO - Available Modes on Display 0 05:39:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:21 INFO - Intel Iris: 05:39:21 INFO - Chipset Model: Intel Iris 05:39:21 INFO - Type: GPU 05:39:21 INFO - Bus: Built-In 05:39:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:21 INFO - Vendor: Intel (0x8086) 05:39:21 INFO - Device ID: 0x0a2e 05:39:21 INFO - Revision ID: 0x0009 05:39:21 INFO - Displays: 05:39:21 INFO - Display: 05:39:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:21 INFO - Display Serial Number: 1600x1200 60 05:39:21 INFO - Main Display: Yes 05:39:21 INFO - Mirror: Off 05:39:21 INFO - Online: Yes 05:39:21 INFO - Rotation: Supported 05:39:21 INFO - Return code: 0 05:39:21 INFO - Running post-action listener: _resource_record_post_action 05:39:21 INFO - Running post-run listener: _resource_record_post_run 05:39:22 INFO - Total resource usage - Wall time: 1236s; CPU: 53.0%; Read bytes: 40011264; Write bytes: 697726464; Read time: 438; Write time: 2182 05:39:22 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 341809664; Write bytes: 339310592; Read time: 26052; Write time: 629 05:39:22 INFO - run-tests - Wall time: 1206s; CPU: 53.0%; Read bytes: 33844736; Write bytes: 348040704; Read time: 348; Write time: 1519 05:39:22 INFO - Running post-run listener: _upload_blobber_files 05:39:22 INFO - Blob upload gear active. 05:39:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:39:22 INFO - Copying logs to upload dir... 05:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.861493 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-20 05:39:22.698748) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:39:22.702725) ========= 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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 build_url:https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009327 build_url: 'https://queue.taskcluster.net/v1/task/HNp6mC4gSzeY7iC1gc5TKA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:39:22.726934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:39:22.727295) ========= 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.YN9dGKG3JF/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.LJkAIn43Ns/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.004962 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:39:22.776244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:39:22.776625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:39:22.777099) ========= ========= Total master_lag: 0.23 =========