builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0090 starttime: 1447797391.14 results: success (0) buildid: 20151117120003 builduid: 75ec2251df8143989d31a8c8472fb2d9 revision: 26143abfbe1a2bea884e3c92cf6e561fb33b635a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.138483) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.138964) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.139258) ========= 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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.006435 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.204084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.207497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.236270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.236646) ========= 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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.025394 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.286193) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.286512) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.286877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.287163) ========= 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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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-17 13:56:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.6M=0s 2015-11-17 13:56:31 (27.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232921 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.741651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.742072) ========= 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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.109229 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.866540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:31.867078) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 26143abfbe1a2bea884e3c92cf6e561fb33b635a --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 26143abfbe1a2bea884e3c92cf6e561fb33b635a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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-17 13:56:31,913 truncating revision to first 12 chars 2015-11-17 13:56:31,913 Setting DEBUG logging. 2015-11-17 13:56:31,913 attempt 1/10 2015-11-17 13:56:31,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/26143abfbe1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 13:56:32,195 unpacking tar archive at: mozilla-inbound-26143abfbe1a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565205 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:32.464558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:32.464869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:32.630820) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:32.631399) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 13:56:32.631804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-17 13:56:32.632091) ========= /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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:56:32 INFO - MultiFileLogger online at 20151117 13:56:32 in /builds/slave/test 13:56:32 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 13:56:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:56:32 INFO - {'append_to_log': False, 13:56:32 INFO - 'base_work_dir': '/builds/slave/test', 13:56:32 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:56:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:56:32 INFO - 'branch': 'Mozilla-Inbound', 13:56:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:56:32 INFO - 'config_files': ('talos/mac_config.py',), 13:56:32 INFO - 'default_actions': ('clobber', 13:56:32 INFO - 'read-buildbot-config', 13:56:32 INFO - 'download-and-extract', 13:56:32 INFO - 'populate-webroot', 13:56:32 INFO - 'create-virtualenv', 13:56:32 INFO - 'install', 13:56:32 INFO - 'run-tests'), 13:56:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:56:32 INFO - 'download_minidump_stackwalk': True, 13:56:32 INFO - 'download_symbols': 'ondemand', 13:56:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:56:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:56:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:56:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:56:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:56:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:56:32 INFO - 'installer_path': 'installer.exe', 13:56:32 INFO - 'log_level': 'info', 13:56:32 INFO - 'log_name': 'talos', 13:56:32 INFO - 'log_to_console': True, 13:56:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:56:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:56:32 INFO - 'opt_config_files': (), 13:56:32 INFO - 'pip_index': False, 13:56:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:32 INFO - 'cmd': ('bash', 13:56:32 INFO - '-c', 13:56:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:32 INFO - 'enabled': True, 13:56:32 INFO - 'halt_on_failure': False, 13:56:32 INFO - 'name': 'check_screen_resolution'},), 13:56:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:32 INFO - 'cmd': ('bash', 13:56:32 INFO - '-c', 13:56:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:32 INFO - 'enabled': True, 13:56:32 INFO - 'halt_on_failure': False, 13:56:32 INFO - 'name': 'check_screen_resolution'},), 13:56:32 INFO - 'run_cmd_checks_enabled': True, 13:56:32 INFO - 'sps_profile': False, 13:56:32 INFO - 'sps_profile_interval': 0, 13:56:32 INFO - 'suite': 'dromaeojs', 13:56:32 INFO - 'system_bits': '64', 13:56:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:56:32 INFO - 'title': 't-yosemite-r5-0090', 13:56:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:56:32 INFO - 'use_talos_json': True, 13:56:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:56:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:56:32 INFO - 'work_dir': 'build'} 13:56:32 INFO - ##### 13:56:32 INFO - ##### Running clobber step. 13:56:32 INFO - ##### 13:56:32 INFO - Running pre-action listener: _resource_record_pre_action 13:56:32 INFO - Running main action method: clobber 13:56:32 INFO - rmtree: /builds/slave/test/build 13:56:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:56:37 INFO - Running post-action listener: _resource_record_post_action 13:56:37 INFO - ##### 13:56:37 INFO - ##### Running read-buildbot-config step. 13:56:37 INFO - ##### 13:56:37 INFO - Running pre-action listener: _resource_record_pre_action 13:56:37 INFO - Running main action method: read_buildbot_config 13:56:37 INFO - Using buildbot properties: 13:56:37 INFO - { 13:56:37 INFO - "properties": { 13:56:37 INFO - "buildnumber": 3351, 13:56:37 INFO - "product": "firefox", 13:56:37 INFO - "script_repo_revision": "production", 13:56:37 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 13:56:37 INFO - "repository": "", 13:56:37 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 13:56:37 INFO - "buildid": "20151117120003", 13:56:37 INFO - "slavename": "t-yosemite-r5-0090", 13:56:37 INFO - "pgo_build": "False", 13:56:37 INFO - "basedir": "/builds/slave/test", 13:56:37 INFO - "project": "", 13:56:37 INFO - "platform": "yosemite", 13:56:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:56:37 INFO - "slavebuilddir": "test", 13:56:37 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 13:56:37 INFO - "branch": "mozilla-inbound", 13:56:37 INFO - "repo_path": "integration/mozilla-inbound", 13:56:37 INFO - "stage_platform": "macosx64", 13:56:37 INFO - "builduid": "75ec2251df8143989d31a8c8472fb2d9", 13:56:37 INFO - "revision": "26143abfbe1a2bea884e3c92cf6e561fb33b635a" 13:56:37 INFO - }, 13:56:37 INFO - "sourcestamp": { 13:56:37 INFO - "repository": "", 13:56:37 INFO - "hasPatch": false, 13:56:37 INFO - "project": "", 13:56:37 INFO - "branch": "mozilla-inbound-macosx64-talos", 13:56:37 INFO - "changes": [ 13:56:37 INFO - { 13:56:37 INFO - "category": null, 13:56:37 INFO - "files": [ 13:56:37 INFO - { 13:56:37 INFO - "url": null, 13:56:37 INFO - "name": "https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 13:56:37 INFO - } 13:56:37 INFO - ], 13:56:37 INFO - "repository": "", 13:56:37 INFO - "rev": "26143abfbe1a2bea884e3c92cf6e561fb33b635a", 13:56:37 INFO - "who": "erahm@mozilla.com", 13:56:37 INFO - "when": 1447796669, 13:56:37 INFO - "number": 6673894, 13:56:37 INFO - "comments": "Bug 1224685 - Add |resident-unique| measurement to Windows. r=njn", 13:56:37 INFO - "project": "", 13:56:37 INFO - "at": "Tue 17 Nov 2015 13:44:29", 13:56:37 INFO - "branch": "mozilla-inbound-macosx64-talos", 13:56:37 INFO - "revlink": "", 13:56:37 INFO - "properties": [ 13:56:37 INFO - [ 13:56:37 INFO - "buildid", 13:56:37 INFO - "20151117120003", 13:56:37 INFO - "Change" 13:56:37 INFO - ], 13:56:37 INFO - [ 13:56:37 INFO - "builduid", 13:56:37 INFO - "75ec2251df8143989d31a8c8472fb2d9", 13:56:37 INFO - "Change" 13:56:37 INFO - ], 13:56:37 INFO - [ 13:56:37 INFO - "pgo_build", 13:56:37 INFO - "False", 13:56:37 INFO - "Change" 13:56:37 INFO - ] 13:56:37 INFO - ], 13:56:37 INFO - "revision": "26143abfbe1a2bea884e3c92cf6e561fb33b635a" 13:56:37 INFO - } 13:56:37 INFO - ], 13:56:37 INFO - "revision": "26143abfbe1a2bea884e3c92cf6e561fb33b635a" 13:56:37 INFO - } 13:56:37 INFO - } 13:56:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 13:56:37 INFO - Running post-action listener: _resource_record_post_action 13:56:37 INFO - ##### 13:56:37 INFO - ##### Running download-and-extract step. 13:56:37 INFO - ##### 13:56:37 INFO - Running pre-action listener: _resource_record_pre_action 13:56:37 INFO - Running main action method: download_and_extract 13:56:37 INFO - mkdir: /builds/slave/test/build/tests 13:56:37 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')]} 13:56:37 INFO - https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/test_packages.json 13:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/test_packages.json 13:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:56:38 INFO - Downloaded 1149 bytes. 13:56:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:56:38 INFO - Using the following test package requirements: 13:56:38 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:56:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 13:56:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'jsshell-mac.zip'], 13:56:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 13:56:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:56:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 13:56:38 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 13:56:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 13:56:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:56:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:56:38 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 13:56:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:56: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')]} 13:56:38 INFO - https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:39 INFO - Downloaded 17463493 bytes. 13:56:39 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 13:56:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:56:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:56:44 INFO - Return code: 0 13:56:44 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 13:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:44 INFO - https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:56:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:56:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:56:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:45 INFO - Downloaded 17463493 bytes. 13:56:45 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 13:56:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:56:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:56:51 INFO - Return code: 0 13:56:51 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')]} 13:56:51 INFO - https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:52 INFO - Downloaded 11130997 bytes. 13:56:52 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 13:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:56:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 13:56:52 INFO - Return code: 0 13:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:52 INFO - https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:56:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:56:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:56:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 13:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JccrhtAZSM2pz-GFQaSa2A/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 13:56:56 INFO - Downloaded 108842169 bytes. 13:56:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:56:56 INFO - mkdir: /builds/slave/test/properties 13:56:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:56:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:56:56 INFO - Contents: 13:56:56 INFO - build_url:https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:56:56 INFO - Running post-action listener: _resource_record_post_action 13:56:56 INFO - Running post-action listener: set_extra_try_arguments 13:56:56 INFO - ##### 13:56:56 INFO - ##### Running populate-webroot step. 13:56:56 INFO - ##### 13:56:56 INFO - Running pre-action listener: _resource_record_pre_action 13:56:56 INFO - Running main action method: populate_webroot 13:56:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:56:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:56:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:56:56 INFO - '../fennec_ids.txt'], 13:56:56 INFO - 'tests': ['tcheck2']}, 13:56:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:56:56 INFO - '--tppagecycles', 13:56:56 INFO - '7'], 13:56:56 INFO - 'tests': ['tsvgm']}}, 13:56:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:56:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:56:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:56:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:56:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'tests': ['damp', 'tps']}, 13:56:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['damp', 'tps']}, 13:56:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:56:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:56:56 INFO - 'other': {'tests': ['a11yr', 13:56:56 INFO - 'ts_paint', 13:56:56 INFO - 'tpaint', 13:56:56 INFO - 'sessionrestore', 13:56:56 INFO - 'sessionrestore_no_auto_restore']}, 13:56:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['a11yr', 13:56:56 INFO - 'ts_paint', 13:56:56 INFO - 'tpaint', 13:56:56 INFO - 'sessionrestore', 13:56:56 INFO - 'sessionrestore_no_auto_restore']}, 13:56:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['a11yr', 13:56:56 INFO - 'ts_paint', 13:56:56 INFO - 'tpaint', 13:56:56 INFO - 'sessionrestore', 13:56:56 INFO - 'sessionrestore_no_auto_restore']}, 13:56:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['a11yr', 13:56:56 INFO - 'ts_paint', 13:56:56 INFO - 'tpaint', 13:56:56 INFO - 'sessionrestore', 13:56:56 INFO - 'sessionrestore_no_auto_restore']}, 13:56:56 INFO - 'other_l64': {'tests': ['a11yr', 13:56:56 INFO - 'ts_paint', 13:56:56 INFO - 'tpaint', 13:56:56 INFO - 'sessionrestore', 13:56:56 INFO - 'sessionrestore_no_auto_restore']}, 13:56:56 INFO - 'other_nol64': {'tests': ['a11yr', 13:56:56 INFO - 'ts_paint', 13:56:56 INFO - 'tpaint', 13:56:56 INFO - 'sessionrestore', 13:56:56 INFO - 'sessionrestore_no_auto_restore']}, 13:56:56 INFO - 'svgr': {'tests': ['tsvgx', 13:56:56 INFO - 'tsvgr_opacity', 13:56:56 INFO - 'tart', 13:56:56 INFO - 'tscrollx', 13:56:56 INFO - 'cart']}, 13:56:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['tsvgx', 13:56:56 INFO - 'tsvgr_opacity', 13:56:56 INFO - 'tart', 13:56:56 INFO - 'tscrollx', 13:56:56 INFO - 'cart']}, 13:56:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'tests': ['tp5o']}, 13:56:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'talos_options': ['--e10s'], 13:56:56 INFO - 'tests': ['tp5o']}, 13:56:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'talos_options': ['--xperf_path', 13:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:56 INFO - 'tests': ['tp5n']}, 13:56:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:56 INFO - 'talos_options': ['--e10s', 13:56:56 INFO - '--xperf_path', 13:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:56 INFO - 'tests': ['tp5n']}}, 13:56:56 INFO - 'talos.zip': {'path': '', 13:56:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:56:56 INFO - Running post-action listener: _resource_record_post_action 13:56:56 INFO - ##### 13:56:56 INFO - ##### Running create-virtualenv step. 13:56:56 INFO - ##### 13:56:56 INFO - Running pre-action listener: _resource_record_pre_action 13:56:56 INFO - Running main action method: create_virtualenv 13:56:56 INFO - Creating virtualenv /builds/slave/test/build/venv 13:56:56 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 13:56:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:56:56 INFO - Using real prefix '/tools/python27' 13:56:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:56:57 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:01 INFO - Installing pip.................done. 13:57:01 INFO - Return code: 0 13:57:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:01 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 13:57:01 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 13:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:01 INFO - 'HOME': '/Users/cltbld', 13:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:01 INFO - 'LOGNAME': 'cltbld', 13:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:01 INFO - 'MOZ_NO_REMOTE': '1', 13:57:01 INFO - 'NO_EM_RESTART': '1', 13:57:01 INFO - 'PAGER': '/bin/cat', 13:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:01 INFO - 'PWD': '/builds/slave/test', 13:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:01 INFO - 'SHELL': '/bin/bash', 13:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:01 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:01 INFO - 'USER': 'cltbld', 13:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:01 INFO - 'XPC_FLAGS': '0x0', 13:57:01 INFO - 'XPC_SERVICE_NAME': '0', 13:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:02 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 13:57:02 INFO - Cleaning up... 13:57:02 INFO - Return code: 0 13:57:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:02 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:02 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 13:57:02 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 13:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:02 INFO - 'HOME': '/Users/cltbld', 13:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:02 INFO - 'LOGNAME': 'cltbld', 13:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:02 INFO - 'MOZ_NO_REMOTE': '1', 13:57:02 INFO - 'NO_EM_RESTART': '1', 13:57:02 INFO - 'PAGER': '/bin/cat', 13:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:02 INFO - 'PWD': '/builds/slave/test', 13:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:02 INFO - 'SHELL': '/bin/bash', 13:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:02 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:02 INFO - 'USER': 'cltbld', 13:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:02 INFO - 'XPC_FLAGS': '0x0', 13:57:02 INFO - 'XPC_SERVICE_NAME': '0', 13:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:02 INFO - Downloading/unpacking psutil>=0.7.1 13:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:05 INFO - Installing collected packages: psutil 13:57:05 INFO - Running setup.py install for psutil 13:57:06 INFO - building 'psutil._psutil_osx' extension 13:57:06 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 13:57:08 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 13:57:08 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 13:57:08 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 13:57:09 INFO - building 'psutil._psutil_posix' extension 13:57:09 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 13:57:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:57:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:57:09 INFO - ^ 13:57:09 INFO - 1 warning generated. 13:57:09 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 13:57:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:09 INFO - Successfully installed psutil 13:57:09 INFO - Cleaning up... 13:57:09 INFO - Return code: 0 13:57:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:57:09 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')]} 13:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:09 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')]} 13:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:09 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:09 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 13:57:09 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 13:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:09 INFO - 'HOME': '/Users/cltbld', 13:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:09 INFO - 'LOGNAME': 'cltbld', 13:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:09 INFO - 'MOZ_NO_REMOTE': '1', 13:57:09 INFO - 'NO_EM_RESTART': '1', 13:57:09 INFO - 'PAGER': '/bin/cat', 13:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:09 INFO - 'PWD': '/builds/slave/test', 13:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:09 INFO - 'SHELL': '/bin/bash', 13:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:09 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:09 INFO - 'USER': 'cltbld', 13:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:09 INFO - 'XPC_FLAGS': '0x0', 13:57:09 INFO - 'XPC_SERVICE_NAME': '0', 13:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:57:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:57:12 INFO - Installing collected packages: mozsystemmonitor 13:57:12 INFO - Running setup.py install for mozsystemmonitor 13:57:12 INFO - Successfully installed mozsystemmonitor 13:57:12 INFO - Cleaning up... 13:57:12 INFO - Return code: 0 13:57:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:12 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:12 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 13:57:12 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 13:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:12 INFO - 'HOME': '/Users/cltbld', 13:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:12 INFO - 'LOGNAME': 'cltbld', 13:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:12 INFO - 'MOZ_NO_REMOTE': '1', 13:57:12 INFO - 'NO_EM_RESTART': '1', 13:57:12 INFO - 'PAGER': '/bin/cat', 13:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:12 INFO - 'PWD': '/builds/slave/test', 13:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:12 INFO - 'SHELL': '/bin/bash', 13:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:12 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:12 INFO - 'USER': 'cltbld', 13:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:12 INFO - 'XPC_FLAGS': '0x0', 13:57:12 INFO - 'XPC_SERVICE_NAME': '0', 13:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:13 INFO - Downloading/unpacking blobuploader==1.2.4 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:15 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 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 13:57:16 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 13:57:17 INFO - Downloading docopt-0.6.1.tar.gz 13:57:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:17 INFO - Running setup.py install for blobuploader 13:57:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:17 INFO - Running setup.py install for requests 13:57:18 INFO - Running setup.py install for docopt 13:57:18 INFO - Successfully installed blobuploader requests docopt 13:57:18 INFO - Cleaning up... 13:57:18 INFO - Return code: 0 13:57:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:18 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')]} 13:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:18 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')]} 13:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:18 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:18 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 13:57:18 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 13:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:18 INFO - 'HOME': '/Users/cltbld', 13:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:18 INFO - 'LOGNAME': 'cltbld', 13:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:18 INFO - 'MOZ_NO_REMOTE': '1', 13:57:18 INFO - 'NO_EM_RESTART': '1', 13:57:18 INFO - 'PAGER': '/bin/cat', 13:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:18 INFO - 'PWD': '/builds/slave/test', 13:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:18 INFO - 'SHELL': '/bin/bash', 13:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:18 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:18 INFO - 'USER': 'cltbld', 13:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:18 INFO - 'XPC_FLAGS': '0x0', 13:57:18 INFO - 'XPC_SERVICE_NAME': '0', 13:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:18 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Mm1DM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-mGozDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-SVkJAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-uRaekr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-CVT4uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-muh1M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-T0moE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:19 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-n0WxlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-G982cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-CNl7kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-UNGvNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-mgYmIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-mzv79D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-4a8I0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:20 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-1EEfRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:21 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-yi6ZD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:21 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-6_BZKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:21 INFO - Running setup.py install for manifestparser 13:57:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:57:21 INFO - Running setup.py install for mozcrash 13:57:21 INFO - Running setup.py install for mozdebug 13:57:21 INFO - Running setup.py install for mozdevice 13:57:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Running setup.py install for mozfile 13:57:22 INFO - Running setup.py install for mozhttpd 13:57:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Running setup.py install for mozinfo 13:57:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Running setup.py install for mozInstall 13:57:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:57:22 INFO - Running setup.py install for mozleak 13:57:23 INFO - Running setup.py install for mozlog 13:57:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:57:23 INFO - Running setup.py install for moznetwork 13:57:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:57:23 INFO - Running setup.py install for mozprocess 13:57:23 INFO - Running setup.py install for mozprofile 13:57:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:57:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:57:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:57:23 INFO - Running setup.py install for mozrunner 13:57:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:57:24 INFO - Running setup.py install for mozscreenshot 13:57:24 INFO - Running setup.py install for moztest 13:57:24 INFO - Running setup.py install for mozversion 13:57:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:57:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:24 INFO - Cleaning up... 13:57:24 INFO - Return code: 0 13:57:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:24 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:24 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 13:57:24 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 13:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:24 INFO - 'HOME': '/Users/cltbld', 13:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:24 INFO - 'LOGNAME': 'cltbld', 13:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:24 INFO - 'MOZ_NO_REMOTE': '1', 13:57:24 INFO - 'NO_EM_RESTART': '1', 13:57:24 INFO - 'PAGER': '/bin/cat', 13:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:24 INFO - 'PWD': '/builds/slave/test', 13:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:24 INFO - 'SHELL': '/bin/bash', 13:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:24 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:24 INFO - 'USER': 'cltbld', 13:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:24 INFO - 'XPC_FLAGS': '0x0', 13:57:24 INFO - 'XPC_SERVICE_NAME': '0', 13:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-5JdW9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:25 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)) 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-2rOik3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:25 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)) 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-A8FROO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:25 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)) 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-yPj9iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:25 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)) 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-RE7tdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:25 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)) 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-TWzvIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:25 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)) 13:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-xVqcyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-7YDcT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Tz0aHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-ScsN4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Lb7Iwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-_vjues-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-g31X77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:26 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)) 13:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-y97R6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:27 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)) 13:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:27 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-rDY07X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:27 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)) 13:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:27 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-25DXZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:27 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)) 13:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:27 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-td7GiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:27 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)) 13:57:27 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)) 13:57:27 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)) 13:57:27 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)) 13:57:27 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)) 13:57:27 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)) 13:57:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:30 INFO - Downloading blessings-1.5.1.tar.gz 13:57:30 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 13:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:30 INFO - Installing collected packages: blessings 13:57:30 INFO - Running setup.py install for blessings 13:57:30 INFO - Successfully installed blessings 13:57:30 INFO - Cleaning up... 13:57:30 INFO - Return code: 0 13:57:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:31 INFO - Reading from file tmpfile_stdout 13:57:31 INFO - Current package versions: 13:57:31 INFO - blessings == 1.5.1 13:57:31 INFO - blobuploader == 1.2.4 13:57:31 INFO - docopt == 0.6.1 13:57:31 INFO - manifestparser == 1.1 13:57:31 INFO - mozInstall == 1.12 13:57:31 INFO - mozcrash == 0.16 13:57:31 INFO - mozdebug == 0.1 13:57:31 INFO - mozdevice == 0.47 13:57:31 INFO - mozfile == 1.2 13:57:31 INFO - mozhttpd == 0.7 13:57:31 INFO - mozinfo == 0.9 13:57:31 INFO - mozleak == 0.1 13:57:31 INFO - mozlog == 3.0 13:57:31 INFO - moznetwork == 0.27 13:57:31 INFO - mozprocess == 0.22 13:57:31 INFO - mozprofile == 0.27 13:57:31 INFO - mozrunner == 6.11 13:57:31 INFO - mozscreenshot == 0.1 13:57:31 INFO - mozsystemmonitor == 0.0 13:57:31 INFO - moztest == 0.7 13:57:31 INFO - mozversion == 1.4 13:57:31 INFO - psutil == 3.1.1 13:57:31 INFO - requests == 1.2.3 13:57:31 INFO - wsgiref == 0.1.2 13:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:31 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')]} 13:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:31 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')]} 13:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:31 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 0x10ce5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce39228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8a8d05970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, '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.5KyPJYu31Y/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.f07k5nqbzS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 13:57:31 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 13:57:31 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 13:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:31 INFO - 'HOME': '/Users/cltbld', 13:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:31 INFO - 'LOGNAME': 'cltbld', 13:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:31 INFO - 'MOZ_NO_REMOTE': '1', 13:57:31 INFO - 'NO_EM_RESTART': '1', 13:57:31 INFO - 'PAGER': '/bin/cat', 13:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:31 INFO - 'PWD': '/builds/slave/test', 13:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:31 INFO - 'SHELL': '/bin/bash', 13:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:57:31 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:31 INFO - 'USER': 'cltbld', 13:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:31 INFO - 'XPC_FLAGS': '0x0', 13:57:31 INFO - 'XPC_SERVICE_NAME': '0', 13:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 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)) 13:57:31 INFO - Cleaning up... 13:57:31 INFO - Return code: 0 13:57:31 INFO - Running post-action listener: _resource_record_post_action 13:57:31 INFO - Running post-action listener: _start_resource_monitoring 13:57:31 INFO - Starting resource monitoring. 13:57:31 INFO - ##### 13:57:31 INFO - ##### Running install step. 13:57:31 INFO - ##### 13:57:31 INFO - Running pre-action listener: _resource_record_pre_action 13:57:31 INFO - Running main action method: install 13:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:31 INFO - Reading from file tmpfile_stdout 13:57:31 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:31 INFO - Reading from file tmpfile_stdout 13:57:31 INFO - Output received: 13:57:31 INFO - Usage: mozinstall [options] installer 13:57:31 INFO - Options: 13:57:31 INFO - -h, --help show this help message and exit 13:57:31 INFO - -d DEST, --destination=DEST 13:57:31 INFO - Directory to install application into. [default: 13:57:31 INFO - "/builds/slave/test"] 13:57:31 INFO - --app=APP Application being installed. [default: firefox] 13:57:31 INFO - mkdir: /builds/slave/test/build/application 13:57:31 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'] 13:57:31 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 13:58:14 INFO - Reading from file tmpfile_stdout 13:58:14 INFO - Output received: 13:58:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:58:14 INFO - Running post-action listener: _resource_record_post_action 13:58:14 INFO - ##### 13:58:14 INFO - ##### Running run-tests step. 13:58:14 INFO - ##### 13:58:14 INFO - Running pre-action listener: _resource_record_pre_action 13:58:14 INFO - Running main action method: run_tests 13:58:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:58:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:58:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:58:14 INFO - 2015-11-17 13:58:14.439 screenresolution[1633:7787] starting screenresolution argv=screenresolution get 13:58:14 INFO - 2015-11-17 13:58:14.443 screenresolution[1633:7787] Display 0: 1600x1200x32@60 13:58:14 INFO - 2015-11-17 13:58:14.450 screenresolution[1634:7789] starting screenresolution argv=screenresolution list 13:58:14 INFO - Available Modes on Display 0 13:58:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:58:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:58:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:58:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:58:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:58:14 INFO - Intel HD Graphics 3000: 13:58:14 INFO - Chipset Model: Intel HD Graphics 3000 13:58:14 INFO - Type: GPU 13:58:14 INFO - Bus: Built-In 13:58:14 INFO - VRAM (Total): 512 MB 13:58:14 INFO - VRAM (Dynamic, Max): 10 13:58:14 INFO - Vendor: Intel (0x8086) 13:58:14 INFO - Device ID: 0x0116 13:58:14 INFO - Revision ID: 0x0009 13:58:14 INFO - Displays: 13:58:14 INFO - Display: 13:58:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:58:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:58:14 INFO - Display Serial Number: 1600x1200 60 13:58:14 INFO - Main Display: Yes 13:58:14 INFO - Mirror: Off 13:58:14 INFO - Online: Yes 13:58:14 INFO - Rotation: Supported 13:58:14 INFO - Return code: 0 13:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:58:14 INFO - Python 2.7.3 13:58:14 INFO - Return code: 0 13:58:14 INFO - grabbing minidump binary from tooltool 13:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:14 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 0x10cd809f0>, '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 0x10cadfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd738c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:58:14 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 13:58:14 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 13:58:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:14 INFO - Return code: 0 13:58:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:58:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:58:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:58:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:58:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:58:14 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/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] in /builds/slave/test/build 13:58:14 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/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0090 --webServer localhost 13:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5KyPJYu31Y/Render', 13:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:14 INFO - 'HOME': '/Users/cltbld', 13:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:14 INFO - 'LOGNAME': 'cltbld', 13:58:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:58:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:14 INFO - 'MOZ_NO_REMOTE': '1', 13:58:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:58:14 INFO - 'NO_EM_RESTART': '1', 13:58:14 INFO - 'PAGER': '/bin/cat', 13:58:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:14 INFO - 'PWD': '/builds/slave/test', 13:58:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:14 INFO - 'SHELL': '/bin/bash', 13:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f07k5nqbzS/Listeners', 13:58:14 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 13:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:14 INFO - 'USER': 'cltbld', 13:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:14 INFO - 'XPC_FLAGS': '0x0', 13:58:14 INFO - 'XPC_SERVICE_NAME': '0', 13:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 13:58:14 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/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] with output_timeout 3600 13:58:15 INFO - mozversion INFO | application_buildid: 20151117120003 13:58:15 INFO - mozversion INFO | application_changeset: 26143abfbe1a2bea884e3c92cf6e561fb33b635a 13:58:15 INFO - mozversion INFO | application_display_name: Nightly 13:58:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:15 INFO - mozversion INFO | application_name: Firefox 13:58:15 INFO - mozversion INFO | application_remotingname: firefox 13:58:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:58:15 INFO - mozversion INFO | application_vendor: Mozilla 13:58:15 INFO - mozversion INFO | application_version: 45.0a1 13:58:15 INFO - mozversion INFO | platform_buildid: 20151117120003 13:58:15 INFO - mozversion INFO | platform_changeset: 26143abfbe1a2bea884e3c92cf6e561fb33b635a 13:58:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:58:15 INFO - mozversion INFO | platform_version: 45.0a1 13:58:15 INFO - 2015-11-17 13:58:15,207 DEBUG : using testdate: 1447797495 13:58:15 INFO - 2015-11-17 13:58:15,207 DEBUG : actual date: 1447797495 13:58:15 INFO - 2015-11-17 13:58:15,216 INFO : starting webserver on 'localhost:49252' 13:58:15 INFO - 2015-11-17 13:58:15,217 INFO : Starting test suite t-yosemite-r5-0090 13:58:15 INFO - 2015-11-17 13:58:15,218 INFO : Starting test dromaeo_css 13:58:15 INFO - 2015-11-17 13:58:15,218 DEBUG : operating with platform_type : mac_ 13:58:15 INFO - 2015-11-17 13:58:15,219 INFO : Initialising browser for dromaeo_css test... 13:58:15 INFO - 2015-11-17 13:58:15,250 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpTwAZQn/profile http://localhost:49252/getInfo.html 13:58:19 INFO - 2015-11-17 13:58:19,030 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:58:19 INFO - 2015-11-17 13:58:19,031 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:58:19 INFO - 2015-11-17 13:58:19,031 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:58:19 INFO - 2015-11-17 13:58:19,031 DEBUG : BROWSER_OUTPUT: __metrics 13:58:19 INFO - 2015-11-17 13:58:19,046 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:19 INFO - 2015-11-17 13:58:19,841 INFO : Browser initialized. 13:58:19 INFO - 2015-11-17 13:58:19,842 INFO : Running cycle 1/1 for dromaeo_css test... 13:58:19 INFO - 2015-11-17 13:58:19,842 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpTwAZQn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:58:32 INFO - 2015-11-17 13:58:32,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 229773312 13:58:32 INFO - 2015-11-17 13:58:32,107 DEBUG : BROWSER_OUTPUT: 13:59:23 INFO - 2015-11-17 13:59:23,594 DEBUG : BROWSER_OUTPUT: 1447797563593 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] 14:01:33 INFO - 2015-11-17 14:01:33,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 14:01:34 INFO - 2015-11-17 14:01:34,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 340979712 14:01:34 INFO - 2015-11-17 14:01:34,459 DEBUG : BROWSER_OUTPUT: 14:04:37 INFO - 2015-11-17 14:04:37,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 14:04:37 INFO - 2015-11-17 14:04:37,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 370528256 14:04:37 INFO - 2015-11-17 14:04:37,893 DEBUG : BROWSER_OUTPUT: 14:07:40 INFO - 2015-11-17 14:07:40,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 14:07:40 INFO - 2015-11-17 14:07:40,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 330371072 14:07:40 INFO - 2015-11-17 14:07:40,877 DEBUG : BROWSER_OUTPUT: 14:10:43 INFO - 2015-11-17 14:10:43,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 14:10:43 INFO - 2015-11-17 14:10:43,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 324231168 14:10:43 INFO - 2015-11-17 14:10:43,704 DEBUG : BROWSER_OUTPUT: 14:13:46 INFO - 2015-11-17 14:13:46,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 14:13:47 INFO - 2015-11-17 14:13:47,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 326668288 14:13:47 INFO - 2015-11-17 14:13:47,562 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 14:16:50 INFO - 2015-11-17 14:16:50,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 372547584 14:16:50 INFO - 2015-11-17 14:16:50,574 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,574 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:16:50 INFO - 2015-11-17 14:16:50,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:16:50 INFO - 2015-11-17 14:16:50,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:16:50 INFO - 2015-11-17 14:16:50,575 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:16:50 INFO - 2015-11-17 14:16:50,575 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2505.536475751986;2525;2551.974480255197;2571.215779187347;2612.581986882098;4015.6586690131303;4052.5339585947627;4148;4154.148399578086;4197.454330936977;4137.482814648169;4155.563665815083;4158.604932531404;4304.332828411593;4332.826686932527;3837.424386342057;3936.822842972073;3945.6646185074305;3947.5657677655436;4013.739106958053;3701.206337331495;3899.3566061599804;3950.8814735557835;3968.6031396860226;4017.216642754664;3774.1885494618514;3805.9723874553715;3876.6898648108086;3888.202918401735;3894.123822139996;3715.089802998256;3809.12390150267;3848.2688289224957;3900.395438707005;3903.238868420659;3796.52543432071;3817.8472861085525;3846.3461211594094;3888.2612303662495;3943.4676318697184;4015.638592526687;4176.415301857743;4177.26897792885;4203.7687927164;4273.3162693969125;4294.098239369736;4341.240282950471;4346.782660866944;4351.4995775485595;4448.888777780549;4407.537208593116;4456.286994080931;4486.394336764528;4498;4580.312953057068;3960.128771670228;4086.0602061526015;4142.109446468993;4150.377443383486;4209.473815773028;4436.112777444459;4494.280915053641;4515.616172625298;4538.568835960578;4569.1547063793305;4359.476862776487;4395.3098162250535;4402.4056752338665;4434.55654434554;4488.528704486047;4227.682923780729;4341.587549182823;4518.8418405356315;4580;4582.106489234568;4332.935005974913;4348.043430445297;4351.673624478113;4383.123375324884;4395.604395604411;4321.762303073361;4324.697271191049;4345.847895323648;4359.04101097758;4368.628666563378;3389.084947064328;3450.0857272822723;3499.772514786531;3506.8246587670515;3548.1484443733316;3149.8110113392813;3158.463061279588;3217.8069315841126;3237.190702324419;3238.239013831748;4198.895027624334;4219.599138081878;4222.894427639272;4256.851010214689;4264.445622069111;4309.525952145262;4375.824967001285;4388.473383193973;4469.709468884512;4473.060657261946;4195.643370313557;4201.495820501559;4233.703640745119;4255.468066491689;4298.075913678574;3976.5824588418377;3991.1219531702977;4030.6976976726864;4045.8786236412957;4101.794910254475;4314.094040251583;4506.59440650343;4513.887152821206;4521.909561808811;4545.954540454619;4474.619657329164;4475.619572336258;4480.14877173336;4503.752293623882;4519.79660915253;4565;4615.861524154281;4637.837675681335;4661.510541393105;4716.504766999416;4286.59277368662;4287.785610719514;4391.626711729538;4404.031113155101;4435.578620031092;4484.977575112103;4486.64106871456;4510.8421205257655;4567.748773817472;4611.377464042312;4299.462567179103;4382.912341753084;4451.621612163002;4459.420275364182;4522.796474158737;4078.8368465261055;4228.2811921972725;4234.195502854448;4258.467691538558;4354.934675979799;4255.851045213402;4288.292431748727;4339.7396156230725;4341.261985462415;4357.71674841147;4375.299952007664;4413.2276851550205;4418.315161149898;4454.665900057444;4485.6187224085015;4144.689148313828;4214.726042807208;4218.7468751874985;4221.66226701857;4339.587739164775 14:16:50 INFO - 2015-11-17 14:16:50,578 DEBUG : BROWSER_OUTPUT: |1;ext.html;468.348994897093;468.60168856472;471.83485779977013;481.1555719711905;511.6111755066151;25637.74362256377;31445.371092578163;32070.67929320709;32135.03594892151;32325.353492930128;31413.685863141363;31481;31636.096405057255;31705.207369815766;31986.84006579964;6693.531452798306;6873.896891546631;7335.303146201116;7430.962845185766;7521.548707077565;6850.794476165723;8771;9042.095790420972;9130.04134565871;9156.771080722969;8874.86687699685;9078.86381704275;9090.954545227298;9092.454452732823;9118.452892826452;6868.278830722802;6931.41083007945;7025.82435439113;8723.738287851374;9105.772355691128;9007.45955242681;9018.503982280972;9039;9184.265258779282;9188.494632795193;32098.19754506156;32287.677123228936;32514.349713005842;32661;32696;2323.3494621506006;2373.964390534143;2756.1593713917246;2819.970710690583;2822.3085344090828;22143.557128857334;22693;22888.656670149794;23120.190793322323;23420.64869026966;1858.4424672598166;1916.7891531931477;1932.7100934859743;1935.6612592796205;1953.1308567687386;213737;215950;216017;217288;218044;43374;45709;46386.30420543694;46745.29882051772;46876.296855547196;41015.38476922848;52460.21309680358;53796.46203537915;54084.18873716897;54724.45275547273;13091.018173637016;13405.664858378423;13409.66475838112;13672.93163534176;13681.521146759816;10045.296829221885;10291.43397113151;10310.43292618913;10342.172626189888;10351.275410721177;15140.621484462976;15172.089674619558;15175.317110730044;15340;15373.692526149638;6483.124778154889;6669.799906002828;6706.41802905875;6723.5293529452465;6845.691943862538;766.8197973476229;828.3083625173048;872.1104473437059;884.8982367027745;908.927285817133;23135.305940821465;23276.883615582152;23348.299551013497;23433;23659;833.1418638802044;871.1245198575391;900.9144131307515;953.9236861051099;996.5714742660725;11778.52885884555;12118.575849845212;12178.81731774024;12305.077119216094;12345.506179752709;257523;261978;262246;262635;262743;42155.57844421578;43194.784026079666;43690.34464483035;43775;43874.561254387045;1060.0989159214605;1080.9135269178605;1098.2586753940898;1120.9047230985295;1160.7678464307003;20203;22555.548889022455;23222;23528.529429410974;23546.293611191693;34750.82624586962;34862.30275394427;34878.82560587181;34899.12752181216;35306;208863;209729;210162;210362;216626;21511.78488215098;21801.56396872022;25445.618315724907;25708.228753137435;26092.217233483025;31349.686503134675;31596.210094747814;31772.29935455512;33279.334413312085;34056.829715851265;26974.595381069692;28086.85956570204;28201.858990704914;29221.85389073126;29319.120426387242;20715.896420518406;25816.8709156453;28292;28322.43355132927;28589.857050714614;25981.870090649427;26371.736282636928;27150.864245679437;27192.960527960087;27523.31191720223;22925;23750;23905.641415378435;24213.152539661027;24326;18370.908145459187;18515.722264166317;18723.157457914698;18866.811331887053;19759.40721778349 14:16:50 INFO - 2015-11-17 14:16:50,580 DEBUG : BROWSER_OUTPUT: |2;jquery.html;272.15631542219126;274.1064130933158;275.89791777042495;278.35421821374405;282.38299315994544;8681.826363472743;11339.546418143285;13854.376553055112;14173.787393189097;14349.067310624816;12564.748705025893;12752.234865908053;14781.852181478209;15161.317740701666;15401.537953861374;4498.97750511247;4692.648051396159;4734.431868175824;4738.099761045408;4753.3107699383745;3348.363810875926;3436.690697837194;4587.472440669316;4649.418822647169;4718.764061796896;3414.9487757683532;4993.425756038066;5117.8464646060675;5128.282040514331;5184.066867963765;3763.266163098197;5056.115179843531;5113.821016264413;5153.819616313411;5165.974170129125;3145.1665308692986;3297.670232976707;3321.717653999413;3326.550915626408;3338.0319707284857;10593.84109238362;10635.734106647318;10761.246712730112;10774.78450430987;10984.286021408583;1352.4928151943022;1412.272679570012;1486.308866377129;1530.3954937799506;1530.97353959088;7782.455228134033;7995;8155;8199.71301004468;8301.66793328266;1228.2569045727384;1261.735035642516;1310.096033736728;1341.7920222365549;1344.0390121063488;47217;48160.75919620415;48610.270845937695;49118;49653.75173124147;5304.336957880265;5328.3605967284175;5368.91946620801;5464.098423760035;5465.098258787335;6156.445919867144;6159.81520554384;6232.220972378453;6247.250329960434;6267.9971204607955;4485.865424037284;4527.7509736964785;4546.590806827401;4565.6119229865835;4592.517785632527;4815.518448155157;4864.683795553277;4897.191963326082;4925.187344088257;4931.16170251051;2378.9286321410386;2400.819938504619;2422.6608274841537;2459.6187590923078;2461.5476868647584;865.2385900407601;865.467737341543;884.6903583745766;895.3106108296705;907.677774390082;337.55779928294015;356.02449288948094;359.0664272890464;359.22586825391323;369.2375245118821;9677.419354838732;9974.301798874008;10022.298439109338;10059.245556583286;10140.746481338025;301.749547875263;311.4254200999153;326.23823372425653;373.30937765134286;385.22954091816365;3754.342989976743;4257.74453532789;4673.929891051637;4721.102990431807;4860.562549370574;421379;424712;468010;476967;477923;58658;62617.68691156515;62909.37090629127;63192.684036580446;63855;365.54124573659885;368.0761289164164;372.63854061560244;373.2423180942691;376.89446954853236;8419.579021049045;8496.872546911678;8529.104444033535;8624.827503450022;8715.869261961203;28228.85885570559;28851.134465966054;29105;29321.413571728874;29417.705822941498;38426.807865960494;38951;38971.80514097412;39015;39161.608383915795;6298.622082675054;6458.38645328693;6537.117489139096;6564.376384243489;6593.769218077345;9603.759906002406;9784.706458806248;9811.215102791617;10035.949820250851;10053.095221429814;7213.278672132745;8323.625436855476;8499.91752020759;8504.107068757692;8626.051134375339;8136.633851476579;8179.468334558234;8266.793330166794;8302.377321700777;8550.700725474579;8163.469374490639;8386.32909367237;8449.11284315138;8494.320454363513;8593.914060859312;5633.4084921082695;5790.884182316414;5864.530837532901;6254.4996400286955;6437.806865794034;8046.476978996347;8218.794530136794;8368.832623347376;8537.359698022548;8576 14:16:50 INFO - 2015-11-17 14:16:50,584 DEBUG : BROWSER_OUTPUT: |3;mootools.html;591.8549955260962;1117.3686866920189;1167.4746364136138;1167.7897978363892;1381.7443772902009;5136.768845401956;5344.171653393731;5421.484958928901;5438;5485.506304432601;5342.813001544947;5651.886962260753;5792.623479473831;5799.159121927329;5899.970500147504;1695.5506790700474;1750.046224807483;1750.982490175101;1773.3172728499492;1778.5286898971783;1745.2844333823134;1749.2653085704035;1771.681097402467;1771.8848274862157;1772;1720.2344956494364;1721.8019927708285;1724.956876078102;1738.582740142363;1764.4442000769716;1662.950111496651;1677.7567252748345;1682.0832646207846;1716.7682362880976;1720.9483715488554;1701.3449821818565;1723.2245489529637;1729.6713624411323;1746.5284373219288;1759.9560010999828;5618.63478873876;5729.742161602738;5784.710764461802;5785.305763308388;5799.159121927339;3135.498320268769;3297.1262615406936;3532.6467353264725;3656.8537258509627;3662.047867554428;1984.4344361856945;2125.447383680239;2134.114342547841;2136.3484137338105;2154.601398741238;696.7352406085706;712.9465290103211;732.6995931667991;733.4719002318323;742.3986570877606;6970.825729356756;7137.8215544611285;7265.346118849276;7298.81752956175;7317.926820731778;2865.7134286571177;3035.165329534396;3153.4008538377634;3214.8874789382257;3271.2312606537444;6499.642519661369;6511.218653761579;6516.152900122954;6518.902216466757;6626.171728533934;3637.0907273181706;3640.162762564625;3667.339878821784;3685.1339935115225;3710.257948410275;3330;3337.2824842658947;3357.0096821437246;3387.966120338765;3394.2702319001532;2811.831290122599;2830.504661684197;2898.4927637663322;2908.0984894682715;2915.02346713849;919.9218066464425;931.5063016601213;932.9253659707207;940.0176815228103;944.6740874398322;795.7374066558021;806.6894245715324;807.1524898856178;820.2003047029099;937.7327461673391;5416.593755468356;5464.863378415572;5476.370217424967;5501.229827824028;5552.028395030853;332.7038935347543;338.73747845419996;340.44507452851695;344.3869911557432;344.7603915278907;4365.192439398721;4369.235383807821;4369.825206991748;4436.0240747035605;4437.800298986489;6256;6398.808035758934;6408.67956602168;6428.614283143026;6448.226212854487;6375.776847810397;6383.840403989844;6520.250171230275;6681.532292739462;6752.459803215731;5379.408265090837;5397.973010135002;5398.946010539923;5422.91865622016;5427.240186373911;5477.808276710455;5524.558035357242;5530.446955304437;5562.860928476821;5586.441355864381;6179.721912513858;6205.2553693557065;6218.4092511213175;6227.626342419469;6280.434760871543;6159.19930409044;6293.244810622755;6339.302676705466;6367.840803979938;6390.968045159744;4424.026714122888;4552.931706024478;4602.194615942263;4687.460941991714;5135.948640513547;5498.257735205856;5503.834884953458;5517.089680202722;5578.163275508706;5589.965856316594;5163.302954101148;5184.274201611702;5225.216217567396;5292.41783403833;5365.114756065205;5144.717040562805;5185.0148471791745;5230.790768369223;5266.052110620125;5276.657017293864;5261.473852614861;5287.841364759063;5294.655847369909;5309.57523398135;5329.227262046904;4806.014766972832;4828.589569886599;4846.982133751811;4876.634252431153;4894.19245824435;4932.580730637936;4943.629227807857;4945.060438516671;4953.603711702983;4959.851204463872 14:16:50 INFO - 2015-11-17 14:16:50,585 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.67408206372747;256.3181936050107;263.1028193858941;265.658628662169;266.9666291713536;5143.871403214916;5146.614003949705;5176.327077479927;5186.533212010918;5229.686218826873;4961.553460188582;5018.899622007567;5051.84844454666;5057.949420505794;5107.948920510794;3922.8823135305843;3927.70542209334;3941.625545573166;3943.0142464383903;3943.940840887389;3871.6709079728257;3906.1211227473877;3908.863189788358;3930.0764320384687;3948.3879998600264;3847.1728578355646;3864.188520410717;3896.844126234947;3899.161680238748;3912;3795.4865023883685;3858.9228215435674;3918.7648741075627;3921.058945852989;3924.4113382992496;3286.901392958191;3309.12308238317;3312.3540909522653;3320.2031512436843;3357.345317663057;4935.161022626162;4976.303317535548;4981.327520784684;4988.152014157602;4997.325361076281;4322.783860806979;4333.58830911063;4373.409589705413;4382.320740285261;4382.422327961931;5279.340082489689;5295.443978382253;5339.65292256006;5341.839744807662;5354.384245811742;3430.5368775215275;3524.2775231077567;3601.1717305019993;3623.6411345745346;3638.0904773806546;5377.085895397791;5584.441555844423;5629.071203251458;5679.233303504016;5758.79844205455;3519.454484554898;3523.136831476305;3523.2953409317724;3554.147004718849;3554.4668299755244;3566.7146628269675;3568.4825700273836;3585.8744943926836;3685.981570092132;3696.0205545530457;4097.057676734368;4211.7051806373875;4320.827166913351;4321.330193819963;4328.069465065026;5218.373795144607;5304.363476382781;5359.035373632705;5467.097928841697;5479.369872464717;1272.5736878145924;1297.331874084847;1302.0690206502397;1315.7039666075248;1320.5972178485654;819.5697258938985;820.7045463633087;828.0766944856442;831.3141658132065;836.4145098431122;5136.948630513647;5205.531502164823;5209.609279304067;5213.2701421800975;5246.265522826808;5593.272874526286;5616.5787565932715;5659.886802263932;5701.2018317435595;5707.600467967202;5120.590352771769;5208.062548741263;5218.7912483500995;5237.135872580981;5241.50205730455;2971.1977766003056;2975.1372102090586;3026.4552380571267;3059.816411015346;3067.6778938211614;5855.414458554111;5897.52819774417;5905.498032667271;5923.466887980103;5970.701464926737;5813.244278243886;5827.24245848037;5871.383504731942;5873.794417195378;5912.556558258148;5910.290765108129;5913.674747888821;5915.142304365929;5940.881182376242;5983.192269043623;5547.697705452353;5663.66018038919;5697.4302569742695;5698.176583493242;5749.367569567261;5601.7759289629585;5608.214849921096;5623.718814059199;5641.605087643826;5648.068068768607;5926.407359264039;5932.080527518242;5948.672822994604;6004.0093384591055;6013.037913933749;3570.339487194877;3600.3339382214376;3634.745567810228;3648.0150359402282;3711.684506816951;5463.918041229305;5593.636413633101;5613.550915926798;5621.353544342453;5688.943110569007;5352.705601191972;5432.728363581884;5491.36849262324;5533.944660553504;5566.415526369673;5508.283923089973;5510.724463776715;5511.311086114236;5526.447355264441;5536.307961504812;5182.144946083854;5380.623356365017;5411.2153737708595;5439.265699130567;5449.291592093003;5428.83713488596;5480.671159730429;5506.889862202814;5520.66875987442;5545.2513910623165;5321.6540924839765;5398.2982212312145;5402.702851343214;5438.564914806727;5444.156155795858 14:16:50 INFO - 2015-11-17 14:16:50,586 DEBUG : BROWSER_OUTPUT: |5;yui.html;494.90844193824137;516.8139469790875;541.3503795445466;580.5529742098585;601.6510423954107;10839.241253112275;11360.147988900824;11408.486618102184;11437.542498300068;11462.828057579143;10040.2469814764;10225.335353202056;10682.412467314294;10793.406362650052;10799.730006749835;721.2643104033896;739.367840496376;741.2883631713562;744.2817680937894;746.2239271158016;726.7529040126356;734.9412047036225;738.1105767550089;744.5458270455018;751.2825251884465;776.7397921696239;780.5706861226331;790.4940837863771;791.0309870408761;796.8326651403183;721.293132729925;768.3622593247591;768.8001119708888;774.380495603515;778.264540009691;567.8949394362015;568.3833041150357;573.8307199376194;574.4829653312053;581.8487193329722;10287.948560257151;10389.480525973671;10432.269741118125;10533.210009249337;10548.103411210057;7649.158592554814;7906.604669766489;8291.626876790559;8708.477491350475;8743.912560874436;7216.386607138399;7419.501405511195;7463.067116610424;7494.775156745306;7633.160352361236;2348.518553696488;2382.5234953009294;2402.3513651314224;2460.980827127233;2547.942603819413;38381.232375352614;38914;39402.21195576101;39799.60200397988;39801;4949.307097006422;5072.112380333427;5075.0357432087785;5228.581713462914;5308.964751873347;9550.426974381558;9678.370905891095;9699.321047526606;9710;9727;4825.613950883921;4855.6115510759055;4859.757012149378;5013.523715247045;5044.848654540297;3001.8348990805716;3050.23744063984;3070.7082827131385;3085.6451508076857;3094.8607312670983;2100.2964007057503;2124.2034237161065;2125.2136709417614;2132.6907598398147;2149.548594795079;322.76922000769565;325.4239995208515;326.23497897430485;327.61178004064783;327.8262520863946;360.4971065363855;366.4448360733491;488.3651253370604;511.88482591416636;523.2517499974996;5575;5964.731587078505;6023.969880150571;6067.271927368655;6077.604955677867;443.7751805018173;460.88938654723296;476.25703901913124;490.9656324057282;494.7056501381672;3036.8937087201843;3154.492308306262;3201.487761958122;3241.6434192238835;3279.8032118072992;44372.11255774867;45131.54868451274;49894.75052624714;50353.24470132951;51222.74388628033;35072;36151.4577281341;38650.80674596609;39068.41397379042;39185.60814391877;31763.20591985219;36098.819505902306;36523;37401.81299093487;38589.42115868264;6273.560850740404;6687;6885.414739747178;7004.194517630538;7109.376169962045;28807.279818004718;29707.702922970493;29806.10581682553;30066.24834379158;30102.548461772654;36045.45931811077;36348.818255908554;36405.27189456249;37056.629433706396;39784.20431591294;5374.435684253097;6368.936310636835;6386.489080873612;6521.152250207443;6655.334466553306;9120.635174593208;9167.404118732527;9400.905990940004;9568.09103135201;9688.982656820932;8707.172818582225;8740.519271440131;8907.821843562962;8953.552322383985;9091.681791137278;8758.386912916034;9033.728988130366;9077;9194.816103678022;9330.300227483101;8675.91324086751;8961.775955601162;8977.057408972225;8988.235999940078;9056.773580660536;7099.893501597583;7179.174394944648;7298.635068246673;7305.853882922418;7664.555519213477;7632.809179770328;7756.961215193888;7759.844803104019;7860.5283682976915;8077.596120193849 14:16:50 INFO - 2015-11-17 14:16:50,586 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:16:50 INFO - 2015-11-17 14:16:50,586 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:16:50 INFO - 2015-11-17 14:16:50,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 14:16:50 INFO - 2015-11-17 14:16:50,587 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:16:50 INFO - 2015-11-17 14:16:50,587 DEBUG : BROWSER_OUTPUT: __startTimestamp1447798610571__endTimestamp 14:16:50 INFO - 2015-11-17 14:16:50,587 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,587 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:16:50 INFO - 2015-11-17 14:16:50,587 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:16:50 INFO - 2015-11-17 14:16:50,588 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,588 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4157.19 Median:4286.59 stddev:423.79 (9.9%) stddev-sans-first:404.80 14:16:50 INFO - 2015-11-17 14:16:50,589 DEBUG : BROWSER_OUTPUT: Values: 2505.5 2525.0 2552.0 2571.2 2612.6 4015.7 4052.5 4148.0 4154.1 4197.5 4137.5 4155.6 4158.6 4304.3 4332.8 3837.4 3936.8 3945.7 3947.6 4013.7 3701.2 3899.4 3950.9 3968.6 4017.2 3774.2 3806.0 3876.7 3888.2 3894.1 3715.1 3809.1 3848.3 3900.4 3903.2 3796.5 3817.8 3846.3 3888.3 3943.5 4015.6 4176.4 4177.3 4203.8 4273.3 4294.1 4341.2 4346.8 4351.5 4448.9 4407.5 4456.3 4486.4 4498.0 4580.3 3960.1 4086.1 4142.1 4150.4 4209.5 4436.1 4494.3 4515.6 4538.6 4569.2 4359.5 4395.3 4402.4 4434.6 4488.5 4227.7 4341.6 4518.8 4580.0 4582.1 4332.9 4348.0 4351.7 4383.1 4395.6 4321.8 4324.7 4345.8 4359.0 4368.6 3389.1 3450.1 3499.8 3506.8 3548.1 3149.8 3158.5 3217.8 3237.2 3238.2 4198.9 4219.6 4222.9 4256.9 4264.4 4309.5 4375.8 4388.5 4469.7 4473.1 4195.6 4201.5 4233.7 4255.5 4298.1 3976.6 3991.1 4030.7 4045.9 4101.8 4314.1 4506.6 4513.9 4521.9 4546.0 4474.6 4475.6 4480.1 4503.8 4519.8 4565.0 4615.9 4637.8 4661.5 4716.5 4286.6 4287.8 4391.6 4404.0 4435.6 4485.0 4486.6 4510.8 4567.7 4611.4 4299.5 4382.9 4451.6 4459.4 4522.8 4078.8 4228.3 4234.2 4258.5 4354.9 4255.9 4288.3 4339.7 4341.3 4357.7 4375.3 4413.2 4418.3 4454.7 4485.6 4144.7 4214.7 4218.7 4221.7 4339.6 14:16:50 INFO - 2015-11-17 14:16:50,589 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,590 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36550.03 Median:15557.15 stddev:60235.89 (387.2%) stddev-sans-first:60343.95 14:16:50 INFO - 2015-11-17 14:16:50,591 DEBUG : BROWSER_OUTPUT: Values: 468.3 468.6 471.8 481.2 511.6 25637.7 31445.4 32070.7 32135.0 32325.4 31413.7 31481.0 31636.1 31705.2 31986.8 6693.5 6873.9 7335.3 7431.0 7521.5 6850.8 8771.0 9042.1 9130.0 9156.8 8874.9 9078.9 9091.0 9092.5 9118.5 6868.3 6931.4 7025.8 8723.7 9105.8 9007.5 9018.5 9039.0 9184.3 9188.5 32098.2 32287.7 32514.3 32661.0 32696.0 2323.3 2374.0 2756.2 2820.0 2822.3 22143.6 22693.0 22888.7 23120.2 23420.6 1858.4 1916.8 1932.7 1935.7 1953.1 213737.0 215950.0 216017.0 217288.0 218044.0 43374.0 45709.0 46386.3 46745.3 46876.3 41015.4 52460.2 53796.5 54084.2 54724.5 13091.0 13405.7 13409.7 13672.9 13681.5 10045.3 10291.4 10310.4 10342.2 10351.3 15140.6 15172.1 15175.3 15340.0 15373.7 6483.1 6669.8 6706.4 6723.5 6845.7 766.8 828.3 872.1 884.9 908.9 23135.3 23276.9 23348.3 23433.0 23659.0 833.1 871.1 900.9 953.9 996.6 11778.5 12118.6 12178.8 12305.1 12345.5 257523.0 261978.0 262246.0 262635.0 262743.0 42155.6 43194.8 43690.3 43775.0 43874.6 1060.1 1080.9 1098.3 1120.9 1160.8 20203.0 22555.5 23222.0 23528.5 23546.3 34750.8 34862.3 34878.8 34899.1 35306.0 208863.0 209729.0 210162.0 210362.0 216626.0 21511.8 21801.6 25445.6 25708.2 26092.2 31349.7 31596.2 31772.3 33279.3 34056.8 26974.6 28086.9 28201.9 29221.9 29319.1 20715.9 25816.9 28292.0 28322.4 28589.9 25981.9 26371.7 27150.9 27193.0 27523.3 22925.0 23750.0 23905.6 24213.2 24326.0 18370.9 18515.7 18723.2 18866.8 19759.4 14:16:50 INFO - 2015-11-17 14:16:50,591 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,591 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22409.17 Median:25975.72 stddev:74462.12 (286.7%) stddev-sans-first:74652.45 14:16:50 INFO - 2015-11-17 14:16:50,593 DEBUG : BROWSER_OUTPUT: Values: 272.2 274.1 275.9 278.4 282.4 8681.8 11339.5 13854.4 14173.8 14349.1 12564.7 12752.2 14781.9 15161.3 15401.5 4499.0 4692.6 4734.4 4738.1 4753.3 3348.4 3436.7 4587.5 4649.4 4718.8 3414.9 4993.4 5117.8 5128.3 5184.1 3763.3 5056.1 5113.8 5153.8 5166.0 3145.2 3297.7 3321.7 3326.6 3338.0 10593.8 10635.7 10761.2 10774.8 10984.3 1352.5 1412.3 1486.3 1530.4 1531.0 7782.5 7995.0 8155.0 8199.7 8301.7 1228.3 1261.7 1310.1 1341.8 1344.0 47217.0 48160.8 48610.3 49118.0 49653.8 5304.3 5328.4 5368.9 5464.1 5465.1 6156.4 6159.8 6232.2 6247.3 6268.0 4485.9 4527.8 4546.6 4565.6 4592.5 4815.5 4864.7 4897.2 4925.2 4931.2 2378.9 2400.8 2422.7 2459.6 2461.5 865.2 865.5 884.7 895.3 907.7 337.6 356.0 359.1 359.2 369.2 9677.4 9974.3 10022.3 10059.2 10140.7 301.7 311.4 326.2 373.3 385.2 3754.3 4257.7 4673.9 4721.1 4860.6 421379.0 424712.0 468010.0 476967.0 477923.0 58658.0 62617.7 62909.4 63192.7 63855.0 365.5 368.1 372.6 373.2 376.9 8419.6 8496.9 8529.1 8624.8 8715.9 28228.9 28851.1 29105.0 29321.4 29417.7 38426.8 38951.0 38971.8 39015.0 39161.6 6298.6 6458.4 6537.1 6564.4 6593.8 9603.8 9784.7 9811.2 10035.9 10053.1 7213.3 8323.6 8499.9 8504.1 8626.1 8136.6 8179.5 8266.8 8302.4 8550.7 8163.5 8386.3 8449.1 8494.3 8593.9 5633.4 5790.9 5864.5 6254.5 6437.8 8046.5 8218.8 8368.8 8537.4 8576.0 14:16:50 INFO - 2015-11-17 14:16:50,593 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,593 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:3993.34 Median:5246.13 stddev:2028.17 (38.7%) stddev-sans-first:2017.73 14:16:50 INFO - 2015-11-17 14:16:50,594 DEBUG : BROWSER_OUTPUT: Values: 591.9 1117.4 1167.5 1167.8 1381.7 5136.8 5344.2 5421.5 5438.0 5485.5 5342.8 5651.9 5792.6 5799.2 5900.0 1695.6 1750.0 1751.0 1773.3 1778.5 1745.3 1749.3 1771.7 1771.9 1772.0 1720.2 1721.8 1725.0 1738.6 1764.4 1663.0 1677.8 1682.1 1716.8 1720.9 1701.3 1723.2 1729.7 1746.5 1760.0 5618.6 5729.7 5784.7 5785.3 5799.2 3135.5 3297.1 3532.6 3656.9 3662.0 1984.4 2125.4 2134.1 2136.3 2154.6 696.7 712.9 732.7 733.5 742.4 6970.8 7137.8 7265.3 7298.8 7317.9 2865.7 3035.2 3153.4 3214.9 3271.2 6499.6 6511.2 6516.2 6518.9 6626.2 3637.1 3640.2 3667.3 3685.1 3710.3 3330.0 3337.3 3357.0 3388.0 3394.3 2811.8 2830.5 2898.5 2908.1 2915.0 919.9 931.5 932.9 940.0 944.7 795.7 806.7 807.2 820.2 937.7 5416.6 5464.9 5476.4 5501.2 5552.0 332.7 338.7 340.4 344.4 344.8 4365.2 4369.2 4369.8 4436.0 4437.8 6256.0 6398.8 6408.7 6428.6 6448.2 6375.8 6383.8 6520.3 6681.5 6752.5 5379.4 5398.0 5398.9 5422.9 5427.2 5477.8 5524.6 5530.4 5562.9 5586.4 6179.7 6205.3 6218.4 6227.6 6280.4 6159.2 6293.2 6339.3 6367.8 6391.0 4424.0 4552.9 4602.2 4687.5 5135.9 5498.3 5503.8 5517.1 5578.2 5590.0 5163.3 5184.3 5225.2 5292.4 5365.1 5144.7 5185.0 5230.8 5266.1 5276.7 5261.5 5287.8 5294.7 5309.6 5329.2 4806.0 4828.6 4847.0 4876.6 4894.2 4932.6 4943.6 4945.1 4953.6 4959.9 14:16:50 INFO - 2015-11-17 14:16:50,595 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,595 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4518.96 Median:5215.82 stddev:1423.84 (27.3%) stddev-sans-first:1391.35 14:16:50 INFO - 2015-11-17 14:16:50,596 DEBUG : BROWSER_OUTPUT: Values: 251.7 256.3 263.1 265.7 267.0 5143.9 5146.6 5176.3 5186.5 5229.7 4961.6 5018.9 5051.8 5057.9 5107.9 3922.9 3927.7 3941.6 3943.0 3943.9 3871.7 3906.1 3908.9 3930.1 3948.4 3847.2 3864.2 3896.8 3899.2 3912.0 3795.5 3858.9 3918.8 3921.1 3924.4 3286.9 3309.1 3312.4 3320.2 3357.3 4935.2 4976.3 4981.3 4988.2 4997.3 4322.8 4333.6 4373.4 4382.3 4382.4 5279.3 5295.4 5339.7 5341.8 5354.4 3430.5 3524.3 3601.2 3623.6 3638.1 5377.1 5584.4 5629.1 5679.2 5758.8 3519.5 3523.1 3523.3 3554.1 3554.5 3566.7 3568.5 3585.9 3686.0 3696.0 4097.1 4211.7 4320.8 4321.3 4328.1 5218.4 5304.4 5359.0 5467.1 5479.4 1272.6 1297.3 1302.1 1315.7 1320.6 819.6 820.7 828.1 831.3 836.4 5136.9 5205.5 5209.6 5213.3 5246.3 5593.3 5616.6 5659.9 5701.2 5707.6 5120.6 5208.1 5218.8 5237.1 5241.5 2971.2 2975.1 3026.5 3059.8 3067.7 5855.4 5897.5 5905.5 5923.5 5970.7 5813.2 5827.2 5871.4 5873.8 5912.6 5910.3 5913.7 5915.1 5940.9 5983.2 5547.7 5663.7 5697.4 5698.2 5749.4 5601.8 5608.2 5623.7 5641.6 5648.1 5926.4 5932.1 5948.7 6004.0 6013.0 3570.3 3600.3 3634.7 3648.0 3711.7 5463.9 5593.6 5613.6 5621.4 5688.9 5352.7 5432.7 5491.4 5533.9 5566.4 5508.3 5510.7 5511.3 5526.4 5536.3 5182.1 5380.6 5411.2 5439.3 5449.3 5428.8 5480.7 5506.9 5520.7 5545.3 5321.7 5398.3 5402.7 5438.6 5444.2 14:16:50 INFO - 2015-11-17 14:16:50,596 DEBUG : BROWSER_OUTPUT: 14:16:50 INFO - 2015-11-17 14:16:50,596 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10618.11 Median:2916.11 stddev:12962.28 (444.5%) stddev-sans-first:12976.35 14:16:50 INFO - 2015-11-17 14:16:50,598 DEBUG : BROWSER_OUTPUT: Values: 494.9 516.8 541.4 580.6 601.7 10839.2 11360.1 11408.5 11437.5 11462.8 10040.2 10225.3 10682.4 10793.4 10799.7 721.3 739.4 741.3 744.3 746.2 726.8 734.9 738.1 744.5 751.3 776.7 780.6 790.5 791.0 796.8 721.3 768.4 768.8 774.4 778.3 567.9 568.4 573.8 574.5 581.8 10287.9 10389.5 10432.3 10533.2 10548.1 7649.2 7906.6 8291.6 8708.5 8743.9 7216.4 7419.5 7463.1 7494.8 7633.2 2348.5 2382.5 2402.4 2461.0 2547.9 38381.2 38914.0 39402.2 39799.6 39801.0 4949.3 5072.1 5075.0 5228.6 5309.0 9550.4 9678.4 9699.3 9710.0 9727.0 4825.6 4855.6 4859.8 5013.5 5044.8 3001.8 3050.2 3070.7 3085.6 3094.9 2100.3 2124.2 2125.2 2132.7 2149.5 322.8 325.4 326.2 327.6 327.8 360.5 366.4 488.4 511.9 523.3 5575.0 5964.7 6024.0 6067.3 6077.6 443.8 460.9 476.3 491.0 494.7 3036.9 3154.5 3201.5 3241.6 3279.8 44372.1 45131.5 49894.8 50353.2 51222.7 35072.0 36151.5 38650.8 39068.4 39185.6 31763.2 36098.8 36523.0 37401.8 38589.4 6273.6 6687.0 6885.4 7004.2 7109.4 28807.3 29707.7 29806.1 30066.2 30102.5 36045.5 36348.8 36405.3 37056.6 39784.2 5374.4 6368.9 6386.5 6521.2 6655.3 9120.6 9167.4 9400.9 9568.1 9689.0 8707.2 8740.5 8907.8 8953.6 9091.7 8758.4 9033.7 9077.0 9194.8 9330.3 8675.9 8961.8 8977.1 8988.2 9056.8 7099.9 7179.2 7298.6 7305.9 7664.6 7632.8 7757.0 7759.8 7860.5 8077.6 14:16:50 INFO - 2015-11-17 14:16:50,598 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:16:50 INFO - 2015-11-17 14:16:50,598 DEBUG : BROWSER_OUTPUT: 14:16:51 INFO - 2015-11-17 14:16:51,310 INFO : Browser exited with error code: 0 14:16:51 INFO - 2015-11-17 14:16:51,343 INFO : Completed test dromaeo_css (00:18:36) 14:16:51 INFO - 2015-11-17 14:16:51,343 INFO : Starting test kraken 14:16:51 INFO - 2015-11-17 14:16:51,343 DEBUG : operating with platform_type : mac_ 14:16:51 INFO - 2015-11-17 14:16:51,343 INFO : Initialising browser for kraken test... 14:16:51 INFO - 2015-11-17 14:16:51,358 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpJ_Eh0S/profile http://localhost:49252/getInfo.html 14:16:53 INFO - 2015-11-17 14:16:53,954 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:16:53 INFO - 2015-11-17 14:16:53,954 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:16:53 INFO - 2015-11-17 14:16:53,954 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:16:53 INFO - 2015-11-17 14:16:53,954 DEBUG : BROWSER_OUTPUT: __metrics 14:16:53 INFO - 2015-11-17 14:16:53,974 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:54 INFO - 2015-11-17 14:16:54,812 INFO : Browser initialized. 14:16:54 INFO - 2015-11-17 14:16:54,812 INFO : Running cycle 1/1 for kraken test... 14:16:54 INFO - 2015-11-17 14:16:54,812 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpJ_Eh0S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:17:07 INFO - 2015-11-17 14:17:07,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 229269504 14:17:07 INFO - 2015-11-17 14:17:07,020 DEBUG : BROWSER_OUTPUT: 14:17:10 INFO - 2015-11-17 14:17:10,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:10 INFO - 2015-11-17 14:17:10,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 286408704 14:17:10 INFO - 2015-11-17 14:17:10,604 DEBUG : BROWSER_OUTPUT: 14:17:13 INFO - 2015-11-17 14:17:13,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 14:17:14 INFO - 2015-11-17 14:17:14,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 297930752 14:17:14 INFO - 2015-11-17 14:17:14,309 DEBUG : BROWSER_OUTPUT: 14:17:17 INFO - 2015-11-17 14:17:17,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 14:17:18 INFO - 2015-11-17 14:17:18,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 284700672 14:17:18 INFO - 2015-11-17 14:17:18,309 DEBUG : BROWSER_OUTPUT: 14:17:20 INFO - 2015-11-17 14:17:20,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 14:17:21 INFO - 2015-11-17 14:17:21,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 285552640 14:17:21 INFO - 2015-11-17 14:17:21,215 DEBUG : BROWSER_OUTPUT: 14:17:23 INFO - 2015-11-17 14:17:23,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:24 INFO - 2015-11-17 14:17:24,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 285900800 14:17:24 INFO - 2015-11-17 14:17:24,303 DEBUG : BROWSER_OUTPUT: 14:17:27 INFO - 2015-11-17 14:17:27,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:28 INFO - 2015-11-17 14:17:28,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 282439680 14:17:28 INFO - 2015-11-17 14:17:28,459 DEBUG : BROWSER_OUTPUT: 14:17:32 INFO - 2015-11-17 14:17:32,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 14:17:32 INFO - 2015-11-17 14:17:32,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 282492928 14:17:32 INFO - 2015-11-17 14:17:32,763 DEBUG : BROWSER_OUTPUT: 14:17:36 INFO - 2015-11-17 14:17:36,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 14:17:36 INFO - 2015-11-17 14:17:36,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 284311552 14:17:36 INFO - 2015-11-17 14:17:36,649 DEBUG : BROWSER_OUTPUT: 14:17:38 INFO - 2015-11-17 14:17:38,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:39 INFO - 2015-11-17 14:17:39,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 317571072 14:17:39 INFO - 2015-11-17 14:17:39,029 DEBUG : BROWSER_OUTPUT: 14:17:41 INFO - 2015-11-17 14:17:41,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:41 INFO - 2015-11-17 14:17:41,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 319410176 14:17:41 INFO - 2015-11-17 14:17:41,728 DEBUG : BROWSER_OUTPUT: 14:17:44 INFO - 2015-11-17 14:17:44,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:44 INFO - 2015-11-17 14:17:44,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 326238208 14:17:44 INFO - 2015-11-17 14:17:44,734 DEBUG : BROWSER_OUTPUT: 14:17:47 INFO - 2015-11-17 14:17:47,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:48 INFO - 2015-11-17 14:17:48,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 328052736 14:17:48 INFO - 2015-11-17 14:17:48,351 DEBUG : BROWSER_OUTPUT: 14:17:51 INFO - 2015-11-17 14:17:51,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:17:51 INFO - 2015-11-17 14:17:51,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 328339456 14:17:51 INFO - 2015-11-17 14:17:51,972 DEBUG : BROWSER_OUTPUT: 14:17:53 INFO - 2015-11-17 14:17:53,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 14:17:54 INFO - 2015-11-17 14:17:54,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 387104768 14:17:54 INFO - 2015-11-17 14:17:54,206 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,206 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:17:54 INFO - 2015-11-17 14:17:54,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:17:54 INFO - 2015-11-17 14:17:54,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:17:54 INFO - 2015-11-17 14:17:54,206 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:17:54 INFO - 2015-11-17 14:17:54,206 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;135;133;134;137;136;134;135;134;145 14:17:54 INFO - 2015-11-17 14:17:54,207 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;189;165;194;222;158;185;180;161;206;156 14:17:54 INFO - 2015-11-17 14:17:54,207 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;196;197;195;196;197;198;198;188;193 14:17:54 INFO - 2015-11-17 14:17:54,207 DEBUG : BROWSER_OUTPUT: |3;audio-fft;92;92;103;148;81;86;87;86;140;85 14:17:54 INFO - 2015-11-17 14:17:54,207 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;118;119;162;108;110;111;157;109;110;161 14:17:54 INFO - 2015-11-17 14:17:54,208 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;143;148;148;142;141;141;148;142;141;147 14:17:54 INFO - 2015-11-17 14:17:54,208 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;155;155;157;156;155;155;156;155;154 14:17:54 INFO - 2015-11-17 14:17:54,208 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;124;119;118;114;124;115;124;120;130 14:17:54 INFO - 2015-11-17 14:17:54,208 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;73;75;75;76;77;77;85;75;76 14:17:54 INFO - 2015-11-17 14:17:54,208 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;80;85;86;85;86;86;86;86;86 14:17:54 INFO - 2015-11-17 14:17:54,208 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;101;103;105;104;104;109;109;109;110;106 14:17:54 INFO - 2015-11-17 14:17:54,209 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;169;167;158;162;150;151;157;157;153 14:17:54 INFO - 2015-11-17 14:17:54,209 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;184;173;187;185;194;173;187;184;191;186 14:17:54 INFO - 2015-11-17 14:17:54,209 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;84;89;87;88;87;88;87;86;89 14:17:54 INFO - 2015-11-17 14:17:54,209 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:17:54 INFO - 2015-11-17 14:17:54,209 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:17:54 INFO - 2015-11-17 14:17:54,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1002 14:17:54 INFO - 2015-11-17 14:17:54,210 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:17:54 INFO - 2015-11-17 14:17:54,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1447798674200__endTimestamp 14:17:54 INFO - 2015-11-17 14:17:54,210 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,210 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:17:54 INFO - 2015-11-17 14:17:54,210 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:17:54 INFO - 2015-11-17 14:17:54,210 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,211 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:134.40 Median:135.00 stddev:5.82 (4.3%) stddev-sans-first:3.62 14:17:54 INFO - 2015-11-17 14:17:54,211 DEBUG : BROWSER_OUTPUT: Values: 121.0 135.0 133.0 134.0 137.0 136.0 134.0 135.0 134.0 145.0 14:17:54 INFO - 2015-11-17 14:17:54,211 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,211 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.60 Median:187.00 stddev:22.02 (11.8%) stddev-sans-first:23.19 14:17:54 INFO - 2015-11-17 14:17:54,211 DEBUG : BROWSER_OUTPUT: Values: 189.0 165.0 194.0 222.0 158.0 185.0 180.0 161.0 206.0 156.0 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:194.40 Median:196.50 stddev:4.20 (2.1%) stddev-sans-first:3.16 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: Values: 186.0 196.0 197.0 195.0 196.0 197.0 198.0 198.0 188.0 193.0 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.00 Median:86.00 stddev:24.01 (27.9%) stddev-sans-first:25.29 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 103.0 148.0 81.0 86.0 87.0 86.0 140.0 85.0 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.50 Median:118.50 stddev:23.43 (19.8%) stddev-sans-first:24.65 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 162.0 108.0 110.0 111.0 157.0 109.0 110.0 161.0 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,212 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:144.10 Median:145.00 stddev:3.21 (2.2%) stddev-sans-first:3.38 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: Values: 143.0 148.0 148.0 142.0 141.0 141.0 148.0 142.0 141.0 147.0 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:155.30 Median:155.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: Values: 155.0 155.0 155.0 157.0 156.0 155.0 155.0 156.0 155.0 154.0 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:120.30 Median:122.00 stddev:5.14 (4.2%) stddev-sans-first:5.09 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: Values: 115.0 124.0 119.0 118.0 114.0 124.0 115.0 124.0 120.0 130.0 14:17:54 INFO - 2015-11-17 14:17:54,213 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.90 Median:76.00 stddev:3.81 (5.0%) stddev-sans-first:3.40 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 75.0 75.0 76.0 77.0 77.0 85.0 75.0 76.0 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:84.40 Median:86.00 stddev:2.91 (3.4%) stddev-sans-first:1.96 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 85.0 86.0 85.0 86.0 86.0 86.0 86.0 86.0 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:106.00 Median:107.50 stddev:3.09 (2.9%) stddev-sans-first:2.70 14:17:54 INFO - 2015-11-17 14:17:54,214 DEBUG : BROWSER_OUTPUT: Values: 101.0 103.0 105.0 104.0 104.0 109.0 109.0 109.0 110.0 106.0 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:158.00 Median:157.50 stddev:6.34 (4.0%) stddev-sans-first:6.69 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: Values: 156.0 169.0 167.0 158.0 162.0 150.0 151.0 157.0 157.0 153.0 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:186.50 stddev:6.77 (3.6%) stddev-sans-first:7.18 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: Values: 184.0 173.0 187.0 185.0 194.0 173.0 187.0 184.0 191.0 186.0 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,215 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.60 Median:87.50 stddev:2.46 (2.8%) stddev-sans-first:1.56 14:17:54 INFO - 2015-11-17 14:17:54,216 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 89.0 87.0 88.0 87.0 88.0 87.0 86.0 89.0 14:17:54 INFO - 2015-11-17 14:17:54,216 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:17:54 INFO - 2015-11-17 14:17:54,216 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-11-17 14:17:54,972 INFO : Browser exited with error code: 0 14:17:55 INFO - 2015-11-17 14:17:55,029 INFO : Completed test kraken (00:01:03) 14:17:55 INFO - 2015-11-17 14:17:55,029 INFO : Starting test v8_7 14:17:55 INFO - 2015-11-17 14:17:55,029 DEBUG : operating with platform_type : mac_ 14:17:55 INFO - 2015-11-17 14:17:55,030 INFO : Initialising browser for v8_7 test... 14:17:55 INFO - 2015-11-17 14:17:55,045 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpWwAC5V/profile http://localhost:49252/getInfo.html 14:17:57 INFO - 2015-11-17 14:17:57,618 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:17:57 INFO - 2015-11-17 14:17:57,618 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:17:57 INFO - 2015-11-17 14:17:57,618 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:17:57 INFO - 2015-11-17 14:17:57,620 DEBUG : BROWSER_OUTPUT: __metrics 14:17:57 INFO - 2015-11-17 14:17:57,640 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:58 INFO - 2015-11-17 14:17:58,456 INFO : Browser initialized. 14:17:58 INFO - 2015-11-17 14:17:58,456 INFO : Running cycle 1/1 for v8_7 test... 14:17:58 INFO - 2015-11-17 14:17:58,457 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpWwAC5V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:18:10 INFO - 2015-11-17 14:18:10,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 229113856 14:18:10 INFO - 2015-11-17 14:18:10,665 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49252/tests/v8_7/run.html (next: http://localhost:49252/tests/v8_7/run.html) 14:18:33 INFO - 2015-11-17 14:18:33,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 732811264 14:18:33 INFO - 2015-11-17 14:18:33,767 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:18:33 INFO - 2015-11-17 14:18:33,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:18:33 INFO - 2015-11-17 14:18:33,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:18:33 INFO - 2015-11-17 14:18:33,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:18:33 INFO - 2015-11-17 14:18:33,768 DEBUG : BROWSER_OUTPUT: |0;Richards;199.04458598726114 14:18:33 INFO - 2015-11-17 14:18:33,768 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;245.82104228121926 14:18:33 INFO - 2015-11-17 14:18:33,768 DEBUG : BROWSER_OUTPUT: |2;Encrypt;395.25691699604744 14:18:33 INFO - 2015-11-17 14:18:33,769 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6777.027027027027 14:18:33 INFO - 2015-11-17 14:18:33,769 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2392.3444976076553 14:18:33 INFO - 2015-11-17 14:18:33,769 DEBUG : BROWSER_OUTPUT: |5;Earley;946.969696969697 14:18:33 INFO - 2015-11-17 14:18:33,769 DEBUG : BROWSER_OUTPUT: |6;Boyer;15569.23076923077 14:18:33 INFO - 2015-11-17 14:18:33,769 DEBUG : BROWSER_OUTPUT: |7;RegExp;36107.142857142855 14:18:33 INFO - 2015-11-17 14:18:33,770 DEBUG : BROWSER_OUTPUT: |8;Splay;835.1373855120733 14:18:33 INFO - 2015-11-17 14:18:33,770 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6883.561643835616 14:18:33 INFO - 2015-11-17 14:18:33,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:18:33 INFO - 2015-11-17 14:18:33,770 DEBUG : BROWSER_OUTPUT: __startTimestamp1447798713765__endTimestamp 14:18:33 INFO - 2015-11-17 14:18:33,771 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,771 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:18:33 INFO - 2015-11-17 14:18:33,771 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:18:33 INFO - 2015-11-17 14:18:33,771 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,771 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:199.04 Median:199.04 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,771 DEBUG : BROWSER_OUTPUT: Values: 199.0 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:245.82 Median:245.82 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: Values: 245.8 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:395.26 Median:395.26 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: Values: 395.3 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,772 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6777.03 Median:6777.03 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,773 DEBUG : BROWSER_OUTPUT: Values: 6777.0 14:18:33 INFO - 2015-11-17 14:18:33,773 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,773 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2392.34 Median:2392.34 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,773 DEBUG : BROWSER_OUTPUT: Values: 2392.3 14:18:33 INFO - 2015-11-17 14:18:33,773 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,773 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,774 DEBUG : BROWSER_OUTPUT: Values: 947.0 14:18:33 INFO - 2015-11-17 14:18:33,774 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,774 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15569.23 Median:15569.23 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,774 DEBUG : BROWSER_OUTPUT: Values: 15569.2 14:18:33 INFO - 2015-11-17 14:18:33,774 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,774 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36107.14 Median:36107.14 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,775 DEBUG : BROWSER_OUTPUT: Values: 36107.1 14:18:33 INFO - 2015-11-17 14:18:33,775 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,775 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:835.14 Median:835.14 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,775 DEBUG : BROWSER_OUTPUT: Values: 835.1 14:18:33 INFO - 2015-11-17 14:18:33,775 DEBUG : BROWSER_OUTPUT: 14:18:33 INFO - 2015-11-17 14:18:33,775 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6883.56 Median:6883.56 stddev:0.00 (0.0%) 14:18:33 INFO - 2015-11-17 14:18:33,777 DEBUG : BROWSER_OUTPUT: Values: 6883.6 14:18:33 INFO - 2015-11-17 14:18:33,777 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:18:33 INFO - 2015-11-17 14:18:33,777 DEBUG : BROWSER_OUTPUT: 14:18:34 INFO - 2015-11-17 14:18:34,585 INFO : Browser exited with error code: 0 14:18:34 INFO - 2015-11-17 14:18:34,610 INFO : Completed test v8_7 (00:00:39) 14:18:35 INFO - 2015-11-17 14:18:35,026 INFO : Completed test suite (00:20:19) 14:18:35 INFO - 2015-11-17 14:18:35,026 DEBUG : Working with test: dromaeo_css 14:18:35 INFO - 2015-11-17 14:18:35,026 DEBUG : Generating results file: dromaeo_css 14:18:35 INFO - 2015-11-17 14:18:35,027 DEBUG : Working with test: kraken 14:18:35 INFO - 2015-11-17 14:18:35,027 DEBUG : Generating results file: kraken 14:18:35 INFO - 2015-11-17 14:18:35,027 INFO : javascript benchmark 14:18:35 INFO - 2015-11-17 14:18:35,028 DEBUG : Working with test: v8_7 14:18:35 INFO - 2015-11-17 14:18:35,028 DEBUG : Generating results file: v8_7 14:18:35 INFO - 2015-11-17 14:18:35,028 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:35 INFO - 2015-11-17 14:18:35,076 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 14:18:35 INFO - 2015-11-17 14:18:35,076 DEBUG : process_Request line: dromaeo_css 5264.83 graph.html#tests=[[72,63,55]] 14:18:35 INFO - 2015-11-17 14:18:35,076 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:35 INFO - 2015-11-17 14:18:35,108 DEBUG : process_Request line: kraken 1851.90 graph.html#tests=[[232,63,55]] 14:18:35 INFO - 2015-11-17 14:18:35,108 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:35 INFO - 2015-11-17 14:18:35,146 DEBUG : process_Request line: v8_7 15197.51 graph.html#tests=[[230,63,55]] 14:18:35 INFO - 2015-11-17 14:18:35,147 INFO : javascript benchmark 14:18:35 INFO - 2015-11-17 14:18:35,149 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2505.536475751986, 2525.0, 2551.974480255197, 2571.215779187347, 2612.581986882098, 4015.6586690131303, 4052.5339585947627, 4148.0, 4154.148399578086, 4197.454330936977, 4137.482814648169, 4155.563665815083, 4158.604932531404, 4304.332828411593, 4332.826686932527, 3837.424386342057, 3936.822842972073, 3945.6646185074305, 3947.5657677655436, 4013.739106958053, 3701.206337331495, 3899.3566061599804, 3950.8814735557835, 3968.6031396860226, 4017.216642754664, 3774.1885494618514, 3805.9723874553715, 3876.6898648108086, 3888.202918401735, 3894.123822139996, 3715.089802998256, 3809.12390150267, 3848.2688289224957, 3900.395438707005, 3903.238868420659, 3796.52543432071, 3817.8472861085525, 3846.3461211594094, 3888.2612303662495, 3943.4676318697184, 4015.638592526687, 4176.415301857743, 4177.26897792885, 4203.7687927164, 4273.3162693969125, 4294.098239369736, 4341.240282950471, 4346.782660866944, 4351.4995775485595, 4448.888777780549, 4407.537208593116, 4456.286994080931, 4486.394336764528, 4498.0, 4580.312953057068, 3960.128771670228, 4086.0602061526015, 4142.109446468993, 4150.377443383486, 4209.473815773028, 4436.112777444459, 4494.280915053641, 4515.616172625298, 4538.568835960578, 4569.1547063793305, 4359.476862776487, 4395.3098162250535, 4402.4056752338665, 4434.55654434554, 4488.528704486047, 4227.682923780729, 4341.587549182823, 4518.8418405356315, 4580.0, 4582.106489234568, 4332.935005974913, 4348.043430445297, 4351.673624478113, 4383.123375324884, 4395.604395604411, 4321.762303073361, 4324.697271191049, 4345.847895323648, 4359.04101097758, 4368.628666563378, 3389.084947064328, 3450.0857272822723, 3499.772514786531, 3506.8246587670515, 3548.1484443733316, 3149.8110113392813, 3158.463061279588, 3217.8069315841126, 3237.190702324419, 3238.239013831748, 4198.895027624334, 4219.599138081878, 4222.894427639272, 4256.851010214689, 4264.445622069111, 4309.525952145262, 4375.824967001285, 4388.473383193973, 4469.709468884512, 4473.060657261946, 4195.643370313557, 4201.495820501559, 4233.703640745119, 4255.468066491689, 4298.075913678574, 3976.5824588418377, 3991.1219531702977, 4030.6976976726864, 4045.8786236412957, 4101.794910254475, 4314.094040251583, 4506.59440650343, 4513.887152821206, 4521.909561808811, 4545.954540454619, 4474.619657329164, 4475.619572336258, 4480.14877173336, 4503.752293623882, 4519.79660915253, 4565.0, 4615.861524154281, 4637.837675681335, 4661.510541393105, 4716.504766999416, 4286.59277368662, 4287.785610719514, 4391.626711729538, 4404.031113155101, 4435.578620031092, 4484.977575112103, 4486.64106871456, 4510.8421205257655, 4567.748773817472, 4611.377464042312, 4299.462567179103, 4382.912341753084, 4451.621612163002, 4459.420275364182, 4522.796474158737, 4078.8368465261055, 4228.2811921972725, 4234.195502854448, 4258.467691538558, 4354.934675979799, 4255.851045213402, 4288.292431748727, 4339.7396156230725, 4341.261985462415, 4357.71674841147, 4375.299952007664, 4413.2276851550205, 4418.315161149898, 4454.665900057444, 4485.6187224085015, 4144.689148313828, 4214.726042807208, 4218.7468751874985, 4221.66226701857, 4339.587739164775], "unit": "ms", "name": "dojo.html", "value": 4132.198582507444}, {"lowerIsBetter": false, "replicates": [468.348994897093, 468.60168856472, 471.83485779977013, 481.1555719711905, 511.6111755066151, 25637.74362256377, 31445.371092578163, 32070.67929320709, 32135.03594892151, 32325.353492930128, 31413.685863141363, 31481.0, 31636.096405057255, 31705.207369815766, 31986.84006579964, 6693.531452798306, 6873.896891546631, 7335.303146201116, 7430.962845185766, 7521.548707077565, 6850.794476165723, 8771.0, 9042.095790420972, 9130.04134565871, 9156.771080722969, 8874.86687699685, 9078.86381704275, 9090.954545227298, 9092.454452732823, 9118.452892826452, 6868.278830722802, 6931.41083007945, 7025.82435439113, 8723.738287851374, 9105.772355691128, 9007.45955242681, 9018.503982280972, 9039.0, 9184.265258779282, 9188.494632795193, 32098.19754506156, 32287.677123228936, 32514.349713005842, 32661.0, 32696.0, 2323.3494621506006, 2373.964390534143, 2756.1593713917246, 2819.970710690583, 2822.3085344090828, 22143.557128857334, 22693.0, 22888.656670149794, 23120.190793322323, 23420.64869026966, 1858.4424672598166, 1916.7891531931477, 1932.7100934859743, 1935.6612592796205, 1953.1308567687386, 213737.0, 215950.0, 216017.0, 217288.0, 218044.0, 43374.0, 45709.0, 46386.30420543694, 46745.29882051772, 46876.296855547196, 41015.38476922848, 52460.21309680358, 53796.46203537915, 54084.18873716897, 54724.45275547273, 13091.018173637016, 13405.664858378423, 13409.66475838112, 13672.93163534176, 13681.521146759816, 10045.296829221885, 10291.43397113151, 10310.43292618913, 10342.172626189888, 10351.275410721177, 15140.621484462976, 15172.089674619558, 15175.317110730044, 15340.0, 15373.692526149638, 6483.124778154889, 6669.799906002828, 6706.41802905875, 6723.5293529452465, 6845.691943862538, 766.8197973476229, 828.3083625173048, 872.1104473437059, 884.8982367027745, 908.927285817133, 23135.305940821465, 23276.883615582152, 23348.299551013497, 23433.0, 23659.0, 833.1418638802044, 871.1245198575391, 900.9144131307515, 953.9236861051099, 996.5714742660725, 11778.52885884555, 12118.575849845212, 12178.81731774024, 12305.077119216094, 12345.506179752709, 257523.0, 261978.0, 262246.0, 262635.0, 262743.0, 42155.57844421578, 43194.784026079666, 43690.34464483035, 43775.0, 43874.561254387045, 1060.0989159214605, 1080.9135269178605, 1098.2586753940898, 1120.9047230985295, 1160.7678464307003, 20203.0, 22555.548889022455, 23222.0, 23528.529429410974, 23546.293611191693, 34750.82624586962, 34862.30275394427, 34878.82560587181, 34899.12752181216, 35306.0, 208863.0, 209729.0, 210162.0, 210362.0, 216626.0, 21511.78488215098, 21801.56396872022, 25445.618315724907, 25708.228753137435, 26092.217233483025, 31349.686503134675, 31596.210094747814, 31772.29935455512, 33279.334413312085, 34056.829715851265, 26974.595381069692, 28086.85956570204, 28201.858990704914, 29221.85389073126, 29319.120426387242, 20715.896420518406, 25816.8709156453, 28292.0, 28322.43355132927, 28589.857050714614, 25981.870090649427, 26371.736282636928, 27150.864245679437, 27192.960527960087, 27523.31191720223, 22925.0, 23750.0, 23905.641415378435, 24213.152539661027, 24326.0, 18370.908145459187, 18515.722264166317, 18723.157457914698, 18866.811331887053, 19759.40721778349], "unit": "ms", "name": "ext.html", "value": 14866.981739139977}, {"lowerIsBetter": false, "replicates": [272.15631542219126, 274.1064130933158, 275.89791777042495, 278.35421821374405, 282.38299315994544, 8681.826363472743, 11339.546418143285, 13854.376553055112, 14173.787393189097, 14349.067310624816, 12564.748705025893, 12752.234865908053, 14781.852181478209, 15161.317740701666, 15401.537953861374, 4498.97750511247, 4692.648051396159, 4734.431868175824, 4738.099761045408, 4753.3107699383745, 3348.363810875926, 3436.690697837194, 4587.472440669316, 4649.418822647169, 4718.764061796896, 3414.9487757683532, 4993.425756038066, 5117.8464646060675, 5128.282040514331, 5184.066867963765, 3763.266163098197, 5056.115179843531, 5113.821016264413, 5153.819616313411, 5165.974170129125, 3145.1665308692986, 3297.670232976707, 3321.717653999413, 3326.550915626408, 3338.0319707284857, 10593.84109238362, 10635.734106647318, 10761.246712730112, 10774.78450430987, 10984.286021408583, 1352.4928151943022, 1412.272679570012, 1486.308866377129, 1530.3954937799506, 1530.97353959088, 7782.455228134033, 7995.0, 8155.0, 8199.71301004468, 8301.66793328266, 1228.2569045727384, 1261.735035642516, 1310.096033736728, 1341.7920222365549, 1344.0390121063488, 47217.0, 48160.75919620415, 48610.270845937695, 49118.0, 49653.75173124147, 5304.336957880265, 5328.3605967284175, 5368.91946620801, 5464.098423760035, 5465.098258787335, 6156.445919867144, 6159.81520554384, 6232.220972378453, 6247.250329960434, 6267.9971204607955, 4485.865424037284, 4527.7509736964785, 4546.590806827401, 4565.6119229865835, 4592.517785632527, 4815.518448155157, 4864.683795553277, 4897.191963326082, 4925.187344088257, 4931.16170251051, 2378.9286321410386, 2400.819938504619, 2422.6608274841537, 2459.6187590923078, 2461.5476868647584, 865.2385900407601, 865.467737341543, 884.6903583745766, 895.3106108296705, 907.677774390082, 337.55779928294015, 356.02449288948094, 359.0664272890464, 359.22586825391323, 369.2375245118821, 9677.419354838732, 9974.301798874008, 10022.298439109338, 10059.245556583286, 10140.746481338025, 301.749547875263, 311.4254200999153, 326.23823372425653, 373.30937765134286, 385.22954091816365, 3754.342989976743, 4257.74453532789, 4673.929891051637, 4721.102990431807, 4860.562549370574, 421379.0, 424712.0, 468010.0, 476967.0, 477923.0, 58658.0, 62617.68691156515, 62909.37090629127, 63192.684036580446, 63855.0, 365.54124573659885, 368.0761289164164, 372.63854061560244, 373.2423180942691, 376.89446954853236, 8419.579021049045, 8496.872546911678, 8529.104444033535, 8624.827503450022, 8715.869261961203, 28228.85885570559, 28851.134465966054, 29105.0, 29321.413571728874, 29417.705822941498, 38426.807865960494, 38951.0, 38971.80514097412, 39015.0, 39161.608383915795, 6298.622082675054, 6458.38645328693, 6537.117489139096, 6564.376384243489, 6593.769218077345, 9603.759906002406, 9784.706458806248, 9811.215102791617, 10035.949820250851, 10053.095221429814, 7213.278672132745, 8323.625436855476, 8499.91752020759, 8504.107068757692, 8626.051134375339, 8136.633851476579, 8179.468334558234, 8266.793330166794, 8302.377321700777, 8550.700725474579, 8163.469374490639, 8386.32909367237, 8449.11284315138, 8494.320454363513, 8593.914060859312, 5633.4084921082695, 5790.884182316414, 5864.530837532901, 6254.4996400286955, 6437.806865794034, 8046.476978996347, 8218.794530136794, 8368.832623347376, 8537.359698022548, 8576.0], "unit": "ms", "name": "jquery.html", "value": 5612.077464075948}, {"lowerIsBetter": false, "replicates": [591.8549955260962, 1117.3686866920189, 1167.4746364136138, 1167.7897978363892, 1381.7443772902009, 5136.768845401956, 5344.171653393731, 5421.484958928901, 5438.0, 5485.506304432601, 5342.813001544947, 5651.886962260753, 5792.623479473831, 5799.159121927329, 5899.970500147504, 1695.5506790700474, 1750.046224807483, 1750.982490175101, 1773.3172728499492, 1778.5286898971783, 1745.2844333823134, 1749.2653085704035, 1771.681097402467, 1771.8848274862157, 1772.0, 1720.2344956494364, 1721.8019927708285, 1724.956876078102, 1738.582740142363, 1764.4442000769716, 1662.950111496651, 1677.7567252748345, 1682.0832646207846, 1716.7682362880976, 1720.9483715488554, 1701.3449821818565, 1723.2245489529637, 1729.6713624411323, 1746.5284373219288, 1759.9560010999828, 5618.63478873876, 5729.742161602738, 5784.710764461802, 5785.305763308388, 5799.159121927339, 3135.498320268769, 3297.1262615406936, 3532.6467353264725, 3656.8537258509627, 3662.047867554428, 1984.4344361856945, 2125.447383680239, 2134.114342547841, 2136.3484137338105, 2154.601398741238, 696.7352406085706, 712.9465290103211, 732.6995931667991, 733.4719002318323, 742.3986570877606, 6970.825729356756, 7137.8215544611285, 7265.346118849276, 7298.81752956175, 7317.926820731778, 2865.7134286571177, 3035.165329534396, 3153.4008538377634, 3214.8874789382257, 3271.2312606537444, 6499.642519661369, 6511.218653761579, 6516.152900122954, 6518.902216466757, 6626.171728533934, 3637.0907273181706, 3640.162762564625, 3667.339878821784, 3685.1339935115225, 3710.257948410275, 3330.0, 3337.2824842658947, 3357.0096821437246, 3387.966120338765, 3394.2702319001532, 2811.831290122599, 2830.504661684197, 2898.4927637663322, 2908.0984894682715, 2915.02346713849, 919.9218066464425, 931.5063016601213, 932.9253659707207, 940.0176815228103, 944.6740874398322, 795.7374066558021, 806.6894245715324, 807.1524898856178, 820.2003047029099, 937.7327461673391, 5416.593755468356, 5464.863378415572, 5476.370217424967, 5501.229827824028, 5552.028395030853, 332.7038935347543, 338.73747845419996, 340.44507452851695, 344.3869911557432, 344.7603915278907, 4365.192439398721, 4369.235383807821, 4369.825206991748, 4436.0240747035605, 4437.800298986489, 6256.0, 6398.808035758934, 6408.67956602168, 6428.614283143026, 6448.226212854487, 6375.776847810397, 6383.840403989844, 6520.250171230275, 6681.532292739462, 6752.459803215731, 5379.408265090837, 5397.973010135002, 5398.946010539923, 5422.91865622016, 5427.240186373911, 5477.808276710455, 5524.558035357242, 5530.446955304437, 5562.860928476821, 5586.441355864381, 6179.721912513858, 6205.2553693557065, 6218.4092511213175, 6227.626342419469, 6280.434760871543, 6159.19930409044, 6293.244810622755, 6339.302676705466, 6367.840803979938, 6390.968045159744, 4424.026714122888, 4552.931706024478, 4602.194615942263, 4687.460941991714, 5135.948640513547, 5498.257735205856, 5503.834884953458, 5517.089680202722, 5578.163275508706, 5589.965856316594, 5163.302954101148, 5184.274201611702, 5225.216217567396, 5292.41783403833, 5365.114756065205, 5144.717040562805, 5185.0148471791745, 5230.790768369223, 5266.052110620125, 5276.657017293864, 5261.473852614861, 5287.841364759063, 5294.655847369909, 5309.57523398135, 5329.227262046904, 4806.014766972832, 4828.589569886599, 4846.982133751811, 4876.634252431153, 4894.19245824435, 4932.580730637936, 4943.629227807857, 4945.060438516671, 4953.603711702983, 4959.851204463872], "unit": "ms", "name": "mootools.html", "value": 3236.861644296198}, {"lowerIsBetter": false, "replicates": [251.67408206372747, 256.3181936050107, 263.1028193858941, 265.658628662169, 266.9666291713536, 5143.871403214916, 5146.614003949705, 5176.327077479927, 5186.533212010918, 5229.686218826873, 4961.553460188582, 5018.899622007567, 5051.84844454666, 5057.949420505794, 5107.948920510794, 3922.8823135305843, 3927.70542209334, 3941.625545573166, 3943.0142464383903, 3943.940840887389, 3871.6709079728257, 3906.1211227473877, 3908.863189788358, 3930.0764320384687, 3948.3879998600264, 3847.1728578355646, 3864.188520410717, 3896.844126234947, 3899.161680238748, 3912.0, 3795.4865023883685, 3858.9228215435674, 3918.7648741075627, 3921.058945852989, 3924.4113382992496, 3286.901392958191, 3309.12308238317, 3312.3540909522653, 3320.2031512436843, 3357.345317663057, 4935.161022626162, 4976.303317535548, 4981.327520784684, 4988.152014157602, 4997.325361076281, 4322.783860806979, 4333.58830911063, 4373.409589705413, 4382.320740285261, 4382.422327961931, 5279.340082489689, 5295.443978382253, 5339.65292256006, 5341.839744807662, 5354.384245811742, 3430.5368775215275, 3524.2775231077567, 3601.1717305019993, 3623.6411345745346, 3638.0904773806546, 5377.085895397791, 5584.441555844423, 5629.071203251458, 5679.233303504016, 5758.79844205455, 3519.454484554898, 3523.136831476305, 3523.2953409317724, 3554.147004718849, 3554.4668299755244, 3566.7146628269675, 3568.4825700273836, 3585.8744943926836, 3685.981570092132, 3696.0205545530457, 4097.057676734368, 4211.7051806373875, 4320.827166913351, 4321.330193819963, 4328.069465065026, 5218.373795144607, 5304.363476382781, 5359.035373632705, 5467.097928841697, 5479.369872464717, 1272.5736878145924, 1297.331874084847, 1302.0690206502397, 1315.7039666075248, 1320.5972178485654, 819.5697258938985, 820.7045463633087, 828.0766944856442, 831.3141658132065, 836.4145098431122, 5136.948630513647, 5205.531502164823, 5209.609279304067, 5213.2701421800975, 5246.265522826808, 5593.272874526286, 5616.5787565932715, 5659.886802263932, 5701.2018317435595, 5707.600467967202, 5120.590352771769, 5208.062548741263, 5218.7912483500995, 5237.135872580981, 5241.50205730455, 2971.1977766003056, 2975.1372102090586, 3026.4552380571267, 3059.816411015346, 3067.6778938211614, 5855.414458554111, 5897.52819774417, 5905.498032667271, 5923.466887980103, 5970.701464926737, 5813.244278243886, 5827.24245848037, 5871.383504731942, 5873.794417195378, 5912.556558258148, 5910.290765108129, 5913.674747888821, 5915.142304365929, 5940.881182376242, 5983.192269043623, 5547.697705452353, 5663.66018038919, 5697.4302569742695, 5698.176583493242, 5749.367569567261, 5601.7759289629585, 5608.214849921096, 5623.718814059199, 5641.605087643826, 5648.068068768607, 5926.407359264039, 5932.080527518242, 5948.672822994604, 6004.0093384591055, 6013.037913933749, 3570.339487194877, 3600.3339382214376, 3634.745567810228, 3648.0150359402282, 3711.684506816951, 5463.918041229305, 5593.636413633101, 5613.550915926798, 5621.353544342453, 5688.943110569007, 5352.705601191972, 5432.728363581884, 5491.36849262324, 5533.944660553504, 5566.415526369673, 5508.283923089973, 5510.724463776715, 5511.311086114236, 5526.447355264441, 5536.307961504812, 5182.144946083854, 5380.623356365017, 5411.2153737708595, 5439.265699130567, 5449.291592093003, 5428.83713488596, 5480.671159730429, 5506.889862202814, 5520.66875987442, 5545.2513910623165, 5321.6540924839765, 5398.2982212312145, 5402.702851343214, 5438.564914806727, 5444.156155795858], "unit": "ms", "name": "prototype.html", "value": 4040.1563528738707}, {"lowerIsBetter": false, "replicates": [494.90844193824137, 516.8139469790875, 541.3503795445466, 580.5529742098585, 601.6510423954107, 10839.241253112275, 11360.147988900824, 11408.486618102184, 11437.542498300068, 11462.828057579143, 10040.2469814764, 10225.335353202056, 10682.412467314294, 10793.406362650052, 10799.730006749835, 721.2643104033896, 739.367840496376, 741.2883631713562, 744.2817680937894, 746.2239271158016, 726.7529040126356, 734.9412047036225, 738.1105767550089, 744.5458270455018, 751.2825251884465, 776.7397921696239, 780.5706861226331, 790.4940837863771, 791.0309870408761, 796.8326651403183, 721.293132729925, 768.3622593247591, 768.8001119708888, 774.380495603515, 778.264540009691, 567.8949394362015, 568.3833041150357, 573.8307199376194, 574.4829653312053, 581.8487193329722, 10287.948560257151, 10389.480525973671, 10432.269741118125, 10533.210009249337, 10548.103411210057, 7649.158592554814, 7906.604669766489, 8291.626876790559, 8708.477491350475, 8743.912560874436, 7216.386607138399, 7419.501405511195, 7463.067116610424, 7494.775156745306, 7633.160352361236, 2348.518553696488, 2382.5234953009294, 2402.3513651314224, 2460.980827127233, 2547.942603819413, 38381.232375352614, 38914.0, 39402.21195576101, 39799.60200397988, 39801.0, 4949.307097006422, 5072.112380333427, 5075.0357432087785, 5228.581713462914, 5308.964751873347, 9550.426974381558, 9678.370905891095, 9699.321047526606, 9710.0, 9727.0, 4825.613950883921, 4855.6115510759055, 4859.757012149378, 5013.523715247045, 5044.848654540297, 3001.8348990805716, 3050.23744063984, 3070.7082827131385, 3085.6451508076857, 3094.8607312670983, 2100.2964007057503, 2124.2034237161065, 2125.2136709417614, 2132.6907598398147, 2149.548594795079, 322.76922000769565, 325.4239995208515, 326.23497897430485, 327.61178004064783, 327.8262520863946, 360.4971065363855, 366.4448360733491, 488.3651253370604, 511.88482591416636, 523.2517499974996, 5575.0, 5964.731587078505, 6023.969880150571, 6067.271927368655, 6077.604955677867, 443.7751805018173, 460.88938654723296, 476.25703901913124, 490.9656324057282, 494.7056501381672, 3036.8937087201843, 3154.492308306262, 3201.487761958122, 3241.6434192238835, 3279.8032118072992, 44372.11255774867, 45131.54868451274, 49894.75052624714, 50353.24470132951, 51222.74388628033, 35072.0, 36151.4577281341, 38650.80674596609, 39068.41397379042, 39185.60814391877, 31763.20591985219, 36098.819505902306, 36523.0, 37401.81299093487, 38589.42115868264, 6273.560850740404, 6687.0, 6885.414739747178, 7004.194517630538, 7109.376169962045, 28807.279818004718, 29707.702922970493, 29806.10581682553, 30066.24834379158, 30102.548461772654, 36045.45931811077, 36348.818255908554, 36405.27189456249, 37056.629433706396, 39784.20431591294, 5374.435684253097, 6368.936310636835, 6386.489080873612, 6521.152250207443, 6655.334466553306, 9120.635174593208, 9167.404118732527, 9400.905990940004, 9568.09103135201, 9688.982656820932, 8707.172818582225, 8740.519271440131, 8907.821843562962, 8953.552322383985, 9091.681791137278, 8758.386912916034, 9033.728988130366, 9077.0, 9194.816103678022, 9330.300227483101, 8675.91324086751, 8961.775955601162, 8977.057408972225, 8988.235999940078, 9056.773580660536, 7099.893501597583, 7179.174394944648, 7298.635068246673, 7305.853882922418, 7664.555519213477, 7632.809179770328, 7756.961215193888, 7759.844803104019, 7860.5283682976915, 8077.596120193849], "unit": "ms", "name": "yui.html", "value": 4722.873314442066}], "name": "dromaeo_css", "value": 5264.831016772708}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [121.0, 135.0, 133.0, 134.0, 137.0, 136.0, 134.0, 135.0, 134.0, 145.0], "unit": "ms", "name": "ai-astar", "value": 134.4}, {"lowerIsBetter": true, "replicates": [189.0, 165.0, 194.0, 222.0, 158.0, 185.0, 180.0, 161.0, 206.0, 156.0], "unit": "ms", "name": "audio-beat-detection", "value": 181.6}, {"lowerIsBetter": true, "replicates": [186.0, 196.0, 197.0, 195.0, 196.0, 197.0, 198.0, 198.0, 188.0, 193.0], "unit": "ms", "name": "audio-dft", "value": 194.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 103.0, 148.0, 81.0, 86.0, 87.0, 86.0, 140.0, 85.0], "unit": "ms", "name": "audio-fft", "value": 100.0}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 162.0, 108.0, 110.0, 111.0, 157.0, 109.0, 110.0, 161.0], "unit": "ms", "name": "audio-oscillator", "value": 126.5}, {"lowerIsBetter": true, "replicates": [143.0, 148.0, 148.0, 142.0, 141.0, 141.0, 148.0, 142.0, 141.0, 147.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 144.1}, {"lowerIsBetter": true, "replicates": [155.0, 155.0, 155.0, 157.0, 156.0, 155.0, 155.0, 156.0, 155.0, 154.0], "unit": "ms", "name": "imaging-darkroom", "value": 155.3}, {"lowerIsBetter": true, "replicates": [115.0, 124.0, 119.0, 118.0, 114.0, 124.0, 115.0, 124.0, 120.0, 130.0], "unit": "ms", "name": "imaging-desaturate", "value": 120.3}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 75.0, 75.0, 76.0, 77.0, 77.0, 85.0, 75.0, 76.0], "unit": "ms", "name": "json-parse-financial", "value": 75.9}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 85.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 84.4}, {"lowerIsBetter": true, "replicates": [101.0, 103.0, 105.0, 104.0, 104.0, 109.0, 109.0, 109.0, 110.0, 106.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 106.0}, {"lowerIsBetter": true, "replicates": [156.0, 169.0, 167.0, 158.0, 162.0, 150.0, 151.0, 157.0, 157.0, 153.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 158.0}, {"lowerIsBetter": true, "replicates": [184.0, 173.0, 187.0, 185.0, 194.0, 173.0, 187.0, 184.0, 191.0, 186.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 184.4}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 89.0, 87.0, 88.0, 87.0, 88.0, 87.0, 86.0, 89.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 86.6}], "name": "kraken", "value": 1851.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [199.04458598726114], "unit": "score", "name": "Richards", "value": 177.357248}, {"lowerIsBetter": false, "replicates": [245.82104228121926], "unit": "score", "name": "DeltaBlue", "value": 268.9680240000001}, {"lowerIsBetter": false, "replicates": [395.25691699604744], "unit": "score", "name": "Encrypt", "value": 673.4379300000002}, {"lowerIsBetter": false, "replicates": [6777.027027027027], "unit": "score", "name": "Decrypt", "value": 39.27695712861416}, {"lowerIsBetter": false, "replicates": [2392.3444976076553], "unit": "score", "name": "RayTrace", "value": 309.31540200000006}, {"lowerIsBetter": false, "replicates": [946.969696969697], "unit": "score", "name": "Earley", "value": 703.7849280000003}, {"lowerIsBetter": false, "replicates": [15569.23076923077], "unit": "score", "name": "Boyer", "value": 42.8064179841897}, {"lowerIsBetter": false, "replicates": [36107.142857142855], "unit": "score", "name": "RegExp", "value": 25.23004945598418}, {"lowerIsBetter": false, "replicates": [835.1373855120733], "unit": "score", "name": "Splay", "value": 97.57795712861414}, {"lowerIsBetter": false, "replicates": [6883.561643835616], "unit": "score", "name": "NavierStokes", "value": 215.5860696517415}], "name": "v8_7", "value": 15197.514925172263}]} 14:18:35 INFO - RETURN: dromaeo_css: 5264.83 14:18:35 INFO - RETURN: kraken: 1851.90 14:18:35 INFO - RETURN: v8_7: 15197.51 14:18:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15197.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1851.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5264.83"}}} 14:18:35 INFO - Return code: 0 14:18:35 INFO - # TBPL SUCCESS # 14:18:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:18:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:18:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:18:35 INFO - 2015-11-17 14:18:35.236 screenresolution[1660:9923] starting screenresolution argv=screenresolution get 14:18:35 INFO - 2015-11-17 14:18:35.239 screenresolution[1660:9923] Display 0: 1600x1200x32@60 14:18:35 INFO - 2015-11-17 14:18:35.246 screenresolution[1661:9926] starting screenresolution argv=screenresolution list 14:18:35 INFO - Available Modes on Display 0 14:18:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:18:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:18:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:18:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:18:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:18:35 INFO - Intel HD Graphics 3000: 14:18:35 INFO - Chipset Model: Intel HD Graphics 3000 14:18:35 INFO - Type: GPU 14:18:35 INFO - Bus: Built-In 14:18:35 INFO - VRAM (Total): 512 MB 14:18:35 INFO - VRAM (Dynamic, Max): 10 14:18:35 INFO - Vendor: Intel (0x8086) 14:18:35 INFO - Device ID: 0x0116 14:18:35 INFO - Revision ID: 0x0009 14:18:35 INFO - Displays: 14:18:35 INFO - Display: 14:18:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:18:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:18:35 INFO - Display Serial Number: 1600x1200 60 14:18:35 INFO - Main Display: Yes 14:18:35 INFO - Mirror: Off 14:18:35 INFO - Online: Yes 14:18:35 INFO - Rotation: Supported 14:18:35 INFO - Return code: 0 14:18:35 INFO - Running post-action listener: _resource_record_post_action 14:18:35 INFO - Running post-run listener: _resource_record_post_run 14:18:36 INFO - Total resource usage - Wall time: 1264s; CPU: 30.0%; Read bytes: 39089152; Write bytes: 685494272; Read time: 5128; Write time: 45147 14:18:36 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 335213056; Write bytes: 337387520; Read time: 36946; Write time: 6842 14:18:36 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 38192128; Write bytes: 337735680; Read time: 4637; Write time: 37374 14:18:36 INFO - Running post-run listener: _upload_blobber_files 14:18:36 INFO - Blob upload gear active. 14:18:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:18:36 INFO - Copying logs to upload dir... 14:18:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1324.053267 ========= master_lag: 0.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-17 14:18:37.644939) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 14:18:37.649724) ========= 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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010349 build_url: 'https://queue.taskcluster.net/v1/task/JccrhtAZSM2pz-GFQaSa2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.78 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 14:18:38.440290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:18:38.440584) ========= 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.5KyPJYu31Y/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.f07k5nqbzS/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.005835 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:18:38.517882) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-17 14:18:38.518153) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-17 14:18:42.456904) ========= ========= Total master_lag: 2.16 =========