builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1448409158.43 results: success (0) buildid: 20151124145732 builduid: 0544f187eff5434cb75c039ba4bfd614 revision: 88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.432481) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.433130) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.433411) ========= 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.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005391 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.455827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.456123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.472176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.472618) ========= 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.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005167 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.520797) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.521223) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.521800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.522103) ========= 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.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-24 15:52:38-- 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% 8.50M=0.001s 2015-11-24 15:52:38 (8.50 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.722888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.723311) ========= 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.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.032710 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:38.775031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 15:52:38.775692) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-24 15:52:38,852 truncating revision to first 12 chars 2015-11-24 15:52:38,852 Setting DEBUG logging. 2015-11-24 15:52:38,852 attempt 1/10 2015-11-24 15:52:38,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/88d5bc46a549?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 15:52:40,018 unpacking tar archive at: fx-team-88d5bc46a549/testing/mozharness/ program finished with exit code 0 elapsedTime=1.407915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 15:52:40.199178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:40.199493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:40.210572) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:40.210981) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 15:52:40.211553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-24 15:52:40.211984) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:52:40 INFO - MultiFileLogger online at 20151124 15:52:40 in /builds/slave/test 15:52:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:52:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:40 INFO - {'append_to_log': False, 15:52:40 INFO - 'base_work_dir': '/builds/slave/test', 15:52:40 INFO - 'blob_upload_branch': 'Fx-Team', 15:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:40 INFO - 'branch': 'Fx-Team', 15:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:40 INFO - 'config_files': ('talos/mac_config.py',), 15:52:40 INFO - 'default_actions': ('clobber', 15:52:40 INFO - 'read-buildbot-config', 15:52:40 INFO - 'download-and-extract', 15:52:40 INFO - 'populate-webroot', 15:52:40 INFO - 'create-virtualenv', 15:52:40 INFO - 'install', 15:52:40 INFO - 'run-tests'), 15:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:40 INFO - 'download_minidump_stackwalk': True, 15:52:40 INFO - 'download_symbols': 'ondemand', 15:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:40 INFO - 'installer_path': 'installer.exe', 15:52:40 INFO - 'log_level': 'info', 15:52:40 INFO - 'log_name': 'talos', 15:52:40 INFO - 'log_to_console': True, 15:52:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:52:40 INFO - 'opt_config_files': (), 15:52:40 INFO - 'pip_index': False, 15:52:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:40 INFO - 'cmd': ('bash', 15:52:40 INFO - '-c', 15:52:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:40 INFO - 'enabled': True, 15:52:40 INFO - 'halt_on_failure': False, 15:52:40 INFO - 'name': 'check_screen_resolution'},), 15:52:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:40 INFO - 'cmd': ('bash', 15:52:40 INFO - '-c', 15:52:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:40 INFO - 'enabled': True, 15:52:40 INFO - 'halt_on_failure': False, 15:52:40 INFO - 'name': 'check_screen_resolution'},), 15:52:40 INFO - 'run_cmd_checks_enabled': True, 15:52:40 INFO - 'sps_profile': False, 15:52:40 INFO - 'sps_profile_interval': 0, 15:52:40 INFO - 'suite': 'dromaeojs', 15:52:40 INFO - 'system_bits': '64', 15:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:40 INFO - 'title': 't-yosemite-r7-0051', 15:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:40 INFO - 'use_talos_json': True, 15:52:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:40 INFO - 'work_dir': 'build'} 15:52:40 INFO - ##### 15:52:40 INFO - ##### Running clobber step. 15:52:40 INFO - ##### 15:52:40 INFO - Running pre-action listener: _resource_record_pre_action 15:52:40 INFO - Running main action method: clobber 15:52:40 INFO - rmtree: /builds/slave/test/build 15:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:42 INFO - Running post-action listener: _resource_record_post_action 15:52:42 INFO - ##### 15:52:42 INFO - ##### Running read-buildbot-config step. 15:52:42 INFO - ##### 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: read_buildbot_config 15:52:42 INFO - Using buildbot properties: 15:52:42 INFO - { 15:52:42 INFO - "properties": { 15:52:42 INFO - "buildnumber": 26, 15:52:42 INFO - "product": "firefox", 15:52:42 INFO - "script_repo_revision": "production", 15:52:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:52:42 INFO - "repository": "", 15:52:42 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:52:42 INFO - "buildid": "20151124145732", 15:52:42 INFO - "slavename": "t-yosemite-r7-0051", 15:52:42 INFO - "pgo_build": "False", 15:52:42 INFO - "basedir": "/builds/slave/test", 15:52:42 INFO - "project": "", 15:52:42 INFO - "platform": "yosemite_r7", 15:52:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:52:42 INFO - "slavebuilddir": "test", 15:52:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:52:42 INFO - "branch": "fx-team", 15:52:42 INFO - "repo_path": "integration/fx-team", 15:52:42 INFO - "stage_platform": "macosx64", 15:52:42 INFO - "builduid": "0544f187eff5434cb75c039ba4bfd614", 15:52:42 INFO - "revision": "88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7" 15:52:42 INFO - }, 15:52:42 INFO - "sourcestamp": { 15:52:42 INFO - "repository": "", 15:52:42 INFO - "hasPatch": false, 15:52:42 INFO - "project": "", 15:52:42 INFO - "branch": "fx-team-macosx64-talos", 15:52:42 INFO - "changes": [ 15:52:42 INFO - { 15:52:42 INFO - "category": null, 15:52:42 INFO - "files": [ 15:52:42 INFO - { 15:52:42 INFO - "url": null, 15:52:42 INFO - "name": "https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:52:42 INFO - } 15:52:42 INFO - ], 15:52:42 INFO - "repository": "", 15:52:42 INFO - "rev": "88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7", 15:52:42 INFO - "who": "archaeopteryx@coole-files.de", 15:52:42 INFO - "when": 1448408527, 15:52:42 INFO - "number": 6702466, 15:52:42 INFO - "comments": "Bug 1227647 - Remove UI code for legacy sync migration. r=markh", 15:52:42 INFO - "project": "", 15:52:42 INFO - "at": "Tue 24 Nov 2015 15:42:07", 15:52:42 INFO - "branch": "fx-team-macosx64-talos", 15:52:42 INFO - "revlink": "", 15:52:42 INFO - "properties": [ 15:52:42 INFO - [ 15:52:42 INFO - "buildid", 15:52:42 INFO - "20151124145732", 15:52:42 INFO - "Change" 15:52:42 INFO - ], 15:52:42 INFO - [ 15:52:42 INFO - "builduid", 15:52:42 INFO - "0544f187eff5434cb75c039ba4bfd614", 15:52:42 INFO - "Change" 15:52:42 INFO - ], 15:52:42 INFO - [ 15:52:42 INFO - "pgo_build", 15:52:42 INFO - "False", 15:52:42 INFO - "Change" 15:52:42 INFO - ] 15:52:42 INFO - ], 15:52:42 INFO - "revision": "88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7" 15:52:42 INFO - } 15:52:42 INFO - ], 15:52:42 INFO - "revision": "88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7" 15:52:42 INFO - } 15:52:42 INFO - } 15:52:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:52:42 INFO - Running post-action listener: _resource_record_post_action 15:52:42 INFO - ##### 15:52:42 INFO - ##### Running download-and-extract step. 15:52:42 INFO - ##### 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: download_and_extract 15:52:42 INFO - mkdir: /builds/slave/test/build/tests 15:52:42 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')]} 15:52:42 INFO - https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/test_packages.json 15:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/test_packages.json 15:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:52:44 INFO - Downloaded 1149 bytes. 15:52:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:52:44 INFO - Using the following test package requirements: 15:52:44 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:52:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:52:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'jsshell-mac.zip'], 15:52:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:52:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:52:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:52:44 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:52:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:52:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:52:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:52:44 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:52:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:52: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')]} 15:52:44 INFO - https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:45 INFO - Downloaded 17527659 bytes. 15:52: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 15:52:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:52:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:52:48 INFO - Return code: 0 15:52:48 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 15:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:48 INFO - https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:49 INFO - Downloaded 17527659 bytes. 15:52:49 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 15:52:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:52:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:52:52 INFO - Return code: 0 15:52: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')]} 15:52:52 INFO - https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:53 INFO - Downloaded 11130997 bytes. 15:52:53 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 15:52:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:52:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:52:53 INFO - Return code: 0 15:52:53 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')]} 15:52:53 INFO - https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpCFTOznR3e8UePhN9rYIA/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 15:52:56 INFO - Downloaded 109910276 bytes. 15:52:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:52:56 INFO - mkdir: /builds/slave/test/properties 15:52:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:56 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:56 INFO - Contents: 15:52:56 INFO - build_url:https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:52:56 INFO - Running post-action listener: _resource_record_post_action 15:52:56 INFO - Running post-action listener: set_extra_try_arguments 15:52:56 INFO - ##### 15:52:56 INFO - ##### Running populate-webroot step. 15:52:56 INFO - ##### 15:52:56 INFO - Running pre-action listener: _resource_record_pre_action 15:52:56 INFO - Running main action method: populate_webroot 15:52:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:52:56 INFO - '../fennec_ids.txt'], 15:52:56 INFO - 'tests': ['tcheck2']}, 15:52:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:56 INFO - '--tppagecycles', 15:52:56 INFO - '7'], 15:52:56 INFO - 'tests': ['tsvgm']}}, 15:52:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:52:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:52:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:52:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'tests': ['damp', 'tps']}, 15:52:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['damp', 'tps']}, 15:52:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:52:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:56 INFO - 'other': {'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore']}, 15:52:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore']}, 15:52:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore']}, 15:52:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore']}, 15:52:56 INFO - 'other_l64': {'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore']}, 15:52:56 INFO - 'other_nol64': {'tests': ['a11yr', 15:52:56 INFO - 'ts_paint', 15:52:56 INFO - 'tpaint', 15:52:56 INFO - 'sessionrestore', 15:52:56 INFO - 'sessionrestore_no_auto_restore']}, 15:52:56 INFO - 'svgr': {'tests': ['tsvgx', 15:52:56 INFO - 'tsvgr_opacity', 15:52:56 INFO - 'tart', 15:52:56 INFO - 'tscrollx', 15:52:56 INFO - 'cart']}, 15:52:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['tsvgx', 15:52:56 INFO - 'tsvgr_opacity', 15:52:56 INFO - 'tart', 15:52:56 INFO - 'tscrollx', 15:52:56 INFO - 'cart']}, 15:52:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'tests': ['tp5o']}, 15:52:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--e10s'], 15:52:56 INFO - 'tests': ['tp5o']}, 15:52:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--xperf_path', 15:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:56 INFO - 'tests': ['tp5n']}, 15:52:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:56 INFO - 'talos_options': ['--e10s', 15:52:56 INFO - '--xperf_path', 15:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:56 INFO - 'tests': ['tp5n']}}, 15:52:56 INFO - 'talos.zip': {'path': '', 15:52:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:56 INFO - Running post-action listener: _resource_record_post_action 15:52:56 INFO - ##### 15:52:56 INFO - ##### Running create-virtualenv step. 15:52:56 INFO - ##### 15:52:56 INFO - Running pre-action listener: _resource_record_pre_action 15:52:56 INFO - Running main action method: create_virtualenv 15:52:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52: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 15:52:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:56 INFO - Using real prefix '/tools/python27' 15:52:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:00 INFO - Installing pip.................done. 15:53:00 INFO - Return code: 0 15:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:00 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')]} 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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')]} 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:00 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 15:53:00 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 15:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:00 INFO - 'HOME': '/Users/cltbld', 15:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:00 INFO - 'LOGNAME': 'cltbld', 15:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:00 INFO - 'MOZ_NO_REMOTE': '1', 15:53:00 INFO - 'NO_EM_RESTART': '1', 15:53:00 INFO - 'PAGER': '/bin/cat', 15:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:00 INFO - 'PWD': '/builds/slave/test', 15:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:00 INFO - 'SHELL': '/bin/bash', 15:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:00 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:00 INFO - 'USER': 'cltbld', 15:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:00 INFO - 'XPC_FLAGS': '0x0', 15:53:00 INFO - 'XPC_SERVICE_NAME': '0', 15:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:00 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 15:53:00 INFO - Cleaning up... 15:53:00 INFO - Return code: 0 15:53:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:53:00 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')]} 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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')]} 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:00 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 15:53:00 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 15:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:00 INFO - 'HOME': '/Users/cltbld', 15:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:00 INFO - 'LOGNAME': 'cltbld', 15:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:00 INFO - 'MOZ_NO_REMOTE': '1', 15:53:00 INFO - 'NO_EM_RESTART': '1', 15:53:00 INFO - 'PAGER': '/bin/cat', 15:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:00 INFO - 'PWD': '/builds/slave/test', 15:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:00 INFO - 'SHELL': '/bin/bash', 15:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:00 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:00 INFO - 'USER': 'cltbld', 15:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:00 INFO - 'XPC_FLAGS': '0x0', 15:53:00 INFO - 'XPC_SERVICE_NAME': '0', 15:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:00 INFO - Downloading/unpacking psutil>=0.7.1 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:53:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:03 INFO - Installing collected packages: psutil 15:53:03 INFO - Running setup.py install for psutil 15:53:03 INFO - building 'psutil._psutil_osx' extension 15:53:03 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 15:53:04 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 15:53:04 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 15:53:04 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 15:53:04 INFO - building 'psutil._psutil_posix' extension 15:53:04 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 15:53:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:53:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:53:04 INFO - ^ 15:53:04 INFO - 1 warning generated. 15:53:04 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 15:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:04 INFO - Successfully installed psutil 15:53:04 INFO - Cleaning up... 15:53:04 INFO - Return code: 0 15:53:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:53:04 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')]} 15:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:04 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')]} 15:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:04 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:04 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 15:53:04 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 15:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:04 INFO - 'HOME': '/Users/cltbld', 15:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:04 INFO - 'LOGNAME': 'cltbld', 15:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:04 INFO - 'MOZ_NO_REMOTE': '1', 15:53:04 INFO - 'NO_EM_RESTART': '1', 15:53:04 INFO - 'PAGER': '/bin/cat', 15:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:04 INFO - 'PWD': '/builds/slave/test', 15:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:04 INFO - 'SHELL': '/bin/bash', 15:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:04 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:04 INFO - 'USER': 'cltbld', 15:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:04 INFO - 'XPC_FLAGS': '0x0', 15:53:04 INFO - 'XPC_SERVICE_NAME': '0', 15:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:53:07 INFO - Installing collected packages: mozsystemmonitor 15:53:07 INFO - Running setup.py install for mozsystemmonitor 15:53:07 INFO - Successfully installed mozsystemmonitor 15:53:07 INFO - Cleaning up... 15:53:07 INFO - Return code: 0 15:53:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:07 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:07 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 15:53:07 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 15:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:07 INFO - 'HOME': '/Users/cltbld', 15:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:07 INFO - 'LOGNAME': 'cltbld', 15:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:07 INFO - 'MOZ_NO_REMOTE': '1', 15:53:07 INFO - 'NO_EM_RESTART': '1', 15:53:07 INFO - 'PAGER': '/bin/cat', 15:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:07 INFO - 'PWD': '/builds/slave/test', 15:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:07 INFO - 'SHELL': '/bin/bash', 15:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:07 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:07 INFO - 'USER': 'cltbld', 15:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:07 INFO - 'XPC_FLAGS': '0x0', 15:53:07 INFO - 'XPC_SERVICE_NAME': '0', 15:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:07 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 15:53:07 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 15:53:07 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 15:53:07 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 15:53:07 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 15:53:07 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 15:53:09 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 INFO - Downloading docopt-0.6.1.tar.gz 15:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:10 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:10 INFO - Running setup.py install for blobuploader 15:53:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:11 INFO - Running setup.py install for requests 15:53:11 INFO - Running setup.py install for docopt 15:53:11 INFO - Successfully installed blobuploader requests docopt 15:53:11 INFO - Cleaning up... 15:53:11 INFO - Return code: 0 15:53:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:11 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:11 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 15:53:11 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 15:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:11 INFO - 'HOME': '/Users/cltbld', 15:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:11 INFO - 'LOGNAME': 'cltbld', 15:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:11 INFO - 'MOZ_NO_REMOTE': '1', 15:53:11 INFO - 'NO_EM_RESTART': '1', 15:53:11 INFO - 'PAGER': '/bin/cat', 15:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:11 INFO - 'PWD': '/builds/slave/test', 15:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:11 INFO - 'SHELL': '/bin/bash', 15:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:11 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:11 INFO - 'USER': 'cltbld', 15:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:11 INFO - 'XPC_FLAGS': '0x0', 15:53:11 INFO - 'XPC_SERVICE_NAME': '0', 15:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-u1TqHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-qbG5yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-vTyQj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zgwFcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-OgSbJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-qaLgCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ZHoMTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-rFqJ2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-88MPXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nQ8Iix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-qNEhxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Yw4Hyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-foFGtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-TKHO6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-wKEOBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-p1J_qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-e6_DTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:13 INFO - Running setup.py install for manifestparser 15:53:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:13 INFO - Running setup.py install for mozcrash 15:53:14 INFO - Running setup.py install for mozdebug 15:53:14 INFO - Running setup.py install for mozdevice 15:53:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Running setup.py install for mozfile 15:53:14 INFO - Running setup.py install for mozhttpd 15:53:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Running setup.py install for mozinfo 15:53:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Running setup.py install for mozInstall 15:53:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:14 INFO - Running setup.py install for mozleak 15:53:15 INFO - Running setup.py install for mozlog 15:53:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:15 INFO - Running setup.py install for moznetwork 15:53:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:15 INFO - Running setup.py install for mozprocess 15:53:15 INFO - Running setup.py install for mozprofile 15:53:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:15 INFO - Running setup.py install for mozrunner 15:53:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:15 INFO - Running setup.py install for mozscreenshot 15:53:15 INFO - Running setup.py install for moztest 15:53:16 INFO - Running setup.py install for mozversion 15:53:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:16 INFO - Cleaning up... 15:53:16 INFO - Return code: 0 15:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:16 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:16 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 15:53:16 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 15:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:16 INFO - 'HOME': '/Users/cltbld', 15:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:16 INFO - 'LOGNAME': 'cltbld', 15:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:16 INFO - 'MOZ_NO_REMOTE': '1', 15:53:16 INFO - 'NO_EM_RESTART': '1', 15:53:16 INFO - 'PAGER': '/bin/cat', 15:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:16 INFO - 'PWD': '/builds/slave/test', 15:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:16 INFO - 'SHELL': '/bin/bash', 15:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:16 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:16 INFO - 'USER': 'cltbld', 15:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:16 INFO - 'XPC_FLAGS': '0x0', 15:53:16 INFO - 'XPC_SERVICE_NAME': '0', 15:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:16 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ocwUmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:16 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)) 15:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:16 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Rkfl8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:16 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5BF3_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:16 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-TqRos3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:16 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)) 15:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2Q6OSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-NI96pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tS3YrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2sExf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-SwKRG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-pOxi6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-z9B3Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-TS0EyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-EeboB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:17 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)) 15:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tLUHoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:18 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)) 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-CfbSGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:18 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)) 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5kFdOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:18 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)) 15:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-CR4FeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:18 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)) 15:53:18 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)) 15:53:18 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)) 15:53:18 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)) 15:53:18 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)) 15:53:18 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)) 15:53:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:18 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 15:53:18 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 15:53:18 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 15:53:18 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 15:53:18 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 15:53:18 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 15:53:20 INFO - Downloading blessings-1.5.1.tar.gz 15:53:20 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 15:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:20 INFO - Installing collected packages: blessings 15:53:20 INFO - Running setup.py install for blessings 15:53:20 INFO - Successfully installed blessings 15:53:20 INFO - Cleaning up... 15:53:20 INFO - Return code: 0 15:53:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:21 INFO - Reading from file tmpfile_stdout 15:53:21 INFO - Current package versions: 15:53:21 INFO - blessings == 1.5.1 15:53:21 INFO - blobuploader == 1.2.4 15:53:21 INFO - docopt == 0.6.1 15:53:21 INFO - manifestparser == 1.1 15:53:21 INFO - mozInstall == 1.12 15:53:21 INFO - mozcrash == 0.16 15:53:21 INFO - mozdebug == 0.1 15:53:21 INFO - mozdevice == 0.47 15:53:21 INFO - mozfile == 1.2 15:53:21 INFO - mozhttpd == 0.7 15:53:21 INFO - mozinfo == 0.9 15:53:21 INFO - mozleak == 0.1 15:53:21 INFO - mozlog == 3.1 15:53:21 INFO - moznetwork == 0.27 15:53:21 INFO - mozprocess == 0.22 15:53:21 INFO - mozprofile == 0.27 15:53:21 INFO - mozrunner == 6.11 15:53:21 INFO - mozscreenshot == 0.1 15:53:21 INFO - mozsystemmonitor == 0.0 15:53:21 INFO - moztest == 0.7 15:53:21 INFO - mozversion == 1.4 15:53:21 INFO - psutil == 3.1.1 15:53:21 INFO - requests == 1.2.3 15:53:21 INFO - wsgiref == 0.1.2 15:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:21 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')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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 0x11034b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110328228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b0c3ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/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.o7r4nt0rYV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:21 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 15:53:21 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 15:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:21 INFO - 'HOME': '/Users/cltbld', 15:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PAGER': '/bin/cat', 15:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:21 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - 'XPC_FLAGS': '0x0', 15:53:21 INFO - 'XPC_SERVICE_NAME': '0', 15:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 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)) 15:53:21 INFO - Cleaning up... 15:53:21 INFO - Return code: 0 15:53:21 INFO - Running post-action listener: _resource_record_post_action 15:53:21 INFO - Running post-action listener: _start_resource_monitoring 15:53:21 INFO - Starting resource monitoring. 15:53:21 INFO - ##### 15:53:21 INFO - ##### Running install step. 15:53:21 INFO - ##### 15:53:21 INFO - Running pre-action listener: _resource_record_pre_action 15:53:21 INFO - Running main action method: install 15:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:21 INFO - Reading from file tmpfile_stdout 15:53:21 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:21 INFO - Reading from file tmpfile_stdout 15:53:21 INFO - Output received: 15:53:21 INFO - Usage: mozinstall [options] installer 15:53:21 INFO - Options: 15:53:21 INFO - -h, --help show this help message and exit 15:53:21 INFO - -d DEST, --destination=DEST 15:53:21 INFO - Directory to install application into. [default: 15:53:21 INFO - "/builds/slave/test"] 15:53:21 INFO - --app=APP Application being installed. [default: firefox] 15:53:21 INFO - mkdir: /builds/slave/test/build/application 15:53:21 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'] 15:53:21 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 15:53:53 INFO - Reading from file tmpfile_stdout 15:53:53 INFO - Output received: 15:53:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:53:53 INFO - Running post-action listener: _resource_record_post_action 15:53:53 INFO - ##### 15:53:53 INFO - ##### Running run-tests step. 15:53:53 INFO - ##### 15:53:53 INFO - Running pre-action listener: _resource_record_pre_action 15:53:53 INFO - Running main action method: run_tests 15:53:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:53 INFO - 2015-11-24 15:53:53.030 screenresolution[1639:7355] starting screenresolution argv=screenresolution get 15:53:53 INFO - 2015-11-24 15:53:53.033 screenresolution[1639:7355] Display 0: 1600x1200x32@60 15:53:53 INFO - 2015-11-24 15:53:53.039 screenresolution[1640:7358] starting screenresolution argv=screenresolution list 15:53:53 INFO - Available Modes on Display 0 15:53:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:53 INFO - Intel Iris: 15:53:53 INFO - Chipset Model: Intel Iris 15:53:53 INFO - Type: GPU 15:53:53 INFO - Bus: Built-In 15:53:53 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:53 INFO - Vendor: Intel (0x8086) 15:53:53 INFO - Device ID: 0x0a2e 15:53:53 INFO - Revision ID: 0x0009 15:53:53 INFO - Displays: 15:53:53 INFO - Display: 15:53:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:53 INFO - Display Serial Number: 1600x1200 60 15:53:53 INFO - Main Display: Yes 15:53:53 INFO - Mirror: Off 15:53:53 INFO - Online: Yes 15:53:53 INFO - Rotation: Supported 15:53:53 INFO - Return code: 0 15:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:53 INFO - Python 2.7.3 15:53:53 INFO - Return code: 0 15:53:53 INFO - grabbing minidump binary from tooltool 15:53:53 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')]} 15:53:53 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 0x11026f9f0>, '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 0x10ffcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102628c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:53 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 15:53:53 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 15:53:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:53 INFO - Return code: 0 15:53:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:53:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:53:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost'] in /builds/slave/test/build 15:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost 15:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6i4X9XxdMw/Render', 15:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:53 INFO - 'HOME': '/Users/cltbld', 15:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:53 INFO - 'LOGNAME': 'cltbld', 15:53:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:53 INFO - 'MOZ_NO_REMOTE': '1', 15:53:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:53 INFO - 'NO_EM_RESTART': '1', 15:53:53 INFO - 'PAGER': '/bin/cat', 15:53:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:53 INFO - 'PWD': '/builds/slave/test', 15:53:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:53 INFO - 'SHELL': '/bin/bash', 15:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o7r4nt0rYV/Listeners', 15:53:53 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:53 INFO - 'USER': 'cltbld', 15:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:53 INFO - 'XPC_FLAGS': '0x0', 15:53:53 INFO - 'XPC_SERVICE_NAME': '0', 15:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost'] with output_timeout 3600 15:53:53 INFO - mozversion INFO | application_buildid: 20151124145732 15:53:53 INFO - mozversion INFO | application_changeset: 88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7 15:53:53 INFO - mozversion INFO | application_display_name: Nightly 15:53:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:53 INFO - mozversion INFO | application_name: Firefox 15:53:53 INFO - mozversion INFO | application_remotingname: firefox 15:53:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:53:53 INFO - mozversion INFO | application_vendor: Mozilla 15:53:53 INFO - mozversion INFO | application_version: 45.0a1 15:53:53 INFO - mozversion INFO | platform_buildid: 20151124145732 15:53:53 INFO - mozversion INFO | platform_changeset: 88d5bc46a5498c15306d6a360c1a57f1cfbc3ea7 15:53:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:53 INFO - mozversion INFO | platform_version: 45.0a1 15:53:53 INFO - 2015-11-24 15:53:53,586 DEBUG : using testdate: 1448409233 15:53:53 INFO - 2015-11-24 15:53:53,586 DEBUG : actual date: 1448409233 15:53:53 INFO - 2015-11-24 15:53:53,971 INFO : starting webserver on 'localhost:49264' 15:53:53 INFO - 2015-11-24 15:53:53,972 INFO : Starting test suite t-yosemite-r7-0051 15:53:53 INFO - 2015-11-24 15:53:53,972 INFO : Starting test dromaeo_css 15:53:53 INFO - 2015-11-24 15:53:53,972 DEBUG : operating with platform_type : mac_ 15:53:53 INFO - 2015-11-24 15:53:53,973 INFO : Initialising browser for dromaeo_css test... 15:53:53 INFO - 2015-11-24 15:53:53,986 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpTzokaJ/profile http://localhost:49264/getInfo.html 15:53:56 INFO - 2015-11-24 15:53:56,213 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:53:56 INFO - 2015-11-24 15:53:56,214 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:53:56 INFO - 2015-11-24 15:53:56,214 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:53:56 INFO - 2015-11-24 15:53:56,214 DEBUG : BROWSER_OUTPUT: __metrics 15:53:56 INFO - 2015-11-24 15:53:56,229 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:56 INFO - 2015-11-24 15:53:56,873 INFO : Browser initialized. 15:53:56 INFO - 2015-11-24 15:53:56,873 INFO : Running cycle 1/1 for dromaeo_css test... 15:53:56 INFO - 2015-11-24 15:53:56,874 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpTzokaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:08 INFO - 2015-11-24 15:54:08,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 226484224 15:54:08 INFO - 2015-11-24 15:54:08,769 DEBUG : BROWSER_OUTPUT: 15:54:59 INFO - 2015-11-24 15:54:59,872 DEBUG : BROWSER_OUTPUT: 1448409299867 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] 15:57:10 INFO - 2015-11-24 15:57:10,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 15:57:12 INFO - 2015-11-24 15:57:12,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 415526912 15:57:12 INFO - 2015-11-24 15:57:12,354 DEBUG : BROWSER_OUTPUT: 16:00:15 INFO - 2015-11-24 16:00:15,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 16:00:15 INFO - 2015-11-24 16:00:15,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 360267776 16:00:15 INFO - 2015-11-24 16:00:15,797 DEBUG : BROWSER_OUTPUT: 16:03:17 INFO - 2015-11-24 16:03:17,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 16:03:18 INFO - 2015-11-24 16:03:18,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 351633408 16:03:18 INFO - 2015-11-24 16:03:18,436 DEBUG : BROWSER_OUTPUT: 16:06:20 INFO - 2015-11-24 16:06:20,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 16:06:20 INFO - 2015-11-24 16:06:20,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 321421312 16:06:20 INFO - 2015-11-24 16:06:20,975 DEBUG : BROWSER_OUTPUT: 16:09:23 INFO - 2015-11-24 16:09:23,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 16:09:24 INFO - 2015-11-24 16:09:24,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 320344064 16:09:24 INFO - 2015-11-24 16:09:24,416 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 16:12:27 INFO - 2015-11-24 16:12:27,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 369123328 16:12:27 INFO - 2015-11-24 16:12:27,354 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,355 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:12:27 INFO - 2015-11-24 16:12:27,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:12:27 INFO - 2015-11-24 16:12:27,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:12:27 INFO - 2015-11-24 16:12:27,355 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:12:27 INFO - 2015-11-24 16:12:27,355 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3306.8346582670865;3474.1314671332166;3514.051206174333;3528.1532432216277;3551.1477245461087;5591.245181900442;5728.226689396935;5731.971340143294;5750.511206547443;5792.304923409186;5653.717314134287;5687.345955215152;5739.684317362543;5768.105943578742;5913;5130.9230361544605;5172.327597412341;5178.378594568657;5192.688438693672;5257.658252213594;5297.152455607104;5308.416074231832;5314.574834013289;5332.546733527654;5382.865428364283;5083.186690129562;5205.24523944026;5210.895782084337;5259.86850328741;5261.473852614727;5090.287359769635;5194.142966410538;5199.662021968597;5216.895662086775;5230.450802665703;5085.059264036166;5122.897542049175;5124.154514505102;5136.512031357015;5176.7411629418375;5562.360328562227;5600.411956744524;5648.406917273709;5671;5672.858178545528;5192.948070519285;6119.602225855349;6170.84572885677;6233.5948163369685;6258.4680302174365;6296.275928268262;6320.431161195468;6335.144755458;6339.683015849189;6360.650164240965;5772.336181339116;5900.1149827526215;5903.26209223847;5907.1434641976675;5939.465448109648;6127.964259358901;6246.625202487865;6281.371862813682;6383.6488993104895;6406.807795766134;6180.783672571439;6206.472449841814;6215.720292586844;6226.750929962841;6237.875242495124;6126.314740042852;6294.181756371642;6297.433231009231;6312.8421789454715;6323.462505686976;6125.540694081699;6145.385461453819;6227.813165605039;6265.65538895356;6273.749050038039;6280.152179455807;6299.464545513591;6302.968485157545;6306.747730090837;6325.620462772248;4812.590929771009;5009.24861270805;5018.433339783774;5019.347484826949;5069.5690866276045;4507.932381014288;4528.660350473728;4533.070720502289;4566.862994110115;4583.427071616048;5709.65742055478;5753.539716822645;5760.452756988079;5778.219940308089;5787.305523337142;6148.815535533941;6232.501399887998;6259.7496100156395;6263.279722831841;6279.717412716439;5826.533877289807;5835.766569337179;5851.21008663825;5874.295084589877;5881.882362352814;5458.4814442627885;5467.5625949923915;5480.835574932758;5482.890342193214;5484.808031718871;6170.938290617126;6318.778842740482;6384.968075159594;6401.3278605746655;6401.3598640135615;6152.0156774915795;6245.469135123383;6291.779787707408;6298.748050077946;6303.49572034227;6335.588186767845;6345.873082538231;6348.396902294275;6357.205349331333;6363.5227357947415;5981.611195272293;6107.5226075721885;6231.4391704746795;6232.532560057924;6242.875142497215;6141.455323060992;6264.812055638338;6298.622082675054;6303.779367722108;6304.148939893055;5961.970190149022;6149.538784591084;6176.382361763787;6194.876102478015;6204.72078756448;5931.495822855106;6031.638101713911;6159.137720719193;6166.537509686702;6187.257529096357;5542.558934677094;5942.554308426799;5944.989351810289;5951.732172052181;5960.940390596039;5055.69665820052;5544.362398324083;6056.788012419544;6099.897739344476;6138.5396095292135;6031.517478601789;6041.667708276087;6054.273487181566;6057.757689692363;6112.17485639433 16:12:27 INFO - 2015-11-24 16:12:27,357 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.8734628806952;579.6782785554021;611.3611276216353;615.599860090941;641.3169973977714;27080.72919270809;32876.83561582192;32937.67062329376;41932.37101443481;42480.57519424805;44704.10591788162;44957;45043.324350134775;45268.868278292975;45285.32072018914;8314.792130196749;9974.152197063258;9982.151517121018;9983.850242246372;10019.699409017741;8913.821723565525;9023.09769023099;9035.593398297093;12104.636860894187;12228.144029917865;11959.521619135225;12038.458269377856;12058.517659293619;12065.517379304818;12090.45592948315;11958.880411195863;12036.217645853036;12063.819042714365;12070.336131512764;12083.758324833454;8993.955030224872;9097.044810294956;9127.634894604207;11934;12085.818712719316;40417;40713;40853;40888.79555602233;40901.682781238545;3114;3143.4341818472667;3150.4329220740256;3235.4014507315987;3552.946705799415;29138.854305728335;29797.255068623243;29842.40315193706;29981;30175.547366789517;2842.3849463644738;2853.7859660525337;2854.3292326303304;2875.52553828618;2992.431438026768;487613;491952;492612;492831;493822;56223.437765622635;56952.71523642355;57038;65549;66083;67951.32048679549;68126;68812;68815.65592172007;69071;15453.38186472551;15605.297761600756;15611.687766244839;15613.297401616728;15618;11766.058715302755;11850.407479625985;11855.762884742257;11856.525738970517;11869;19972.300969466;20204.898975505028;20301.28945486901;20317.9841007949;20342;8373.645704233886;8472.406931514735;8505.447145935494;8513.361497887683;8569.771859316497;987.9407235565889;1017.6794309792392;1056.1550759392455;1080.0765345629532;1160.7562411893427;29362.853185733933;29611;29994.700052999626;30085;30200.395992080037;1026.3790406803926;1096.7587130831364;1097.308695521832;1114.7101753544136;1143.805553055966;14752.852471475362;15137.016093953858;15154.090754554762;15395.769063464057;15441.227938603024;519558;528219;528470;530429.3478532659;530871;58831;59111;59150;59193.40806591965;59195.704021479614;1421.289355322339;1429.0568224971469;1462.7293950619169;1463.4804644351102;1466.4280930437137;26768.59847102256;29164.27089322784;31083.378332433676;31254.374912501167;31865.522017170224;53549;54065.45934540762;54122;54147.729261355016;54217.72891135677;463858;466670;466893;466947;467389;28680.996165134122;29231.85384073066;31545.895893643614;32883.50674739929;34049.82975085109;41732.3740143892;42258.78870605627;42418;42591;43173.136537269704;30549.847250763603;31445.213869652525;33286.500702489;33771.83114084414;35436.64563354333;31849.68150318467;32136;36388;36511.269774603825;37370.813145934095;35733.57065717342;35754.64245357513;36329.45505817362;36533.817330913174;36533.81733091424;32210.19474513156;32259.838700806347;32338.676613233565;42137.15725685408;42448.36327455029;31455.37089258248;33009.009729708145;33538;33696.831515843245;34008.14979625529 16:12:27 INFO - 2015-11-24 16:12:27,360 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.46708171283916;358.6861496190833;364.22056798451337;365.99634003659963;369.3536311454954;15629.296681649324;16008.119553424556;19189.520261993457;19607.901960490195;20262.797372026256;16660.333586656518;19164.520886977796;19481.610367792637;19507.804921950777;19529;5715.771369145229;5878.823635290927;5884.264466941632;5893.734781934823;5896.793612223584;3950.091478959841;4063.5123785145825;4066.9796651016704;5855.033919403315;5882.029465138247;5682.801101961432;5787.971060144693;5835.387284335147;5840.620359676629;5844.736986835603;5736.684482353469;5822.1266809978415;5986.161937328778;6243.812685619393;6476.158099447089;5143.27994080829;5428.697112692965;5719.170720245583;5723.742431590588;5725.770969161229;19595.530335224914;24936.12723554685;25096.37259068538;25482;25528.617070743952;2057.1565658080267;2073.2763339935655;2132.5201829588373;2170.0885628036103;2274.9886250568643;8621.05168431472;9653.71038868828;9857.457839818808;10065.949670251675;11857.762844743056;1677.3626022111641;1696.1349711647026;1720.4924547258588;1728.9221985010704;1768.8231176882337;94814;97849;100493;100512.98974020552;100601;10023.799524009479;10049.69850904474;10055.346402483816;10105.949470252748;10141.340812847142;12165.574204902787;12189.451474683661;12191.658917519066;12215.816762748565;12225.388730563436;7799;7835;7849.411294152847;7858.724944626911;7978.281954623995;7987;7993.600319984093;8038.598070096472;8062.314703250289;8071.4349995500925;3411.7441191910707;3722.906927326784;3848.634379733921;3891.2412079644196;3940.172563761585;1454.9709005819825;1755.262789628359;1758.806531281558;1774.600714839151;1791.6595846789069;703.7536862098327;914.5655813488539;1036.1917704190744;1047.9476026198658;1091.0725882999545;19471.12379942906;20038.799612003986;20342.59314813725;20618.58762824765;20690.068946897427;917.3440989692268;966.1884017425256;981.3277904635347;1004.8794144702537;1052.7315534538643;11015.251502420415;11469.655910322537;11490.885091149148;11513.827292590619;11521.48153333102;750824;757849;768344;768377.1581142058;773244;103337;113403.43298283455;120212;120223.79776202301;120783;1160.0719424460399;1180.887815657511;1192.1237890150733;1194.0686264713538;1197.3175290084569;18004;18138.274469021093;18144.364947226783;18243.270269189616;18339.26642934321;49840.75079624579;50413.73965650888;50614.49385506098;50633.49366506288;51124.23313650224;65435;66415.66792166009;67285.66357168183;67612;68608.6569567149;9516.286278529276;9605.47169905662;9616.615335386507;9780;9794.412335259907;11491.942540287246;11561.826572601249;14877.702445951238;19314.806851931302;20057;15347.462838800588;15372.769408458658;15623.531294061197;15695.058296502246;15776.053436793829;15265;15365.692686146438;15431.228438578251;15572.221388930735;15620.531384058497;15849.447685860983;16043.919780401024;16668.41660541875;16672.749908751135;16673.333066677198;9151.86272205904;9792.069753373418;9878.209743220668;9880.35777674449;9920;8841.823163536821;10266.743331416475;12113.333766642567;15425.61435964065;15984.600384990468 16:12:27 INFO - 2015-11-24 16:12:27,361 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1581.61250493629;1584.8018997625297;1588.4202266172842;1899.7150427435884;1915.984528200054;7574.24257574243;8012.158723334053;8059.879101813477;8449.281811046068;8480.151984801516;8217.342612590994;8347.582620868963;8393.076761556224;8397.202265784756;8398;2342.2153578551206;2342.5197834443898;2360.7875291223786;2381.011880069778;2382.273406610983;2357.6581395697613;2382.9761702383016;2435.3789783605243;2437.512497500507;2439.1950656283384;2357.422431504284;2377.4294169399304;2380.440596459839;2385.0817435287454;2396.580598395283;2276.829237807171;2307.2270789285526;2314.2941402872116;2317.571249318873;2318.6058370077126;2356.964645530318;2374.358923090756;2381.3332266965276;2389.7251816041203;2392.210570511727;7697.615119244016;8317;8375.329973602158;8376.329893608498;8377.162283771635;4690.0854333405;4739.170645137087;5090.618203634742;5143.897122057575;5185.222216667492;3255.951160732591;3266.281418088017;3390.0677313738674;3601.4957905893198;3640.6541378568995;1042.9478526073742;1046.602291129366;1050.9842352364722;1066.834013178539;1078.3745427651943;11031.22781405302;11081.891810818854;11089.168312376603;11096.05683516902;11115.83326250107;4610.95389046112;4723.929141062887;4739.454962679267;4747.264174053027;4756.048790241965;9809.901900981042;9814.06766357195;9821.263405244636;9837.9016209837;9840.704778856645;5161.612879034087;5193.68837869729;5198.142306519458;5200.583953283728;5204.21936709489;4649.139909116824;4661.95338046622;4662.207424737802;4676.0647870426055;4697.13103075932;3678.8712395066045;3713.795741234258;3730.5896351401325;3736.4768932349493;3753.249350129985;1240.3984067727326;1252.7619752247044;1257.490716259898;1261.8296529968336;1262.5959692898368;1195.3485350484007;1328.9069765116349;1369.9041067125404;1399.8670126337981;1403.8175037245094;7835.373170146375;7858.332041776399;7923.6830526778285;7938.56337901421;7945.364370850318;458.429255576809;464.38237144597605;497.9153543897546;503.31800410444055;503.7556784959292;5996.880062398727;6132.50939924805;6146.262448506208;6164.075388691732;6167.074938759222;9449.196818270386;10234.590616375262;10244.897551024544;10250.231232657581;10344.896551034393;10044.29689921713;10138.188944884392;10226.693199204035;10348.275620706478;10354.948225258826;7873.409494287951;7936.56348900816;8034.397420193392;8085.353171746128;8088.4742491739025;7650.8087297818;7710.460267781202;7738.883916741141;7762.5730584818375;7764.06831180262;9041.77395565116;9091.090890910857;9129.45223286605;9149.483891929773;9151.588178532114;9227.169554740105;9443.952780236055;9445.716628501155;9541.856872146784;9555.569999349907;6738.696758645775;7118.145822501126;7173.6054516999975;7208;7235.63821808918;7910.169432209535;8004.399670024888;8013.038435387558;8021.558814265271;8022.157673444438;7267.273272672691;7440.962795185989;7463.328300452985;7573.46985710995;7631.3513351365755;7333.449991250571;7345.265473452826;7361;7394.704211831467;7454.3663788576405;7465.216152303929;7519.285667861544;7522.548647081193;7524.05949256343;7526.172121066569;6667.866642667216;6823.147106611674;6847.417969472651;6854.691538880663;6859.622720750406;6900.171979362509;6963.1644202696;6967.233604303421;6969.7909062728195;6972.4073453757 16:12:27 INFO - 2015-11-24 16:12:27,363 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.95982562441264;300.47117073949846;331.3770112189084;332.81362437035244;335.0668388537919;6544.705488253028;6569.50728695348;6610.2398224204235;6635.668216589163;6641;6518.120053792736;6523.575967562105;6525.706343214555;6532.216134063919;6533.705983230754;4628.652851036169;4697.037107392976;4702.97648511757;4867.123917694814;4895.9510404895855;4740.360051393052;4773.164696178173;4851.078295123933;4865.975670121645;4878.390201224847;4762.618990480753;4763.26169443735;4773.331733557305;4789.305550695147;4795.256735206049;4633.305004249356;4656.906861862778;4715.599174070208;4748.5014073522125;4787.425508938914;4091.0590564170407;4094.2016306820183;4100.01599616093;4119.743478239136;4121.155163191538;6250.374962503759;6337.112804207414;6364.649944253064;6389.7763578274535;6390;4701.365315682373;5460.699661518614;5775.27809023872;5798.072308430631;5813.883722325572;6862.4853136015;7149.53528020677;7163.641817909083;7183.102112235971;7197.496175267734;4011.7191796574252;4602.378678878342;4621.445426548836;4622.560856718606;4624.8150073997;5955.940440595626;7271.63641817907;7522.097348318237;7573.242675732383;7585.734499292498;4637.721736695741;4680.485146633868;4682.274247491644;4693.20215563355;4695.929561056587;4757.595604373667;4761.285807128958;4767.118083154627;4771.379720636295;4775.021120670254;5671.574631902624;5679.971600141973;5690.317161940511;5699.74351154199;5707.1153971134545;7010.579365238102;7197.604131772698;7201.099862517185;7216.170140433812;7276.272372762787;1639.2213698493358;1657.7927759030122;1660.7342825147919;1661.567992322005;1663.4926347463897;1030.4744580263969;1036.1451802263164;1041.1670663469345;1045.3988956350129;1055.630529314749;5382.461753824665;6644.435223006099;6655.201375834931;6678.131842860397;6684.665766711742;6491.123698300763;6867.836631461074;7424.257574242532;7427.814304642319;7442.813929651802;6472.093906853044;6645.269020407752;6648.5678430901835;6654.567453115629;6664.400203981665;3942.5466071402157;3956.2680904032845;3959.465472161279;3959.5842436544326;3978.3236849735613;7715.382769378436;7720.3437707795465;7727.729529466554;7737;7742.806429839186;7028.718851245892;7437.479376443705;7697.807554811063;7745.92254077452;7771.028621422322;7701.961490192513;7737.497062690907;7738.342240909473;7742.070951485858;7743.070831500256;7379.926200737924;7380.630968451664;7392.630368481662;7399.371053460516;7401.555906645403;7034.577925324497;7248.710051598088;7336.853262934605;7356.558606483414;7381.557106573623;6277.937220627735;7702;7706.614669266626;7719.3052625264;7727.961360193163;3938.8380427773304;4658.114958157939;4681.297805329228;4684.48470668233;4695.812167513262;5492.780288788404;7379.631018449163;7388.224236455309;7404.445066536087;7418.109826820816;7113.644317784194;7129.500934934712;7131.536450130725;7133.607651579213;7140.750073747394;5695.316562012585;6885.414739746977;7111.359977602041;7122.893156602759;7123.643817808985;6754.5947243165565;6952.930470695228;6957.443404527525;6960.443164546926;6974.407175390149;6939.201991771011;7065.929340706527;7085.185203701434;7170.533915295698;7173.569585824867;7007.579545227099;7039.753608623879;7048.788536343918;7052.612106334201;7054.047703559953 16:12:27 INFO - 2015-11-24 16:12:27,366 DEBUG : BROWSER_OUTPUT: |5;yui.html;723.8407550338926;754.0950858969238;786.551665550636;814.5194335342147;840.6595328891793;14838.703225935475;15193.392264309414;15201.391944322228;15259.389624415011;15272.236388180601;13967.44130234792;14164.291785410715;14196.929015354908;14201.857981420182;14240.78638820416;757.2124990010383;772.2354868679995;774.1561697749452;933.9019402962676;950.6815216902346;946.5693109635134;950.7337945375306;962.0860182826308;963.3689933093834;963.6819849449665;751.4364226829878;992.4095163377779;1001.444198469849;1013.3869009249408;1021.5198856537453;779.5205948341758;792.13657113746;793.6587267474983;975.9170470510015;992.7319623701633;743.5835931878112;749.5727435361846;751.5903832411349;754.1628792040831;755.365492985889;15092.24538773068;15199.316030778642;15209.467668631656;15210.08739475624;15214.391424343014;12662.176958497668;12887.806682899763;12928.741425171538;13170.53903113396;13401.46394144233;10102.949485252526;10118.392896426165;10147.89852101477;10161.034701703325;10198.337108088024;3496.772709773882;3567.7145828333933;3573.8391772370046;3574.5531808523933;3576.660217279354;73581.26418735851;75071;75243.49513009709;75558;83998;9429.009953954735;9432.481213533321;9433.76415589602;9437.292203084797;9497.335186537015;21218.469538261357;21449;21463.67804482934;21507.13971441156;21617.459563510725;7226.674799633924;7249.746258880914;7404.259574042552;7414.036175297177;7558.9244107558225;3883.2815929053218;3919.9608003920166;3935.74417662851;3937.645611894943;3956.347202711578;3570.1431656402797;3619.4570814378053;3619.6923261523066;3621.492990981265;3622.3660859349507;638.3329420755322;639.2073828452778;644.5520363347522;648.844277373427;656.2846497317946;401.3538203492375;488.01177615329243;506.76435457512434;525.6530689744826;526.2500936166025;8189.549574773326;8584.098669639723;8658.307335413152;8778.912210877937;8896.688615898542;534.3080710479937;581.5725441800273;623.3486007122477;634.4892361648824;656.7602824968852;3506.929861402809;3619.7647152934974;3630.3283892479976;3641.2535430237267;3758.642928921748;96785;101769.49115254376;102654.48672756589;102840.48579757054;102922;87706.24587508342;88052.67920981062;88069;88593;89920.55039724891;76979;78361.4327713454;79296;79802.60098699585;79887.60056199682;7134.821629459305;8358.665653373797;8397.118302578141;8588.398812083344;8608.655653774029;49663;49871;50076.74961625168;50416;54604.90790184095;71963.64018179875;73280;73693.26306737079;73720.26279737349;73830;10847.728806779895;11231.71920701989;11285.37930413835;11390.715232119263;11524.59663911759;10300;12134;12420.503179872703;12514.12401131912;12595.307258100893;11731;11843.348615826213;11854.525818967144;11892.345920974429;11962.700932476757;11339.546418143182;11604.419779011185;11618.302901825917;12011.339376334035;12439.191452555555;6730.497628254369;10445.529951152368;11225;11533.250338727956;12340.691482713004;9788.216942644429;9793.510324483605;9954.651587194414;10093.848592270975;10301.639442619473;9624.951875240578;9828.4102953823;10042.69871903844;10098;10226.233032522441 16:12:27 INFO - 2015-11-24 16:12:27,366 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:12:27 INFO - 2015-11-24 16:12:27,366 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1754 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: __startTimestamp1448410347351__endTimestamp 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5765.55 Median:5951.73 stddev:629.58 (10.6%) stddev-sans-first:601.24 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: Values: 3306.8 3474.1 3514.1 3528.2 3551.1 5591.2 5728.2 5732.0 5750.5 5792.3 5653.7 5687.3 5739.7 5768.1 5913.0 5130.9 5172.3 5178.4 5192.7 5257.7 5297.2 5308.4 5314.6 5332.5 5382.9 5083.2 5205.2 5210.9 5259.9 5261.5 5090.3 5194.1 5199.7 5216.9 5230.5 5085.1 5122.9 5124.2 5136.5 5176.7 5562.4 5600.4 5648.4 5671.0 5672.9 5192.9 6119.6 6170.8 6233.6 6258.5 6296.3 6320.4 6335.1 6339.7 6360.7 5772.3 5900.1 5903.3 5907.1 5939.5 6128.0 6246.6 6281.4 6383.6 6406.8 6180.8 6206.5 6215.7 6226.8 6237.9 6126.3 6294.2 6297.4 6312.8 6323.5 6125.5 6145.4 6227.8 6265.7 6273.7 6280.2 6299.5 6303.0 6306.7 6325.6 4812.6 5009.2 5018.4 5019.3 5069.6 4507.9 4528.7 4533.1 4566.9 4583.4 5709.7 5753.5 5760.5 5778.2 5787.3 6148.8 6232.5 6259.7 6263.3 6279.7 5826.5 5835.8 5851.2 5874.3 5881.9 5458.5 5467.6 5480.8 5482.9 5484.8 6170.9 6318.8 6385.0 6401.3 6401.4 6152.0 6245.5 6291.8 6298.7 6303.5 6335.6 6345.9 6348.4 6357.2 6363.5 5981.6 6107.5 6231.4 6232.5 6242.9 6141.5 6264.8 6298.6 6303.8 6304.1 5962.0 6149.5 6176.4 6194.9 6204.7 5931.5 6031.6 6159.1 6166.5 6187.3 5542.6 5942.6 5945.0 5951.7 5960.9 5055.7 5544.4 6056.8 6099.9 6138.5 6031.5 6041.7 6054.3 6057.8 6112.2 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,367 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64487.30 Median:33617.42 stddev:131694.22 (391.7%) stddev-sans-first:131976.10 16:12:27 INFO - 2015-11-24 16:12:27,369 DEBUG : BROWSER_OUTPUT: Values: 526.9 579.7 611.4 615.6 641.3 27080.7 32876.8 32937.7 41932.4 42480.6 44704.1 44957.0 45043.3 45268.9 45285.3 8314.8 9974.2 9982.2 9983.9 10019.7 8913.8 9023.1 9035.6 12104.6 12228.1 11959.5 12038.5 12058.5 12065.5 12090.5 11958.9 12036.2 12063.8 12070.3 12083.8 8994.0 9097.0 9127.6 11934.0 12085.8 40417.0 40713.0 40853.0 40888.8 40901.7 3114.0 3143.4 3150.4 3235.4 3552.9 29138.9 29797.3 29842.4 29981.0 30175.5 2842.4 2853.8 2854.3 2875.5 2992.4 487613.0 491952.0 492612.0 492831.0 493822.0 56223.4 56952.7 57038.0 65549.0 66083.0 67951.3 68126.0 68812.0 68815.7 69071.0 15453.4 15605.3 15611.7 15613.3 15618.0 11766.1 11850.4 11855.8 11856.5 11869.0 19972.3 20204.9 20301.3 20318.0 20342.0 8373.6 8472.4 8505.4 8513.4 8569.8 987.9 1017.7 1056.2 1080.1 1160.8 29362.9 29611.0 29994.7 30085.0 30200.4 1026.4 1096.8 1097.3 1114.7 1143.8 14752.9 15137.0 15154.1 15395.8 15441.2 519558.0 528219.0 528470.0 530429.3 530871.0 58831.0 59111.0 59150.0 59193.4 59195.7 1421.3 1429.1 1462.7 1463.5 1466.4 26768.6 29164.3 31083.4 31254.4 31865.5 53549.0 54065.5 54122.0 54147.7 54217.7 463858.0 466670.0 466893.0 466947.0 467389.0 28681.0 29231.9 31545.9 32883.5 34049.8 41732.4 42258.8 42418.0 42591.0 43173.1 30549.8 31445.2 33286.5 33771.8 35436.6 31849.7 32136.0 36388.0 36511.3 37370.8 35733.6 35754.6 36329.5 36533.8 36533.8 32210.2 32259.8 32338.7 42137.2 42448.4 31455.4 33009.0 33538.0 33696.8 34008.1 16:12:27 INFO - 2015-11-24 16:12:27,369 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,369 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38625.01 Median:11381.67 stddev:125520.38 (1102.8%) stddev-sans-first:125839.61 16:12:27 INFO - 2015-11-24 16:12:27,370 DEBUG : BROWSER_OUTPUT: Values: 356.5 358.7 364.2 366.0 369.4 15629.3 16008.1 19189.5 19607.9 20262.8 16660.3 19164.5 19481.6 19507.8 19529.0 5715.8 5878.8 5884.3 5893.7 5896.8 3950.1 4063.5 4067.0 5855.0 5882.0 5682.8 5788.0 5835.4 5840.6 5844.7 5736.7 5822.1 5986.2 6243.8 6476.2 5143.3 5428.7 5719.2 5723.7 5725.8 19595.5 24936.1 25096.4 25482.0 25528.6 2057.2 2073.3 2132.5 2170.1 2275.0 8621.1 9653.7 9857.5 10065.9 11857.8 1677.4 1696.1 1720.5 1728.9 1768.8 94814.0 97849.0 100493.0 100513.0 100601.0 10023.8 10049.7 10055.3 10105.9 10141.3 12165.6 12189.5 12191.7 12215.8 12225.4 7799.0 7835.0 7849.4 7858.7 7978.3 7987.0 7993.6 8038.6 8062.3 8071.4 3411.7 3722.9 3848.6 3891.2 3940.2 1455.0 1755.3 1758.8 1774.6 1791.7 703.8 914.6 1036.2 1047.9 1091.1 19471.1 20038.8 20342.6 20618.6 20690.1 917.3 966.2 981.3 1004.9 1052.7 11015.3 11469.7 11490.9 11513.8 11521.5 750824.0 757849.0 768344.0 768377.2 773244.0 103337.0 113403.4 120212.0 120223.8 120783.0 1160.1 1180.9 1192.1 1194.1 1197.3 18004.0 18138.3 18144.4 18243.3 18339.3 49840.8 50413.7 50614.5 50633.5 51124.2 65435.0 66415.7 67285.7 67612.0 68608.7 9516.3 9605.5 9616.6 9780.0 9794.4 11491.9 11561.8 14877.7 19314.8 20057.0 15347.5 15372.8 15623.5 15695.1 15776.1 15265.0 15365.7 15431.2 15572.2 15620.5 15849.4 16043.9 16668.4 16672.7 16673.3 9151.9 9792.1 9878.2 9880.4 9920.0 8841.8 10266.7 12113.3 15425.6 15984.6 16:12:27 INFO - 2015-11-24 16:12:27,371 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,371 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5828.97 Median:5195.92 stddev:3059.81 (58.9%) stddev-sans-first:3051.74 16:12:27 INFO - 2015-11-24 16:12:27,371 DEBUG : BROWSER_OUTPUT: Values: 1581.6 1584.8 1588.4 1899.7 1916.0 7574.2 8012.2 8059.9 8449.3 8480.2 8217.3 8347.6 8393.1 8397.2 8398.0 2342.2 2342.5 2360.8 2381.0 2382.3 2357.7 2383.0 2435.4 2437.5 2439.2 2357.4 2377.4 2380.4 2385.1 2396.6 2276.8 2307.2 2314.3 2317.6 2318.6 2357.0 2374.4 2381.3 2389.7 2392.2 7697.6 8317.0 8375.3 8376.3 8377.2 4690.1 4739.2 5090.6 5143.9 5185.2 3256.0 3266.3 3390.1 3601.5 3640.7 1042.9 1046.6 1051.0 1066.8 1078.4 11031.2 11081.9 11089.2 11096.1 11115.8 4611.0 4723.9 4739.5 4747.3 4756.0 9809.9 9814.1 9821.3 9837.9 9840.7 5161.6 5193.7 5198.1 5200.6 5204.2 4649.1 4662.0 4662.2 4676.1 4697.1 3678.9 3713.8 3730.6 3736.5 3753.2 1240.4 1252.8 1257.5 1261.8 1262.6 1195.3 1328.9 1369.9 1399.9 1403.8 7835.4 7858.3 7923.7 7938.6 7945.4 458.4 464.4 497.9 503.3 503.8 5996.9 6132.5 6146.3 6164.1 6167.1 9449.2 10234.6 10244.9 10250.2 10344.9 10044.3 10138.2 10226.7 10348.3 10354.9 7873.4 7936.6 8034.4 8085.4 8088.5 7650.8 7710.5 7738.9 7762.6 7764.1 9041.8 9091.1 9129.5 9149.5 9151.6 9227.2 9444.0 9445.7 9541.9 9555.6 6738.7 7118.1 7173.6 7208.0 7235.6 7910.2 8004.4 8013.0 8021.6 8022.2 7267.3 7441.0 7463.3 7573.5 7631.4 7333.4 7345.3 7361.0 7394.7 7454.4 7465.2 7519.3 7522.5 7524.1 7526.2 6667.9 6823.1 6847.4 6854.7 6859.6 6900.2 6963.2 6967.2 6969.8 6972.4 16:12:27 INFO - 2015-11-24 16:12:27,372 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,372 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5777.48 Median:6532.96 stddev:1868.04 (28.6%) stddev-sans-first:1827.26 16:12:27 INFO - 2015-11-24 16:12:27,372 DEBUG : BROWSER_OUTPUT: Values: 287.0 300.5 331.4 332.8 335.1 6544.7 6569.5 6610.2 6635.7 6641.0 6518.1 6523.6 6525.7 6532.2 6533.7 4628.7 4697.0 4703.0 4867.1 4896.0 4740.4 4773.2 4851.1 4866.0 4878.4 4762.6 4763.3 4773.3 4789.3 4795.3 4633.3 4656.9 4715.6 4748.5 4787.4 4091.1 4094.2 4100.0 4119.7 4121.2 6250.4 6337.1 6364.6 6389.8 6390.0 4701.4 5460.7 5775.3 5798.1 5813.9 6862.5 7149.5 7163.6 7183.1 7197.5 4011.7 4602.4 4621.4 4622.6 4624.8 5955.9 7271.6 7522.1 7573.2 7585.7 4637.7 4680.5 4682.3 4693.2 4695.9 4757.6 4761.3 4767.1 4771.4 4775.0 5671.6 5680.0 5690.3 5699.7 5707.1 7010.6 7197.6 7201.1 7216.2 7276.3 1639.2 1657.8 1660.7 1661.6 1663.5 1030.5 1036.1 1041.2 1045.4 1055.6 5382.5 6644.4 6655.2 6678.1 6684.7 6491.1 6867.8 7424.3 7427.8 7442.8 6472.1 6645.3 6648.6 6654.6 6664.4 3942.5 3956.3 3959.5 3959.6 3978.3 7715.4 7720.3 7727.7 7737.0 7742.8 7028.7 7437.5 7697.8 7745.9 7771.0 7702.0 7737.5 7738.3 7742.1 7743.1 7379.9 7380.6 7392.6 7399.4 7401.6 7034.6 7248.7 7336.9 7356.6 7381.6 6277.9 7702.0 7706.6 7719.3 7728.0 3938.8 4658.1 4681.3 4684.5 4695.8 5492.8 7379.6 7388.2 7404.4 7418.1 7113.6 7129.5 7131.5 7133.6 7140.8 5695.3 6885.4 7111.4 7122.9 7123.6 6754.6 6952.9 6957.4 6960.4 6974.4 6939.2 7065.9 7085.2 7170.5 7173.6 7007.6 7039.8 7048.8 7052.6 7054.0 16:12:27 INFO - 2015-11-24 16:12:27,372 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,372 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19203.64 Median:50246.37 stddev:27728.61 (55.2%) stddev-sans-first:27771.68 16:12:27 INFO - 2015-11-24 16:12:27,373 DEBUG : BROWSER_OUTPUT: Values: 723.8 754.1 786.6 814.5 840.7 14838.7 15193.4 15201.4 15259.4 15272.2 13967.4 14164.3 14196.9 14201.9 14240.8 757.2 772.2 774.2 933.9 950.7 946.6 950.7 962.1 963.4 963.7 751.4 992.4 1001.4 1013.4 1021.5 779.5 792.1 793.7 975.9 992.7 743.6 749.6 751.6 754.2 755.4 15092.2 15199.3 15209.5 15210.1 15214.4 12662.2 12887.8 12928.7 13170.5 13401.5 10102.9 10118.4 10147.9 10161.0 10198.3 3496.8 3567.7 3573.8 3574.6 3576.7 73581.3 75071.0 75243.5 75558.0 83998.0 9429.0 9432.5 9433.8 9437.3 9497.3 21218.5 21449.0 21463.7 21507.1 21617.5 7226.7 7249.7 7404.3 7414.0 7558.9 3883.3 3920.0 3935.7 3937.6 3956.3 3570.1 3619.5 3619.7 3621.5 3622.4 638.3 639.2 644.6 648.8 656.3 401.4 488.0 506.8 525.7 526.3 8189.5 8584.1 8658.3 8778.9 8896.7 534.3 581.6 623.3 634.5 656.8 3506.9 3619.8 3630.3 3641.3 3758.6 96785.0 101769.5 102654.5 102840.5 102922.0 87706.2 88052.7 88069.0 88593.0 89920.6 76979.0 78361.4 79296.0 79802.6 79887.6 7134.8 8358.7 8397.1 8588.4 8608.7 49663.0 49871.0 50076.7 50416.0 54604.9 71963.6 73280.0 73693.3 73720.3 73830.0 10847.7 11231.7 11285.4 11390.7 11524.6 10300.0 12134.0 12420.5 12514.1 12595.3 11731.0 11843.3 11854.5 11892.3 11962.7 11339.5 11604.4 11618.3 12011.3 12439.2 6730.5 10445.5 11225.0 11533.3 12340.7 9788.2 9793.5 9954.7 10093.8 10301.6 9625.0 9828.4 10042.7 10098.0 10226.2 16:12:27 INFO - 2015-11-24 16:12:27,374 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:12:27 INFO - 2015-11-24 16:12:27,374 DEBUG : BROWSER_OUTPUT: 16:12:27 INFO - 2015-11-24 16:12:27,765 INFO : Browser exited with error code: 0 16:12:27 INFO - 2015-11-24 16:12:27,789 INFO : Completed test dromaeo_css (00:18:33) 16:12:27 INFO - 2015-11-24 16:12:27,789 INFO : Starting test kraken 16:12:27 INFO - 2015-11-24 16:12:27,789 DEBUG : operating with platform_type : mac_ 16:12:27 INFO - 2015-11-24 16:12:27,789 INFO : Initialising browser for kraken test... 16:12:27 INFO - 2015-11-24 16:12:27,801 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp9XySYX/profile http://localhost:49264/getInfo.html 16:12:29 INFO - 2015-11-24 16:12:29,845 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:12:29 INFO - 2015-11-24 16:12:29,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:12:29 INFO - 2015-11-24 16:12:29,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:12:29 INFO - 2015-11-24 16:12:29,846 DEBUG : BROWSER_OUTPUT: __metrics 16:12:29 INFO - 2015-11-24 16:12:29,862 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:30 INFO - 2015-11-24 16:12:30,621 INFO : Browser initialized. 16:12:30 INFO - 2015-11-24 16:12:30,621 INFO : Running cycle 1/1 for kraken test... 16:12:30 INFO - 2015-11-24 16:12:30,621 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp9XySYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:12:42 INFO - 2015-11-24 16:12:42,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 225447936 16:12:42 INFO - 2015-11-24 16:12:42,414 DEBUG : BROWSER_OUTPUT: 16:12:44 INFO - 2015-11-24 16:12:44,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:45 INFO - 2015-11-24 16:12:45,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 275767296 16:12:45 INFO - 2015-11-24 16:12:45,530 DEBUG : BROWSER_OUTPUT: 16:12:48 INFO - 2015-11-24 16:12:48,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 16:12:48 INFO - 2015-11-24 16:12:48,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 289890304 16:12:48 INFO - 2015-11-24 16:12:48,792 DEBUG : BROWSER_OUTPUT: 16:12:52 INFO - 2015-11-24 16:12:52,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 16:12:52 INFO - 2015-11-24 16:12:52,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 276242432 16:12:52 INFO - 2015-11-24 16:12:52,675 DEBUG : BROWSER_OUTPUT: 16:12:54 INFO - 2015-11-24 16:12:54,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 16:12:55 INFO - 2015-11-24 16:12:55,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 277295104 16:12:55 INFO - 2015-11-24 16:12:55,220 DEBUG : BROWSER_OUTPUT: 16:12:57 INFO - 2015-11-24 16:12:57,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:57 INFO - 2015-11-24 16:12:57,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 279547904 16:12:57 INFO - 2015-11-24 16:12:57,798 DEBUG : BROWSER_OUTPUT: 16:13:00 INFO - 2015-11-24 16:13:00,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:01 INFO - 2015-11-24 16:13:01,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 281894912 16:13:01 INFO - 2015-11-24 16:13:01,055 DEBUG : BROWSER_OUTPUT: 16:13:03 INFO - 2015-11-24 16:13:03,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:04 INFO - 2015-11-24 16:13:04,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 282378240 16:13:04 INFO - 2015-11-24 16:13:04,511 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-11-24 16:13:07,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 16:13:07 INFO - 2015-11-24 16:13:07,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 280547328 16:13:07 INFO - 2015-11-24 16:13:07,836 DEBUG : BROWSER_OUTPUT: 16:13:09 INFO - 2015-11-24 16:13:09,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:09 INFO - 2015-11-24 16:13:09,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 316743680 16:13:09 INFO - 2015-11-24 16:13:09,956 DEBUG : BROWSER_OUTPUT: 16:13:11 INFO - 2015-11-24 16:13:11,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:12 INFO - 2015-11-24 16:13:12,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 315891712 16:13:12 INFO - 2015-11-24 16:13:12,488 DEBUG : BROWSER_OUTPUT: 16:13:14 INFO - 2015-11-24 16:13:14,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:15 INFO - 2015-11-24 16:13:15,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 322424832 16:13:15 INFO - 2015-11-24 16:13:15,364 DEBUG : BROWSER_OUTPUT: 16:13:17 INFO - 2015-11-24 16:13:17,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:18 INFO - 2015-11-24 16:13:18,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 324874240 16:13:18 INFO - 2015-11-24 16:13:18,523 DEBUG : BROWSER_OUTPUT: 16:13:20 INFO - 2015-11-24 16:13:20,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:21 INFO - 2015-11-24 16:13:21,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 323600384 16:13:21 INFO - 2015-11-24 16:13:21,535 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 382464000 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;102;109;109;106;109;108;102;108 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;125;179;186;125;142;139;117;156;125 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;182;183;193;254;182;182;184;180;181 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;78;112;97;62;58;57;72;73;59 16:13:23 INFO - 2015-11-24 16:13:23,474 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;83;115;73;75;76;108;77;75;107 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;85;86;84;85;85;85;87;87;88 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;94;111;150;93;92;97;93;94;93 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;86;84;86;85;84;118;86;86;83;86 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;54;54;54;54;53;52;66;53;53 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;65;66;98;99;101;66;66;67;67 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;107;103;105;81;83;85;94;108;107 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;131;132;123;130;120;121;124;118;118 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;133;131;135;136;135;137;134;135;123 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;63;65;64;64;64;64;66;68;65 16:13:23 INFO - 2015-11-24 16:13:23,475 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1046 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: __startTimestamp1448410403469__endTimestamp 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:13:23 INFO - 2015-11-24 16:13:23,476 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:109.00 stddev:2.94 (2.7%) stddev-sans-first:3.04 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 102.0 109.0 109.0 106.0 109.0 108.0 102.0 108.0 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:147.00 stddev:23.65 (16.1%) stddev-sans-first:24.93 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: Values: 152.0 125.0 179.0 186.0 125.0 142.0 139.0 117.0 156.0 125.0 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,478 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:190.30 Median:182.50 stddev:22.67 (12.4%) stddev-sans-first:23.85 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: Values: 182.0 182.0 183.0 193.0 254.0 182.0 182.0 184.0 180.0 181.0 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.40 Median:69.00 stddev:18.16 (26.3%) stddev-sans-first:19.06 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: Values: 66.0 78.0 112.0 97.0 62.0 58.0 57.0 72.0 73.0 59.0 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.30 Median:75.50 stddev:16.17 (21.4%) stddev-sans-first:17.11 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 115.0 73.0 75.0 76.0 108.0 77.0 75.0 107.0 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:1.23 (1.4%) stddev-sans-first:1.30 16:13:23 INFO - 2015-11-24 16:13:23,479 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 86.0 84.0 85.0 85.0 85.0 87.0 87.0 88.0 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:101.00 Median:93.00 stddev:18.11 (19.5%) stddev-sans-first:18.98 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 111.0 150.0 93.0 92.0 97.0 93.0 94.0 93.0 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:88.40 Median:86.00 stddev:10.46 (12.2%) stddev-sans-first:11.06 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 86.0 85.0 84.0 118.0 86.0 86.0 83.0 86.0 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:4.03 (7.5%) stddev-sans-first:4.27 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: Values: 54.0 54.0 54.0 54.0 54.0 53.0 52.0 66.0 53.0 53.0 16:13:23 INFO - 2015-11-24 16:13:23,480 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,481 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:66.50 stddev:16.38 (24.6%) stddev-sans-first:16.61 16:13:23 INFO - 2015-11-24 16:13:23,481 DEBUG : BROWSER_OUTPUT: Values: 62.0 65.0 66.0 98.0 99.0 101.0 66.0 66.0 67.0 67.0 16:13:23 INFO - 2015-11-24 16:13:23,481 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,481 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:95.90 Median:82.00 stddev:11.23 (13.7%) stddev-sans-first:11.32 16:13:23 INFO - 2015-11-24 16:13:23,481 DEBUG : BROWSER_OUTPUT: Values: 86.0 107.0 103.0 105.0 81.0 83.0 85.0 94.0 108.0 107.0 16:13:23 INFO - 2015-11-24 16:13:23,481 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,482 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.50 stddev:5.32 (4.2%) stddev-sans-first:5.56 16:13:23 INFO - 2015-11-24 16:13:23,482 DEBUG : BROWSER_OUTPUT: Values: 127.0 131.0 132.0 123.0 130.0 120.0 121.0 124.0 118.0 118.0 16:13:23 INFO - 2015-11-24 16:13:23,482 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.10 Median:135.00 stddev:3.98 (3.0%) stddev-sans-first:4.21 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: Values: 132.0 133.0 131.0 135.0 136.0 135.0 137.0 134.0 135.0 123.0 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.40 (2.2%) stddev-sans-first:1.48 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 65.0 64.0 64.0 64.0 64.0 66.0 68.0 65.0 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:13:23 INFO - 2015-11-24 16:13:23,483 DEBUG : BROWSER_OUTPUT: 16:13:24 INFO - 2015-11-24 16:13:24,198 INFO : Browser exited with error code: 0 16:13:24 INFO - 2015-11-24 16:13:24,245 INFO : Completed test kraken (00:00:56) 16:13:24 INFO - 2015-11-24 16:13:24,245 INFO : Starting test v8_7 16:13:24 INFO - 2015-11-24 16:13:24,245 DEBUG : operating with platform_type : mac_ 16:13:24 INFO - 2015-11-24 16:13:24,245 INFO : Initialising browser for v8_7 test... 16:13:24 INFO - 2015-11-24 16:13:24,257 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpT0QHHK/profile http://localhost:49264/getInfo.html 16:13:26 INFO - 2015-11-24 16:13:26,401 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:13:26 INFO - 2015-11-24 16:13:26,402 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:13:26 INFO - 2015-11-24 16:13:26,402 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:13:26 INFO - 2015-11-24 16:13:26,402 DEBUG : BROWSER_OUTPUT: __metrics 16:13:26 INFO - 2015-11-24 16:13:26,417 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:13:27 INFO - 2015-11-24 16:13:27,092 INFO : Browser initialized. 16:13:27 INFO - 2015-11-24 16:13:27,092 INFO : Running cycle 1/1 for v8_7 test... 16:13:27 INFO - 2015-11-24 16:13:27,093 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpT0QHHK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:13:38 INFO - 2015-11-24 16:13:38,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 228356096 16:13:38 INFO - 2015-11-24 16:13:38,971 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 620126208 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: |0;Richards;173.64125716270186 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.51364365971108 16:14:00 INFO - 2015-11-24 16:14:00,704 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4655.813953488372 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1724.1379310344828 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |5;Earley;788.8100866824271 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |6;Boyer;12871.794871794871 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |7;RegExp;27432.432432432433 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |8;Splay;649.0663232453317 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4575.342465753424 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: __startTimestamp1448410440698__endTimestamp 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:14:00 INFO - 2015-11-24 16:14:00,705 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.64 Median:173.64 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: Values: 173.6 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.51 Median:160.51 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: Values: 160.5 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: Values: 279.6 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4655.81 Median:4655.81 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: Values: 4655.8 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,706 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1724.14 Median:1724.14 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: Values: 1724.1 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.81 Median:788.81 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: Values: 788.8 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12871.79 Median:12871.79 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: Values: 12871.8 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27432.43 Median:27432.43 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: Values: 27432.4 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:649.07 Median:649.07 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,707 DEBUG : BROWSER_OUTPUT: Values: 649.1 16:14:00 INFO - 2015-11-24 16:14:00,708 DEBUG : BROWSER_OUTPUT: 16:14:00 INFO - 2015-11-24 16:14:00,708 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4575.34 Median:4575.34 stddev:0.00 (0.0%) 16:14:00 INFO - 2015-11-24 16:14:00,708 DEBUG : BROWSER_OUTPUT: Values: 4575.3 16:14:00 INFO - 2015-11-24 16:14:00,708 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:14:00 INFO - 2015-11-24 16:14:00,708 DEBUG : BROWSER_OUTPUT: 16:14:01 INFO - 2015-11-24 16:14:01,314 INFO : Browser exited with error code: 0 16:14:01 INFO - 2015-11-24 16:14:01,332 INFO : Completed test v8_7 (00:00:37) 16:14:01 INFO - 2015-11-24 16:14:01,719 INFO : Completed test suite (00:20:07) 16:14:01 INFO - 2015-11-24 16:14:01,719 DEBUG : Working with test: dromaeo_css 16:14:01 INFO - 2015-11-24 16:14:01,719 DEBUG : Generating results file: dromaeo_css 16:14:01 INFO - 2015-11-24 16:14:01,720 DEBUG : Working with test: kraken 16:14:01 INFO - 2015-11-24 16:14:01,720 DEBUG : Generating results file: kraken 16:14:01 INFO - 2015-11-24 16:14:01,720 INFO : javascript benchmark 16:14:01 INFO - 2015-11-24 16:14:01,720 DEBUG : Working with test: v8_7 16:14:01 INFO - 2015-11-24 16:14:01,720 DEBUG : Generating results file: v8_7 16:14:01 INFO - 2015-11-24 16:14:01,721 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:14:02 INFO - 2015-11-24 16:14:02,130 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 16:14:02 INFO - 2015-11-24 16:14:02,130 DEBUG : process_Request line: dromaeo_css 7581.67 graph.html#tests=[[72,64,59]] 16:14:02 INFO - 2015-11-24 16:14:02,130 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:14:02 INFO - 2015-11-24 16:14:02,164 DEBUG : process_Request line: kraken 1426.60 graph.html#tests=[[232,64,59]] 16:14:02 INFO - 2015-11-24 16:14:02,164 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:14:02 INFO - 2015-11-24 16:14:02,195 DEBUG : process_Request line: v8_7 20327.60 graph.html#tests=[[230,64,59]] 16:14:02 INFO - 2015-11-24 16:14:02,196 INFO : javascript benchmark 16:14:02 INFO - 2015-11-24 16:14:02,200 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3306.8346582670865, 3474.1314671332166, 3514.051206174333, 3528.1532432216277, 3551.1477245461087, 5591.245181900442, 5728.226689396935, 5731.971340143294, 5750.511206547443, 5792.304923409186, 5653.717314134287, 5687.345955215152, 5739.684317362543, 5768.105943578742, 5913.0, 5130.9230361544605, 5172.327597412341, 5178.378594568657, 5192.688438693672, 5257.658252213594, 5297.152455607104, 5308.416074231832, 5314.574834013289, 5332.546733527654, 5382.865428364283, 5083.186690129562, 5205.24523944026, 5210.895782084337, 5259.86850328741, 5261.473852614727, 5090.287359769635, 5194.142966410538, 5199.662021968597, 5216.895662086775, 5230.450802665703, 5085.059264036166, 5122.897542049175, 5124.154514505102, 5136.512031357015, 5176.7411629418375, 5562.360328562227, 5600.411956744524, 5648.406917273709, 5671.0, 5672.858178545528, 5192.948070519285, 6119.602225855349, 6170.84572885677, 6233.5948163369685, 6258.4680302174365, 6296.275928268262, 6320.431161195468, 6335.144755458, 6339.683015849189, 6360.650164240965, 5772.336181339116, 5900.1149827526215, 5903.26209223847, 5907.1434641976675, 5939.465448109648, 6127.964259358901, 6246.625202487865, 6281.371862813682, 6383.6488993104895, 6406.807795766134, 6180.783672571439, 6206.472449841814, 6215.720292586844, 6226.750929962841, 6237.875242495124, 6126.314740042852, 6294.181756371642, 6297.433231009231, 6312.8421789454715, 6323.462505686976, 6125.540694081699, 6145.385461453819, 6227.813165605039, 6265.65538895356, 6273.749050038039, 6280.152179455807, 6299.464545513591, 6302.968485157545, 6306.747730090837, 6325.620462772248, 4812.590929771009, 5009.24861270805, 5018.433339783774, 5019.347484826949, 5069.5690866276045, 4507.932381014288, 4528.660350473728, 4533.070720502289, 4566.862994110115, 4583.427071616048, 5709.65742055478, 5753.539716822645, 5760.452756988079, 5778.219940308089, 5787.305523337142, 6148.815535533941, 6232.501399887998, 6259.7496100156395, 6263.279722831841, 6279.717412716439, 5826.533877289807, 5835.766569337179, 5851.21008663825, 5874.295084589877, 5881.882362352814, 5458.4814442627885, 5467.5625949923915, 5480.835574932758, 5482.890342193214, 5484.808031718871, 6170.938290617126, 6318.778842740482, 6384.968075159594, 6401.3278605746655, 6401.3598640135615, 6152.0156774915795, 6245.469135123383, 6291.779787707408, 6298.748050077946, 6303.49572034227, 6335.588186767845, 6345.873082538231, 6348.396902294275, 6357.205349331333, 6363.5227357947415, 5981.611195272293, 6107.5226075721885, 6231.4391704746795, 6232.532560057924, 6242.875142497215, 6141.455323060992, 6264.812055638338, 6298.622082675054, 6303.779367722108, 6304.148939893055, 5961.970190149022, 6149.538784591084, 6176.382361763787, 6194.876102478015, 6204.72078756448, 5931.495822855106, 6031.638101713911, 6159.137720719193, 6166.537509686702, 6187.257529096357, 5542.558934677094, 5942.554308426799, 5944.989351810289, 5951.732172052181, 5960.940390596039, 5055.69665820052, 5544.362398324083, 6056.788012419544, 6099.897739344476, 6138.5396095292135, 6031.517478601789, 6041.667708276087, 6054.273487181566, 6057.757689692363, 6112.17485639433], "unit": "ms", "name": "dojo.html", "value": 5726.8794843450305}, {"lowerIsBetter": false, "replicates": [526.8734628806952, 579.6782785554021, 611.3611276216353, 615.599860090941, 641.3169973977714, 27080.72919270809, 32876.83561582192, 32937.67062329376, 41932.37101443481, 42480.57519424805, 44704.10591788162, 44957.0, 45043.324350134775, 45268.868278292975, 45285.32072018914, 8314.792130196749, 9974.152197063258, 9982.151517121018, 9983.850242246372, 10019.699409017741, 8913.821723565525, 9023.09769023099, 9035.593398297093, 12104.636860894187, 12228.144029917865, 11959.521619135225, 12038.458269377856, 12058.517659293619, 12065.517379304818, 12090.45592948315, 11958.880411195863, 12036.217645853036, 12063.819042714365, 12070.336131512764, 12083.758324833454, 8993.955030224872, 9097.044810294956, 9127.634894604207, 11934.0, 12085.818712719316, 40417.0, 40713.0, 40853.0, 40888.79555602233, 40901.682781238545, 3114.0, 3143.4341818472667, 3150.4329220740256, 3235.4014507315987, 3552.946705799415, 29138.854305728335, 29797.255068623243, 29842.40315193706, 29981.0, 30175.547366789517, 2842.3849463644738, 2853.7859660525337, 2854.3292326303304, 2875.52553828618, 2992.431438026768, 487613.0, 491952.0, 492612.0, 492831.0, 493822.0, 56223.437765622635, 56952.71523642355, 57038.0, 65549.0, 66083.0, 67951.32048679549, 68126.0, 68812.0, 68815.65592172007, 69071.0, 15453.38186472551, 15605.297761600756, 15611.687766244839, 15613.297401616728, 15618.0, 11766.058715302755, 11850.407479625985, 11855.762884742257, 11856.525738970517, 11869.0, 19972.300969466, 20204.898975505028, 20301.28945486901, 20317.9841007949, 20342.0, 8373.645704233886, 8472.406931514735, 8505.447145935494, 8513.361497887683, 8569.771859316497, 987.9407235565889, 1017.6794309792392, 1056.1550759392455, 1080.0765345629532, 1160.7562411893427, 29362.853185733933, 29611.0, 29994.700052999626, 30085.0, 30200.395992080037, 1026.3790406803926, 1096.7587130831364, 1097.308695521832, 1114.7101753544136, 1143.805553055966, 14752.852471475362, 15137.016093953858, 15154.090754554762, 15395.769063464057, 15441.227938603024, 519558.0, 528219.0, 528470.0, 530429.3478532659, 530871.0, 58831.0, 59111.0, 59150.0, 59193.40806591965, 59195.704021479614, 1421.289355322339, 1429.0568224971469, 1462.7293950619169, 1463.4804644351102, 1466.4280930437137, 26768.59847102256, 29164.27089322784, 31083.378332433676, 31254.374912501167, 31865.522017170224, 53549.0, 54065.45934540762, 54122.0, 54147.729261355016, 54217.72891135677, 463858.0, 466670.0, 466893.0, 466947.0, 467389.0, 28680.996165134122, 29231.85384073066, 31545.895893643614, 32883.50674739929, 34049.82975085109, 41732.3740143892, 42258.78870605627, 42418.0, 42591.0, 43173.136537269704, 30549.847250763603, 31445.213869652525, 33286.500702489, 33771.83114084414, 35436.64563354333, 31849.68150318467, 32136.0, 36388.0, 36511.269774603825, 37370.813145934095, 35733.57065717342, 35754.64245357513, 36329.45505817362, 36533.817330913174, 36533.81733091424, 32210.19474513156, 32259.838700806347, 32338.676613233565, 42137.15725685408, 42448.36327455029, 31455.37089258248, 33009.009729708145, 33538.0, 33696.831515843245, 34008.14979625529], "unit": "ms", "name": "ext.html", "value": 20322.789533727537}, {"lowerIsBetter": false, "replicates": [356.46708171283916, 358.6861496190833, 364.22056798451337, 365.99634003659963, 369.3536311454954, 15629.296681649324, 16008.119553424556, 19189.520261993457, 19607.901960490195, 20262.797372026256, 16660.333586656518, 19164.520886977796, 19481.610367792637, 19507.804921950777, 19529.0, 5715.771369145229, 5878.823635290927, 5884.264466941632, 5893.734781934823, 5896.793612223584, 3950.091478959841, 4063.5123785145825, 4066.9796651016704, 5855.033919403315, 5882.029465138247, 5682.801101961432, 5787.971060144693, 5835.387284335147, 5840.620359676629, 5844.736986835603, 5736.684482353469, 5822.1266809978415, 5986.161937328778, 6243.812685619393, 6476.158099447089, 5143.27994080829, 5428.697112692965, 5719.170720245583, 5723.742431590588, 5725.770969161229, 19595.530335224914, 24936.12723554685, 25096.37259068538, 25482.0, 25528.617070743952, 2057.1565658080267, 2073.2763339935655, 2132.5201829588373, 2170.0885628036103, 2274.9886250568643, 8621.05168431472, 9653.71038868828, 9857.457839818808, 10065.949670251675, 11857.762844743056, 1677.3626022111641, 1696.1349711647026, 1720.4924547258588, 1728.9221985010704, 1768.8231176882337, 94814.0, 97849.0, 100493.0, 100512.98974020552, 100601.0, 10023.799524009479, 10049.69850904474, 10055.346402483816, 10105.949470252748, 10141.340812847142, 12165.574204902787, 12189.451474683661, 12191.658917519066, 12215.816762748565, 12225.388730563436, 7799.0, 7835.0, 7849.411294152847, 7858.724944626911, 7978.281954623995, 7987.0, 7993.600319984093, 8038.598070096472, 8062.314703250289, 8071.4349995500925, 3411.7441191910707, 3722.906927326784, 3848.634379733921, 3891.2412079644196, 3940.172563761585, 1454.9709005819825, 1755.262789628359, 1758.806531281558, 1774.600714839151, 1791.6595846789069, 703.7536862098327, 914.5655813488539, 1036.1917704190744, 1047.9476026198658, 1091.0725882999545, 19471.12379942906, 20038.799612003986, 20342.59314813725, 20618.58762824765, 20690.068946897427, 917.3440989692268, 966.1884017425256, 981.3277904635347, 1004.8794144702537, 1052.7315534538643, 11015.251502420415, 11469.655910322537, 11490.885091149148, 11513.827292590619, 11521.48153333102, 750824.0, 757849.0, 768344.0, 768377.1581142058, 773244.0, 103337.0, 113403.43298283455, 120212.0, 120223.79776202301, 120783.0, 1160.0719424460399, 1180.887815657511, 1192.1237890150733, 1194.0686264713538, 1197.3175290084569, 18004.0, 18138.274469021093, 18144.364947226783, 18243.270269189616, 18339.26642934321, 49840.75079624579, 50413.73965650888, 50614.49385506098, 50633.49366506288, 51124.23313650224, 65435.0, 66415.66792166009, 67285.66357168183, 67612.0, 68608.6569567149, 9516.286278529276, 9605.47169905662, 9616.615335386507, 9780.0, 9794.412335259907, 11491.942540287246, 11561.826572601249, 14877.702445951238, 19314.806851931302, 20057.0, 15347.462838800588, 15372.769408458658, 15623.531294061197, 15695.058296502246, 15776.053436793829, 15265.0, 15365.692686146438, 15431.228438578251, 15572.221388930735, 15620.531384058497, 15849.447685860983, 16043.919780401024, 16668.41660541875, 16672.749908751135, 16673.333066677198, 9151.86272205904, 9792.069753373418, 9878.209743220668, 9880.35777674449, 9920.0, 8841.823163536821, 10266.743331416475, 12113.333766642567, 15425.61435964065, 15984.600384990468], "unit": "ms", "name": "jquery.html", "value": 9670.167680672452}, {"lowerIsBetter": false, "replicates": [1581.61250493629, 1584.8018997625297, 1588.4202266172842, 1899.7150427435884, 1915.984528200054, 7574.24257574243, 8012.158723334053, 8059.879101813477, 8449.281811046068, 8480.151984801516, 8217.342612590994, 8347.582620868963, 8393.076761556224, 8397.202265784756, 8398.0, 2342.2153578551206, 2342.5197834443898, 2360.7875291223786, 2381.011880069778, 2382.273406610983, 2357.6581395697613, 2382.9761702383016, 2435.3789783605243, 2437.512497500507, 2439.1950656283384, 2357.422431504284, 2377.4294169399304, 2380.440596459839, 2385.0817435287454, 2396.580598395283, 2276.829237807171, 2307.2270789285526, 2314.2941402872116, 2317.571249318873, 2318.6058370077126, 2356.964645530318, 2374.358923090756, 2381.3332266965276, 2389.7251816041203, 2392.210570511727, 7697.615119244016, 8317.0, 8375.329973602158, 8376.329893608498, 8377.162283771635, 4690.0854333405, 4739.170645137087, 5090.618203634742, 5143.897122057575, 5185.222216667492, 3255.951160732591, 3266.281418088017, 3390.0677313738674, 3601.4957905893198, 3640.6541378568995, 1042.9478526073742, 1046.602291129366, 1050.9842352364722, 1066.834013178539, 1078.3745427651943, 11031.22781405302, 11081.891810818854, 11089.168312376603, 11096.05683516902, 11115.83326250107, 4610.95389046112, 4723.929141062887, 4739.454962679267, 4747.264174053027, 4756.048790241965, 9809.901900981042, 9814.06766357195, 9821.263405244636, 9837.9016209837, 9840.704778856645, 5161.612879034087, 5193.68837869729, 5198.142306519458, 5200.583953283728, 5204.21936709489, 4649.139909116824, 4661.95338046622, 4662.207424737802, 4676.0647870426055, 4697.13103075932, 3678.8712395066045, 3713.795741234258, 3730.5896351401325, 3736.4768932349493, 3753.249350129985, 1240.3984067727326, 1252.7619752247044, 1257.490716259898, 1261.8296529968336, 1262.5959692898368, 1195.3485350484007, 1328.9069765116349, 1369.9041067125404, 1399.8670126337981, 1403.8175037245094, 7835.373170146375, 7858.332041776399, 7923.6830526778285, 7938.56337901421, 7945.364370850318, 458.429255576809, 464.38237144597605, 497.9153543897546, 503.31800410444055, 503.7556784959292, 5996.880062398727, 6132.50939924805, 6146.262448506208, 6164.075388691732, 6167.074938759222, 9449.196818270386, 10234.590616375262, 10244.897551024544, 10250.231232657581, 10344.896551034393, 10044.29689921713, 10138.188944884392, 10226.693199204035, 10348.275620706478, 10354.948225258826, 7873.409494287951, 7936.56348900816, 8034.397420193392, 8085.353171746128, 8088.4742491739025, 7650.8087297818, 7710.460267781202, 7738.883916741141, 7762.5730584818375, 7764.06831180262, 9041.77395565116, 9091.090890910857, 9129.45223286605, 9149.483891929773, 9151.588178532114, 9227.169554740105, 9443.952780236055, 9445.716628501155, 9541.856872146784, 9555.569999349907, 6738.696758645775, 7118.145822501126, 7173.6054516999975, 7208.0, 7235.63821808918, 7910.169432209535, 8004.399670024888, 8013.038435387558, 8021.558814265271, 8022.157673444438, 7267.273272672691, 7440.962795185989, 7463.328300452985, 7573.46985710995, 7631.3513351365755, 7333.449991250571, 7345.265473452826, 7361.0, 7394.704211831467, 7454.3663788576405, 7465.216152303929, 7519.285667861544, 7522.548647081193, 7524.05949256343, 7526.172121066569, 6667.866642667216, 6823.147106611674, 6847.417969472651, 6854.691538880663, 6859.622720750406, 6900.171979362509, 6963.1644202696, 6967.233604303421, 6969.7909062728195, 6972.4073453757], "unit": "ms", "name": "mootools.html", "value": 4688.647784797738}, {"lowerIsBetter": false, "replicates": [286.95982562441264, 300.47117073949846, 331.3770112189084, 332.81362437035244, 335.0668388537919, 6544.705488253028, 6569.50728695348, 6610.2398224204235, 6635.668216589163, 6641.0, 6518.120053792736, 6523.575967562105, 6525.706343214555, 6532.216134063919, 6533.705983230754, 4628.652851036169, 4697.037107392976, 4702.97648511757, 4867.123917694814, 4895.9510404895855, 4740.360051393052, 4773.164696178173, 4851.078295123933, 4865.975670121645, 4878.390201224847, 4762.618990480753, 4763.26169443735, 4773.331733557305, 4789.305550695147, 4795.256735206049, 4633.305004249356, 4656.906861862778, 4715.599174070208, 4748.5014073522125, 4787.425508938914, 4091.0590564170407, 4094.2016306820183, 4100.01599616093, 4119.743478239136, 4121.155163191538, 6250.374962503759, 6337.112804207414, 6364.649944253064, 6389.7763578274535, 6390.0, 4701.365315682373, 5460.699661518614, 5775.27809023872, 5798.072308430631, 5813.883722325572, 6862.4853136015, 7149.53528020677, 7163.641817909083, 7183.102112235971, 7197.496175267734, 4011.7191796574252, 4602.378678878342, 4621.445426548836, 4622.560856718606, 4624.8150073997, 5955.940440595626, 7271.63641817907, 7522.097348318237, 7573.242675732383, 7585.734499292498, 4637.721736695741, 4680.485146633868, 4682.274247491644, 4693.20215563355, 4695.929561056587, 4757.595604373667, 4761.285807128958, 4767.118083154627, 4771.379720636295, 4775.021120670254, 5671.574631902624, 5679.971600141973, 5690.317161940511, 5699.74351154199, 5707.1153971134545, 7010.579365238102, 7197.604131772698, 7201.099862517185, 7216.170140433812, 7276.272372762787, 1639.2213698493358, 1657.7927759030122, 1660.7342825147919, 1661.567992322005, 1663.4926347463897, 1030.4744580263969, 1036.1451802263164, 1041.1670663469345, 1045.3988956350129, 1055.630529314749, 5382.461753824665, 6644.435223006099, 6655.201375834931, 6678.131842860397, 6684.665766711742, 6491.123698300763, 6867.836631461074, 7424.257574242532, 7427.814304642319, 7442.813929651802, 6472.093906853044, 6645.269020407752, 6648.5678430901835, 6654.567453115629, 6664.400203981665, 3942.5466071402157, 3956.2680904032845, 3959.465472161279, 3959.5842436544326, 3978.3236849735613, 7715.382769378436, 7720.3437707795465, 7727.729529466554, 7737.0, 7742.806429839186, 7028.718851245892, 7437.479376443705, 7697.807554811063, 7745.92254077452, 7771.028621422322, 7701.961490192513, 7737.497062690907, 7738.342240909473, 7742.070951485858, 7743.070831500256, 7379.926200737924, 7380.630968451664, 7392.630368481662, 7399.371053460516, 7401.555906645403, 7034.577925324497, 7248.710051598088, 7336.853262934605, 7356.558606483414, 7381.557106573623, 6277.937220627735, 7702.0, 7706.614669266626, 7719.3052625264, 7727.961360193163, 3938.8380427773304, 4658.114958157939, 4681.297805329228, 4684.48470668233, 4695.812167513262, 5492.780288788404, 7379.631018449163, 7388.224236455309, 7404.445066536087, 7418.109826820816, 7113.644317784194, 7129.500934934712, 7131.536450130725, 7133.607651579213, 7140.750073747394, 5695.316562012585, 6885.414739746977, 7111.359977602041, 7122.893156602759, 7123.643817808985, 6754.5947243165565, 6952.930470695228, 6957.443404527525, 6960.443164546926, 6974.407175390149, 6939.201991771011, 7065.929340706527, 7085.185203701434, 7170.533915295698, 7173.569585824867, 7007.579545227099, 7039.753608623879, 7048.788536343918, 7052.612106334201, 7054.047703559953], "unit": "ms", "name": "prototype.html", "value": 5149.204589299986}, {"lowerIsBetter": false, "replicates": [723.8407550338926, 754.0950858969238, 786.551665550636, 814.5194335342147, 840.6595328891793, 14838.703225935475, 15193.392264309414, 15201.391944322228, 15259.389624415011, 15272.236388180601, 13967.44130234792, 14164.291785410715, 14196.929015354908, 14201.857981420182, 14240.78638820416, 757.2124990010383, 772.2354868679995, 774.1561697749452, 933.9019402962676, 950.6815216902346, 946.5693109635134, 950.7337945375306, 962.0860182826308, 963.3689933093834, 963.6819849449665, 751.4364226829878, 992.4095163377779, 1001.444198469849, 1013.3869009249408, 1021.5198856537453, 779.5205948341758, 792.13657113746, 793.6587267474983, 975.9170470510015, 992.7319623701633, 743.5835931878112, 749.5727435361846, 751.5903832411349, 754.1628792040831, 755.365492985889, 15092.24538773068, 15199.316030778642, 15209.467668631656, 15210.08739475624, 15214.391424343014, 12662.176958497668, 12887.806682899763, 12928.741425171538, 13170.53903113396, 13401.46394144233, 10102.949485252526, 10118.392896426165, 10147.89852101477, 10161.034701703325, 10198.337108088024, 3496.772709773882, 3567.7145828333933, 3573.8391772370046, 3574.5531808523933, 3576.660217279354, 73581.26418735851, 75071.0, 75243.49513009709, 75558.0, 83998.0, 9429.009953954735, 9432.481213533321, 9433.76415589602, 9437.292203084797, 9497.335186537015, 21218.469538261357, 21449.0, 21463.67804482934, 21507.13971441156, 21617.459563510725, 7226.674799633924, 7249.746258880914, 7404.259574042552, 7414.036175297177, 7558.9244107558225, 3883.2815929053218, 3919.9608003920166, 3935.74417662851, 3937.645611894943, 3956.347202711578, 3570.1431656402797, 3619.4570814378053, 3619.6923261523066, 3621.492990981265, 3622.3660859349507, 638.3329420755322, 639.2073828452778, 644.5520363347522, 648.844277373427, 656.2846497317946, 401.3538203492375, 488.01177615329243, 506.76435457512434, 525.6530689744826, 526.2500936166025, 8189.549574773326, 8584.098669639723, 8658.307335413152, 8778.912210877937, 8896.688615898542, 534.3080710479937, 581.5725441800273, 623.3486007122477, 634.4892361648824, 656.7602824968852, 3506.929861402809, 3619.7647152934974, 3630.3283892479976, 3641.2535430237267, 3758.642928921748, 96785.0, 101769.49115254376, 102654.48672756589, 102840.48579757054, 102922.0, 87706.24587508342, 88052.67920981062, 88069.0, 88593.0, 89920.55039724891, 76979.0, 78361.4327713454, 79296.0, 79802.60098699585, 79887.60056199682, 7134.821629459305, 8358.665653373797, 8397.118302578141, 8588.398812083344, 8608.655653774029, 49663.0, 49871.0, 50076.74961625168, 50416.0, 54604.90790184095, 71963.64018179875, 73280.0, 73693.26306737079, 73720.26279737349, 73830.0, 10847.728806779895, 11231.71920701989, 11285.37930413835, 11390.715232119263, 11524.59663911759, 10300.0, 12134.0, 12420.503179872703, 12514.12401131912, 12595.307258100893, 11731.0, 11843.348615826213, 11854.525818967144, 11892.345920974429, 11962.700932476757, 11339.546418143182, 11604.419779011185, 11618.302901825917, 12011.339376334035, 12439.191452555555, 6730.497628254369, 10445.529951152368, 11225.0, 11533.250338727956, 12340.691482713004, 9788.216942644429, 9793.510324483605, 9954.651587194414, 10093.848592270975, 10301.639442619473, 9624.951875240578, 9828.4102953823, 10042.69871903844, 10098.0, 10226.233032522441], "unit": "ms", "name": "yui.html", "value": 6989.244378561993}], "name": "dromaeo_css", "value": 7581.674673286012}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 102.0, 109.0, 109.0, 106.0, 109.0, 108.0, 102.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 179.0, 186.0, 125.0, 142.0, 139.0, 117.0, 156.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [182.0, 182.0, 183.0, 193.0, 254.0, 182.0, 182.0, 184.0, 180.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 190.3}, {"lowerIsBetter": true, "replicates": [66.0, 78.0, 112.0, 97.0, 62.0, 58.0, 57.0, 72.0, 73.0, 59.0], "unit": "ms", "name": "audio-fft", "value": 73.4}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 115.0, 73.0, 75.0, 76.0, 108.0, 77.0, 75.0, 107.0], "unit": "ms", "name": "audio-oscillator", "value": 87.3}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 84.0, 85.0, 85.0, 85.0, 87.0, 87.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 111.0, 150.0, 93.0, 92.0, 97.0, 93.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 101.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 85.0, 84.0, 118.0, 86.0, 86.0, 83.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 88.4}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 52.0, 66.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 66.0, 98.0, 99.0, 101.0, 66.0, 66.0, 67.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 75.7}, {"lowerIsBetter": true, "replicates": [86.0, 107.0, 103.0, 105.0, 81.0, 83.0, 85.0, 94.0, 108.0, 107.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 95.9}, {"lowerIsBetter": true, "replicates": [127.0, 131.0, 132.0, 123.0, 130.0, 120.0, 121.0, 124.0, 118.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [132.0, 133.0, 131.0, 135.0, 136.0, 135.0, 137.0, 134.0, 135.0, 123.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 133.1}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 66.0, 68.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1426.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.64125716270186], "unit": "score", "name": "Richards", "value": 203.30421799999996}, {"lowerIsBetter": false, "replicates": [160.51364365971108], "unit": "score", "name": "DeltaBlue", "value": 411.9151399999998}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [4655.813953488372], "unit": "score", "name": "Decrypt", "value": 57.17174325674327}, {"lowerIsBetter": false, "replicates": [1724.1379310344828], "unit": "score", "name": "RayTrace", "value": 429.19361999999984}, {"lowerIsBetter": false, "replicates": [788.8100866824271], "unit": "score", "name": "Earley", "value": 844.8966503496501}, {"lowerIsBetter": false, "replicates": [12871.794871794871], "unit": "score", "name": "Boyer", "value": 51.77700597609562}, {"lowerIsBetter": false, "replicates": [27432.432432432433], "unit": "score", "name": "RegExp", "value": 33.208320197044344}, {"lowerIsBetter": false, "replicates": [649.0663232453317], "unit": "score", "name": "Splay", "value": 125.55111408730158}, {"lowerIsBetter": false, "replicates": [4575.342465753424], "unit": "score", "name": "NavierStokes", "value": 324.34730538922156}], "name": "v8_7", "value": 20327.598141335602}]} 16:14:02 INFO - RETURN: dromaeo_css: 7581.67 16:14:02 INFO - RETURN: kraken: 1426.60 16:14:02 INFO - RETURN: v8_7: 20327.60 16:14:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20327.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1426.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7581.67"}}} 16:14:02 INFO - Return code: 0 16:14:02 INFO - # TBPL SUCCESS # 16:14:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:14:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:14:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:14:02 INFO - 2015-11-24 16:14:02.287 screenresolution[1671:10055] starting screenresolution argv=screenresolution get 16:14:02 INFO - 2015-11-24 16:14:02.290 screenresolution[1671:10055] Display 0: 1600x1200x32@60 16:14:02 INFO - 2015-11-24 16:14:02.296 screenresolution[1672:10058] starting screenresolution argv=screenresolution list 16:14:02 INFO - Available Modes on Display 0 16:14:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:14:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:14:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:14:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:14:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:14:02 INFO - Intel Iris: 16:14:02 INFO - Chipset Model: Intel Iris 16:14:02 INFO - Type: GPU 16:14:02 INFO - Bus: Built-In 16:14:02 INFO - VRAM (Dynamic, Max): 1536 MB 16:14:02 INFO - Vendor: Intel (0x8086) 16:14:02 INFO - Device ID: 0x0a2e 16:14:02 INFO - Revision ID: 0x0009 16:14:02 INFO - Displays: 16:14:02 INFO - Display: 16:14:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:14:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:14:02 INFO - Display Serial Number: 1600x1200 60 16:14:02 INFO - Main Display: Yes 16:14:02 INFO - Mirror: Off 16:14:02 INFO - Online: Yes 16:14:02 INFO - Rotation: Supported 16:14:02 INFO - Return code: 0 16:14:02 INFO - Running post-action listener: _resource_record_post_action 16:14:02 INFO - Running post-run listener: _resource_record_post_run 16:14:03 INFO - Total resource usage - Wall time: 1240s; CPU: 52.0%; Read bytes: 38700544; Write bytes: 692503040; Read time: 416; Write time: 3216 16:14:03 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 339939840; Write bytes: 339642368; Read time: 27954; Write time: 1637 16:14:03 INFO - run-tests - Wall time: 1210s; CPU: 52.0%; Read bytes: 36734464; Write bytes: 341580288; Read time: 396; Write time: 1545 16:14:03 INFO - Running post-run listener: _upload_blobber_files 16:14:03 INFO - Blob upload gear active. 16:14:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:14:03 INFO - Copying logs to upload dir... 16:14:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.406257 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-24 16:14:03.649599) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:14:03.652989) ========= 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.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009406 build_url: 'https://queue.taskcluster.net/v1/task/IpCFTOznR3e8UePhN9rYIA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:14:03.676110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:14:03.676426) ========= 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.6i4X9XxdMw/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.o7r4nt0rYV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005109 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:14:03.725723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 16:14:03.726221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 16:14:03.726885) ========= ========= Total master_lag: 0.20 =========