builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0036 starttime: 1447345679.52 results: success (0) buildid: 20151112070744 builduid: a52ea9a3e1a5489788414863b7da21e9 revision: 4fe9c44ee56af900b221bd41cd78c987448ad385 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.519618) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.520084) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.520381) ========= 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.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006234 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.544778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.545130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.561477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.561919) ========= 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.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005902 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.612032) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.612341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.612729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.613045) ========= 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.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False --2015-11-12 08:27:59-- 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% 39.0M=0s 2015-11-12 08:27:59 (39.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.796469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.796841) ========= 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.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.022088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.847900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:27:59.848256) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4fe9c44ee56af900b221bd41cd78c987448ad385 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4fe9c44ee56af900b221bd41cd78c987448ad385 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False 2015-11-12 08:27:59,929 truncating revision to first 12 chars 2015-11-12 08:27:59,930 Setting DEBUG logging. 2015-11-12 08:27:59,930 attempt 1/10 2015-11-12 08:27:59,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4fe9c44ee56a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 08:28:00,173 unpacking tar archive at: mozilla-inbound-4fe9c44ee56a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:28:00.381816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 08:28:00.382146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 08:28:00.395808) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 08:28:00.396139) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 08:28:00.396557) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 50 secs) (at 2015-11-12 08:28:00.396864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False 08:28:00 INFO - MultiFileLogger online at 20151112 08:28:00 in /builds/slave/test 08:28:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:28:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:00 INFO - {'append_to_log': False, 08:28:00 INFO - 'base_work_dir': '/builds/slave/test', 08:28:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:28:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:00 INFO - 'branch': 'Mozilla-Inbound', 08:28:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:00 INFO - 'config_files': ('talos/mac_config.py',), 08:28:00 INFO - 'default_actions': ('clobber', 08:28:00 INFO - 'read-buildbot-config', 08:28:00 INFO - 'download-and-extract', 08:28:00 INFO - 'populate-webroot', 08:28:00 INFO - 'create-virtualenv', 08:28:00 INFO - 'install', 08:28:00 INFO - 'run-tests'), 08:28:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:00 INFO - 'download_minidump_stackwalk': True, 08:28:00 INFO - 'download_symbols': 'ondemand', 08:28:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:00 INFO - 'installer_path': 'installer.exe', 08:28:00 INFO - 'log_level': 'info', 08:28:00 INFO - 'log_name': 'talos', 08:28:00 INFO - 'log_to_console': True, 08:28:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:28:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:28:00 INFO - 'opt_config_files': (), 08:28:00 INFO - 'pip_index': False, 08:28:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:28:00 INFO - 'cmd': ('bash', 08:28:00 INFO - '-c', 08:28:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:28:00 INFO - 'enabled': True, 08:28:00 INFO - 'halt_on_failure': False, 08:28:00 INFO - 'name': 'check_screen_resolution'},), 08:28:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:28:00 INFO - 'cmd': ('bash', 08:28:00 INFO - '-c', 08:28:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:28:00 INFO - 'enabled': True, 08:28:00 INFO - 'halt_on_failure': False, 08:28:00 INFO - 'name': 'check_screen_resolution'},), 08:28:00 INFO - 'run_cmd_checks_enabled': True, 08:28:00 INFO - 'sps_profile': False, 08:28:00 INFO - 'sps_profile_interval': 0, 08:28:00 INFO - 'suite': 'dromaeojs', 08:28:00 INFO - 'system_bits': '64', 08:28:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:00 INFO - 'title': 't-yosemite-r5-0036', 08:28:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:00 INFO - 'use_talos_json': True, 08:28:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:00 INFO - 'work_dir': 'build'} 08:28:00 INFO - ##### 08:28:00 INFO - ##### Running clobber step. 08:28:00 INFO - ##### 08:28:00 INFO - Running pre-action listener: _resource_record_pre_action 08:28:00 INFO - Running main action method: clobber 08:28:00 INFO - rmtree: /builds/slave/test/build 08:28:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:03 INFO - Running post-action listener: _resource_record_post_action 08:28:03 INFO - ##### 08:28:03 INFO - ##### Running read-buildbot-config step. 08:28:03 INFO - ##### 08:28:03 INFO - Running pre-action listener: _resource_record_pre_action 08:28:03 INFO - Running main action method: read_buildbot_config 08:28:03 INFO - Using buildbot properties: 08:28:03 INFO - { 08:28:03 INFO - "properties": { 08:28:03 INFO - "buildnumber": 3132, 08:28:03 INFO - "product": "firefox", 08:28:03 INFO - "script_repo_revision": "production", 08:28:03 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 08:28:03 INFO - "repository": "", 08:28:03 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 08:28:03 INFO - "buildid": "20151112070744", 08:28:03 INFO - "slavename": "t-yosemite-r5-0036", 08:28:03 INFO - "pgo_build": "False", 08:28:03 INFO - "basedir": "/builds/slave/test", 08:28:03 INFO - "project": "", 08:28:03 INFO - "platform": "yosemite", 08:28:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:28:03 INFO - "slavebuilddir": "test", 08:28:03 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 08:28:03 INFO - "branch": "mozilla-inbound", 08:28:03 INFO - "repo_path": "integration/mozilla-inbound", 08:28:03 INFO - "stage_platform": "macosx64", 08:28:03 INFO - "builduid": "a52ea9a3e1a5489788414863b7da21e9", 08:28:03 INFO - "revision": "4fe9c44ee56af900b221bd41cd78c987448ad385" 08:28:03 INFO - }, 08:28:03 INFO - "sourcestamp": { 08:28:03 INFO - "repository": "", 08:28:03 INFO - "hasPatch": false, 08:28:03 INFO - "project": "", 08:28:03 INFO - "branch": "mozilla-inbound-macosx64-talos", 08:28:03 INFO - "changes": [ 08:28:03 INFO - { 08:28:03 INFO - "category": null, 08:28:03 INFO - "files": [ 08:28:03 INFO - { 08:28:03 INFO - "url": null, 08:28:03 INFO - "name": "https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:28:03 INFO - } 08:28:03 INFO - ], 08:28:03 INFO - "repository": "", 08:28:03 INFO - "rev": "4fe9c44ee56af900b221bd41cd78c987448ad385", 08:28:03 INFO - "who": "jcoppeard@mozilla.com", 08:28:03 INFO - "when": 1447345587, 08:28:03 INFO - "number": 6653863, 08:28:03 INFO - "comments": "Bug 1219905 - Don't assume an exception is pending if the execution failed in oomTest() r=jandem", 08:28:03 INFO - "project": "", 08:28:03 INFO - "at": "Thu 12 Nov 2015 08:26:27", 08:28:03 INFO - "branch": "mozilla-inbound-macosx64-talos", 08:28:03 INFO - "revlink": "", 08:28:03 INFO - "properties": [ 08:28:03 INFO - [ 08:28:03 INFO - "buildid", 08:28:03 INFO - "20151112070744", 08:28:03 INFO - "Change" 08:28:03 INFO - ], 08:28:03 INFO - [ 08:28:03 INFO - "builduid", 08:28:03 INFO - "a52ea9a3e1a5489788414863b7da21e9", 08:28:03 INFO - "Change" 08:28:03 INFO - ], 08:28:03 INFO - [ 08:28:03 INFO - "pgo_build", 08:28:03 INFO - "False", 08:28:03 INFO - "Change" 08:28:03 INFO - ] 08:28:03 INFO - ], 08:28:03 INFO - "revision": "4fe9c44ee56af900b221bd41cd78c987448ad385" 08:28:03 INFO - } 08:28:03 INFO - ], 08:28:03 INFO - "revision": "4fe9c44ee56af900b221bd41cd78c987448ad385" 08:28:03 INFO - } 08:28:03 INFO - } 08:28:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:28:03 INFO - Running post-action listener: _resource_record_post_action 08:28:03 INFO - ##### 08:28:03 INFO - ##### Running download-and-extract step. 08:28:03 INFO - ##### 08:28:03 INFO - Running pre-action listener: _resource_record_pre_action 08:28:03 INFO - Running main action method: download_and_extract 08:28:03 INFO - mkdir: /builds/slave/test/build/tests 08:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:03 INFO - https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/test_packages.json 08:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/test_packages.json 08:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:28:03 INFO - Downloaded 1149 bytes. 08:28:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:28:03 INFO - Using the following test package requirements: 08:28:03 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:28:03 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:28:03 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'jsshell-mac.zip'], 08:28:03 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:28:03 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:28:03 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:28:03 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:28:03 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:28:03 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:28:03 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:28:03 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:28:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:03 INFO - https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:28:04 INFO - Downloaded 17455613 bytes. 08:28:04 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 08:28:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:28:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:28:11 INFO - Return code: 0 08:28: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 08:28: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')]} 08:28:11 INFO - https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:28:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:28:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:28:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:29:17 INFO - Downloaded 17455613 bytes. 08:29:17 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 08:29:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:29:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:29:25 INFO - Return code: 0 08:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:25 INFO - https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:29:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:29:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:29:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:31:16 INFO - Downloaded 11131693 bytes. 08:31: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 08:31:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:31:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:31:17 INFO - Return code: 0 08:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:17 INFO - https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:31:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:31:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:31:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Brgk30SVRx-na7T0SJez4g/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 08:31:20 INFO - Downloaded 108704337 bytes. 08:31:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:31:20 INFO - mkdir: /builds/slave/test/properties 08:31:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:31:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:31:20 INFO - Contents: 08:31:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:31:20 INFO - Running post-action listener: _resource_record_post_action 08:31:20 INFO - Running post-action listener: set_extra_try_arguments 08:31:20 INFO - ##### 08:31:20 INFO - ##### Running populate-webroot step. 08:31:20 INFO - ##### 08:31:20 INFO - Running pre-action listener: _resource_record_pre_action 08:31:20 INFO - Running main action method: populate_webroot 08:31:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:20 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:31:20 INFO - '../fennec_ids.txt'], 08:31:20 INFO - 'tests': ['tcheck2']}, 08:31:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:20 INFO - '--tppagecycles', 08:31:20 INFO - '7'], 08:31:20 INFO - 'tests': ['tsvgm']}}, 08:31:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:31:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:31:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:31:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'tests': ['damp', 'tps']}, 08:31:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['damp', 'tps']}, 08:31:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:31:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:20 INFO - 'other': {'tests': ['a11yr', 08:31:20 INFO - 'ts_paint', 08:31:20 INFO - 'tpaint', 08:31:20 INFO - 'sessionrestore', 08:31:20 INFO - 'sessionrestore_no_auto_restore']}, 08:31:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['a11yr', 08:31:20 INFO - 'ts_paint', 08:31:20 INFO - 'tpaint', 08:31:20 INFO - 'sessionrestore', 08:31:20 INFO - 'sessionrestore_no_auto_restore']}, 08:31:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['a11yr', 08:31:20 INFO - 'ts_paint', 08:31:20 INFO - 'tpaint', 08:31:20 INFO - 'sessionrestore', 08:31:20 INFO - 'sessionrestore_no_auto_restore']}, 08:31:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['a11yr', 08:31:20 INFO - 'ts_paint', 08:31:20 INFO - 'tpaint', 08:31:20 INFO - 'sessionrestore', 08:31:20 INFO - 'sessionrestore_no_auto_restore']}, 08:31:20 INFO - 'other_l64': {'tests': ['a11yr', 08:31:20 INFO - 'ts_paint', 08:31:20 INFO - 'tpaint', 08:31:20 INFO - 'sessionrestore', 08:31:20 INFO - 'sessionrestore_no_auto_restore']}, 08:31:20 INFO - 'other_nol64': {'tests': ['a11yr', 08:31:20 INFO - 'ts_paint', 08:31:20 INFO - 'tpaint', 08:31:20 INFO - 'sessionrestore', 08:31:20 INFO - 'sessionrestore_no_auto_restore']}, 08:31:20 INFO - 'svgr': {'tests': ['tsvgx', 08:31:20 INFO - 'tsvgr_opacity', 08:31:20 INFO - 'tart', 08:31:20 INFO - 'tscrollx', 08:31:20 INFO - 'cart']}, 08:31:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['tsvgx', 08:31:20 INFO - 'tsvgr_opacity', 08:31:20 INFO - 'tart', 08:31:20 INFO - 'tscrollx', 08:31:20 INFO - 'cart']}, 08:31:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'tests': ['tp5o']}, 08:31:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'talos_options': ['--e10s'], 08:31:20 INFO - 'tests': ['tp5o']}, 08:31:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'talos_options': ['--xperf_path', 08:31:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:20 INFO - 'tests': ['tp5n']}, 08:31:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:20 INFO - 'talos_options': ['--e10s', 08:31:20 INFO - '--xperf_path', 08:31:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:20 INFO - 'tests': ['tp5n']}}, 08:31:20 INFO - 'talos.zip': {'path': '', 08:31:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:20 INFO - Running post-action listener: _resource_record_post_action 08:31:20 INFO - ##### 08:31:20 INFO - ##### Running create-virtualenv step. 08:31:20 INFO - ##### 08:31:20 INFO - Running pre-action listener: _resource_record_pre_action 08:31:20 INFO - Running main action method: create_virtualenv 08:31:20 INFO - Creating virtualenv /builds/slave/test/build/venv 08:31:20 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 08:31:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:31:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:20 INFO - Using real prefix '/tools/python27' 08:31:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:31:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:25 INFO - Installing pip.................done. 08:31:25 INFO - Return code: 0 08:31:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:25 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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31:25 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 08:31:25 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 08:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:25 INFO - 'HOME': '/Users/cltbld', 08:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:25 INFO - 'LOGNAME': 'cltbld', 08:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:25 INFO - 'MOZ_NO_REMOTE': '1', 08:31:25 INFO - 'NO_EM_RESTART': '1', 08:31:25 INFO - 'PAGER': '/bin/cat', 08:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:25 INFO - 'PWD': '/builds/slave/test', 08:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:25 INFO - 'SHELL': '/bin/bash', 08:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:25 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:25 INFO - 'USER': 'cltbld', 08:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:25 INFO - 'XPC_FLAGS': '0x0', 08:31:25 INFO - 'XPC_SERVICE_NAME': '0', 08:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:31:25 INFO - Cleaning up... 08:31:25 INFO - Return code: 0 08:31:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:25 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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31:25 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 08:31:25 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 08:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:25 INFO - 'HOME': '/Users/cltbld', 08:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:25 INFO - 'LOGNAME': 'cltbld', 08:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:25 INFO - 'MOZ_NO_REMOTE': '1', 08:31:25 INFO - 'NO_EM_RESTART': '1', 08:31:25 INFO - 'PAGER': '/bin/cat', 08:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:25 INFO - 'PWD': '/builds/slave/test', 08:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:25 INFO - 'SHELL': '/bin/bash', 08:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:25 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:25 INFO - 'USER': 'cltbld', 08:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:25 INFO - 'XPC_FLAGS': '0x0', 08:31:25 INFO - 'XPC_SERVICE_NAME': '0', 08:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:26 INFO - Downloading/unpacking psutil>=0.7.1 08:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:31:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:28 INFO - Installing collected packages: psutil 08:31:28 INFO - Running setup.py install for psutil 08:31:28 INFO - building 'psutil._psutil_osx' extension 08:31:28 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 08:31:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:31:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:31:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:31:29 INFO - building 'psutil._psutil_posix' extension 08:31:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:31:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:31:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:31:29 INFO - ^ 08:31:29 INFO - 1 warning generated. 08:31:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:29 INFO - Successfully installed psutil 08:31:29 INFO - Cleaning up... 08:31:29 INFO - Return code: 0 08:31:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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', '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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:31: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 mozsystemmonitor==0.0.0 08:31:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:30 INFO - 'HOME': '/Users/cltbld', 08:31:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:30 INFO - 'LOGNAME': 'cltbld', 08:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:30 INFO - 'MOZ_NO_REMOTE': '1', 08:31:30 INFO - 'NO_EM_RESTART': '1', 08:31:30 INFO - 'PAGER': '/bin/cat', 08:31:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:30 INFO - 'PWD': '/builds/slave/test', 08:31:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:30 INFO - 'SHELL': '/bin/bash', 08:31:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:30 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:30 INFO - 'USER': 'cltbld', 08:31:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:30 INFO - 'XPC_FLAGS': '0x0', 08:31:30 INFO - 'XPC_SERVICE_NAME': '0', 08:31:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:31:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:31:33 INFO - Installing collected packages: mozsystemmonitor 08:31:33 INFO - Running setup.py install for mozsystemmonitor 08:31:33 INFO - Successfully installed mozsystemmonitor 08:31:33 INFO - Cleaning up... 08:31:33 INFO - Return code: 0 08:31:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:31:33 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')]} 08:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:33 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')]} 08:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:33 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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31:33 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 08:31:33 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 08:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:33 INFO - 'HOME': '/Users/cltbld', 08:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:33 INFO - 'LOGNAME': 'cltbld', 08:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:33 INFO - 'MOZ_NO_REMOTE': '1', 08:31:33 INFO - 'NO_EM_RESTART': '1', 08:31:33 INFO - 'PAGER': '/bin/cat', 08:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:33 INFO - 'PWD': '/builds/slave/test', 08:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:33 INFO - 'SHELL': '/bin/bash', 08:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:33 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:33 INFO - 'USER': 'cltbld', 08:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:33 INFO - 'XPC_FLAGS': '0x0', 08:31:33 INFO - 'XPC_SERVICE_NAME': '0', 08:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:31:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:37 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 08:31:37 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 08:31:37 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 08:31:37 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 08:31:37 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 08:31:37 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 08:31:37 INFO - Downloading docopt-0.6.1.tar.gz 08:31:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:37 INFO - Running setup.py install for blobuploader 08:31:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:31:37 INFO - Running setup.py install for requests 08:31:38 INFO - Running setup.py install for docopt 08:31:38 INFO - Successfully installed blobuploader requests docopt 08:31:38 INFO - Cleaning up... 08:31:38 INFO - Return code: 0 08:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:38 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')]} 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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')]} 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31:38 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 08:31:38 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 08:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:38 INFO - 'HOME': '/Users/cltbld', 08:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:38 INFO - 'LOGNAME': 'cltbld', 08:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:38 INFO - 'MOZ_NO_REMOTE': '1', 08:31:38 INFO - 'NO_EM_RESTART': '1', 08:31:38 INFO - 'PAGER': '/bin/cat', 08:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:38 INFO - 'PWD': '/builds/slave/test', 08:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:38 INFO - 'SHELL': '/bin/bash', 08:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:38 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:38 INFO - 'USER': 'cltbld', 08:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:38 INFO - 'XPC_FLAGS': '0x0', 08:31:38 INFO - 'XPC_SERVICE_NAME': '0', 08:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-0t8yxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-6Ogx1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-9ssaWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-3mx5fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-itoZYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-FzJpL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:39 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-AYV9rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-0iAvD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-934Zgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-DxoZMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-QntN5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-DqYCjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-xh2DST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:40 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-K9sA6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:41 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-CMnQJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:41 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-TX66Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:41 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-O81sOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:41 INFO - Running setup.py install for manifestparser 08:31:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:31:41 INFO - Running setup.py install for mozcrash 08:31:41 INFO - Running setup.py install for mozdebug 08:31:41 INFO - Running setup.py install for mozdevice 08:31:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozfile 08:31:42 INFO - Running setup.py install for mozhttpd 08:31:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozinfo 08:31:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozInstall 08:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozleak 08:31:43 INFO - Running setup.py install for mozlog 08:31:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for moznetwork 08:31:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for mozprocess 08:31:43 INFO - Running setup.py install for mozprofile 08:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for mozrunner 08:31:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:31:44 INFO - Running setup.py install for mozscreenshot 08:31:44 INFO - Running setup.py install for moztest 08:31:44 INFO - Running setup.py install for mozversion 08:31:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:31:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:44 INFO - Cleaning up... 08:31:44 INFO - Return code: 0 08:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31: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')]} 08:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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/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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31: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/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 08:31: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/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 08:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:44 INFO - 'HOME': '/Users/cltbld', 08:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:44 INFO - 'LOGNAME': 'cltbld', 08:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:44 INFO - 'MOZ_NO_REMOTE': '1', 08:31:44 INFO - 'NO_EM_RESTART': '1', 08:31:44 INFO - 'PAGER': '/bin/cat', 08:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:44 INFO - 'PWD': '/builds/slave/test', 08:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:44 INFO - 'SHELL': '/bin/bash', 08:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:44 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:44 INFO - 'USER': 'cltbld', 08:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:44 INFO - 'XPC_FLAGS': '0x0', 08:31:44 INFO - 'XPC_SERVICE_NAME': '0', 08:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-3Zn7Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-1ccR2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-Ds66tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-16tdDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-tb6WCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-6fOk_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-3pvQH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:45 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-jDM8vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-IeFEfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-WB2R1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-R1l0H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-Aombfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-SIjVOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-X6ltJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:46 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-AdLmW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:47 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)) 08:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:47 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-9YU1Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:47 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)) 08:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:47 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-W71ReQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:47 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)) 08:31:47 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)) 08:31:47 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)) 08:31:47 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)) 08:31:47 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)) 08:31:47 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)) 08:31:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:49 INFO - Downloading blessings-1.5.1.tar.gz 08:31:49 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 08:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:50 INFO - Installing collected packages: blessings 08:31:50 INFO - Running setup.py install for blessings 08:31:50 INFO - Successfully installed blessings 08:31:50 INFO - Cleaning up... 08:31:50 INFO - Return code: 0 08:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:50 INFO - Reading from file tmpfile_stdout 08:31:50 INFO - Current package versions: 08:31:50 INFO - blessings == 1.5.1 08:31:50 INFO - blobuploader == 1.2.4 08:31:50 INFO - docopt == 0.6.1 08:31:50 INFO - manifestparser == 1.1 08:31:50 INFO - mozInstall == 1.12 08:31:50 INFO - mozcrash == 0.16 08:31:50 INFO - mozdebug == 0.1 08:31:50 INFO - mozdevice == 0.47 08:31:50 INFO - mozfile == 1.2 08:31:50 INFO - mozhttpd == 0.7 08:31:50 INFO - mozinfo == 0.9 08:31:50 INFO - mozleak == 0.1 08:31:50 INFO - mozlog == 3.0 08:31:50 INFO - moznetwork == 0.27 08:31:50 INFO - mozprocess == 0.22 08:31:50 INFO - mozprofile == 0.27 08:31:50 INFO - mozrunner == 6.11 08:31:50 INFO - mozscreenshot == 0.1 08:31:50 INFO - mozsystemmonitor == 0.0 08:31:50 INFO - moztest == 0.7 08:31:50 INFO - mozversion == 1.4 08:31:50 INFO - psutil == 3.1.1 08:31:50 INFO - requests == 1.2.3 08:31:50 INFO - wsgiref == 0.1.2 08:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:50 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 0x10259c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102579228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8196498f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/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.qWQ50Kncjr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:31:50 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 08:31:50 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 08:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:50 INFO - 'HOME': '/Users/cltbld', 08:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:50 INFO - 'LOGNAME': 'cltbld', 08:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:50 INFO - 'MOZ_NO_REMOTE': '1', 08:31:50 INFO - 'NO_EM_RESTART': '1', 08:31:50 INFO - 'PAGER': '/bin/cat', 08:31:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:50 INFO - 'PWD': '/builds/slave/test', 08:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:50 INFO - 'SHELL': '/bin/bash', 08:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:31:50 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:50 INFO - 'USER': 'cltbld', 08:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:50 INFO - 'XPC_FLAGS': '0x0', 08:31:50 INFO - 'XPC_SERVICE_NAME': '0', 08:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 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)) 08:31:51 INFO - Cleaning up... 08:31:51 INFO - Return code: 0 08:31:51 INFO - Running post-action listener: _resource_record_post_action 08:31:51 INFO - Running post-action listener: _start_resource_monitoring 08:31:51 INFO - Starting resource monitoring. 08:31:51 INFO - ##### 08:31:51 INFO - ##### Running install step. 08:31:51 INFO - ##### 08:31:51 INFO - Running pre-action listener: _resource_record_pre_action 08:31:51 INFO - Running main action method: install 08:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:51 INFO - Reading from file tmpfile_stdout 08:31:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:31:51 INFO - Reading from file tmpfile_stdout 08:31:51 INFO - Output received: 08:31:51 INFO - Usage: mozinstall [options] installer 08:31:51 INFO - Options: 08:31:51 INFO - -h, --help show this help message and exit 08:31:51 INFO - -d DEST, --destination=DEST 08:31:51 INFO - Directory to install application into. [default: 08:31:51 INFO - "/builds/slave/test"] 08:31:51 INFO - --app=APP Application being installed. [default: firefox] 08:31:51 INFO - mkdir: /builds/slave/test/build/application 08:31:51 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'] 08:31:51 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 08:32:32 INFO - Reading from file tmpfile_stdout 08:32:32 INFO - Output received: 08:32:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:32:32 INFO - Running post-action listener: _resource_record_post_action 08:32:32 INFO - ##### 08:32:32 INFO - ##### Running run-tests step. 08:32:32 INFO - ##### 08:32:32 INFO - Running pre-action listener: _resource_record_pre_action 08:32:32 INFO - Running main action method: run_tests 08:32:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:32:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:32:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:32:32 INFO - 2015-11-12 08:32:32.374 screenresolution[2253:20409] starting screenresolution argv=screenresolution get 08:32:32 INFO - 2015-11-12 08:32:32.377 screenresolution[2253:20409] Display 0: 1600x1200x32@60 08:32:32 INFO - 2015-11-12 08:32:32.384 screenresolution[2254:20411] starting screenresolution argv=screenresolution list 08:32:32 INFO - Available Modes on Display 0 08:32:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:32:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:32:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:32:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:32:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:32:32 INFO - Intel HD Graphics 3000: 08:32:32 INFO - Chipset Model: Intel HD Graphics 3000 08:32:32 INFO - Type: GPU 08:32:32 INFO - Bus: Built-In 08:32:32 INFO - VRAM (Total): 512 MB 08:32:32 INFO - VRAM (Dynamic, Max): 10 08:32:32 INFO - Vendor: Intel (0x8086) 08:32:32 INFO - Device ID: 0x0116 08:32:32 INFO - Revision ID: 0x0009 08:32:32 INFO - Displays: 08:32:32 INFO - Display: 08:32:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:32:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:32:32 INFO - Display Serial Number: 1600x1200 60 08:32:32 INFO - Main Display: Yes 08:32:32 INFO - Mirror: Off 08:32:32 INFO - Online: Yes 08:32:32 INFO - Rotation: Supported 08:32:32 INFO - Return code: 0 08:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:32:32 INFO - Python 2.7.3 08:32:32 INFO - Return code: 0 08:32:32 INFO - grabbing minidump binary from tooltool 08:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:32 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 0x1024bf9f0>, '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 0x10221fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024b38c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:32:32 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 08:32:32 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 08:32:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:32 INFO - Return code: 0 08:32:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:32:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:32:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:32:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:32:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0036', '--webServer', 'localhost'] in /builds/slave/test/build 08:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0036 --webServer localhost 08:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrdCcKlxlG/Render', 08:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:32 INFO - 'HOME': '/Users/cltbld', 08:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:32 INFO - 'LOGNAME': 'cltbld', 08:32:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:32:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:32 INFO - 'MOZ_NO_REMOTE': '1', 08:32:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:32:32 INFO - 'NO_EM_RESTART': '1', 08:32:32 INFO - 'PAGER': '/bin/cat', 08:32:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:32 INFO - 'PWD': '/builds/slave/test', 08:32:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:32 INFO - 'SHELL': '/bin/bash', 08:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWQ50Kncjr/Listeners', 08:32:32 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 08:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:32 INFO - 'USER': 'cltbld', 08:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:32 INFO - 'XPC_FLAGS': '0x0', 08:32:32 INFO - 'XPC_SERVICE_NAME': '0', 08:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:32:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0036', '--webServer', 'localhost'] with output_timeout 3600 08:32:33 INFO - mozversion INFO | application_buildid: 20151112070744 08:32:33 INFO - mozversion INFO | application_changeset: 4fe9c44ee56af900b221bd41cd78c987448ad385 08:32:33 INFO - mozversion INFO | application_display_name: Nightly 08:32:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:33 INFO - mozversion INFO | application_name: Firefox 08:32:33 INFO - mozversion INFO | application_remotingname: firefox 08:32:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:32:33 INFO - mozversion INFO | application_vendor: Mozilla 08:32:33 INFO - mozversion INFO | application_version: 45.0a1 08:32:33 INFO - mozversion INFO | platform_buildid: 20151112070744 08:32:33 INFO - mozversion INFO | platform_changeset: 4fe9c44ee56af900b221bd41cd78c987448ad385 08:32:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:32:33 INFO - mozversion INFO | platform_version: 45.0a1 08:32:33 INFO - 2015-11-12 08:32:33,047 DEBUG : using testdate: 1447345953 08:32:33 INFO - 2015-11-12 08:32:33,047 DEBUG : actual date: 1447345953 08:32:33 INFO - 2015-11-12 08:32:33,061 INFO : starting webserver on 'localhost:50033' 08:32:33 INFO - 2015-11-12 08:32:33,063 INFO : Starting test suite t-yosemite-r5-0036 08:32:33 INFO - 2015-11-12 08:32:33,063 INFO : Starting test dromaeo_css 08:32:33 INFO - 2015-11-12 08:32:33,063 DEBUG : operating with platform_type : mac_ 08:32:33 INFO - 2015-11-12 08:32:33,064 INFO : Initialising browser for dromaeo_css test... 08:32:33 INFO - 2015-11-12 08:32:33,079 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpSngx5u/profile http://localhost:50033/getInfo.html 08:32:35 INFO - 2015-11-12 08:32:35,659 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:32:35 INFO - 2015-11-12 08:32:35,659 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:32:35 INFO - 2015-11-12 08:32:35,659 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:32:35 INFO - 2015-11-12 08:32:35,659 DEBUG : BROWSER_OUTPUT: __metrics 08:32:35 INFO - 2015-11-12 08:32:35,675 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:36 INFO - 2015-11-12 08:32:36,428 INFO : Browser initialized. 08:32:36 INFO - 2015-11-12 08:32:36,429 INFO : Running cycle 1/1 for dromaeo_css test... 08:32:36 INFO - 2015-11-12 08:32:36,429 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpSngx5u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:32:48 INFO - 2015-11-12 08:32:48,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 228753408 08:32:48 INFO - 2015-11-12 08:32:48,536 DEBUG : BROWSER_OUTPUT: 08:33:39 INFO - 2015-11-12 08:33:39,391 DEBUG : BROWSER_OUTPUT: 1447346019383 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] 08:35:50 INFO - 2015-11-12 08:35:50,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50033/tests/dromaeo/cssquery-ext.html) 08:35:51 INFO - 2015-11-12 08:35:51,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 320724992 08:35:51 INFO - 2015-11-12 08:35:51,431 DEBUG : BROWSER_OUTPUT: 08:38:54 INFO - 2015-11-12 08:38:54,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/dromaeo/cssquery-ext.html (next: http://localhost:50033/tests/dromaeo/cssquery-jquery.html) 08:38:54 INFO - 2015-11-12 08:38:54,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 366489600 08:38:54 INFO - 2015-11-12 08:38:54,816 DEBUG : BROWSER_OUTPUT: 08:41:57 INFO - 2015-11-12 08:41:57,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50033/tests/dromaeo/cssquery-mootools.html) 08:41:57 INFO - 2015-11-12 08:41:57,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 327528448 08:41:57 INFO - 2015-11-12 08:41:57,762 DEBUG : BROWSER_OUTPUT: 08:44:59 INFO - 2015-11-12 08:44:59,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50033/tests/dromaeo/cssquery-prototype.html) 08:45:00 INFO - 2015-11-12 08:45:00,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 320032768 08:45:00 INFO - 2015-11-12 08:45:00,489 DEBUG : BROWSER_OUTPUT: 08:48:03 INFO - 2015-11-12 08:48:03,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50033/tests/dromaeo/cssquery-yui.html) 08:48:04 INFO - 2015-11-12 08:48:04,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 318070784 08:48:04 INFO - 2015-11-12 08:48:04,192 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/dromaeo/cssquery-yui.html (next: http://localhost:50033/tests/dromaeo/cssquery-dojo.html) 08:51:07 INFO - 2015-11-12 08:51:07,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 369557504 08:51:07 INFO - 2015-11-12 08:51:07,300 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,300 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:51:07 INFO - 2015-11-12 08:51:07,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:51:07 INFO - 2015-11-12 08:51:07,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:51:07 INFO - 2015-11-12 08:51:07,300 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:51:07 INFO - 2015-11-12 08:51:07,304 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.1573254424857;2688.0865277556863;2709.6477457930464;2760.2685288398566;2764.074035198207;4375.5843194896515;4518.412606361168;4543.613792827609;4559.908801823962;4589.678722489427;4411.713238639486;4484.260097083986;4516.864494065175;4562.954370456295;4605.102005109005;4163.313053346209;4188.162367526492;4234.470691163605;4243.087736136746;4245.23585754564;4278.507971583276;4357.956420435803;4361.563843615645;4382.342648602719;4440.111977604492;4104.527979282361;4200.411942328046;4202.411662367271;4332.978335108336;4354.281543545311;4084.9183016339803;4199.223143718391;4221.535631080578;4224.38746381776;4281.272183728743;4198.9370159447635;4201;4222.0500387412585;4229.429027081366;4253.3194688849635;4411.845585404495;4519;4526.592606665383;4609.723416595015;4612.838550650711;4705.035467729142;4771.546703063238;4775.928361074587;4807.062622788558;4834.564889159958;4924.679895806797;4936.086823937583;4946.629002824767;4956.504349565051;4991.425986011619;4488.708233964782;4614.123316569841;4616.722996620214;4642;4697.765111744399;4819.445763737145;4948.4309304429735;4954.752262386866;4976.0794253063295;5046.6719663221775;4800.423949126127;4891.51084891508;4891.559759621651;4897.216445368724;4938.629602779806;4757.429108507002;4843.878903027382;4894.119058569491;4988.700677959334;5011.874703132378;4649.511801260819;4748.762561871893;4774.3077253798;4784.138855006063;4807.423109226916;4834.613230941516;4849.75751212438;4853.3447984522345;4854.126257273725;4858.295547145714;3687.539057617798;3697.352963231424;3778.1688028633657;3800.9619903801163;3832.2718683450057;3354.4129777288877;3403.4724617684296;3436.1924947637285;3436.43298855686;3448.413769659164;4468.3074123510905;4535.863924082283;4536.931946020813;4585.72485650862;4630.166570017362;4960.057589058068;4972.825951091694;4992.8002879885125;5005.849824505271;5041.2438134280155;4429.2027435062;4519.81920723174;4593.311003349458;4635.860924172281;4654.115718013634;4173.52004519478;4259.1268789897995;4263.062126332202;4265.55211702773;4287.8499252526635;5058.4435712071645;5105.566026887682;5123.129068058439;5127.359080114986;5139.357580302462;4723.622110231242;4870.196417591058;4962.652614316963;4990.600751939909;5045.596352291735;4849.878753031202;5021.4225364083595;5028.949710502849;5049;5075.746212689277;4812.181929071996;4829.27560865873;4837.612990960644;4855.295982082507;4895.485973972682;4669.229577119873;4796.808127674994;4890.364252647133;4894.314795928644;4948.208286674115;4707;4709.105269998826;4744.952550474451;4778.7849546769785;4795.976020119877;4747.786349614206;4778.928316075331;4794.376731024944;4836.371271734793;4850.490698476609;4468.664850136188;4598.402207712976;4716.29255611661;4734.384530011076;4775.6179505638775;4628;4665.183592871302;4675.13510000651;4719.150552900511;4748.240281554935;4645.68304919746;4669.696469729457;4709.105269998689;4717.268823332389;4769.403824521934 08:51:07 INFO - 2015-11-12 08:51:07,305 DEBUG : BROWSER_OUTPUT: |1;ext.html;458.52771645205434;464.7490355208188;470.7457972694745;471.3189441257384;492.0012374878997;26553.867230663844;33083.33833323332;33855.49216761751;33868.322633547315;33992.15019624511;35839.64160358396;36185;36325.0918727032;36366.63633363672;36401;6920.65396730164;7046.154461464632;7750.457467977244;7974.880376794324;8048.476849004825;9497.81004379912;9602;9644.228461723045;9661.661841835537;9687.467189304585;9346.532673366304;9454.81090378192;9467.053294670512;9468.431894086343;9534.666286679967;7148.46386521013;7325.084364454443;9306.488143152124;9331.206847417978;9490.572924218392;9174.495402752846;9280.675176368863;9289.442633442015;9333.393329433566;9336.299777516646;33439.498407523904;33591.6640833591;33612.49581256283;33759.831200844084;33858.83070584656;2424.35754525051;2487.2165267940723;2539.5047965646704;2611.099170786076;2765.6404667393313;23232.186873459348;23523.294301170994;23660.526789464115;24352.756472435227;24433;2025.5948810238012;2073.2432662078386;2090.95818083639;2104.168853302952;2210.5910406574835;217455;217504;217659;218146;219176;49477;50051.24923126156;50563.74718126386;50730.23904641433;51565.29651145327;54447;55578.054768082926;56020.15969760457;56266.43733562612;56385.43614563802;12474.563390281297;12885.549005784753;12897.355132243538;12925.741485170243;12965.675858103434;9718.854217186748;9769.364991275545;9780.217582593375;9898.752531186634;9919.256055795844;16369.345226191057;16796.66406671884;16918.830811691972;16954.491365259062;17072.146392680315;7093.89359159613;7240.96379518099;7274.30894065063;7286.781396558005;7301.817454563678;837.9762872662452;843.7637461510786;903.9864402033975;906.6781292641017;992.6616422054798;24165.516689666107;24451;24533.754662453503;24555.877220613784;24576;916.3219217778795;921.05131714333;978.192990782593;986.3391527676474;1022.7238645565656;12600.936995315147;12609.469348582412;12759.808602870964;12765.872341276468;12859.0998630095;276927;283059;283288;283453;284498;46515;46658;46827.53172468232;46834.531654683014;47068.529314706415;1154.7113221694576;1160.9477573509382;1180.15029178991;1187.4834447015576;1189.881011898803;24173.51652966966;24217.51564968726;24466.51066978686;24539.631905521073;24641.876790615934;36440;37090.814545927096;41048;41660.58339416567;41808.79095604503;170099;171086;172409;172791;173404;24132;24257;24315.270541883772;24329.878350608134;24410.87794561016;28916;29222.707772922;33958.32083358269;35237;35734.28531429409;27479.450410991267;28610.284742881595;28736.712632873405;28797.28006799847;28859.278518037216;28050.859745701142;28103;28103;28324.85837570799;28410.715892840806;27887.581686275127;28270.71729282681;28575.14274571766;28580.714192857806;28590.142295731162;25593.488130237663;25785.613215801404;26858.32854178583;26915.86542067277;27145.321366965985;20391.59216815685;20687.27594534184;20692.379228623166;20820.699010533084;20847.270345537832 08:51:07 INFO - 2015-11-12 08:51:07,307 DEBUG : BROWSER_OUTPUT: |2;jquery.html;276.98338099714005;281.6831065051817;284.5092215927525;290.504689504395;296.6055146654949;9456.763580910481;10220.182385409167;14679.70640587189;15036.699266014686;15255.771163432544;16109.677806443864;16282.918585407057;16486.75269870953;16561.17194140291;16828.57928551787;4654.04592058628;4812.278158276269;4833.806647734086;4863.537963893442;4877.70733755974;4690.4605970313505;4760.738159401231;4776.761161941907;4780.737059461728;4787.569118779309;3392.7116195123444;3527.3121741260466;3565.750397472178;4749.4775574686755;4787.16224660683;5013.824516141935;5121.2318152277085;5175.327207463006;5177.016366890316;5214.478552144793;4296.806643701041;4305.827766889321;4463.107378524308;4535.9773201133785;4570.4743954445;18059.187336569885;18161.091945402808;18382.724259136125;18907.716384254247;18911.81088189128;1638.3446621351436;1697.6944150052987;1700.4473546097445;1729.7751292332043;1803.0263657624866;11718;12118.091143164209;12313.44589493475;12399.628011159679;12420.875791242062;1432.18365531647;1433.5054406229938;1481.103932121062;1509.8339182689895;1518.9316480758393;50688.23967640451;51564;52018.21972670413;52878.47121528774;53190.73404632952;8858.689945851864;8991.235744961621;9203.079692030744;9245;9281.90718092824;11582.942085289687;11585.420728963518;11587.188896777314;11622.244554103956;11645.708857278636;6799.762008329685;6937;7044.964775176091;7046.1192350956135;7113.217546069928;6479.546431749826;6869.725210991504;6901.75843845463;6932.168139823253;6972;5305.681659100466;5365.839024829262;5381.67709937405;5396.325459317585;5422.864428389322;1523.748581484065;1590.3161640494698;1593.4184022831582;1602.7275363188287;1608.7265164921992;341.56450525580084;345.34384669128855;357.26225344663186;384.7076222071246;394.9940750888739;8684.78288042804;9234.584443699916;9353.625854965861;9574.281928855364;9582.66460673887;386.0560928529718;393.1174513217844;402.7140730081616;409.00203503451485;409.5106347914214;4403.229434848889;5270;5505.9724701376235;5511.917321240185;5539.362973258127;393461;401477;419337;434612;447780;55848.44151558432;57387.426125739046;57910.7104464475;58018;60254.69872650609;422.48878856583264;430.41893443851177;432.46806428093623;434.10790824855223;437.1366551061628;9281.814363712823;9357.672481463116;9360.765980850534;9411.152996230372;9469.905300946903;27280.317992050357;28464.573031404132;28476.145715628565;28834.567481488215;28921.710782892744;35725.28549428945;36066.09834754152;36242.8187859059;36334.63665363418;36687;5201.453847346125;5222.3472065991755;5303.416624171416;5318.97340513295;5350.143976963667;10002.44986525719;10127.797444051224;10139.340942838691;10149.289549731448;10287.7428064296;8480.15198480147;8546.102659220942;8549.700760473354;8756.25571826402;8775.648974041222;6609;8397.790055248423;8411.200935911078;8496.745097647081;8712.172343627346;8493.872591911002;8683.782905427415;8789.736307910773;8829.028806831371;8837;5173.4826517347965;5285.339332583427;5286.418493965583;5288.894222115459;5289.074411977812;7301.452391070585;8433.662653493791;8650.43772154808;8681.131886811268;8754.649814007624 08:51:07 INFO - 2015-11-12 08:51:07,311 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1170.8185231289153;1185.964421067368;1195.2649120790713;1301.069735139375;1540.4608387064523;5482.890342193159;5760.078387458002;6303.905441418382;6443.226812782473;6494.350564943504;6323.5257355698395;6366.777162799303;6405.3274406187375;6477.935220647792;6508.446782023522;1584.833592472791;1654.4044144108173;1772.051952205567;1797.9011154386503;1799.9190036448392;1637.2795969773322;1768.7523746675477;1797.7573027641297;1804.188115348092;1813.9637207255846;1773.982260177401;1783.785945686513;1787.41908879614;1789.3468883857363;1798.4604618614428;1819.5360183153343;1823.3344829137402;1843.1337271482382;1844.4466660002013;1845.9169337379851;1821.8724689271755;1838.4944140361374;1842.631473705251;1872.6722823505831;1874.8593855460895;6470.870582588322;6480.805575832733;6526.347365263483;6538.051982462516;6550.377714117151;3766.5856755756845;3875.9418608720894;3890.0858298299877;3893.1824316893485;3894.2990261752875;2382.9285121446383;2452.3256104571205;2493.4140476987895;2497.825152239344;2528.9873550632315;758.4690716498418;770.6801677303969;787.263908245792;812.6749300279877;834.8038211020466;8573.52845593492;8622;8676.305895528343;8685.478871267807;8703.173198546128;3371.174062354739;3440.673136052071;3502.0894567412147;3511.5610548681416;3517.3141237458963;7613.619319034137;7623.275788800055;7632.885506717404;7633.503822251536;7661.310482056641;3921.137349783043;3929.31237033518;3933.6459718624888;3950;3955.624215699504;3596.604373518911;3604.747667663238;3606.8737594184076;3609.4585812127866;3617.4573813928123;2795.2872017635373;3096.303331750338;3111.471049921519;3114.8286844223785;3114.8909788157307;880.1946219209352;903.6520939438232;918.4213945214606;925.3615005646083;950.0404591362774;899.2895612466209;903.814717982812;905.4748246017294;957.6408846682494;1148.7070796946891;6102.786402475981;6152.78465253714;6224.221972253468;6233.657148856766;6260.686965651699;948.11798579819;973.9123478886793;977.2768151567931;984.015984015984;986.7582442301682;4801.447833499123;4816.831410900601;4848.175810112219;4905.141600219948;4954.355933728592;7434.847598622222;7562.319391254813;7653;7751.534907905544;7771.922280777233;7441.218672039467;7642.197569255148;7650.540967541854;7734.1492435832015;7775.4168437367425;6094.9695251524345;6170.321264660884;6178.907316390258;6188.4739797117745;6193.81418557444;5845.152452894392;5901;5941.851453713692;5975.521958243243;6032.185654936703;6596.571222870498;6759.222689390783;6817;6823.727050917908;6847.07564478789;6957.443404527727;7064.505484616233;7066;7067.151941767021;7095.148582170173;5379.784808607612;5505.284313039279;5722.484976352148;5817.7963771267805;5858.970705146618;5666.065099258576;6167.969160154171;6237.220347456568;6267.843303917439;6312.084747711648;5339.839804805862;5527.032769265443;5581.162825576196;5852.151438041375;5938.4061593842;5783.421657834183;5806.1000544915605;5837.503812176013;5859.355470898283;5903.763849445974;5879.706014699163;5940.821775346573;5988.580799344179;6000.789972350947;6044.546659000681;5268.710220937885;5314.202869569595;5368.1679339702405;5477.75350109238;5486.1222204447095;5510.366307874646;5512.283403157564;5535.833924982257;5538.778448862;5563.415841336601 08:51:07 INFO - 2015-11-12 08:51:07,311 DEBUG : BROWSER_OUTPUT: |4;prototype.html;231.91071437496564;234.56839415475528;245.61193314562993;263.0870878053155;270.8117858088627;5394.244805727197;5409.863928574999;5410.594205434593;5417.322834645669;5507.972460137694;5253.133233016557;5356.1697936819755;5371.409144994057;5399.62202645815;5402.8919421611545;4089.5705950875176;4115.897102572445;4121.5466298707115;4125.906634741796;4146.543880173179;4098.303288440972;4104;4107.527634322061;4110.362893751473;4125.711200215971;3836.673882719972;3948.190620922704;3962.969627896739;4029.9395509067385;4054.432379466877;3889.8444062237477;3949.980250098731;3975.185087057146;3982.820773065219;3985;3393.915152121192;3400.96599034009;3402.030421329909;3408.3694516514524;3408.7613867029318;5030.974845125751;5101.897962040775;5197.064528384927;5202.115640341151;5213.7393130343335;4498.820047198108;4515.887102822423;4521.864344069683;4535.546445355438;4541.591256786872;5636.830895073154;5653.180288858133;5664.716764161775;5670.432956704338;5675.148727690838;3687.907802304937;3692.132348898007;3702.981485092584;3713.832877520518;3721.106934335767;5752.482276595127;5862.853428664275;5878.735456904449;5902.380250073767;5912.320083190445;3759.661630453272;3768.9057773555332;3770;3772.038130276817;3778.112143646241;3802.6957843372466;3842.404427313715;3844.7116466264583;3848.3457812171996;3859.6526312631436;4491.910161796745;4493.7977790999485;4503.144402563568;4506.278995360792;4511.345854851028;4830.830920917751;5248.527632513092;5398.730063496888;5649.293838270216;5652.858678532987;1354.7019655675736;1382.5783136143373;1394.4561620967831;1398.377721913759;1402.9298535073206;900.8918929728475;903.2051794420868;921.6313474610209;926.1248120526038;931.0317270039084;5361.276227709287;5382;5389.9191512127345;5404.702741349263;5415.4313797050745;5847.415258474203;5870.119482077723;5881.206037184926;5881.588288819741;5949.137375080589;5365.865853353619;5387.649802762808;5401.162819762943;5412.296401467784;5413.566914646819;3087.876484940577;3162.1462205204466;3195.744340452758;3215.324781795802;3216.1637974126897;6146.385361463907;6159.876802464015;6179.474744646665;6196.0705894116245;6197.287311959092;6089.269287685417;6108.75564977396;6110.358412366726;6115.602485838406;6141.662208578482;5918.230630017984;6119.602225855305;6135.11040899076;6139.907901381483;6155.569110162335;5907.793227237026;5921;5921.851953701192;5936.13925980739;5940.940590594038;5791.855203619774;5806;5817.94182058174;5818.214541037075;5818.534517238526;5884.323302820059;6096.0855871619615;6100.572959892942;6132.509399247961;6136.417040381157;3784.4512545680172;3788.1855401088897;3795.715321350965;3800.7529510581726;3804.4483549885667;5683.9715801420725;5849.064149736022;5901.498372638202;5911.852203694942;5928.318243402064;5538.363088244742;5609.27079479665;5699.772009119589;5709.857253568694;5719.399463056319;5693.5160511357;5726.685032323262;5738.368779434342;5747.453991870766;5754.338251101177;5434.728263586726;5618.04493236159;5624.268845050117;5629.662220266797;5635.239242702347;5694.572907031907;5697.145428185805;5712.828615141552;5722.284714410699;5732.914006289826;5568.49883510486;5610.438956104357;5616.6068375213345;5630.408807075362;5652.943470565407 08:51:07 INFO - 2015-11-12 08:51:07,313 DEBUG : BROWSER_OUTPUT: |5;yui.html;566.9801556945506;572.7823427097702;575.4668858921468;626.2234828812271;641.8555824939388;13586.3206839658;13917.721645567082;14033.859661403383;14062.437502499888;14082.85917140827;11974.401279936012;11992.700182495442;12008;12043.518259269618;12060.21608595443;587.9353271140171;596.2070446306402;734.2217249715305;752.5146280648978;760.9048868891389;603.815836169968;729.2998721227627;746.7013194722127;752.8343764371857;755.6561764397213;753.6947536247801;775.8603451378749;783.0877028262067;784.6155383861895;784.9882251766228;610.1762620462384;620.5780069552702;755.8828381600861;763.4808330335397;776.4681193382523;565.3865555871884;571.7170000849565;571.8427432456108;572.3618165745206;577.933537643168;11210.327380357205;11218.270812397168;11326.603568875049;11332.150088743294;11409.885901141048;8348.916510834935;8353.33173346137;8370;8435.536045517494;8552.102029286898;7783.883241751379;7962.920370796276;7998;8194.959025204837;8368.24685778283;2489.8031916999894;2599.506093842164;2632.289281893878;2645.2196602002455;2660.787137029033;37969.15231357659;38117.237655247016;38129.23741525154;38459.42310865339;40657.59342406597;6020.187274717945;6174.938250617526;6202.968985155136;6232.8130156095385;6259.062828993104;10417.166626669848;10436.478176091165;10456.32033917808;10692.358458492516;10724.195685323475;5157.097507936096;5201.502546311246;5244.868878277997;5281.12861377876;5404.3784964728775;3070.8618112185004;3088.104449709559;3101.379724055153;3135.153508552678;3146.1348129264634;2315.953680926372;2345.5074434368976;2347.3192774095664;2354.4702441950426;2359.5988681924114;344.63812996353727;349.9580050393969;353.5086230140107;353.72409520573996;354.9006278242096;307.898393530139;374.6725322524827;409.9795010249476;443.89790348219447;475.7725069321143;6041.365656606081;6442;6444.484441244689;6451.806445806634;6454.451371633464;404.324777621373;472.7825200407851;509.2564855311213;517.2861451197399;541.8509909774765;3154.870462437845;3220.951685724716;3237.5953005874267;3301.273719781644;3316.519104729849;46236.306455403195;52979.205311920356;53233;53421.46578534243;53521.73239133779;40613.39079913804;40830.59169408268;40850.38724419136;40866.59133408687;41086;36854;39502.209955800725;40622.39066413947;40755.18099751039;41430.58569414327;6669.233038200669;6708.329167083252;6759.864802704017;6846.5892046477375;7014.333638304353;30087.398252035273;30762;31020.689793102683;31045;31315.37369252648;38828;40267.597324026385;40678;40759.59240407558;40942.385864211465;6457.321981191907;6608.768693095719;6620.470362371095;6688.398044176048;6690.397864192246;9338;9438.48088355147;9450.385724927857;9463.101005404476;9553.808923821623;8215;8297.460665056751;8338.708145214889;8348.791280218044;8657.350698697497;9153.542322883963;9161;9190.678326258549;9215.539223038955;9255.074492550692;8883.511406872683;8983.685571004984;9103.044180360966;9158.58786354629;9163.129502697233;7647.009296267033;7824.334931530883;7971.242731940456;8235.51666119098;8304.294134998592;7440.218777028334;7493.737719179802;7912.892195092807;8203.917960820554;8233.50598964064 08:51:07 INFO - 2015-11-12 08:51:07,313 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:51:07 INFO - 2015-11-12 08:51:07,313 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,904 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1447347067299__endTimestamp 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:51:07 INFO - 2015-11-12 08:51:07,314 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,315 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4547.30 Median:4675.14 stddev:490.06 (10.5%) stddev-sans-first:469.04 08:51:07 INFO - 2015-11-12 08:51:07,316 DEBUG : BROWSER_OUTPUT: Values: 2675.2 2688.1 2709.6 2760.3 2764.1 4375.6 4518.4 4543.6 4559.9 4589.7 4411.7 4484.3 4516.9 4563.0 4605.1 4163.3 4188.2 4234.5 4243.1 4245.2 4278.5 4358.0 4361.6 4382.3 4440.1 4104.5 4200.4 4202.4 4333.0 4354.3 4084.9 4199.2 4221.5 4224.4 4281.3 4198.9 4201.0 4222.1 4229.4 4253.3 4411.8 4519.0 4526.6 4609.7 4612.8 4705.0 4771.5 4775.9 4807.1 4834.6 4924.7 4936.1 4946.6 4956.5 4991.4 4488.7 4614.1 4616.7 4642.0 4697.8 4819.4 4948.4 4954.8 4976.1 5046.7 4800.4 4891.5 4891.6 4897.2 4938.6 4757.4 4843.9 4894.1 4988.7 5011.9 4649.5 4748.8 4774.3 4784.1 4807.4 4834.6 4849.8 4853.3 4854.1 4858.3 3687.5 3697.4 3778.2 3801.0 3832.3 3354.4 3403.5 3436.2 3436.4 3448.4 4468.3 4535.9 4536.9 4585.7 4630.2 4960.1 4972.8 4992.8 5005.8 5041.2 4429.2 4519.8 4593.3 4635.9 4654.1 4173.5 4259.1 4263.1 4265.6 4287.8 5058.4 5105.6 5123.1 5127.4 5139.4 4723.6 4870.2 4962.7 4990.6 5045.6 4849.9 5021.4 5028.9 5049.0 5075.7 4812.2 4829.3 4837.6 4855.3 4895.5 4669.2 4796.8 4890.4 4894.3 4948.2 4707.0 4709.1 4745.0 4778.8 4796.0 4747.8 4778.9 4794.4 4836.4 4850.5 4468.7 4598.4 4716.3 4734.4 4775.6 4628.0 4665.2 4675.1 4719.2 4748.2 4645.7 4669.7 4709.1 4717.3 4769.4 08:51:07 INFO - 2015-11-12 08:51:07,316 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,316 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37244.50 Median:28828.28 stddev:59765.20 (207.3%) stddev-sans-first:59869.03 08:51:07 INFO - 2015-11-12 08:51:07,317 DEBUG : BROWSER_OUTPUT: Values: 458.5 464.7 470.7 471.3 492.0 26553.9 33083.3 33855.5 33868.3 33992.2 35839.6 36185.0 36325.1 36366.6 36401.0 6920.7 7046.2 7750.5 7974.9 8048.5 9497.8 9602.0 9644.2 9661.7 9687.5 9346.5 9454.8 9467.1 9468.4 9534.7 7148.5 7325.1 9306.5 9331.2 9490.6 9174.5 9280.7 9289.4 9333.4 9336.3 33439.5 33591.7 33612.5 33759.8 33858.8 2424.4 2487.2 2539.5 2611.1 2765.6 23232.2 23523.3 23660.5 24352.8 24433.0 2025.6 2073.2 2091.0 2104.2 2210.6 217455.0 217504.0 217659.0 218146.0 219176.0 49477.0 50051.2 50563.7 50730.2 51565.3 54447.0 55578.1 56020.2 56266.4 56385.4 12474.6 12885.5 12897.4 12925.7 12965.7 9718.9 9769.4 9780.2 9898.8 9919.3 16369.3 16796.7 16918.8 16954.5 17072.1 7093.9 7241.0 7274.3 7286.8 7301.8 838.0 843.8 904.0 906.7 992.7 24165.5 24451.0 24533.8 24555.9 24576.0 916.3 921.1 978.2 986.3 1022.7 12600.9 12609.5 12759.8 12765.9 12859.1 276927.0 283059.0 283288.0 283453.0 284498.0 46515.0 46658.0 46827.5 46834.5 47068.5 1154.7 1160.9 1180.2 1187.5 1189.9 24173.5 24217.5 24466.5 24539.6 24641.9 36440.0 37090.8 41048.0 41660.6 41808.8 170099.0 171086.0 172409.0 172791.0 173404.0 24132.0 24257.0 24315.3 24329.9 24410.9 28916.0 29222.7 33958.3 35237.0 35734.3 27479.5 28610.3 28736.7 28797.3 28859.3 28050.9 28103.0 28103.0 28324.9 28410.7 27887.6 28270.7 28575.1 28580.7 28590.1 25593.5 25785.6 26858.3 26915.9 27145.3 20391.6 20687.3 20692.4 20820.7 20847.3 08:51:07 INFO - 2015-11-12 08:51:07,317 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,317 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22269.49 Median:4755.11 stddev:68629.26 (1443.3%) stddev-sans-first:68801.92 08:51:07 INFO - 2015-11-12 08:51:07,319 DEBUG : BROWSER_OUTPUT: Values: 277.0 281.7 284.5 290.5 296.6 9456.8 10220.2 14679.7 15036.7 15255.8 16109.7 16282.9 16486.8 16561.2 16828.6 4654.0 4812.3 4833.8 4863.5 4877.7 4690.5 4760.7 4776.8 4780.7 4787.6 3392.7 3527.3 3565.8 4749.5 4787.2 5013.8 5121.2 5175.3 5177.0 5214.5 4296.8 4305.8 4463.1 4536.0 4570.5 18059.2 18161.1 18382.7 18907.7 18911.8 1638.3 1697.7 1700.4 1729.8 1803.0 11718.0 12118.1 12313.4 12399.6 12420.9 1432.2 1433.5 1481.1 1509.8 1518.9 50688.2 51564.0 52018.2 52878.5 53190.7 8858.7 8991.2 9203.1 9245.0 9281.9 11582.9 11585.4 11587.2 11622.2 11645.7 6799.8 6937.0 7045.0 7046.1 7113.2 6479.5 6869.7 6901.8 6932.2 6972.0 5305.7 5365.8 5381.7 5396.3 5422.9 1523.7 1590.3 1593.4 1602.7 1608.7 341.6 345.3 357.3 384.7 395.0 8684.8 9234.6 9353.6 9574.3 9582.7 386.1 393.1 402.7 409.0 409.5 4403.2 5270.0 5506.0 5511.9 5539.4 393461.0 401477.0 419337.0 434612.0 447780.0 55848.4 57387.4 57910.7 58018.0 60254.7 422.5 430.4 432.5 434.1 437.1 9281.8 9357.7 9360.8 9411.2 9469.9 27280.3 28464.6 28476.1 28834.6 28921.7 35725.3 36066.1 36242.8 36334.6 36687.0 5201.5 5222.3 5303.4 5319.0 5350.1 10002.4 10127.8 10139.3 10149.3 10287.7 8480.2 8546.1 8549.7 8756.3 8775.6 6609.0 8397.8 8411.2 8496.7 8712.2 8493.9 8683.8 8789.7 8829.0 8837.0 5173.5 5285.3 5286.4 5288.9 5289.1 7301.5 8433.7 8650.4 8681.1 8754.6 08:51:07 INFO - 2015-11-12 08:51:07,319 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,319 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4500.40 Median:5855.56 stddev:2337.05 (39.9%) stddev-sans-first:2330.21 08:51:07 INFO - 2015-11-12 08:51:07,320 DEBUG : BROWSER_OUTPUT: Values: 1170.8 1186.0 1195.3 1301.1 1540.5 5482.9 5760.1 6303.9 6443.2 6494.4 6323.5 6366.8 6405.3 6477.9 6508.4 1584.8 1654.4 1772.1 1797.9 1799.9 1637.3 1768.8 1797.8 1804.2 1814.0 1774.0 1783.8 1787.4 1789.3 1798.5 1819.5 1823.3 1843.1 1844.4 1845.9 1821.9 1838.5 1842.6 1872.7 1874.9 6470.9 6480.8 6526.3 6538.1 6550.4 3766.6 3875.9 3890.1 3893.2 3894.3 2382.9 2452.3 2493.4 2497.8 2529.0 758.5 770.7 787.3 812.7 834.8 8573.5 8622.0 8676.3 8685.5 8703.2 3371.2 3440.7 3502.1 3511.6 3517.3 7613.6 7623.3 7632.9 7633.5 7661.3 3921.1 3929.3 3933.6 3950.0 3955.6 3596.6 3604.7 3606.9 3609.5 3617.5 2795.3 3096.3 3111.5 3114.8 3114.9 880.2 903.7 918.4 925.4 950.0 899.3 903.8 905.5 957.6 1148.7 6102.8 6152.8 6224.2 6233.7 6260.7 948.1 973.9 977.3 984.0 986.8 4801.4 4816.8 4848.2 4905.1 4954.4 7434.8 7562.3 7653.0 7751.5 7771.9 7441.2 7642.2 7650.5 7734.1 7775.4 6095.0 6170.3 6178.9 6188.5 6193.8 5845.2 5901.0 5941.9 5975.5 6032.2 6596.6 6759.2 6817.0 6823.7 6847.1 6957.4 7064.5 7066.0 7067.2 7095.1 5379.8 5505.3 5722.5 5817.8 5859.0 5666.1 6168.0 6237.2 6267.8 6312.1 5339.8 5527.0 5581.2 5852.2 5938.4 5783.4 5806.1 5837.5 5859.4 5903.8 5879.7 5940.8 5988.6 6000.8 6044.5 5268.7 5314.2 5368.2 5477.8 5486.1 5510.4 5512.3 5535.8 5538.8 5563.4 08:51:07 INFO - 2015-11-12 08:51:07,320 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,320 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4701.27 Median:5407.28 stddev:1470.92 (27.2%) stddev-sans-first:1436.29 08:51:07 INFO - 2015-11-12 08:51:07,322 DEBUG : BROWSER_OUTPUT: Values: 231.9 234.6 245.6 263.1 270.8 5394.2 5409.9 5410.6 5417.3 5508.0 5253.1 5356.2 5371.4 5399.6 5402.9 4089.6 4115.9 4121.5 4125.9 4146.5 4098.3 4104.0 4107.5 4110.4 4125.7 3836.7 3948.2 3963.0 4029.9 4054.4 3889.8 3950.0 3975.2 3982.8 3985.0 3393.9 3401.0 3402.0 3408.4 3408.8 5031.0 5101.9 5197.1 5202.1 5213.7 4498.8 4515.9 4521.9 4535.5 4541.6 5636.8 5653.2 5664.7 5670.4 5675.1 3687.9 3692.1 3703.0 3713.8 3721.1 5752.5 5862.9 5878.7 5902.4 5912.3 3759.7 3768.9 3770.0 3772.0 3778.1 3802.7 3842.4 3844.7 3848.3 3859.7 4491.9 4493.8 4503.1 4506.3 4511.3 4830.8 5248.5 5398.7 5649.3 5652.9 1354.7 1382.6 1394.5 1398.4 1402.9 900.9 903.2 921.6 926.1 931.0 5361.3 5382.0 5389.9 5404.7 5415.4 5847.4 5870.1 5881.2 5881.6 5949.1 5365.9 5387.6 5401.2 5412.3 5413.6 3087.9 3162.1 3195.7 3215.3 3216.2 6146.4 6159.9 6179.5 6196.1 6197.3 6089.3 6108.8 6110.4 6115.6 6141.7 5918.2 6119.6 6135.1 6139.9 6155.6 5907.8 5921.0 5921.9 5936.1 5940.9 5791.9 5806.0 5817.9 5818.2 5818.5 5884.3 6096.1 6100.6 6132.5 6136.4 3784.5 3788.2 3795.7 3800.8 3804.4 5684.0 5849.1 5901.5 5911.9 5928.3 5538.4 5609.3 5699.8 5709.9 5719.4 5693.5 5726.7 5738.4 5747.5 5754.3 5434.7 5618.0 5624.3 5629.7 5635.2 5694.6 5697.1 5712.8 5722.3 5732.9 5568.5 5610.4 5616.6 5630.4 5652.9 08:51:07 INFO - 2015-11-12 08:51:07,322 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-11-12 08:51:07,322 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11288.43 Median:566.18 stddev:13821.82 (2441.2%) stddev-sans-first:13837.14 08:51:07 INFO - 2015-11-12 08:51:07,323 DEBUG : BROWSER_OUTPUT: Values: 567.0 572.8 575.5 626.2 641.9 13586.3 13917.7 14033.9 14062.4 14082.9 11974.4 11992.7 12008.0 12043.5 12060.2 587.9 596.2 734.2 752.5 760.9 603.8 729.3 746.7 752.8 755.7 753.7 775.9 783.1 784.6 785.0 610.2 620.6 755.9 763.5 776.5 565.4 571.7 571.8 572.4 577.9 11210.3 11218.3 11326.6 11332.2 11409.9 8348.9 8353.3 8370.0 8435.5 8552.1 7783.9 7962.9 7998.0 8195.0 8368.2 2489.8 2599.5 2632.3 2645.2 2660.8 37969.2 38117.2 38129.2 38459.4 40657.6 6020.2 6174.9 6203.0 6232.8 6259.1 10417.2 10436.5 10456.3 10692.4 10724.2 5157.1 5201.5 5244.9 5281.1 5404.4 3070.9 3088.1 3101.4 3135.2 3146.1 2316.0 2345.5 2347.3 2354.5 2359.6 344.6 350.0 353.5 353.7 354.9 307.9 374.7 410.0 443.9 475.8 6041.4 6442.0 6444.5 6451.8 6454.5 404.3 472.8 509.3 517.3 541.9 3154.9 3221.0 3237.6 3301.3 3316.5 46236.3 52979.2 53233.0 53421.5 53521.7 40613.4 40830.6 40850.4 40866.6 41086.0 36854.0 39502.2 40622.4 40755.2 41430.6 6669.2 6708.3 6759.9 6846.6 7014.3 30087.4 30762.0 31020.7 31045.0 31315.4 38828.0 40267.6 40678.0 40759.6 40942.4 6457.3 6608.8 6620.5 6688.4 6690.4 9338.0 9438.5 9450.4 9463.1 9553.8 8215.0 8297.5 8338.7 8348.8 8657.4 9153.5 9161.0 9190.7 9215.5 9255.1 8883.5 8983.7 9103.0 9158.6 9163.1 7647.0 7824.3 7971.2 8235.5 8304.3 7440.2 7493.7 7912.9 8203.9 8233.5 08:51:07 INFO - 2015-11-12 08:51:07,323 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:51:07 INFO - 2015-11-12 08:51:07,324 DEBUG : BROWSER_OUTPUT: 08:51:08 INFO - 2015-11-12 08:51:08,018 INFO : Browser exited with error code: 0 08:51:08 INFO - 2015-11-12 08:51:08,051 INFO : Completed test dromaeo_css (00:18:34) 08:51:08 INFO - 2015-11-12 08:51:08,051 INFO : Starting test kraken 08:51:08 INFO - 2015-11-12 08:51:08,051 DEBUG : operating with platform_type : mac_ 08:51:08 INFO - 2015-11-12 08:51:08,051 INFO : Initialising browser for kraken test... 08:51:08 INFO - 2015-11-12 08:51:08,067 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmp2dfrbO/profile http://localhost:50033/getInfo.html 08:51:10 INFO - 2015-11-12 08:51:10,639 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:51:10 INFO - 2015-11-12 08:51:10,639 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:51:10 INFO - 2015-11-12 08:51:10,639 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:51:10 INFO - 2015-11-12 08:51:10,639 DEBUG : BROWSER_OUTPUT: __metrics 08:51:10 INFO - 2015-11-12 08:51:10,658 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:11 INFO - 2015-11-12 08:51:11,422 INFO : Browser initialized. 08:51:11 INFO - 2015-11-12 08:51:11,422 INFO : Running cycle 1/1 for kraken test... 08:51:11 INFO - 2015-11-12 08:51:11,422 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmp2dfrbO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:51:23 INFO - 2015-11-12 08:51:23,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 228622336 08:51:23 INFO - 2015-11-12 08:51:23,511 DEBUG : BROWSER_OUTPUT: 08:51:26 INFO - 2015-11-12 08:51:26,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50033/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:26 INFO - 2015-11-12 08:51:26,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 284753920 08:51:26 INFO - 2015-11-12 08:51:26,939 DEBUG : BROWSER_OUTPUT: 08:51:29 INFO - 2015-11-12 08:51:29,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50033/tests/kraken/driver.html?testName=audio-dft) 08:51:30 INFO - 2015-11-12 08:51:30,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 299683840 08:51:30 INFO - 2015-11-12 08:51:30,551 DEBUG : BROWSER_OUTPUT: 08:51:33 INFO - 2015-11-12 08:51:33,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50033/tests/kraken/driver.html?testName=audio-fft) 08:51:34 INFO - 2015-11-12 08:51:34,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 279908352 08:51:34 INFO - 2015-11-12 08:51:34,439 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2015-11-12 08:51:36,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50033/tests/kraken/driver.html?testName=audio-oscillator) 08:51:37 INFO - 2015-11-12 08:51:37,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 282296320 08:51:37 INFO - 2015-11-12 08:51:37,270 DEBUG : BROWSER_OUTPUT: 08:51:39 INFO - 2015-11-12 08:51:39,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:40 INFO - 2015-11-12 08:51:40,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 282914816 08:51:40 INFO - 2015-11-12 08:51:40,300 DEBUG : BROWSER_OUTPUT: 08:51:43 INFO - 2015-11-12 08:51:43,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50033/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:44 INFO - 2015-11-12 08:51:44,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 283447296 08:51:44 INFO - 2015-11-12 08:51:44,337 DEBUG : BROWSER_OUTPUT: 08:51:47 INFO - 2015-11-12 08:51:47,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50033/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:48 INFO - 2015-11-12 08:51:48,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 281362432 08:51:48 INFO - 2015-11-12 08:51:48,480 DEBUG : BROWSER_OUTPUT: 08:51:51 INFO - 2015-11-12 08:51:51,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50033/tests/kraken/driver.html?testName=json-parse-financial) 08:51:52 INFO - 2015-11-12 08:51:52,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 282161152 08:51:52 INFO - 2015-11-12 08:51:52,254 DEBUG : BROWSER_OUTPUT: 08:51:53 INFO - 2015-11-12 08:51:53,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:54 INFO - 2015-11-12 08:51:54,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 317935616 08:51:54 INFO - 2015-11-12 08:51:54,551 DEBUG : BROWSER_OUTPUT: 08:51:56 INFO - 2015-11-12 08:51:56,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:57 INFO - 2015-11-12 08:51:57,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 321564672 08:51:57 INFO - 2015-11-12 08:51:57,194 DEBUG : BROWSER_OUTPUT: 08:51:59 INFO - 2015-11-12 08:51:59,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:00 INFO - 2015-11-12 08:52:00,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 326545408 08:52:00 INFO - 2015-11-12 08:52:00,107 DEBUG : BROWSER_OUTPUT: 08:52:03 INFO - 2015-11-12 08:52:03,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:03 INFO - 2015-11-12 08:52:03,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 329482240 08:52:03 INFO - 2015-11-12 08:52:03,642 DEBUG : BROWSER_OUTPUT: 08:52:06 INFO - 2015-11-12 08:52:06,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:07 INFO - 2015-11-12 08:52:07,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 327639040 08:52:07 INFO - 2015-11-12 08:52:07,190 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50033/tests/kraken/driver.html?testName=ai-astar) 08:52:09 INFO - 2015-11-12 08:52:09,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 386822144 08:52:09 INFO - 2015-11-12 08:52:09,386 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,386 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:09 INFO - 2015-11-12 08:52:09,387 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:09 INFO - 2015-11-12 08:52:09,387 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:09 INFO - 2015-11-12 08:52:09,387 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:09 INFO - 2015-11-12 08:52:09,387 DEBUG : BROWSER_OUTPUT: |0;ai-astar;124;126;121;129;129;128;128;127;118;128 08:52:09 INFO - 2015-11-12 08:52:09,387 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;157;187;192;148;175;174;150;197;154 08:52:09 INFO - 2015-11-12 08:52:09,388 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;187;189;188;181;188;187;190;189;188 08:52:09 INFO - 2015-11-12 08:52:09,388 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;93;98;142;77;96;81;83;131;82 08:52:09 INFO - 2015-11-12 08:52:09,388 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;113;116;163;104;104;106;152;104;104;152 08:52:09 INFO - 2015-11-12 08:52:09,388 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;141;141;134;142;141;135;137;134;141 08:52:09 INFO - 2015-11-12 08:52:09,388 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;148;147;142;147;148 08:52:09 INFO - 2015-11-12 08:52:09,388 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;123;110;110;118;110;109;109;119;124 08:52:09 INFO - 2015-11-12 08:52:09,389 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;65;68;69;68;69;68;79;68;68 08:52:09 INFO - 2015-11-12 08:52:09,389 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;76;76;79;80;79;80;81;80;80;81 08:52:09 INFO - 2015-11-12 08:52:09,390 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;99;99;99;100;99;100;101;100;102;100 08:52:09 INFO - 2015-11-12 08:52:09,391 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;145;153;160;161;148;156;152;157;155;147 08:52:09 INFO - 2015-11-12 08:52:09,391 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;166;169;182;182;188;170;185;183;175;168 08:52:09 INFO - 2015-11-12 08:52:09,391 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;83;86;85;84;84;85;84;84;86 08:52:09 INFO - 2015-11-12 08:52:09,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:09 INFO - 2015-11-12 08:52:09,391 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: __startTimestamp1447347129385__endTimestamp 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:52:09 INFO - 2015-11-12 08:52:09,392 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,393 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.80 Median:128.00 stddev:3.71 (2.9%) stddev-sans-first:3.87 08:52:09 INFO - 2015-11-12 08:52:09,393 DEBUG : BROWSER_OUTPUT: Values: 124.0 126.0 121.0 129.0 129.0 128.0 128.0 127.0 118.0 128.0 08:52:09 INFO - 2015-11-12 08:52:09,393 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,393 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:171.90 Median:180.00 stddev:18.38 (10.2%) stddev-sans-first:18.88 08:52:09 INFO - 2015-11-12 08:52:09,393 DEBUG : BROWSER_OUTPUT: Values: 185.0 157.0 187.0 192.0 148.0 175.0 174.0 150.0 197.0 154.0 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:187.30 Median:188.00 stddev:2.50 (1.3%) stddev-sans-first:2.60 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: Values: 186.0 187.0 189.0 188.0 181.0 188.0 187.0 190.0 189.0 188.0 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:96.70 Median:83.50 stddev:22.22 (26.6%) stddev-sans-first:23.09 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: Values: 84.0 93.0 98.0 142.0 77.0 96.0 81.0 83.0 131.0 82.0 08:52:09 INFO - 2015-11-12 08:52:09,394 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,395 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.80 Median:114.50 stddev:23.92 (20.9%) stddev-sans-first:25.16 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: Values: 113.0 116.0 163.0 104.0 104.0 106.0 152.0 104.0 104.0 152.0 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:138.80 Median:141.00 stddev:3.39 (2.4%) stddev-sans-first:3.40 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 141.0 134.0 142.0 141.0 135.0 137.0 134.0 141.0 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:148.00 stddev:1.83 (1.2%) stddev-sans-first:1.90 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 148.0 147.0 142.0 147.0 148.0 08:52:09 INFO - 2015-11-12 08:52:09,396 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:114.20 Median:114.00 stddev:6.11 (5.4%) stddev-sans-first:6.28 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: Values: 110.0 123.0 110.0 110.0 118.0 110.0 109.0 109.0 119.0 124.0 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.00 stddev:3.89 (5.7%) stddev-sans-first:3.89 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 68.0 69.0 68.0 69.0 68.0 79.0 68.0 68.0 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.20 Median:80.00 stddev:1.81 (2.3%) stddev-sans-first:1.51 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 79.0 80.0 79.0 80.0 81.0 80.0 80.0 81.0 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.90 Median:100.50 stddev:0.99 (1.0%) stddev-sans-first:1.00 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: Values: 99.0 99.0 99.0 100.0 99.0 100.0 101.0 100.0 102.0 100.0 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:155.50 stddev:5.44 (3.5%) stddev-sans-first:4.85 08:52:09 INFO - 2015-11-12 08:52:09,397 DEBUG : BROWSER_OUTPUT: Values: 145.0 153.0 160.0 161.0 148.0 156.0 152.0 157.0 155.0 147.0 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:182.00 stddev:8.09 (4.4%) stddev-sans-first:7.58 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: Values: 166.0 169.0 182.0 182.0 188.0 170.0 185.0 183.0 175.0 168.0 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.00 Median:84.50 stddev:2.00 (2.4%) stddev-sans-first:1.01 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: Values: 79.0 83.0 86.0 85.0 84.0 84.0 85.0 84.0 84.0 86.0 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:09 INFO - 2015-11-12 08:52:09,398 DEBUG : BROWSER_OUTPUT: 08:52:10 INFO - 2015-11-12 08:52:10,117 INFO : Browser exited with error code: 0 08:52:10 INFO - 2015-11-12 08:52:10,172 INFO : Completed test kraken (00:01:02) 08:52:10 INFO - 2015-11-12 08:52:10,173 INFO : Starting test v8_7 08:52:10 INFO - 2015-11-12 08:52:10,173 DEBUG : operating with platform_type : mac_ 08:52:10 INFO - 2015-11-12 08:52:10,173 INFO : Initialising browser for v8_7 test... 08:52:10 INFO - 2015-11-12 08:52:10,188 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmp2yqLcM/profile http://localhost:50033/getInfo.html 08:52:12 INFO - 2015-11-12 08:52:12,699 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:12 INFO - 2015-11-12 08:52:12,699 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:12 INFO - 2015-11-12 08:52:12,700 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:52:12 INFO - 2015-11-12 08:52:12,700 DEBUG : BROWSER_OUTPUT: __metrics 08:52:12 INFO - 2015-11-12 08:52:12,719 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:13 INFO - 2015-11-12 08:52:13,479 INFO : Browser initialized. 08:52:13 INFO - 2015-11-12 08:52:13,480 INFO : Running cycle 1/1 for v8_7 test... 08:52:13 INFO - 2015-11-12 08:52:13,480 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmp2yqLcM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:25 INFO - 2015-11-12 08:52:25,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 228524032 08:52:25 INFO - 2015-11-12 08:52:25,564 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50033/tests/v8_7/run.html (next: http://localhost:50033/tests/v8_7/run.html) 08:52:48 INFO - 2015-11-12 08:52:48,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 762601472 08:52:48 INFO - 2015-11-12 08:52:48,462 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: |0;Richards;195.00780031201248 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;221.58209616662973 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: |2;Encrypt;382.262996941896 08:52:48 INFO - 2015-11-12 08:52:48,463 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6958.333333333333 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2188.183807439825 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: |5;Earley;1051.5247108307046 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: |6;Boyer;14442.857142857143 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: |7;RegExp;35051.724137931036 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: |8;Splay;710.2272727272727 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6662.251655629139 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:48 INFO - 2015-11-12 08:52:48,464 DEBUG : BROWSER_OUTPUT: __startTimestamp1447347168458__endTimestamp 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:195.01 Median:195.01 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: Values: 195.0 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:221.58 Median:221.58 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,465 DEBUG : BROWSER_OUTPUT: Values: 221.6 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:382.26 Median:382.26 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: Values: 382.3 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6958.33 Median:6958.33 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: Values: 6958.3 08:52:48 INFO - 2015-11-12 08:52:48,466 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2188.18 Median:2188.18 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: Values: 2188.2 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: Values: 1051.5 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,467 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14442.86 Median:14442.86 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: Values: 14442.9 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35051.72 Median:35051.72 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: Values: 35051.7 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:710.23 Median:710.23 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,468 DEBUG : BROWSER_OUTPUT: Values: 710.2 08:52:48 INFO - 2015-11-12 08:52:48,469 DEBUG : BROWSER_OUTPUT: 08:52:48 INFO - 2015-11-12 08:52:48,469 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6662.25 Median:6662.25 stddev:0.00 (0.0%) 08:52:48 INFO - 2015-11-12 08:52:48,469 DEBUG : BROWSER_OUTPUT: Values: 6662.3 08:52:48 INFO - 2015-11-12 08:52:48,469 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:48 INFO - 2015-11-12 08:52:48,469 DEBUG : BROWSER_OUTPUT: 08:52:49 INFO - 2015-11-12 08:52:49,265 INFO : Browser exited with error code: 0 08:52:49 INFO - 2015-11-12 08:52:49,288 INFO : Completed test v8_7 (00:00:39) 08:52:49 INFO - 2015-11-12 08:52:49,411 INFO : Completed test suite (00:20:16) 08:52:49 INFO - 2015-11-12 08:52:49,411 DEBUG : Working with test: dromaeo_css 08:52:49 INFO - 2015-11-12 08:52:49,412 DEBUG : Generating results file: dromaeo_css 08:52:49 INFO - 2015-11-12 08:52:49,413 DEBUG : Working with test: kraken 08:52:49 INFO - 2015-11-12 08:52:49,413 DEBUG : Generating results file: kraken 08:52:49 INFO - 2015-11-12 08:52:49,413 INFO : javascript benchmark 08:52:49 INFO - 2015-11-12 08:52:49,413 DEBUG : Working with test: v8_7 08:52:49 INFO - 2015-11-12 08:52:49,413 DEBUG : Generating results file: v8_7 08:52:49 INFO - 2015-11-12 08:52:49,414 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:49 INFO - 2015-11-12 08:52:49,464 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 08:52:49 INFO - 2015-11-12 08:52:49,464 DEBUG : process_Request line: dromaeo_css 5713.24 graph.html#tests=[[72,63,55]] 08:52:49 INFO - 2015-11-12 08:52:49,464 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:49 INFO - 2015-11-12 08:52:49,504 DEBUG : process_Request line: kraken 1765.50 graph.html#tests=[[232,63,55]] 08:52:49 INFO - 2015-11-12 08:52:49,504 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:49 INFO - 2015-11-12 08:52:49,533 DEBUG : process_Request line: v8_7 15839.08 graph.html#tests=[[230,63,55]] 08:52:49 INFO - 2015-11-12 08:52:49,534 INFO : javascript benchmark 08:52:49 INFO - 2015-11-12 08:52:49,536 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [276.98338099714005, 281.6831065051817, 284.5092215927525, 290.504689504395, 296.6055146654949, 9456.763580910481, 10220.182385409167, 14679.70640587189, 15036.699266014686, 15255.771163432544, 16109.677806443864, 16282.918585407057, 16486.75269870953, 16561.17194140291, 16828.57928551787, 4654.04592058628, 4812.278158276269, 4833.806647734086, 4863.537963893442, 4877.70733755974, 4690.4605970313505, 4760.738159401231, 4776.761161941907, 4780.737059461728, 4787.569118779309, 3392.7116195123444, 3527.3121741260466, 3565.750397472178, 4749.4775574686755, 4787.16224660683, 5013.824516141935, 5121.2318152277085, 5175.327207463006, 5177.016366890316, 5214.478552144793, 4296.806643701041, 4305.827766889321, 4463.107378524308, 4535.9773201133785, 4570.4743954445, 18059.187336569885, 18161.091945402808, 18382.724259136125, 18907.716384254247, 18911.81088189128, 1638.3446621351436, 1697.6944150052987, 1700.4473546097445, 1729.7751292332043, 1803.0263657624866, 11718.0, 12118.091143164209, 12313.44589493475, 12399.628011159679, 12420.875791242062, 1432.18365531647, 1433.5054406229938, 1481.103932121062, 1509.8339182689895, 1518.9316480758393, 50688.23967640451, 51564.0, 52018.21972670413, 52878.47121528774, 53190.73404632952, 8858.689945851864, 8991.235744961621, 9203.079692030744, 9245.0, 9281.90718092824, 11582.942085289687, 11585.420728963518, 11587.188896777314, 11622.244554103956, 11645.708857278636, 6799.762008329685, 6937.0, 7044.964775176091, 7046.1192350956135, 7113.217546069928, 6479.546431749826, 6869.725210991504, 6901.75843845463, 6932.168139823253, 6972.0, 5305.681659100466, 5365.839024829262, 5381.67709937405, 5396.325459317585, 5422.864428389322, 1523.748581484065, 1590.3161640494698, 1593.4184022831582, 1602.7275363188287, 1608.7265164921992, 341.56450525580084, 345.34384669128855, 357.26225344663186, 384.7076222071246, 394.9940750888739, 8684.78288042804, 9234.584443699916, 9353.625854965861, 9574.281928855364, 9582.66460673887, 386.0560928529718, 393.1174513217844, 402.7140730081616, 409.00203503451485, 409.5106347914214, 4403.229434848889, 5270.0, 5505.9724701376235, 5511.917321240185, 5539.362973258127, 393461.0, 401477.0, 419337.0, 434612.0, 447780.0, 55848.44151558432, 57387.426125739046, 57910.7104464475, 58018.0, 60254.69872650609, 422.48878856583264, 430.41893443851177, 432.46806428093623, 434.10790824855223, 437.1366551061628, 9281.814363712823, 9357.672481463116, 9360.765980850534, 9411.152996230372, 9469.905300946903, 27280.317992050357, 28464.573031404132, 28476.145715628565, 28834.567481488215, 28921.710782892744, 35725.28549428945, 36066.09834754152, 36242.8187859059, 36334.63665363418, 36687.0, 5201.453847346125, 5222.3472065991755, 5303.416624171416, 5318.97340513295, 5350.143976963667, 10002.44986525719, 10127.797444051224, 10139.340942838691, 10149.289549731448, 10287.7428064296, 8480.15198480147, 8546.102659220942, 8549.700760473354, 8756.25571826402, 8775.648974041222, 6609.0, 8397.790055248423, 8411.200935911078, 8496.745097647081, 8712.172343627346, 8493.872591911002, 8683.782905427415, 8789.736307910773, 8829.028806831371, 8837.0, 5173.4826517347965, 5285.339332583427, 5286.418493965583, 5288.894222115459, 5289.074411977812, 7301.452391070585, 8433.662653493791, 8650.43772154808, 8681.131886811268, 8754.649814007624], "dojo.html": [2675.1573254424857, 2688.0865277556863, 2709.6477457930464, 2760.2685288398566, 2764.074035198207, 4375.5843194896515, 4518.412606361168, 4543.613792827609, 4559.908801823962, 4589.678722489427, 4411.713238639486, 4484.260097083986, 4516.864494065175, 4562.954370456295, 4605.102005109005, 4163.313053346209, 4188.162367526492, 4234.470691163605, 4243.087736136746, 4245.23585754564, 4278.507971583276, 4357.956420435803, 4361.563843615645, 4382.342648602719, 4440.111977604492, 4104.527979282361, 4200.411942328046, 4202.411662367271, 4332.978335108336, 4354.281543545311, 4084.9183016339803, 4199.223143718391, 4221.535631080578, 4224.38746381776, 4281.272183728743, 4198.9370159447635, 4201.0, 4222.0500387412585, 4229.429027081366, 4253.3194688849635, 4411.845585404495, 4519.0, 4526.592606665383, 4609.723416595015, 4612.838550650711, 4705.035467729142, 4771.546703063238, 4775.928361074587, 4807.062622788558, 4834.564889159958, 4924.679895806797, 4936.086823937583, 4946.629002824767, 4956.504349565051, 4991.425986011619, 4488.708233964782, 4614.123316569841, 4616.722996620214, 4642.0, 4697.765111744399, 4819.445763737145, 4948.4309304429735, 4954.752262386866, 4976.0794253063295, 5046.6719663221775, 4800.423949126127, 4891.51084891508, 4891.559759621651, 4897.216445368724, 4938.629602779806, 4757.429108507002, 4843.878903027382, 4894.119058569491, 4988.700677959334, 5011.874703132378, 4649.511801260819, 4748.762561871893, 4774.3077253798, 4784.138855006063, 4807.423109226916, 4834.613230941516, 4849.75751212438, 4853.3447984522345, 4854.126257273725, 4858.295547145714, 3687.539057617798, 3697.352963231424, 3778.1688028633657, 3800.9619903801163, 3832.2718683450057, 3354.4129777288877, 3403.4724617684296, 3436.1924947637285, 3436.43298855686, 3448.413769659164, 4468.3074123510905, 4535.863924082283, 4536.931946020813, 4585.72485650862, 4630.166570017362, 4960.057589058068, 4972.825951091694, 4992.8002879885125, 5005.849824505271, 5041.2438134280155, 4429.2027435062, 4519.81920723174, 4593.311003349458, 4635.860924172281, 4654.115718013634, 4173.52004519478, 4259.1268789897995, 4263.062126332202, 4265.55211702773, 4287.8499252526635, 5058.4435712071645, 5105.566026887682, 5123.129068058439, 5127.359080114986, 5139.357580302462, 4723.622110231242, 4870.196417591058, 4962.652614316963, 4990.600751939909, 5045.596352291735, 4849.878753031202, 5021.4225364083595, 5028.949710502849, 5049.0, 5075.746212689277, 4812.181929071996, 4829.27560865873, 4837.612990960644, 4855.295982082507, 4895.485973972682, 4669.229577119873, 4796.808127674994, 4890.364252647133, 4894.314795928644, 4948.208286674115, 4707.0, 4709.105269998826, 4744.952550474451, 4778.7849546769785, 4795.976020119877, 4747.786349614206, 4778.928316075331, 4794.376731024944, 4836.371271734793, 4850.490698476609, 4468.664850136188, 4598.402207712976, 4716.29255611661, 4734.384530011076, 4775.6179505638775, 4628.0, 4665.183592871302, 4675.13510000651, 4719.150552900511, 4748.240281554935, 4645.68304919746, 4669.696469729457, 4709.105269998689, 4717.268823332389, 4769.403824521934], "mootools.html": [1170.8185231289153, 1185.964421067368, 1195.2649120790713, 1301.069735139375, 1540.4608387064523, 5482.890342193159, 5760.078387458002, 6303.905441418382, 6443.226812782473, 6494.350564943504, 6323.5257355698395, 6366.777162799303, 6405.3274406187375, 6477.935220647792, 6508.446782023522, 1584.833592472791, 1654.4044144108173, 1772.051952205567, 1797.9011154386503, 1799.9190036448392, 1637.2795969773322, 1768.7523746675477, 1797.7573027641297, 1804.188115348092, 1813.9637207255846, 1773.982260177401, 1783.785945686513, 1787.41908879614, 1789.3468883857363, 1798.4604618614428, 1819.5360183153343, 1823.3344829137402, 1843.1337271482382, 1844.4466660002013, 1845.9169337379851, 1821.8724689271755, 1838.4944140361374, 1842.631473705251, 1872.6722823505831, 1874.8593855460895, 6470.870582588322, 6480.805575832733, 6526.347365263483, 6538.051982462516, 6550.377714117151, 3766.5856755756845, 3875.9418608720894, 3890.0858298299877, 3893.1824316893485, 3894.2990261752875, 2382.9285121446383, 2452.3256104571205, 2493.4140476987895, 2497.825152239344, 2528.9873550632315, 758.4690716498418, 770.6801677303969, 787.263908245792, 812.6749300279877, 834.8038211020466, 8573.52845593492, 8622.0, 8676.305895528343, 8685.478871267807, 8703.173198546128, 3371.174062354739, 3440.673136052071, 3502.0894567412147, 3511.5610548681416, 3517.3141237458963, 7613.619319034137, 7623.275788800055, 7632.885506717404, 7633.503822251536, 7661.310482056641, 3921.137349783043, 3929.31237033518, 3933.6459718624888, 3950.0, 3955.624215699504, 3596.604373518911, 3604.747667663238, 3606.8737594184076, 3609.4585812127866, 3617.4573813928123, 2795.2872017635373, 3096.303331750338, 3111.471049921519, 3114.8286844223785, 3114.8909788157307, 880.1946219209352, 903.6520939438232, 918.4213945214606, 925.3615005646083, 950.0404591362774, 899.2895612466209, 903.814717982812, 905.4748246017294, 957.6408846682494, 1148.7070796946891, 6102.786402475981, 6152.78465253714, 6224.221972253468, 6233.657148856766, 6260.686965651699, 948.11798579819, 973.9123478886793, 977.2768151567931, 984.015984015984, 986.7582442301682, 4801.447833499123, 4816.831410900601, 4848.175810112219, 4905.141600219948, 4954.355933728592, 7434.847598622222, 7562.319391254813, 7653.0, 7751.534907905544, 7771.922280777233, 7441.218672039467, 7642.197569255148, 7650.540967541854, 7734.1492435832015, 7775.4168437367425, 6094.9695251524345, 6170.321264660884, 6178.907316390258, 6188.4739797117745, 6193.81418557444, 5845.152452894392, 5901.0, 5941.851453713692, 5975.521958243243, 6032.185654936703, 6596.571222870498, 6759.222689390783, 6817.0, 6823.727050917908, 6847.07564478789, 6957.443404527727, 7064.505484616233, 7066.0, 7067.151941767021, 7095.148582170173, 5379.784808607612, 5505.284313039279, 5722.484976352148, 5817.7963771267805, 5858.970705146618, 5666.065099258576, 6167.969160154171, 6237.220347456568, 6267.843303917439, 6312.084747711648, 5339.839804805862, 5527.032769265443, 5581.162825576196, 5852.151438041375, 5938.4061593842, 5783.421657834183, 5806.1000544915605, 5837.503812176013, 5859.355470898283, 5903.763849445974, 5879.706014699163, 5940.821775346573, 5988.580799344179, 6000.789972350947, 6044.546659000681, 5268.710220937885, 5314.202869569595, 5368.1679339702405, 5477.75350109238, 5486.1222204447095, 5510.366307874646, 5512.283403157564, 5535.833924982257, 5538.778448862, 5563.415841336601], "ext.html": [458.52771645205434, 464.7490355208188, 470.7457972694745, 471.3189441257384, 492.0012374878997, 26553.867230663844, 33083.33833323332, 33855.49216761751, 33868.322633547315, 33992.15019624511, 35839.64160358396, 36185.0, 36325.0918727032, 36366.63633363672, 36401.0, 6920.65396730164, 7046.154461464632, 7750.457467977244, 7974.880376794324, 8048.476849004825, 9497.81004379912, 9602.0, 9644.228461723045, 9661.661841835537, 9687.467189304585, 9346.532673366304, 9454.81090378192, 9467.053294670512, 9468.431894086343, 9534.666286679967, 7148.46386521013, 7325.084364454443, 9306.488143152124, 9331.206847417978, 9490.572924218392, 9174.495402752846, 9280.675176368863, 9289.442633442015, 9333.393329433566, 9336.299777516646, 33439.498407523904, 33591.6640833591, 33612.49581256283, 33759.831200844084, 33858.83070584656, 2424.35754525051, 2487.2165267940723, 2539.5047965646704, 2611.099170786076, 2765.6404667393313, 23232.186873459348, 23523.294301170994, 23660.526789464115, 24352.756472435227, 24433.0, 2025.5948810238012, 2073.2432662078386, 2090.95818083639, 2104.168853302952, 2210.5910406574835, 217455.0, 217504.0, 217659.0, 218146.0, 219176.0, 49477.0, 50051.24923126156, 50563.74718126386, 50730.23904641433, 51565.29651145327, 54447.0, 55578.054768082926, 56020.15969760457, 56266.43733562612, 56385.43614563802, 12474.563390281297, 12885.549005784753, 12897.355132243538, 12925.741485170243, 12965.675858103434, 9718.854217186748, 9769.364991275545, 9780.217582593375, 9898.752531186634, 9919.256055795844, 16369.345226191057, 16796.66406671884, 16918.830811691972, 16954.491365259062, 17072.146392680315, 7093.89359159613, 7240.96379518099, 7274.30894065063, 7286.781396558005, 7301.817454563678, 837.9762872662452, 843.7637461510786, 903.9864402033975, 906.6781292641017, 992.6616422054798, 24165.516689666107, 24451.0, 24533.754662453503, 24555.877220613784, 24576.0, 916.3219217778795, 921.05131714333, 978.192990782593, 986.3391527676474, 1022.7238645565656, 12600.936995315147, 12609.469348582412, 12759.808602870964, 12765.872341276468, 12859.0998630095, 276927.0, 283059.0, 283288.0, 283453.0, 284498.0, 46515.0, 46658.0, 46827.53172468232, 46834.531654683014, 47068.529314706415, 1154.7113221694576, 1160.9477573509382, 1180.15029178991, 1187.4834447015576, 1189.881011898803, 24173.51652966966, 24217.51564968726, 24466.51066978686, 24539.631905521073, 24641.876790615934, 36440.0, 37090.814545927096, 41048.0, 41660.58339416567, 41808.79095604503, 170099.0, 171086.0, 172409.0, 172791.0, 173404.0, 24132.0, 24257.0, 24315.270541883772, 24329.878350608134, 24410.87794561016, 28916.0, 29222.707772922, 33958.32083358269, 35237.0, 35734.28531429409, 27479.450410991267, 28610.284742881595, 28736.712632873405, 28797.28006799847, 28859.278518037216, 28050.859745701142, 28103.0, 28103.0, 28324.85837570799, 28410.715892840806, 27887.581686275127, 28270.71729282681, 28575.14274571766, 28580.714192857806, 28590.142295731162, 25593.488130237663, 25785.613215801404, 26858.32854178583, 26915.86542067277, 27145.321366965985, 20391.59216815685, 20687.27594534184, 20692.379228623166, 20820.699010533084, 20847.270345537832], "prototype.html": [231.91071437496564, 234.56839415475528, 245.61193314562993, 263.0870878053155, 270.8117858088627, 5394.244805727197, 5409.863928574999, 5410.594205434593, 5417.322834645669, 5507.972460137694, 5253.133233016557, 5356.1697936819755, 5371.409144994057, 5399.62202645815, 5402.8919421611545, 4089.5705950875176, 4115.897102572445, 4121.5466298707115, 4125.906634741796, 4146.543880173179, 4098.303288440972, 4104.0, 4107.527634322061, 4110.362893751473, 4125.711200215971, 3836.673882719972, 3948.190620922704, 3962.969627896739, 4029.9395509067385, 4054.432379466877, 3889.8444062237477, 3949.980250098731, 3975.185087057146, 3982.820773065219, 3985.0, 3393.915152121192, 3400.96599034009, 3402.030421329909, 3408.3694516514524, 3408.7613867029318, 5030.974845125751, 5101.897962040775, 5197.064528384927, 5202.115640341151, 5213.7393130343335, 4498.820047198108, 4515.887102822423, 4521.864344069683, 4535.546445355438, 4541.591256786872, 5636.830895073154, 5653.180288858133, 5664.716764161775, 5670.432956704338, 5675.148727690838, 3687.907802304937, 3692.132348898007, 3702.981485092584, 3713.832877520518, 3721.106934335767, 5752.482276595127, 5862.853428664275, 5878.735456904449, 5902.380250073767, 5912.320083190445, 3759.661630453272, 3768.9057773555332, 3770.0, 3772.038130276817, 3778.112143646241, 3802.6957843372466, 3842.404427313715, 3844.7116466264583, 3848.3457812171996, 3859.6526312631436, 4491.910161796745, 4493.7977790999485, 4503.144402563568, 4506.278995360792, 4511.345854851028, 4830.830920917751, 5248.527632513092, 5398.730063496888, 5649.293838270216, 5652.858678532987, 1354.7019655675736, 1382.5783136143373, 1394.4561620967831, 1398.377721913759, 1402.9298535073206, 900.8918929728475, 903.2051794420868, 921.6313474610209, 926.1248120526038, 931.0317270039084, 5361.276227709287, 5382.0, 5389.9191512127345, 5404.702741349263, 5415.4313797050745, 5847.415258474203, 5870.119482077723, 5881.206037184926, 5881.588288819741, 5949.137375080589, 5365.865853353619, 5387.649802762808, 5401.162819762943, 5412.296401467784, 5413.566914646819, 3087.876484940577, 3162.1462205204466, 3195.744340452758, 3215.324781795802, 3216.1637974126897, 6146.385361463907, 6159.876802464015, 6179.474744646665, 6196.0705894116245, 6197.287311959092, 6089.269287685417, 6108.75564977396, 6110.358412366726, 6115.602485838406, 6141.662208578482, 5918.230630017984, 6119.602225855305, 6135.11040899076, 6139.907901381483, 6155.569110162335, 5907.793227237026, 5921.0, 5921.851953701192, 5936.13925980739, 5940.940590594038, 5791.855203619774, 5806.0, 5817.94182058174, 5818.214541037075, 5818.534517238526, 5884.323302820059, 6096.0855871619615, 6100.572959892942, 6132.509399247961, 6136.417040381157, 3784.4512545680172, 3788.1855401088897, 3795.715321350965, 3800.7529510581726, 3804.4483549885667, 5683.9715801420725, 5849.064149736022, 5901.498372638202, 5911.852203694942, 5928.318243402064, 5538.363088244742, 5609.27079479665, 5699.772009119589, 5709.857253568694, 5719.399463056319, 5693.5160511357, 5726.685032323262, 5738.368779434342, 5747.453991870766, 5754.338251101177, 5434.728263586726, 5618.04493236159, 5624.268845050117, 5629.662220266797, 5635.239242702347, 5694.572907031907, 5697.145428185805, 5712.828615141552, 5722.284714410699, 5732.914006289826, 5568.49883510486, 5610.438956104357, 5616.6068375213345, 5630.408807075362, 5652.943470565407], "yui.html": [566.9801556945506, 572.7823427097702, 575.4668858921468, 626.2234828812271, 641.8555824939388, 13586.3206839658, 13917.721645567082, 14033.859661403383, 14062.437502499888, 14082.85917140827, 11974.401279936012, 11992.700182495442, 12008.0, 12043.518259269618, 12060.21608595443, 587.9353271140171, 596.2070446306402, 734.2217249715305, 752.5146280648978, 760.9048868891389, 603.815836169968, 729.2998721227627, 746.7013194722127, 752.8343764371857, 755.6561764397213, 753.6947536247801, 775.8603451378749, 783.0877028262067, 784.6155383861895, 784.9882251766228, 610.1762620462384, 620.5780069552702, 755.8828381600861, 763.4808330335397, 776.4681193382523, 565.3865555871884, 571.7170000849565, 571.8427432456108, 572.3618165745206, 577.933537643168, 11210.327380357205, 11218.270812397168, 11326.603568875049, 11332.150088743294, 11409.885901141048, 8348.916510834935, 8353.33173346137, 8370.0, 8435.536045517494, 8552.102029286898, 7783.883241751379, 7962.920370796276, 7998.0, 8194.959025204837, 8368.24685778283, 2489.8031916999894, 2599.506093842164, 2632.289281893878, 2645.2196602002455, 2660.787137029033, 37969.15231357659, 38117.237655247016, 38129.23741525154, 38459.42310865339, 40657.59342406597, 6020.187274717945, 6174.938250617526, 6202.968985155136, 6232.8130156095385, 6259.062828993104, 10417.166626669848, 10436.478176091165, 10456.32033917808, 10692.358458492516, 10724.195685323475, 5157.097507936096, 5201.502546311246, 5244.868878277997, 5281.12861377876, 5404.3784964728775, 3070.8618112185004, 3088.104449709559, 3101.379724055153, 3135.153508552678, 3146.1348129264634, 2315.953680926372, 2345.5074434368976, 2347.3192774095664, 2354.4702441950426, 2359.5988681924114, 344.63812996353727, 349.9580050393969, 353.5086230140107, 353.72409520573996, 354.9006278242096, 307.898393530139, 374.6725322524827, 409.9795010249476, 443.89790348219447, 475.7725069321143, 6041.365656606081, 6442.0, 6444.484441244689, 6451.806445806634, 6454.451371633464, 404.324777621373, 472.7825200407851, 509.2564855311213, 517.2861451197399, 541.8509909774765, 3154.870462437845, 3220.951685724716, 3237.5953005874267, 3301.273719781644, 3316.519104729849, 46236.306455403195, 52979.205311920356, 53233.0, 53421.46578534243, 53521.73239133779, 40613.39079913804, 40830.59169408268, 40850.38724419136, 40866.59133408687, 41086.0, 36854.0, 39502.209955800725, 40622.39066413947, 40755.18099751039, 41430.58569414327, 6669.233038200669, 6708.329167083252, 6759.864802704017, 6846.5892046477375, 7014.333638304353, 30087.398252035273, 30762.0, 31020.689793102683, 31045.0, 31315.37369252648, 38828.0, 40267.597324026385, 40678.0, 40759.59240407558, 40942.385864211465, 6457.321981191907, 6608.768693095719, 6620.470362371095, 6688.398044176048, 6690.397864192246, 9338.0, 9438.48088355147, 9450.385724927857, 9463.101005404476, 9553.808923821623, 8215.0, 8297.460665056751, 8338.708145214889, 8348.791280218044, 8657.350698697497, 9153.542322883963, 9161.0, 9190.678326258549, 9215.539223038955, 9255.074492550692, 8883.511406872683, 8983.685571004984, 9103.044180360966, 9158.58786354629, 9163.129502697233, 7647.009296267033, 7824.334931530883, 7971.242731940456, 8235.51666119098, 8304.294134998592, 7440.218777028334, 7493.737719179802, 7912.892195092807, 8203.917960820554, 8233.50598964064]}, "summary": {"lowerIsBetter": false, "suite": 5713.238005085888, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6485.18771904125, "unit": "ms", "value": 6485.18771904125}, "dojo.html": {"lowerIsBetter": false, "filtered": 4516.380563281782, "unit": "ms", "value": 4516.380563281782}, "mootools.html": {"lowerIsBetter": false, "filtered": 3683.4200781991203, "unit": "ms", "value": 3683.4200781991203}, "ext.html": {"lowerIsBetter": false, "filtered": 15571.92586956046, "unit": "ms", "value": 15571.92586956046}, "prototype.html": {"lowerIsBetter": false, "filtered": 4203.446994804736, "unit": "ms", "value": 4203.446994804736}, "yui.html": {"lowerIsBetter": false, "filtered": 4924.218716051257, "unit": "ms", "value": 4924.218716051257}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0036"}, "testrun": {"date": 1447345953, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112070744", "branch": "Mozilla-Inbound", "revision": "4fe9c44ee56af900b221bd41cd78c987448ad385"}}, {"talos_counters": {}, "results": {"audio-dft": [186.0, 187.0, 189.0, 188.0, 181.0, 188.0, 187.0, 190.0, 189.0, 188.0], "ai-astar": [124.0, 126.0, 121.0, 129.0, 129.0, 128.0, 128.0, 127.0, 118.0, 128.0], "imaging-gaussian-blur": [142.0, 141.0, 141.0, 134.0, 142.0, 141.0, 135.0, 137.0, 134.0, 141.0], "audio-beat-detection": [185.0, 157.0, 187.0, 192.0, 148.0, 175.0, 174.0, 150.0, 197.0, 154.0], "json-stringify-tinderbox": [76.0, 76.0, 79.0, 80.0, 79.0, 80.0, 81.0, 80.0, 80.0, 81.0], "stanford-crypto-pbkdf2": [166.0, 169.0, 182.0, 182.0, 188.0, 170.0, 185.0, 183.0, 175.0, 168.0], "json-parse-financial": [65.0, 65.0, 68.0, 69.0, 68.0, 69.0, 68.0, 79.0, 68.0, 68.0], "stanford-crypto-sha256-iterative": [79.0, 83.0, 86.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0], "audio-fft": [84.0, 93.0, 98.0, 142.0, 77.0, 96.0, 81.0, 83.0, 131.0, 82.0], "imaging-darkroom": [148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 142.0, 147.0, 148.0], "stanford-crypto-ccm": [145.0, 153.0, 160.0, 161.0, 148.0, 156.0, 152.0, 157.0, 155.0, 147.0], "audio-oscillator": [113.0, 116.0, 163.0, 104.0, 104.0, 106.0, 152.0, 104.0, 104.0, 152.0], "stanford-crypto-aes": [99.0, 99.0, 99.0, 100.0, 99.0, 100.0, 101.0, 100.0, 102.0, 100.0], "imaging-desaturate": [110.0, 123.0, 110.0, 110.0, 118.0, 110.0, 109.0, 109.0, 119.0, 124.0]}, "summary": {"lowerIsBetter": true, "suite": 1765.5000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 96.7, "unit": "ms", "value": 96.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 176.8, "unit": "ms", "value": 176.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 171.9, "unit": "ms", "value": 171.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 153.4, "unit": "ms", "value": 153.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 68.7, "unit": "ms", "value": 68.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 121.8, "unit": "ms", "value": 121.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 125.8, "unit": "ms", "value": 125.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 187.3, "unit": "ms", "value": 187.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 84.0, "unit": "ms", "value": 84.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 79.2, "unit": "ms", "value": 79.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 138.8, "unit": "ms", "value": 138.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 99.9, "unit": "ms", "value": 99.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 114.2, "unit": "ms", "value": 114.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0036"}, "testrun": {"date": 1447345953, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112070744", "branch": "Mozilla-Inbound", "revision": "4fe9c44ee56af900b221bd41cd78c987448ad385"}}, {"talos_counters": {}, "results": {"DeltaBlue": [221.58209616662973], "Encrypt": [382.262996941896], "NavierStokes": [6662.251655629139], "Decrypt": [6958.333333333333], "Splay": [710.2272727272727], "Richards": [195.00780031201248], "RegExp": [35051.724137931036], "Earley": [1051.5247108307046], "Boyer": [14442.857142857143], "RayTrace": [2188.183807439825]}, "summary": {"lowerIsBetter": false, "suite": 15839.076889755768, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 298.3905340000001, "unit": "score", "value": 298.3905340000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 696.3294960000003, "unit": "score", "value": 696.3294960000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 222.74751491053678, "unit": "score", "value": 222.74751491053678}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.253556886227535, "unit": "score", "value": 38.253556886227535}, "Splay": {"lowerIsBetter": false, "filtered": 114.73932799999996, "unit": "score", "value": 114.73932799999996}, "RegExp": {"lowerIsBetter": false, "filtered": 25.989734382685686, "unit": "score", "value": 25.989734382685686}, "Richards": {"lowerIsBetter": false, "filtered": 181.02865600000007, "unit": "score", "value": 181.02865600000007}, "Earley": {"lowerIsBetter": false, "filtered": 633.8063129999999, "unit": "score", "value": 633.8063129999999}, "Boyer": {"lowerIsBetter": false, "filtered": 46.144817012858546, "unit": "score", "value": 46.144817012858546}, "RayTrace": {"lowerIsBetter": false, "filtered": 338.174973, "unit": "score", "value": 338.174973}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0036"}, "testrun": {"date": 1447345953, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112070744", "branch": "Mozilla-Inbound", "revision": "4fe9c44ee56af900b221bd41cd78c987448ad385"}}] 08:52:49 INFO - RETURN: dromaeo_css: 5713.24 08:52:49 INFO - RETURN: kraken: 1765.50 08:52:49 INFO - RETURN: v8_7: 15839.08 08:52:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15839.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1765.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5713.24"}}} 08:52:49 INFO - Return code: 0 08:52:49 INFO - # TBPL SUCCESS # 08:52:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:49 INFO - 2015-11-12 08:52:49.672 screenresolution[2278:22441] starting screenresolution argv=screenresolution get 08:52:49 INFO - 2015-11-12 08:52:49.675 screenresolution[2278:22441] Display 0: 1600x1200x32@60 08:52:49 INFO - 2015-11-12 08:52:49.682 screenresolution[2279:22444] starting screenresolution argv=screenresolution list 08:52:49 INFO - Available Modes on Display 0 08:52:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:49 INFO - Intel HD Graphics 3000: 08:52:49 INFO - Chipset Model: Intel HD Graphics 3000 08:52:49 INFO - Type: GPU 08:52:49 INFO - Bus: Built-In 08:52:49 INFO - VRAM (Total): 512 MB 08:52:49 INFO - VRAM (Dynamic, Max): 10 08:52:49 INFO - Vendor: Intel (0x8086) 08:52:49 INFO - Device ID: 0x0116 08:52:49 INFO - Revision ID: 0x0009 08:52:49 INFO - Displays: 08:52:49 INFO - Display: 08:52:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:49 INFO - Display Serial Number: 1600x1200 60 08:52:49 INFO - Main Display: Yes 08:52:49 INFO - Mirror: Off 08:52:49 INFO - Online: Yes 08:52:49 INFO - Rotation: Supported 08:52:49 INFO - Return code: 0 08:52:49 INFO - Running post-action listener: _resource_record_post_action 08:52:49 INFO - Running post-run listener: _resource_record_post_run 08:52:51 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 135168; Write bytes: 686356480; Read time: 32; Write time: 57970 08:52:51 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 342057472; Write bytes: 343560192; Read time: 36298; Write time: 10446 08:52:51 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 135168; Write bytes: 337520640; Read time: 32; Write time: 44717 08:52:51 INFO - Running post-run listener: _upload_blobber_files 08:52:51 INFO - Blob upload gear active. 08:52:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:52:51 INFO - Copying logs to upload dir... 08:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1490.700716 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 50 secs) (at 2015-11-12 08:52:51.133297) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 08:52:51.138032) ========= 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.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.019548 build_url: 'https://queue.taskcluster.net/v1/task/Brgk30SVRx-na7T0SJez4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.13 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 08:52:51.285216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:52:51.285575) ========= 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.WrdCcKlxlG/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.qWQ50Kncjr/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.008238 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 08:52:51.338651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 08:52:51.338970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 08:52:51.339385) ========= ========= Total master_lag: 0.33 =========