builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0050 starttime: 1448022641.04 results: success (0) buildid: 20151120025236 builduid: b2301726c6954653b7937ff5fcb94463 revision: 8751a85b4f2592cd388685237ad54c1739ecc654 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.042910) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.043437) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.043752) ========= 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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005874 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.090862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.091214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.159730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.160023) ========= 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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005182 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.235057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.235396) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.235769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.236051) ========= 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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-20 04:30:41-- 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% 13.2M=0.001s 2015-11-20 04:30:41 (13.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.553947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.804314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.804632) ========= 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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.019458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:41.853458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 04:30:41.853862) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8751a85b4f2592cd388685237ad54c1739ecc654 --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 8751a85b4f2592cd388685237ad54c1739ecc654 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-20 04:30:41,929 truncating revision to first 12 chars 2015-11-20 04:30:41,929 Setting DEBUG logging. 2015-11-20 04:30:41,929 attempt 1/10 2015-11-20 04:30:41,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8751a85b4f25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 04:30:43,134 unpacking tar archive at: fx-team-8751a85b4f25/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 04:30:43.311891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:43.312185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:43.326765) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:43.327112) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 04:30:43.327527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-20 04:30:43.327829) ========= /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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:30:43 INFO - MultiFileLogger online at 20151120 04:30:43 in /builds/slave/test 04:30:43 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 04:30:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:43 INFO - {'append_to_log': False, 04:30:43 INFO - 'base_work_dir': '/builds/slave/test', 04:30:43 INFO - 'blob_upload_branch': 'Fx-Team', 04:30:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:43 INFO - 'branch': 'Fx-Team', 04:30:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:43 INFO - 'config_files': ('talos/mac_config.py',), 04:30:43 INFO - 'default_actions': ('clobber', 04:30:43 INFO - 'read-buildbot-config', 04:30:43 INFO - 'download-and-extract', 04:30:43 INFO - 'populate-webroot', 04:30:43 INFO - 'create-virtualenv', 04:30:43 INFO - 'install', 04:30:43 INFO - 'run-tests'), 04:30:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:43 INFO - 'download_minidump_stackwalk': True, 04:30:43 INFO - 'download_symbols': 'ondemand', 04:30:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:43 INFO - 'installer_path': 'installer.exe', 04:30:43 INFO - 'log_level': 'info', 04:30:43 INFO - 'log_name': 'talos', 04:30:43 INFO - 'log_to_console': True, 04:30:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:43 INFO - 'opt_config_files': (), 04:30:43 INFO - 'pip_index': False, 04:30:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:43 INFO - 'cmd': ('bash', 04:30:43 INFO - '-c', 04:30:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:43 INFO - 'enabled': True, 04:30:43 INFO - 'halt_on_failure': False, 04:30:43 INFO - 'name': 'check_screen_resolution'},), 04:30:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:43 INFO - 'cmd': ('bash', 04:30:43 INFO - '-c', 04:30:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:43 INFO - 'enabled': True, 04:30:43 INFO - 'halt_on_failure': False, 04:30:43 INFO - 'name': 'check_screen_resolution'},), 04:30:43 INFO - 'run_cmd_checks_enabled': True, 04:30:43 INFO - 'sps_profile': False, 04:30:43 INFO - 'sps_profile_interval': 0, 04:30:43 INFO - 'suite': 'dromaeojs', 04:30:43 INFO - 'system_bits': '64', 04:30:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:43 INFO - 'title': 't-yosemite-r7-0050', 04:30:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:43 INFO - 'use_talos_json': True, 04:30:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:43 INFO - 'work_dir': 'build'} 04:30:43 INFO - ##### 04:30:43 INFO - ##### Running clobber step. 04:30:43 INFO - ##### 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: clobber 04:30:43 INFO - rmtree: /builds/slave/test/build 04:30:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:44 INFO - Running post-action listener: _resource_record_post_action 04:30:44 INFO - ##### 04:30:44 INFO - ##### Running read-buildbot-config step. 04:30:44 INFO - ##### 04:30:44 INFO - Running pre-action listener: _resource_record_pre_action 04:30:44 INFO - Running main action method: read_buildbot_config 04:30:44 INFO - Using buildbot properties: 04:30:44 INFO - { 04:30:44 INFO - "properties": { 04:30:44 INFO - "buildnumber": 5, 04:30:44 INFO - "product": "firefox", 04:30:44 INFO - "script_repo_revision": "production", 04:30:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:30:44 INFO - "repository": "", 04:30:44 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:30:44 INFO - "buildid": "20151120025236", 04:30:44 INFO - "slavename": "t-yosemite-r7-0050", 04:30:44 INFO - "pgo_build": "False", 04:30:44 INFO - "basedir": "/builds/slave/test", 04:30:44 INFO - "project": "", 04:30:44 INFO - "platform": "yosemite_r7", 04:30:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:30:44 INFO - "slavebuilddir": "test", 04:30:44 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:30:44 INFO - "branch": "fx-team", 04:30:44 INFO - "repo_path": "integration/fx-team", 04:30:44 INFO - "stage_platform": "macosx64", 04:30:44 INFO - "builduid": "b2301726c6954653b7937ff5fcb94463", 04:30:44 INFO - "revision": "8751a85b4f2592cd388685237ad54c1739ecc654" 04:30:44 INFO - }, 04:30:44 INFO - "sourcestamp": { 04:30:44 INFO - "repository": "", 04:30:44 INFO - "hasPatch": false, 04:30:44 INFO - "project": "", 04:30:44 INFO - "branch": "fx-team-macosx64-talos", 04:30:44 INFO - "changes": [ 04:30:44 INFO - { 04:30:44 INFO - "category": null, 04:30:44 INFO - "files": [ 04:30:44 INFO - { 04:30:44 INFO - "url": null, 04:30:44 INFO - "name": "https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:30:44 INFO - } 04:30:44 INFO - ], 04:30:44 INFO - "repository": "", 04:30:44 INFO - "rev": "8751a85b4f2592cd388685237ad54c1739ecc654", 04:30:44 INFO - "who": "georg.fritzsche@googlemail.com", 04:30:44 INFO - "when": 1448022622, 04:30:44 INFO - "number": 6688210, 04:30:44 INFO - "comments": "Bug 1223018: Rename about:telemetry 'System Information' section to 'Session Information'. r=gfritzsche", 04:30:44 INFO - "project": "", 04:30:44 INFO - "at": "Fri 20 Nov 2015 04:30:22", 04:30:44 INFO - "branch": "fx-team-macosx64-talos", 04:30:44 INFO - "revlink": "", 04:30:44 INFO - "properties": [ 04:30:44 INFO - [ 04:30:44 INFO - "buildid", 04:30:44 INFO - "20151120025236", 04:30:44 INFO - "Change" 04:30:44 INFO - ], 04:30:44 INFO - [ 04:30:44 INFO - "builduid", 04:30:44 INFO - "b2301726c6954653b7937ff5fcb94463", 04:30:44 INFO - "Change" 04:30:44 INFO - ], 04:30:44 INFO - [ 04:30:44 INFO - "pgo_build", 04:30:44 INFO - "False", 04:30:44 INFO - "Change" 04:30:44 INFO - ] 04:30:44 INFO - ], 04:30:44 INFO - "revision": "8751a85b4f2592cd388685237ad54c1739ecc654" 04:30:44 INFO - } 04:30:44 INFO - ], 04:30:44 INFO - "revision": "8751a85b4f2592cd388685237ad54c1739ecc654" 04:30:44 INFO - } 04:30:44 INFO - } 04:30:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:30:44 INFO - Running post-action listener: _resource_record_post_action 04:30:44 INFO - ##### 04:30:44 INFO - ##### Running download-and-extract step. 04:30:44 INFO - ##### 04:30:44 INFO - Running pre-action listener: _resource_record_pre_action 04:30:44 INFO - Running main action method: download_and_extract 04:30:44 INFO - mkdir: /builds/slave/test/build/tests 04:30: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')]} 04:30:44 INFO - https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/test_packages.json 04:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/test_packages.json 04:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:04 INFO - Downloaded 1149 bytes. 04:31:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:04 INFO - Using the following test package requirements: 04:31:04 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:04 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:04 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'jsshell-mac.zip'], 04:31:04 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:31:04 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:04 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:31:04 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:31:04 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:31:04 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:04 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:04 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:04 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31: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')]} 04:31:04 INFO - https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:31:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:06 INFO - Downloaded 17525175 bytes. 04:31:06 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 04:31:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:31:09 INFO - Return code: 0 04:31:09 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 04:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:09 INFO - https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:10 INFO - Downloaded 17525175 bytes. 04:31:10 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 04:31:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:31:13 INFO - Return code: 0 04:31:13 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')]} 04:31:13 INFO - https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:31:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:31:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:31:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:15 INFO - Downloaded 11130997 bytes. 04:31:15 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 04:31:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:31:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:31:15 INFO - Return code: 0 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:15 INFO - https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:31:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/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 04:31:41 INFO - Downloaded 109415987 bytes. 04:31:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:41 INFO - mkdir: /builds/slave/test/properties 04:31:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:41 INFO - Contents: 04:31:41 INFO - build_url:https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:41 INFO - Running post-action listener: _resource_record_post_action 04:31:41 INFO - Running post-action listener: set_extra_try_arguments 04:31:41 INFO - ##### 04:31:41 INFO - ##### Running populate-webroot step. 04:31:41 INFO - ##### 04:31:41 INFO - Running pre-action listener: _resource_record_pre_action 04:31:41 INFO - Running main action method: populate_webroot 04:31:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:31:41 INFO - '../fennec_ids.txt'], 04:31:41 INFO - 'tests': ['tcheck2']}, 04:31:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:41 INFO - '--tppagecycles', 04:31:41 INFO - '7'], 04:31:41 INFO - 'tests': ['tsvgm']}}, 04:31:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:31:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:31:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:31:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'tests': ['damp', 'tps']}, 04:31:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['damp', 'tps']}, 04:31:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:31:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:41 INFO - 'other': {'tests': ['a11yr', 04:31:41 INFO - 'ts_paint', 04:31:41 INFO - 'tpaint', 04:31:41 INFO - 'sessionrestore', 04:31:41 INFO - 'sessionrestore_no_auto_restore']}, 04:31:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['a11yr', 04:31:41 INFO - 'ts_paint', 04:31:41 INFO - 'tpaint', 04:31:41 INFO - 'sessionrestore', 04:31:41 INFO - 'sessionrestore_no_auto_restore']}, 04:31:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['a11yr', 04:31:41 INFO - 'ts_paint', 04:31:41 INFO - 'tpaint', 04:31:41 INFO - 'sessionrestore', 04:31:41 INFO - 'sessionrestore_no_auto_restore']}, 04:31:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['a11yr', 04:31:41 INFO - 'ts_paint', 04:31:41 INFO - 'tpaint', 04:31:41 INFO - 'sessionrestore', 04:31:41 INFO - 'sessionrestore_no_auto_restore']}, 04:31:41 INFO - 'other_l64': {'tests': ['a11yr', 04:31:41 INFO - 'ts_paint', 04:31:41 INFO - 'tpaint', 04:31:41 INFO - 'sessionrestore', 04:31:41 INFO - 'sessionrestore_no_auto_restore']}, 04:31:41 INFO - 'other_nol64': {'tests': ['a11yr', 04:31:41 INFO - 'ts_paint', 04:31:41 INFO - 'tpaint', 04:31:41 INFO - 'sessionrestore', 04:31:41 INFO - 'sessionrestore_no_auto_restore']}, 04:31:41 INFO - 'svgr': {'tests': ['tsvgx', 04:31:41 INFO - 'tsvgr_opacity', 04:31:41 INFO - 'tart', 04:31:41 INFO - 'tscrollx', 04:31:41 INFO - 'cart']}, 04:31:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['tsvgx', 04:31:41 INFO - 'tsvgr_opacity', 04:31:41 INFO - 'tart', 04:31:41 INFO - 'tscrollx', 04:31:41 INFO - 'cart']}, 04:31:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'tests': ['tp5o']}, 04:31:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'talos_options': ['--e10s'], 04:31:41 INFO - 'tests': ['tp5o']}, 04:31:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'talos_options': ['--xperf_path', 04:31:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:41 INFO - 'tests': ['tp5n']}, 04:31:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:41 INFO - 'talos_options': ['--e10s', 04:31:41 INFO - '--xperf_path', 04:31:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:41 INFO - 'tests': ['tp5n']}}, 04:31:41 INFO - 'talos.zip': {'path': '', 04:31:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:41 INFO - Running post-action listener: _resource_record_post_action 04:31:41 INFO - ##### 04:31:41 INFO - ##### Running create-virtualenv step. 04:31:41 INFO - ##### 04:31:41 INFO - Running pre-action listener: _resource_record_pre_action 04:31:41 INFO - Running main action method: create_virtualenv 04:31:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:41 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 04:31:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:41 INFO - Using real prefix '/tools/python27' 04:31:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:42 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:45 INFO - Installing pip.................done. 04:31:45 INFO - Return code: 0 04:31:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:45 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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:31:45 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 04:31:45 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 04:31:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:31:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:45 INFO - 'HOME': '/Users/cltbld', 04:31:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:45 INFO - 'LOGNAME': 'cltbld', 04:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:45 INFO - 'MOZ_NO_REMOTE': '1', 04:31:45 INFO - 'NO_EM_RESTART': '1', 04:31:45 INFO - 'PAGER': '/bin/cat', 04:31:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:45 INFO - 'PWD': '/builds/slave/test', 04:31:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:45 INFO - 'SHELL': '/bin/bash', 04:31:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:31:45 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:31:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:45 INFO - 'USER': 'cltbld', 04:31:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:45 INFO - 'XPC_FLAGS': '0x0', 04:31:45 INFO - 'XPC_SERVICE_NAME': '0', 04:31:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:45 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 04:31:45 INFO - Cleaning up... 04:31:45 INFO - Return code: 0 04:31:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:45 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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:31:46 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 04:31:46 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 04:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:46 INFO - 'HOME': '/Users/cltbld', 04:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:46 INFO - 'LOGNAME': 'cltbld', 04:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:46 INFO - 'MOZ_NO_REMOTE': '1', 04:31:46 INFO - 'NO_EM_RESTART': '1', 04:31:46 INFO - 'PAGER': '/bin/cat', 04:31:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:46 INFO - 'PWD': '/builds/slave/test', 04:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:46 INFO - 'SHELL': '/bin/bash', 04:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:31:46 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:46 INFO - 'USER': 'cltbld', 04:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:46 INFO - 'XPC_FLAGS': '0x0', 04:31:46 INFO - 'XPC_SERVICE_NAME': '0', 04:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:46 INFO - Downloading/unpacking psutil>=0.7.1 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:31:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:48 INFO - Installing collected packages: psutil 04:31:48 INFO - Running setup.py install for psutil 04:31:49 INFO - building 'psutil._psutil_osx' extension 04:31:49 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 04:31:49 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 04:31:49 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 04:31:49 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 04:31:49 INFO - building 'psutil._psutil_posix' extension 04:31:49 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 04:31:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:31:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:31:49 INFO - ^ 04:31:49 INFO - 1 warning generated. 04:31:49 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 04:31:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:49 INFO - Successfully installed psutil 04:31:49 INFO - Cleaning up... 04:31:49 INFO - Return code: 0 04:31:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:31:49 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')]} 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:49 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')]} 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:49 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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:31:49 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 04:31:49 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 04:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:49 INFO - 'HOME': '/Users/cltbld', 04:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:49 INFO - 'LOGNAME': 'cltbld', 04:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:49 INFO - 'MOZ_NO_REMOTE': '1', 04:31:49 INFO - 'NO_EM_RESTART': '1', 04:31:49 INFO - 'PAGER': '/bin/cat', 04:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:49 INFO - 'PWD': '/builds/slave/test', 04:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:49 INFO - 'SHELL': '/bin/bash', 04:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:31:49 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:49 INFO - 'USER': 'cltbld', 04:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:49 INFO - 'XPC_FLAGS': '0x0', 04:31:49 INFO - 'XPC_SERVICE_NAME': '0', 04:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:31:50 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 04:31:50 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 04:31:50 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 04:31:50 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 04:31:50 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 04:31:50 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 04:31:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:31:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:31:52 INFO - Installing collected packages: mozsystemmonitor 04:31:52 INFO - Running setup.py install for mozsystemmonitor 04:31:52 INFO - Successfully installed mozsystemmonitor 04:31:52 INFO - Cleaning up... 04:31:52 INFO - Return code: 0 04:31:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:52 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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:31:52 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 04:31:52 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 04:31:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:31:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:52 INFO - 'HOME': '/Users/cltbld', 04:31:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:52 INFO - 'LOGNAME': 'cltbld', 04:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:52 INFO - 'MOZ_NO_REMOTE': '1', 04:31:52 INFO - 'NO_EM_RESTART': '1', 04:31:52 INFO - 'PAGER': '/bin/cat', 04:31:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:52 INFO - 'PWD': '/builds/slave/test', 04:31:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:52 INFO - 'SHELL': '/bin/bash', 04:31:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:31:52 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:31:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:52 INFO - 'USER': 'cltbld', 04:31:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:52 INFO - 'XPC_FLAGS': '0x0', 04:31:52 INFO - 'XPC_SERVICE_NAME': '0', 04:31:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:52 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 04:31:52 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 04:31:52 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 04:31:52 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 04:31:52 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 04:31:52 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 04:31:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:55 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 04:31:55 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 04:31:55 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 04:31:55 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 04:31:55 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 04:31:55 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 04:31:55 INFO - Downloading docopt-0.6.1.tar.gz 04:31:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:56 INFO - Running setup.py install for blobuploader 04:31:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:56 INFO - Running setup.py install for requests 04:31:56 INFO - Running setup.py install for docopt 04:31:56 INFO - Successfully installed blobuploader requests docopt 04:31:56 INFO - Cleaning up... 04:31:56 INFO - Return code: 0 04:31:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:56 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')]} 04:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 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')]} 04:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:31:56 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 04:31:56 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 04:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:56 INFO - 'HOME': '/Users/cltbld', 04:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:56 INFO - 'LOGNAME': 'cltbld', 04:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:56 INFO - 'MOZ_NO_REMOTE': '1', 04:31:56 INFO - 'NO_EM_RESTART': '1', 04:31:56 INFO - 'PAGER': '/bin/cat', 04:31:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:56 INFO - 'PWD': '/builds/slave/test', 04:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:56 INFO - 'SHELL': '/bin/bash', 04:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:31:56 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:56 INFO - 'USER': 'cltbld', 04:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:56 INFO - 'XPC_FLAGS': '0x0', 04:31:56 INFO - 'XPC_SERVICE_NAME': '0', 04:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-LP0rEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-fwn5zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-0pYtVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-mc5wiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-dwz0JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-KcD7SD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-0H6HjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-IKKROE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:57 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-cKWHIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-SdkKzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-4nmCz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-EJ2Jo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-loPUrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-hIZ22i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-nCNuXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-f3dnMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:58 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Ox4hTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:58 INFO - Running setup.py install for manifestparser 04:31:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:59 INFO - Running setup.py install for mozcrash 04:31:59 INFO - Running setup.py install for mozdebug 04:31:59 INFO - Running setup.py install for mozdevice 04:31:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:59 INFO - Running setup.py install for mozfile 04:31:59 INFO - Running setup.py install for mozhttpd 04:31:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:59 INFO - Running setup.py install for mozinfo 04:31:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:59 INFO - Running setup.py install for mozInstall 04:32:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Running setup.py install for mozleak 04:32:00 INFO - Running setup.py install for mozlog 04:32:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Running setup.py install for moznetwork 04:32:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Running setup.py install for mozprocess 04:32:00 INFO - Running setup.py install for mozprofile 04:32:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:00 INFO - Running setup.py install for mozrunner 04:32:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:01 INFO - Running setup.py install for mozscreenshot 04:32:01 INFO - Running setup.py install for moztest 04:32:01 INFO - Running setup.py install for mozversion 04:32:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:01 INFO - Cleaning up... 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:32:01 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 04:32:01 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 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-JSLMGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:01 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)) 04:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-7F_qjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:01 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)) 04:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-CWADj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-TlS68D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-WZ1HtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Dn_4CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-RdbFNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-t3sSsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-yvlO8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-BCrR6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-tEyehM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:02 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)) 04:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-0KL1sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:03 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)) 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-a1u046-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:03 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)) 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-LiELDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:03 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)) 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-8Cd0oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:03 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)) 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-8AnLTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:03 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)) 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-7MwraS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:03 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)) 04:32:03 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)) 04:32:03 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)) 04:32:03 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)) 04:32:03 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)) 04:32:03 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)) 04:32:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:03 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 04:32:03 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 04:32:03 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 04:32:03 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 04:32:03 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 04:32:03 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 04:32:05 INFO - Downloading blessings-1.5.1.tar.gz 04:32:05 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 04:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:05 INFO - Installing collected packages: blessings 04:32:05 INFO - Running setup.py install for blessings 04:32:05 INFO - Successfully installed blessings 04:32:05 INFO - Cleaning up... 04:32:06 INFO - Return code: 0 04:32:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:06 INFO - Reading from file tmpfile_stdout 04:32:06 INFO - Current package versions: 04:32:06 INFO - blessings == 1.5.1 04:32:06 INFO - blobuploader == 1.2.4 04:32:06 INFO - docopt == 0.6.1 04:32:06 INFO - manifestparser == 1.1 04:32:06 INFO - mozInstall == 1.12 04:32:06 INFO - mozcrash == 0.16 04:32:06 INFO - mozdebug == 0.1 04:32:06 INFO - mozdevice == 0.47 04:32:06 INFO - mozfile == 1.2 04:32:06 INFO - mozhttpd == 0.7 04:32:06 INFO - mozinfo == 0.9 04:32:06 INFO - mozleak == 0.1 04:32:06 INFO - mozlog == 3.0 04:32:06 INFO - moznetwork == 0.27 04:32:06 INFO - mozprocess == 0.22 04:32:06 INFO - mozprofile == 0.27 04:32:06 INFO - mozrunner == 6.11 04:32:06 INFO - mozscreenshot == 0.1 04:32:06 INFO - mozsystemmonitor == 0.0 04:32:06 INFO - moztest == 0.7 04:32:06 INFO - mozversion == 1.4 04:32:06 INFO - psutil == 3.1.1 04:32:06 INFO - requests == 1.2.3 04:32:06 INFO - wsgiref == 0.1.2 04:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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 0x109f45490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f22228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff79155dd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, '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.TqvqUwfGnd/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.9ppifvkJeq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 04:32:06 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 04:32:06 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 04:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 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)) 04:32:06 INFO - Cleaning up... 04:32:06 INFO - Return code: 0 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - Running post-action listener: _start_resource_monitoring 04:32:06 INFO - Starting resource monitoring. 04:32:06 INFO - ##### 04:32:06 INFO - ##### Running install step. 04:32:06 INFO - ##### 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: install 04:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:06 INFO - Reading from file tmpfile_stdout 04:32:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:06 INFO - Reading from file tmpfile_stdout 04:32:06 INFO - Output received: 04:32:06 INFO - Usage: mozinstall [options] installer 04:32:06 INFO - Options: 04:32:06 INFO - -h, --help show this help message and exit 04:32:06 INFO - -d DEST, --destination=DEST 04:32:06 INFO - Directory to install application into. [default: 04:32:06 INFO - "/builds/slave/test"] 04:32:06 INFO - --app=APP Application being installed. [default: firefox] 04:32:06 INFO - mkdir: /builds/slave/test/build/application 04:32:06 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'] 04:32:06 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 04:32:37 INFO - Reading from file tmpfile_stdout 04:32:37 INFO - Output received: 04:32:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:32:37 INFO - Running post-action listener: _resource_record_post_action 04:32:37 INFO - ##### 04:32:37 INFO - ##### Running run-tests step. 04:32:37 INFO - ##### 04:32:37 INFO - Running pre-action listener: _resource_record_pre_action 04:32:37 INFO - Running main action method: run_tests 04:32:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:37 INFO - 2015-11-20 04:32:37.325 screenresolution[1963:12055] starting screenresolution argv=screenresolution get 04:32:37 INFO - 2015-11-20 04:32:37.327 screenresolution[1963:12055] Display 0: 1600x1200x32@60 04:32:37 INFO - 2015-11-20 04:32:37.333 screenresolution[1964:12057] starting screenresolution argv=screenresolution list 04:32:37 INFO - Available Modes on Display 0 04:32:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:37 INFO - Intel Iris: 04:32:37 INFO - Chipset Model: Intel Iris 04:32:37 INFO - Type: GPU 04:32:37 INFO - Bus: Built-In 04:32:37 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:37 INFO - Vendor: Intel (0x8086) 04:32:37 INFO - Device ID: 0x0a2e 04:32:37 INFO - Revision ID: 0x0009 04:32:37 INFO - Displays: 04:32:37 INFO - Display: 04:32:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:37 INFO - Display Serial Number: 1600x1200 60 04:32:37 INFO - Main Display: Yes 04:32:37 INFO - Mirror: Off 04:32:37 INFO - Online: Yes 04:32:37 INFO - Rotation: Supported 04:32:37 INFO - Return code: 0 04:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:37 INFO - Python 2.7.3 04:32:37 INFO - Return code: 0 04:32:37 INFO - grabbing minidump binary from tooltool 04:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:37 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 0x109e699f0>, '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 0x109bc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5c8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:37 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 04:32:37 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 04:32:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:37 INFO - Return code: 0 04:32:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:32:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:32:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:37 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/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--webServer', 'localhost'] in /builds/slave/test/build 04:32:37 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/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --webServer localhost 04:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TqvqUwfGnd/Render', 04:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:37 INFO - 'HOME': '/Users/cltbld', 04:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:37 INFO - 'LOGNAME': 'cltbld', 04:32:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:37 INFO - 'MOZ_NO_REMOTE': '1', 04:32:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:37 INFO - 'NO_EM_RESTART': '1', 04:32:37 INFO - 'PAGER': '/bin/cat', 04:32:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:37 INFO - 'PWD': '/builds/slave/test', 04:32:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:37 INFO - 'SHELL': '/bin/bash', 04:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ppifvkJeq/Listeners', 04:32:37 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:37 INFO - 'USER': 'cltbld', 04:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:37 INFO - 'XPC_FLAGS': '0x0', 04:32:37 INFO - 'XPC_SERVICE_NAME': '0', 04:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:37 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/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--webServer', 'localhost'] with output_timeout 3600 04:32:37 INFO - mozversion INFO | application_buildid: 20151120025236 04:32:37 INFO - mozversion INFO | application_changeset: 8751a85b4f2592cd388685237ad54c1739ecc654 04:32:37 INFO - mozversion INFO | application_display_name: Nightly 04:32:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:37 INFO - mozversion INFO | application_name: Firefox 04:32:37 INFO - mozversion INFO | application_remotingname: firefox 04:32:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:32:37 INFO - mozversion INFO | application_vendor: Mozilla 04:32:37 INFO - mozversion INFO | application_version: 45.0a1 04:32:37 INFO - mozversion INFO | platform_buildid: 20151120025236 04:32:37 INFO - mozversion INFO | platform_changeset: 8751a85b4f2592cd388685237ad54c1739ecc654 04:32:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:32:37 INFO - mozversion INFO | platform_version: 45.0a1 04:32:37 INFO - 2015-11-20 04:32:37,868 DEBUG : using testdate: 1448022757 04:32:37 INFO - 2015-11-20 04:32:37,868 DEBUG : actual date: 1448022757 04:32:38 INFO - 2015-11-20 04:32:38,211 INFO : starting webserver on 'localhost:49511' 04:32:38 INFO - 2015-11-20 04:32:38,212 INFO : Starting test suite t-yosemite-r7-0050 04:32:38 INFO - 2015-11-20 04:32:38,212 INFO : Starting test dromaeo_css 04:32:38 INFO - 2015-11-20 04:32:38,212 DEBUG : operating with platform_type : mac_ 04:32:38 INFO - 2015-11-20 04:32:38,213 INFO : Initialising browser for dromaeo_css test... 04:32:38 INFO - 2015-11-20 04:32:38,226 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp2SZ3hg/profile http://localhost:49511/getInfo.html 04:32:40 INFO - 2015-11-20 04:32:40,181 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:32:40 INFO - 2015-11-20 04:32:40,181 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:32:40 INFO - 2015-11-20 04:32:40,181 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:32:40 INFO - 2015-11-20 04:32:40,181 DEBUG : BROWSER_OUTPUT: __metrics 04:32:40 INFO - 2015-11-20 04:32:40,197 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:40 INFO - 2015-11-20 04:32:40,812 INFO : Browser initialized. 04:32:40 INFO - 2015-11-20 04:32:40,813 INFO : Running cycle 1/1 for dromaeo_css test... 04:32:40 INFO - 2015-11-20 04:32:40,813 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp2SZ3hg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:32:52 INFO - 2015-11-20 04:32:52,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 225808384 04:32:52 INFO - 2015-11-20 04:32:52,663 DEBUG : BROWSER_OUTPUT: 04:33:43 INFO - 2015-11-20 04:33:43,664 DEBUG : BROWSER_OUTPUT: 1448022823661 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] 04:35:55 INFO - 2015-11-20 04:35:55,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49511/tests/dromaeo/cssquery-ext.html) 04:35:57 INFO - 2015-11-20 04:35:57,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 354164736 04:35:57 INFO - 2015-11-20 04:35:57,270 DEBUG : BROWSER_OUTPUT: 04:38:59 INFO - 2015-11-20 04:38:59,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-ext.html (next: http://localhost:49511/tests/dromaeo/cssquery-jquery.html) 04:39:00 INFO - 2015-11-20 04:39:00,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 363708416 04:39:00 INFO - 2015-11-20 04:39:00,505 DEBUG : BROWSER_OUTPUT: 04:42:02 INFO - 2015-11-20 04:42:02,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49511/tests/dromaeo/cssquery-mootools.html) 04:42:03 INFO - 2015-11-20 04:42:03,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 349515776 04:42:03 INFO - 2015-11-20 04:42:03,180 DEBUG : BROWSER_OUTPUT: 04:45:05 INFO - 2015-11-20 04:45:05,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49511/tests/dromaeo/cssquery-prototype.html) 04:45:05 INFO - 2015-11-20 04:45:05,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 323923968 04:45:05 INFO - 2015-11-20 04:45:05,779 DEBUG : BROWSER_OUTPUT: 04:48:08 INFO - 2015-11-20 04:48:08,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49511/tests/dromaeo/cssquery-yui.html) 04:48:09 INFO - 2015-11-20 04:48:09,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 324198400 04:48:09 INFO - 2015-11-20 04:48:09,447 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-yui.html (next: http://localhost:49511/tests/dromaeo/cssquery-dojo.html) 04:51:12 INFO - 2015-11-20 04:51:12,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 366587904 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3390;3521.788692678438;3577.8389972451237;3579.7494175407733;3615.2046549759043;5682;5805.912911306324;5936.495397891179;5945.554083443748;5945.7027148642555;5727.083666613343;5825.213596164516;5844.50321722653;5861.7948371807;5866.73599688014;5385.515303622683;5429.484199001108;5478.726063696819;5493.972530137364;5527;5501;5531.668099913998;5532.197831314457;5534.52956498696;5537.473939975695;5487.039768040577;5514.6691198528015;5515.255440515539;5517.531009864167;5523.337199536061;5504.4495550445035;5515.448455154493;5520.1167813149705;5521.061419558685;5522.420145884665;5350.892982140335;5361.383440904307;5459.099248623972;5489.64317319373;5528.640638358494;5880.911786323209;6000.909986350208;6026.819195424145;6031.24609423822;6071.939280607226;6348.777792777277;6355.3009168991375;6360.459360954324;6386.904196437057;6404.4236018758065;5084.898302033976;6240.469560087398;6284.591501552384;6368.904466433008;6405.19935008124;5440.319960004999;6075.149479072933;6166.290876549165;6167.229096362955;6169.413905678908;6521.184851893513;6546.345365463416;6553.311902250291;6566.737330506822;6571.934280657132;5951.494122999594;6058.575899687068;6069.666168360783;6278.623282603058;6388.297287298394;6432.51756118293;6441.967790161019;6453.548251622341;6454.483641308684;6467.062275969958;6305.905411418832;6317.6209427434505;6369.808905732835;6378.77674281398;6391.328910464427;6242;6363.5863668861375;6399;6401.9039714404325;6405.231372235268;5002.624803139779;5079.720615366116;5090.083784918676;5109.080365534165;5124.846254612367;4562.201614717411;4596.563326484045;4606.746628935373;4611.723296602215;4630.560096790799;5801.680907550125;5984.311804142492;6016.157737916695;6029.186059881948;6034.064719968412;6305.274893387227;6333.050042493663;6335.303116657164;6340.904886426707;6417.550771445954;6013.428724271187;6014.548908831855;6041.305249896318;6064.02975523914;6070.119832624245;5343.812966546152;5591.937531868932;5600.6919619420505;5613.887722245532;5655.349634791969;6240.063990401294;6391.424771770563;6410.679466026773;6411.711472983727;6493.960966245378;5642.5485961122195;6354.4281014708895;6396.71214795326;6418;6418.29398766126;6229.065640154013;6530;6535.248446428722;6542.051402546699;6543.967280163569;6275.686215689106;6360.904586431115;6376.585521941059;6385.77649782274;6385.840353991188;6169.352218017223;6323.620582765049;6332.651704156316;6351.30135685065;6369.044643303541;6337.524685648503;6365.363463653597;6377.202849643794;6382.904256436064;6407.711652975534;4946.629002824874;6081.300650425258;6334.841628959129;6367.140436041075;6383.489320854414;6045.76955676319;6129.6671895451245;6172.845678858064;6185.134081228722;6194.225721784777;6335.493160547053;6379.904301435575;6383;6383.840403989938;6402.551821372459;6172.845678857885;6249.562530622813;6264.561480696308;6282.026285925689;6284.08880712285 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.1571826541921;594.215635361323;600.3996003996006;615.9692015399229;623.1151764494421;32201.19497012573;40662;40834.38748418769;40974.18051638969;41061.7946910265;42772.14455710884;43087.56912430875;43135.92160195989;43157.78421107898;43283.350749738776;8725.912740872605;8873.112688731107;9691.17625001874;9869.457179855106;9891.406515609087;8665.39342246043;11925.821112683318;11950.282983021003;11954.402279886015;11964.102692298113;11723.5896743614;11855;11857;11862.703432414173;11981.880181198163;8877.067907869645;8942.508162051085;9018.819623607491;11647.767044659102;11744.7651046979;8726.738197854074;8846.15961483658;11806.232594881305;11875.703107422298;11888;40026.59973400258;40369.59630403688;40384.59615403867;40466.39300410496;40472.19055618901;3171.1120886151684;3296.192432853942;3323.0861513083855;3360.5631267935014;3547.396942519778;29319;29425.55861662077;29938.054026488207;30175;30271.091867244017;2770.667519897625;2830.674472435676;2856.8571571421344;2883.7116288371203;2913.9708602914125;511172;514169;514426.9999999963;515091;515773;61065.694671526355;61753.07370389448;62011.6899415509;70691.64654176697;71965;68442.31557684459;68616;68870.65564672244;69140.6542967282;69152.6542367285;16436.589085272724;16681.832271740863;16692.916535417244;16728.247228874487;16742.246598902835;12600.936995314965;12674.683132921566;12695.809562856564;12735.23588584688;12784;20647.79352206459;20987.58024839495;21004.47488812792;21054.578908422052;21062.946852657307;8635.222829945335;8851.33614978879;8856.468611883307;8874.600642971081;8899.466032038099;838.5471845203643;986.6497393425374;1045.895410458948;1068.5832525315134;1136.3579577538665;28038.299042523693;28303.71696283011;28304.8584757079;28553.428931421255;29364.853175733984;1100.7193165742685;1111.9610813621484;1154.3535620052796;1160.5067846165346;1191.713988642737;14612.634684132769;14707;14767.40930362795;15062.924685376722;15080.698386032218;541214;545701;546274;547632;547863;58260.41739582635;58950.705246474354;59039.524011899186;59058;59242.40757592455;1246.9563565275353;1459.569427019032;1482.78499617557;1485.123776971592;1487.5314276003025;28405.857970710014;28457.573136402556;28740.577530978084;29141.125766227047;29165;47704.04591908212;48163.759181203866;49047.754761225966;49395.75302123466;49412;379455;383091;383417;651881;652217;29367.559486608145;29658.258543536584;29943.85028074846;29967.951121710634;30040.098797036124;41118.58881411267;41167;41295.380569290886;42484.362734559625;42703.5729642712;35141.47287790736;35290.94127176189;35677.82161089178;36007.459888102225;36151;36385.818070909474;36520;36561.45157822582;37039;37067.814660926524;36254;37188.81405593063;37585.81207093947;37734.43398348972;37754.8112259437;29730.70269297366;31864;31888.521672174473;32203.51694724628;32359;18867.811321886606;24368.63447048331;24589.508209835345;24670.753292466845;24879.852679172505 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.37983528824554;357.4816516051725;361.96018437971827;362.6156274349192;367.845504887947;16423.932444391106;16911.40810071648;19586.922719250437;20687.482812929684;21510.784892151092;17128.002599545092;20879.060442280097;20903.68644470334;21026.789732102712;21318.360449186548;6436.613803171801;6596.34036596339;6622.602643841385;6636.0377745226915;6637.601743895381;4639.559241872033;4793.496682848303;6570.704318305688;6659.433948114416;7613.581253031081;6178.56750027496;6384.585001974857;7576.166621671612;7577.090749110114;7582.393408527305;6408;6423.325550817191;6442.0014897690935;6445.8710825783455;6450.4194622483965;5333.066713325153;5339.09235429974;5340.359156901158;5349.251104845324;5427.375851777057;25003;25229.61237131957;25339.746602533924;25775.484490310275;25807.83864726073;2157.7302837145357;2165.621016322153;2213.236433430464;2220.622494175978;2263.7736226377397;9688.564014619358;9804.166645835112;10069.748256293651;10693.679189624323;13026.088173827837;1729.8097209306966;1730.4462571976972;1732.3763445159732;1775.2189036823886;1779.1015537153655;91115.17769644636;97916.51041744817;98711;99985;100300.99999999927;10877.83683244752;10904.50929708165;10948.890511094787;10956.506957186946;10964.945175274232;12981.675458113434;13019.544315948897;13023.47906083746;13030.08789384734;13034.348282585834;8370.95363079615;8388.035375931724;8389.790255243668;8455.154484551496;8459.02721187059;8505.021922478994;8517.276031537265;8521.659133634585;8574.871376929352;8587.22714955657;3974.4038394241097;4130.793460327031;4276.016516201229;4303.419038429772;4375.256206444912;1731.6622559544514;1756.5169578365796;1780.2167046499499;1785.749995000701;1791.9820801792075;803.606232945864;930.6835675870236;934.9859752103724;954.5036580977992;1005.4520286443906;19616.509587260432;20607.381778546667;20891.854634087915;21233.469163271042;21326.10268968051;870.7939503787301;961.077365728894;996.0736515041082;1010.3836659637615;1060.3319908457622;8713.869291960626;10773.245872788986;11463.598774042868;11481.253718508271;11568.826467602992;593216;634121.2939353014;691137.5443122752;693800;754679;101198;112320.19199520077;118505;125197;128925;471.9551642593948;482.6380214838941;1167.626359564948;1195.3246415775059;1199.6700907250402;10904.964028417287;10975.945120274348;11000.779984400107;11087.55649774;11123.833142502706;46928.061438771714;47393.630318484626;52950.205746914595;53487;53799;72888.635556824;73339;76559;79337.60331198307;81047.3790524198;9905.603775848886;10057.49712514386;10142.29003969715;10221.795564088825;10243.84634230502;20394.490137746674;20467.692984604946;20562.383128506168;20662.863542505307;21122;15958.281877315781;16043.359895077927;16528.25622846951;16529.090900000614;16539.255733492264;15641.217939103228;15827.604309892346;16154.919225404268;16282.837171628606;16494.83505164981;16650.58373540671;17025.574360641083;17282.740758888376;17293.22180501855;17294.308227670754;9806.705798826046;9934.602615895283;9947.602095916081;9949.900500994898;10001.049900259464;16084.517464476085;16096;16428.835711642732;16570.66858662796;16683.91658041702 04:51:12 INFO - 2015-11-20 04:51:12,678 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1569.5212960047181;1576.227648452258;1714.9485515434542;1863.5713785829257;1883.5385330594002;7395.889061664079;7788.299053085221;8232.341412686985;8424.663013479454;8445.28215101717;8183.836323273531;8261.710840120597;8324.33405327574;8328.75013749587;8333;2373.8931748071336;2380.571497130516;2383.6067048936907;2384.8807559622037;2387.1883559589737;2018.3944816555047;2409.325388891113;2427.356750461129;2433.4646377796857;2433.610622300432;2353.8116950643994;2380.8452450590657;2381.785639292463;2392.3660230039054;2401.7478164792706;2351.318117745852;2378.3816207785926;2383.940401489959;2391.402149462643;2393.0906255622926;1980.3266889257723;2359.304005318435;2361.456864921078;2364.7162340519076;2369.158948573266;7376.963115184443;8237.711680091168;8287.917120828775;8305.127961564009;8317.126701696356;4691.249400095969;4803.951960480385;5031.144705400091;5195.584353251731;5196.714180720059;3428.400029994766;3465.9480107798404;3538.752287339887;3541.4687796830426;3542.8582856685703;972.2173650211577;1010.5048526222098;1046.7278507588005;1059.6820953713932;1071.6945670483874;10817.567297308098;10865.239433239676;10872.347659140398;10877.456127193687;10899.891001089967;4602;4687.484376718558;4734.668573199911;4748.643851711066;4752.239641657318;9586.616535338648;9591.088846559565;9602.855957160647;9615.759606009906;9640.4215747054;5182.896342073137;5194.870128246824;5194.896102077937;5219.791208351699;5225.869353266199;4690.390249267573;4719.811207551728;4736.5500277474275;4737.763111844394;4754.881127971828;3701.555813302421;3757.9812100939866;3765.4163604641326;3787.5265591801026;3789.4694742736037;1207.8429804125408;1227.2943057741657;1233.9383030848421;1234.7530493901256;1236.5548402575066;1027.9743006424749;1338.7322535492747;1374.0381732787089;1398.601398601414;1406.0228141441805;7434.925650743531;7462.514936529108;7511.51175173612;7530.698772049166;7534;500.4320096690283;504.9368828896388;509.0404587352867;511.36590627622223;514.362190883302;5832.912506312408;5994.400559943971;6132.846678833065;6158.753649854045;6175.59858609189;9044.186023257938;9803.852942205873;9857.063578960131;9857.30998830075;9957.452340121217;9755.073268039525;9776.9022309776;9832.115109640166;9970.40177589347;10113.140383067375;7827.373810095179;7880.369570434466;7902.68389264423;7920.4059695523065;7966.880496792553;7542.2834830691;7714.074311082706;7741.1871753465075;7747.186545412876;7775.339096176888;8632.697855575025;8936.24041956441;8972;9048.50233237152;9106.772330691785;9058.230050445785;9276.1651451367;9347.766305842408;9363.344565880323;9374.062593740571;7147.749828755968;7258.274172582699;7272;7325.816854578678;7326.120865496175;7957.920420795949;7993.640286187252;8007.279344858757;8010.599470026592;8012.679492820455;7334.889976650248;7448.106227252764;7460.253974602496;7604.961975190088;7643.503172293783;7319.634018298957;7332.19345871943;7341.229170937188;7366.226546212785;7368.56739955127;7420.332170104716;7467.701291948261;7486.51337663072;7504.587247701429;7510.511816731895;6770.729170833111;6795.45636349081;6852.349026842442;6854.862902742017;6855.383015528626;6830.419414349836;6886.311368863274;6898.620575868375;6915.377616014583;6931.757388491378 04:51:12 INFO - 2015-11-20 04:51:12,682 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.23706197780274;327.18530858163166;329.6653896295262;332.33201265456427;333.8113965609432;6801.455883529318;6867.038614593961;6896.413804826596;6961.060256865321;7007.789766307006;6845.452363810896;6870.1068861048;6872.518923675345;6875.106236189288;6885.896711549331;4957.033378491195;5074.264231686403;5077.466865979074;5111.2333150027425;5114.207297868837;5071.974640126794;5078.238264260372;5086.389633244016;5103.2855400244;5111.4121875984365;3675.705943524525;4447.777611119447;4992.800287988494;5026.97486512567;5030.7987680492915;4797.8320758773625;4865.82969596066;4867.904721437683;4890.975545122287;5056.443791182967;3442.862285508577;4139.958600413987;4163.791810409498;4169.478815148106;4208.600182982612;6532.804015879484;6582.308857569982;6596.670166491705;6603.042558828991;6612;5971.880562388771;5977.8804423911715;5981.5214782817275;5989.880202395928;5990.161377407167;5905;6972.372486476242;6994.300569943016;7131.894556343775;7232.674529646179;4434.334849772527;4632.18936686082;4711.48173700896;4719.433667959833;4824.927626085611;6492.383223593751;7042.964785176093;7309.086364204474;7437.590932498711;7478.8878166827;4738.384010078667;4739.289106634033;4741.620670346364;4750.358701575243;4856.80572777092;4407.955920440754;4508.729476231371;4959.752012399365;4969.875753106201;4996.850094497171;4791.401074865642;5770.567207459458;5937.495312898365;5968.910466343008;5976.163337132805;5999.880002399927;7375.483716139926;7389.076365454318;7390.260973902567;7391.445641576904;1721.9827801721822;1745.2495426966527;1745.9214335354939;1747.2399506214583;1751.0281793604672;1111.6220485034964;1127.6842484104463;1127.973544074888;1137.5734099712608;1153.8846115388394;6741.292164322774;6757.054012438164;6765.966170169216;6780.457563394916;6789.117414736152;7600.80997975055;7643.4267429942975;7650.1202361728;7656.961715191388;7667.731629392944;6615.338466153443;6763.391294783395;6766.25571187169;6767.898481522781;6795.320467953264;3388.322335532854;4028.657564107025;4032.2540330039037;4038.1318016626565;4062.4921884764403;6234.750609975641;7906.011748531434;7921.881171782428;7945.12603613602;7973.760787176394;7802.219778022266;7904.960475197702;7979.441439099207;7991.120976692559;8001.8399632008195;7939.087004994384;7942.801429964182;7945.761627151194;7947.920520794718;7966.402519810921;7442.62786860644;7676.117246516722;7679.424043196671;7713.267239612228;7720.189380115232;7541.472096953161;7564.810879728051;7578.938948547318;7579.696812127453;7585.8001179657285;7637.2362763725405;7711.11322197932;7732.961335193288;7743.5353878767455;7744.961275193588;4648.883777905579;4779.928301075417;4780.976095119502;4781.737004464649;4787.40157480315;7381.224971378143;7555.8866616999685;7602.581857997863;7604.277593628596;7607.657655405409;6239.719212635351;7334.376577990931;7406;7429.294217049372;7435.144958329862;7369;7372.926270737438;7376.668049937658;7376.852462950818;7401.48189626721;7009.754658586925;7187.101612298463;7193.964030179815;7210.387117095106;7232.168300645493;7346.33882950537;7349.77950661481;7363.042804435389;7372.926270737224;7377.26227377258;6975.372216500539;7210.495265331377;7210.495265331377;7211.413489032405;7219.783406497813 04:51:12 INFO - 2015-11-20 04:51:12,683 DEBUG : BROWSER_OUTPUT: |5;yui.html;743.4832791210108;797.1271457753758;806.959652017399;809.550699361854;869.8999615044268;12462.501499940003;13644.522441714542;14469.63825904353;14479.565613031626;14501.129932204061;12731.236125832456;13906.304684765772;13928.93035534821;13934.721305573908;13949.163050216968;763.8777795552712;776.1036003416064;778.4434129597337;801.5230937592123;978.5645387802431;773.4779024158698;783.298947442039;784.90973538043;785.7603430953557;963.3641796414367;1015.2436434856006;1015.9847602285971;1030.1707125763794;1032.1175395037249;1036.3988886445843;1022.642075273652;1027.8509616105698;1028.454918892988;1028.83538633819;1029.7425643589104;593.2999061107892;601.9886590527911;602.7076867719196;603.1194456094108;604.585858686801;12363.75272494545;14074.788878166835;14322.85677143236;14327.856721432756;14344.713105737826;11324.584426946632;11531.481083351186;12080;12151.210171338835;12307.26156430617;10043.799124017552;10047.196224302039;10094.041066098709;10112.443815590139;10182.54178561959;3495.0563347895927;3516.1385460562324;3517.50754894315;3525.506429099928;3671.541057367829;86232;86927.13072869317;87208;88338;88629.55685221597;9508;9511.762205944768;9566.473843938651;9616.471094089753;10036.899631003742;20290.492737681678;20439.79560204379;20670;20671.069801858954;20675.8966205168;7209.639518024078;7245.529040612343;7285.854282914312;7462.514936529108;7501.362384197295;4084.550699423061;4088;4124.670026397881;4133.503979522477;4136.648384887319;3431;3459;3466.942582512358;3472.7916325020074;3475.9826200868833;621.1087090025827;629.9874002519924;631.8041407163702;640.0846789091551;647.4205586000503;490.2791202877853;493.5262148337636;510.6578592343065;522.7229568328792;554.3735578796015;8355.582220888931;8426.115257897955;8515.701950431705;8687.478751274944;8705.390622656354;524.7245196271912;564.3650892745661;575.1573944171724;623.9157713708591;630.8359826445158;3706.703463722896;3832.48261484696;3868.845246190121;4314.158739045856;4420.005498762753;94823.10353792885;96774.51612741892;97575;104201;104586.47706761418;84399;84854;87214.69177962336;87330.56334718286;88222.55888720644;77799.83300250501;78345;78489.60755196188;78690;79640.00899977547;8794.42836215644;8802.515861627671;8948.149925757303;8951.01538830741;8979.46123232608;45376.95803688908;45749.77125114353;50363;50869.98260034853;51946.74026629994;57751.556211095056;64924;66737;76471.61764191143;79042.6047869757;8992.28061755045;11044.116470682166;11201.60794372193;11240.55037798479;11613.30320180792;11560.595379161688;11859.762804744028;12007.699807504881;12373.814392783936;12509.624711258677;11714.472848721998;11748.177627565989;11749.706257343634;11840.585579505021;11853.466594003463;11301;11570.016548593463;11574.421278936188;11808.114391420506;11915.880841191478;11152.553897843994;11466.77066458683;11503.309801411942;11543.653690389301;11750.58872939443;9687.757806054906;9760.755981100529;9782.510874456391;9787.265955053543;10093.596256149673;9837.360571562825;9928.354656947275;9930.453825039693;9932.404055756677;9955.950220249142 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1142 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: __startTimestamp1448023872669__endTimestamp 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5925.87 Median:6167.23 stddev:633.22 (10.3%) stddev-sans-first:603.11 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: Values: 3390.0 3521.8 3577.8 3579.7 3615.2 5682.0 5805.9 5936.5 5945.6 5945.7 5727.1 5825.2 5844.5 5861.8 5866.7 5385.5 5429.5 5478.7 5494.0 5527.0 5501.0 5531.7 5532.2 5534.5 5537.5 5487.0 5514.7 5515.3 5517.5 5523.3 5504.4 5515.4 5520.1 5521.1 5522.4 5350.9 5361.4 5459.1 5489.6 5528.6 5880.9 6000.9 6026.8 6031.2 6071.9 6348.8 6355.3 6360.5 6386.9 6404.4 5084.9 6240.5 6284.6 6368.9 6405.2 5440.3 6075.1 6166.3 6167.2 6169.4 6521.2 6546.3 6553.3 6566.7 6571.9 5951.5 6058.6 6069.7 6278.6 6388.3 6432.5 6442.0 6453.5 6454.5 6467.1 6305.9 6317.6 6369.8 6378.8 6391.3 6242.0 6363.6 6399.0 6401.9 6405.2 5002.6 5079.7 5090.1 5109.1 5124.8 4562.2 4596.6 4606.7 4611.7 4630.6 5801.7 5984.3 6016.2 6029.2 6034.1 6305.3 6333.1 6335.3 6340.9 6417.6 6013.4 6014.5 6041.3 6064.0 6070.1 5343.8 5591.9 5600.7 5613.9 5655.3 6240.1 6391.4 6410.7 6411.7 6494.0 5642.5 6354.4 6396.7 6418.0 6418.3 6229.1 6530.0 6535.2 6542.1 6544.0 6275.7 6360.9 6376.6 6385.8 6385.8 6169.4 6323.6 6332.7 6351.3 6369.0 6337.5 6365.4 6377.2 6382.9 6407.7 4946.6 6081.3 6334.8 6367.1 6383.5 6045.8 6129.7 6172.8 6185.1 6194.2 6335.5 6379.9 6383.0 6383.8 6402.6 6172.8 6249.6 6264.6 6282.0 6284.1 04:51:12 INFO - 2015-11-20 04:51:12,684 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,685 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65985.17 Median:35842.64 stddev:139379.21 (388.9%) stddev-sans-first:139683.64 04:51:12 INFO - 2015-11-20 04:51:12,686 DEBUG : BROWSER_OUTPUT: Values: 558.2 594.2 600.4 616.0 623.1 32201.2 40662.0 40834.4 40974.2 41061.8 42772.1 43087.6 43135.9 43157.8 43283.4 8725.9 8873.1 9691.2 9869.5 9891.4 8665.4 11925.8 11950.3 11954.4 11964.1 11723.6 11855.0 11857.0 11862.7 11981.9 8877.1 8942.5 9018.8 11647.8 11744.8 8726.7 8846.2 11806.2 11875.7 11888.0 40026.6 40369.6 40384.6 40466.4 40472.2 3171.1 3296.2 3323.1 3360.6 3547.4 29319.0 29425.6 29938.1 30175.0 30271.1 2770.7 2830.7 2856.9 2883.7 2914.0 511172.0 514169.0 514427.0 515091.0 515773.0 61065.7 61753.1 62011.7 70691.6 71965.0 68442.3 68616.0 68870.7 69140.7 69152.7 16436.6 16681.8 16692.9 16728.2 16742.2 12600.9 12674.7 12695.8 12735.2 12784.0 20647.8 20987.6 21004.5 21054.6 21062.9 8635.2 8851.3 8856.5 8874.6 8899.5 838.5 986.6 1045.9 1068.6 1136.4 28038.3 28303.7 28304.9 28553.4 29364.9 1100.7 1112.0 1154.4 1160.5 1191.7 14612.6 14707.0 14767.4 15062.9 15080.7 541214.0 545701.0 546274.0 547632.0 547863.0 58260.4 58950.7 59039.5 59058.0 59242.4 1247.0 1459.6 1482.8 1485.1 1487.5 28405.9 28457.6 28740.6 29141.1 29165.0 47704.0 48163.8 49047.8 49395.8 49412.0 379455.0 383091.0 383417.0 651881.0 652217.0 29367.6 29658.3 29943.9 29968.0 30040.1 41118.6 41167.0 41295.4 42484.4 42703.6 35141.5 35290.9 35677.8 36007.5 36151.0 36385.8 36520.0 36561.5 37039.0 37067.8 36254.0 37188.8 37585.8 37734.4 37754.8 29730.7 31864.0 31888.5 32203.5 32359.0 18867.8 24368.6 24589.5 24670.8 24879.9 04:51:12 INFO - 2015-11-20 04:51:12,686 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,686 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36826.49 Median:2189.43 stddev:111383.55 (5087.3%) stddev-sans-first:111662.34 04:51:12 INFO - 2015-11-20 04:51:12,688 DEBUG : BROWSER_OUTPUT: Values: 354.4 357.5 362.0 362.6 367.8 16423.9 16911.4 19586.9 20687.5 21510.8 17128.0 20879.1 20903.7 21026.8 21318.4 6436.6 6596.3 6622.6 6636.0 6637.6 4639.6 4793.5 6570.7 6659.4 7613.6 6178.6 6384.6 7576.2 7577.1 7582.4 6408.0 6423.3 6442.0 6445.9 6450.4 5333.1 5339.1 5340.4 5349.3 5427.4 25003.0 25229.6 25339.7 25775.5 25807.8 2157.7 2165.6 2213.2 2220.6 2263.8 9688.6 9804.2 10069.7 10693.7 13026.1 1729.8 1730.4 1732.4 1775.2 1779.1 91115.2 97916.5 98711.0 99985.0 100301.0 10877.8 10904.5 10948.9 10956.5 10964.9 12981.7 13019.5 13023.5 13030.1 13034.3 8371.0 8388.0 8389.8 8455.2 8459.0 8505.0 8517.3 8521.7 8574.9 8587.2 3974.4 4130.8 4276.0 4303.4 4375.3 1731.7 1756.5 1780.2 1785.7 1792.0 803.6 930.7 935.0 954.5 1005.5 19616.5 20607.4 20891.9 21233.5 21326.1 870.8 961.1 996.1 1010.4 1060.3 8713.9 10773.2 11463.6 11481.3 11568.8 593216.0 634121.3 691137.5 693800.0 754679.0 101198.0 112320.2 118505.0 125197.0 128925.0 472.0 482.6 1167.6 1195.3 1199.7 10905.0 10975.9 11000.8 11087.6 11123.8 46928.1 47393.6 52950.2 53487.0 53799.0 72888.6 73339.0 76559.0 79337.6 81047.4 9905.6 10057.5 10142.3 10221.8 10243.8 20394.5 20467.7 20562.4 20662.9 21122.0 15958.3 16043.4 16528.3 16529.1 16539.3 15641.2 15827.6 16154.9 16282.8 16494.8 16650.6 17025.6 17282.7 17293.2 17294.3 9806.7 9934.6 9947.6 9949.9 10001.0 16084.5 16096.0 16428.8 16570.7 16683.9 04:51:12 INFO - 2015-11-20 04:51:12,688 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,688 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5768.25 Median:6783.09 stddev:2990.72 (44.1%) stddev-sans-first:2982.46 04:51:12 INFO - 2015-11-20 04:51:12,688 DEBUG : BROWSER_OUTPUT: Values: 1569.5 1576.2 1714.9 1863.6 1883.5 7395.9 7788.3 8232.3 8424.7 8445.3 8183.8 8261.7 8324.3 8328.8 8333.0 2373.9 2380.6 2383.6 2384.9 2387.2 2018.4 2409.3 2427.4 2433.5 2433.6 2353.8 2380.8 2381.8 2392.4 2401.7 2351.3 2378.4 2383.9 2391.4 2393.1 1980.3 2359.3 2361.5 2364.7 2369.2 7377.0 8237.7 8287.9 8305.1 8317.1 4691.2 4804.0 5031.1 5195.6 5196.7 3428.4 3465.9 3538.8 3541.5 3542.9 972.2 1010.5 1046.7 1059.7 1071.7 10817.6 10865.2 10872.3 10877.5 10899.9 4602.0 4687.5 4734.7 4748.6 4752.2 9586.6 9591.1 9602.9 9615.8 9640.4 5182.9 5194.9 5194.9 5219.8 5225.9 4690.4 4719.8 4736.6 4737.8 4754.9 3701.6 3758.0 3765.4 3787.5 3789.5 1207.8 1227.3 1233.9 1234.8 1236.6 1028.0 1338.7 1374.0 1398.6 1406.0 7434.9 7462.5 7511.5 7530.7 7534.0 500.4 504.9 509.0 511.4 514.4 5832.9 5994.4 6132.8 6158.8 6175.6 9044.2 9803.9 9857.1 9857.3 9957.5 9755.1 9776.9 9832.1 9970.4 10113.1 7827.4 7880.4 7902.7 7920.4 7966.9 7542.3 7714.1 7741.2 7747.2 7775.3 8632.7 8936.2 8972.0 9048.5 9106.8 9058.2 9276.2 9347.8 9363.3 9374.1 7147.7 7258.3 7272.0 7325.8 7326.1 7957.9 7993.6 8007.3 8010.6 8012.7 7334.9 7448.1 7460.3 7605.0 7643.5 7319.6 7332.2 7341.2 7366.2 7368.6 7420.3 7467.7 7486.5 7504.6 7510.5 6770.7 6795.5 6852.3 6854.9 6855.4 6830.4 6886.3 6898.6 6915.4 6931.8 04:51:12 INFO - 2015-11-20 04:51:12,689 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,689 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5952.15 Median:6767.08 stddev:1927.89 (28.5%) stddev-sans-first:1886.40 04:51:12 INFO - 2015-11-20 04:51:12,690 DEBUG : BROWSER_OUTPUT: Values: 321.2 327.2 329.7 332.3 333.8 6801.5 6867.0 6896.4 6961.1 7007.8 6845.5 6870.1 6872.5 6875.1 6885.9 4957.0 5074.3 5077.5 5111.2 5114.2 5072.0 5078.2 5086.4 5103.3 5111.4 3675.7 4447.8 4992.8 5027.0 5030.8 4797.8 4865.8 4867.9 4891.0 5056.4 3442.9 4140.0 4163.8 4169.5 4208.6 6532.8 6582.3 6596.7 6603.0 6612.0 5971.9 5977.9 5981.5 5989.9 5990.2 5905.0 6972.4 6994.3 7131.9 7232.7 4434.3 4632.2 4711.5 4719.4 4824.9 6492.4 7043.0 7309.1 7437.6 7478.9 4738.4 4739.3 4741.6 4750.4 4856.8 4408.0 4508.7 4959.8 4969.9 4996.9 4791.4 5770.6 5937.5 5968.9 5976.2 5999.9 7375.5 7389.1 7390.3 7391.4 1722.0 1745.2 1745.9 1747.2 1751.0 1111.6 1127.7 1128.0 1137.6 1153.9 6741.3 6757.1 6766.0 6780.5 6789.1 7600.8 7643.4 7650.1 7657.0 7667.7 6615.3 6763.4 6766.3 6767.9 6795.3 3388.3 4028.7 4032.3 4038.1 4062.5 6234.8 7906.0 7921.9 7945.1 7973.8 7802.2 7905.0 7979.4 7991.1 8001.8 7939.1 7942.8 7945.8 7947.9 7966.4 7442.6 7676.1 7679.4 7713.3 7720.2 7541.5 7564.8 7578.9 7579.7 7585.8 7637.2 7711.1 7733.0 7743.5 7745.0 4648.9 4779.9 4781.0 4781.7 4787.4 7381.2 7555.9 7602.6 7604.3 7607.7 6239.7 7334.4 7406.0 7429.3 7435.1 7369.0 7372.9 7376.7 7376.9 7401.5 7009.8 7187.1 7194.0 7210.4 7232.2 7346.3 7349.8 7363.0 7372.9 7377.3 6975.4 7210.5 7210.5 7211.4 7219.8 04:51:12 INFO - 2015-11-20 04:51:12,690 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-11-20 04:51:12,690 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19106.51 Median:491.90 stddev:27852.11 (5662.1%) stddev-sans-first:27896.12 04:51:12 INFO - 2015-11-20 04:51:12,691 DEBUG : BROWSER_OUTPUT: Values: 743.5 797.1 807.0 809.6 869.9 12462.5 13644.5 14469.6 14479.6 14501.1 12731.2 13906.3 13928.9 13934.7 13949.2 763.9 776.1 778.4 801.5 978.6 773.5 783.3 784.9 785.8 963.4 1015.2 1016.0 1030.2 1032.1 1036.4 1022.6 1027.9 1028.5 1028.8 1029.7 593.3 602.0 602.7 603.1 604.6 12363.8 14074.8 14322.9 14327.9 14344.7 11324.6 11531.5 12080.0 12151.2 12307.3 10043.8 10047.2 10094.0 10112.4 10182.5 3495.1 3516.1 3517.5 3525.5 3671.5 86232.0 86927.1 87208.0 88338.0 88629.6 9508.0 9511.8 9566.5 9616.5 10036.9 20290.5 20439.8 20670.0 20671.1 20675.9 7209.6 7245.5 7285.9 7462.5 7501.4 4084.6 4088.0 4124.7 4133.5 4136.6 3431.0 3459.0 3466.9 3472.8 3476.0 621.1 630.0 631.8 640.1 647.4 490.3 493.5 510.7 522.7 554.4 8355.6 8426.1 8515.7 8687.5 8705.4 524.7 564.4 575.2 623.9 630.8 3706.7 3832.5 3868.8 4314.2 4420.0 94823.1 96774.5 97575.0 104201.0 104586.5 84399.0 84854.0 87214.7 87330.6 88222.6 77799.8 78345.0 78489.6 78690.0 79640.0 8794.4 8802.5 8948.1 8951.0 8979.5 45377.0 45749.8 50363.0 50870.0 51946.7 57751.6 64924.0 66737.0 76471.6 79042.6 8992.3 11044.1 11201.6 11240.6 11613.3 11560.6 11859.8 12007.7 12373.8 12509.6 11714.5 11748.2 11749.7 11840.6 11853.5 11301.0 11570.0 11574.4 11808.1 11915.9 11152.6 11466.8 11503.3 11543.7 11750.6 9687.8 9760.8 9782.5 9787.3 10093.6 9837.4 9928.4 9930.5 9932.4 9956.0 04:51:12 INFO - 2015-11-20 04:51:12,692 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:51:12 INFO - 2015-11-20 04:51:12,692 DEBUG : BROWSER_OUTPUT: 04:51:13 INFO - 2015-11-20 04:51:13,108 INFO : Browser exited with error code: 0 04:51:13 INFO - 2015-11-20 04:51:13,133 INFO : Completed test dromaeo_css (00:18:34) 04:51:13 INFO - 2015-11-20 04:51:13,134 INFO : Starting test kraken 04:51:13 INFO - 2015-11-20 04:51:13,134 DEBUG : operating with platform_type : mac_ 04:51:13 INFO - 2015-11-20 04:51:13,134 INFO : Initialising browser for kraken test... 04:51:13 INFO - 2015-11-20 04:51:13,146 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpvITCWb/profile http://localhost:49511/getInfo.html 04:51:15 INFO - 2015-11-20 04:51:15,148 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:51:15 INFO - 2015-11-20 04:51:15,148 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:51:15 INFO - 2015-11-20 04:51:15,148 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:51:15 INFO - 2015-11-20 04:51:15,149 DEBUG : BROWSER_OUTPUT: __metrics 04:51:15 INFO - 2015-11-20 04:51:15,165 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:15 INFO - 2015-11-20 04:51:15,792 INFO : Browser initialized. 04:51:15 INFO - 2015-11-20 04:51:15,792 INFO : Running cycle 1/1 for kraken test... 04:51:15 INFO - 2015-11-20 04:51:15,793 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpvITCWb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:27 INFO - 2015-11-20 04:51:27,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 225005568 04:51:27 INFO - 2015-11-20 04:51:27,647 DEBUG : BROWSER_OUTPUT: 04:51:30 INFO - 2015-11-20 04:51:30,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:30 INFO - 2015-11-20 04:51:30,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 275877888 04:51:30 INFO - 2015-11-20 04:51:30,743 DEBUG : BROWSER_OUTPUT: 04:51:33 INFO - 2015-11-20 04:51:33,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-dft) 04:51:33 INFO - 2015-11-20 04:51:33,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 291565568 04:51:33 INFO - 2015-11-20 04:51:33,949 DEBUG : BROWSER_OUTPUT: 04:51:37 INFO - 2015-11-20 04:51:37,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-fft) 04:51:37 INFO - 2015-11-20 04:51:37,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 275128320 04:51:37 INFO - 2015-11-20 04:51:37,721 DEBUG : BROWSER_OUTPUT: 04:51:39 INFO - 2015-11-20 04:51:39,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-oscillator) 04:51:40 INFO - 2015-11-20 04:51:40,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 277540864 04:51:40 INFO - 2015-11-20 04:51:40,165 DEBUG : BROWSER_OUTPUT: 04:51:42 INFO - 2015-11-20 04:51:42,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:42 INFO - 2015-11-20 04:51:42,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 277200896 04:51:42 INFO - 2015-11-20 04:51:42,746 DEBUG : BROWSER_OUTPUT: 04:51:45 INFO - 2015-11-20 04:51:45,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:45 INFO - 2015-11-20 04:51:45,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 280436736 04:51:45 INFO - 2015-11-20 04:51:45,995 DEBUG : BROWSER_OUTPUT: 04:51:48 INFO - 2015-11-20 04:51:48,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:49 INFO - 2015-11-20 04:51:49,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 279441408 04:51:49 INFO - 2015-11-20 04:51:49,481 DEBUG : BROWSER_OUTPUT: 04:51:52 INFO - 2015-11-20 04:51:52,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49511/tests/kraken/driver.html?testName=json-parse-financial) 04:51:52 INFO - 2015-11-20 04:51:52,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 279523328 04:51:52 INFO - 2015-11-20 04:51:52,755 DEBUG : BROWSER_OUTPUT: 04:51:54 INFO - 2015-11-20 04:51:54,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:54 INFO - 2015-11-20 04:51:54,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 314281984 04:51:54 INFO - 2015-11-20 04:51:54,827 DEBUG : BROWSER_OUTPUT: 04:51:56 INFO - 2015-11-20 04:51:56,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:57 INFO - 2015-11-20 04:51:57,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 315441152 04:51:57 INFO - 2015-11-20 04:51:57,222 DEBUG : BROWSER_OUTPUT: 04:51:59 INFO - 2015-11-20 04:51:59,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:59 INFO - 2015-11-20 04:51:59,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 323346432 04:51:59 INFO - 2015-11-20 04:51:59,866 DEBUG : BROWSER_OUTPUT: 04:52:02 INFO - 2015-11-20 04:52:02,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:03 INFO - 2015-11-20 04:52:03,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 326017024 04:52:03 INFO - 2015-11-20 04:52:03,011 DEBUG : BROWSER_OUTPUT: 04:52:05 INFO - 2015-11-20 04:52:05,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:06 INFO - 2015-11-20 04:52:06,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 325074944 04:52:06 INFO - 2015-11-20 04:52:06,148 DEBUG : BROWSER_OUTPUT: 04:52:07 INFO - 2015-11-20 04:52:07,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49511/tests/kraken/driver.html?testName=ai-astar) 04:52:08 INFO - 2015-11-20 04:52:08,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 383668224 04:52:08 INFO - 2015-11-20 04:52:08,048 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;110;108;108;97;109;112;111 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;142;129;169;140;168;134;117;156;116 04:52:08 INFO - 2015-11-20 04:52:08,050 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;185;180;181;182;183;183;183;185;180 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;65;71;71;56;56;57;73;72;55 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;87;112;73;78;74;113;74;75;112 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;86;85;86;86;86;86;85;87;85 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;93;99;93;96;93;93;93;121;150 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;87;87;86;84;87;87;86;86;85 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;54;53;54;53;55;64;52;53 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;66;63;64;66;67;67;68;68;67 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;80;82;81;81;83;82;83;84 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;125;133;130;122;119;120;119;109;136 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;135;167;170;173;122;133;131;138;134 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;65;64;64;63;65;65;64;65 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:52:08 INFO - 2015-11-20 04:52:08,051 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:52:08 INFO - 2015-11-20 04:52:08,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1060 04:52:08 INFO - 2015-11-20 04:52:08,052 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:52:08 INFO - 2015-11-20 04:52:08,052 DEBUG : BROWSER_OUTPUT: __startTimestamp1448023928049__endTimestamp 04:52:08 INFO - 2015-11-20 04:52:08,052 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,053 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:52:08 INFO - 2015-11-20 04:52:08,053 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:52:08 INFO - 2015-11-20 04:52:08,053 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,053 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:4.32 (3.9%) stddev-sans-first:4.56 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 110.0 108.0 108.0 97.0 109.0 112.0 111.0 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:144.00 stddev:18.72 (13.0%) stddev-sans-first:19.79 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: Values: 146.0 142.0 129.0 169.0 140.0 168.0 134.0 117.0 156.0 116.0 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.78 (1.0%) stddev-sans-first:1.88 04:52:08 INFO - 2015-11-20 04:52:08,054 DEBUG : BROWSER_OUTPUT: Values: 183.0 185.0 180.0 181.0 182.0 183.0 183.0 183.0 185.0 180.0 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:63.90 Median:68.00 stddev:7.48 (11.0%) stddev-sans-first:7.92 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 71.0 71.0 56.0 56.0 57.0 73.0 72.0 55.0 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.10 Median:74.50 stddev:17.28 (23.2%) stddev-sans-first:18.23 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 112.0 73.0 78.0 74.0 113.0 74.0 75.0 112.0 04:52:08 INFO - 2015-11-20 04:52:08,055 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,056 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 85.0 86.0 86.0 86.0 86.0 85.0 87.0 85.0 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:102.40 Median:93.00 stddev:18.84 (20.3%) stddev-sans-first:19.67 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 99.0 93.0 96.0 93.0 93.0 93.0 121.0 150.0 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 87.0 86.0 84.0 87.0 87.0 86.0 86.0 85.0 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.41 (6.3%) stddev-sans-first:3.60 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 54.0 53.0 54.0 53.0 55.0 64.0 52.0 53.0 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:67.00 stddev:1.91 (2.9%) stddev-sans-first:1.72 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: Values: 63.0 66.0 63.0 64.0 66.0 67.0 67.0 68.0 68.0 67.0 04:52:08 INFO - 2015-11-20 04:52:08,057 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.49 (1.8%) stddev-sans-first:1.58 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 80.0 82.0 81.0 81.0 83.0 82.0 83.0 84.0 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:127.50 stddev:8.11 (6.4%) stddev-sans-first:8.34 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: Values: 130.0 125.0 133.0 130.0 122.0 119.0 120.0 119.0 109.0 136.0 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:136.50 stddev:18.61 (13.6%) stddev-sans-first:19.47 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 167.0 170.0 173.0 122.0 133.0 131.0 138.0 134.0 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 65.0 64.0 64.0 63.0 65.0 65.0 64.0 65.0 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:52:08 INFO - 2015-11-20 04:52:08,058 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-20 04:52:08,668 INFO : Browser exited with error code: 0 04:52:08 INFO - 2015-11-20 04:52:08,714 INFO : Completed test kraken (00:00:55) 04:52:08 INFO - 2015-11-20 04:52:08,714 INFO : Starting test v8_7 04:52:08 INFO - 2015-11-20 04:52:08,714 DEBUG : operating with platform_type : mac_ 04:52:08 INFO - 2015-11-20 04:52:08,714 INFO : Initialising browser for v8_7 test... 04:52:08 INFO - 2015-11-20 04:52:08,727 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpiBXhFC/profile http://localhost:49511/getInfo.html 04:52:10 INFO - 2015-11-20 04:52:10,729 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:52:10 INFO - 2015-11-20 04:52:10,729 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:52:10 INFO - 2015-11-20 04:52:10,729 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:52:10 INFO - 2015-11-20 04:52:10,729 DEBUG : BROWSER_OUTPUT: __metrics 04:52:10 INFO - 2015-11-20 04:52:10,744 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:11 INFO - 2015-11-20 04:52:11,455 INFO : Browser initialized. 04:52:11 INFO - 2015-11-20 04:52:11,456 INFO : Running cycle 1/1 for v8_7 test... 04:52:11 INFO - 2015-11-20 04:52:11,456 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpiBXhFC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:52:23 INFO - 2015-11-20 04:52:23,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 226095104 04:52:23 INFO - 2015-11-20 04:52:23,223 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49511/tests/v8_7/run.html (next: http://localhost:49511/tests/v8_7/run.html) 04:52:44 INFO - 2015-11-20 04:52:44,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 570007552 04:52:44 INFO - 2015-11-20 04:52:44,878 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,878 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |0;Richards;145.49687181725594 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.16035455278 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4699.530516431925 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1709.4017094017095 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |6;Boyer;12456.79012345679 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |7;RegExp;28162.162162162163 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |8;Splay;757.5757575757576 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4545.454545454545 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:52:44 INFO - 2015-11-20 04:52:44,879 DEBUG : BROWSER_OUTPUT: __startTimestamp1448023964874__endTimestamp 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:145.50 Median:145.50 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: Values: 145.5 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.16 Median:161.16 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: Values: 161.2 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: Values: 280.0 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4699.53 Median:4699.53 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,880 DEBUG : BROWSER_OUTPUT: Values: 4699.5 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1709.40 Median:1709.40 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: Values: 1709.4 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: Values: 788.6 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: Values: 12456.8 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28162.16 Median:28162.16 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: Values: 28162.2 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,881 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:757.58 Median:757.58 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,882 DEBUG : BROWSER_OUTPUT: Values: 757.6 04:52:44 INFO - 2015-11-20 04:52:44,882 DEBUG : BROWSER_OUTPUT: 04:52:44 INFO - 2015-11-20 04:52:44,882 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4545.45 Median:4545.45 stddev:0.00 (0.0%) 04:52:44 INFO - 2015-11-20 04:52:44,882 DEBUG : BROWSER_OUTPUT: Values: 4545.5 04:52:44 INFO - 2015-11-20 04:52:44,882 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:52:44 INFO - 2015-11-20 04:52:44,882 DEBUG : BROWSER_OUTPUT: 04:52:45 INFO - 2015-11-20 04:52:45,535 INFO : Browser exited with error code: 0 04:52:45 INFO - 2015-11-20 04:52:45,554 INFO : Completed test v8_7 (00:00:36) 04:52:45 INFO - 2015-11-20 04:52:45,996 INFO : Completed test suite (00:20:07) 04:52:45 INFO - 2015-11-20 04:52:45,997 DEBUG : Working with test: dromaeo_css 04:52:45 INFO - 2015-11-20 04:52:45,997 DEBUG : Generating results file: dromaeo_css 04:52:45 INFO - 2015-11-20 04:52:45,997 DEBUG : Working with test: kraken 04:52:45 INFO - 2015-11-20 04:52:45,997 DEBUG : Generating results file: kraken 04:52:45 INFO - 2015-11-20 04:52:45,998 INFO : javascript benchmark 04:52:45 INFO - 2015-11-20 04:52:45,998 DEBUG : Working with test: v8_7 04:52:45 INFO - 2015-11-20 04:52:45,998 DEBUG : Generating results file: v8_7 04:52:45 INFO - 2015-11-20 04:52:45,998 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:46 INFO - 2015-11-20 04:52:46,046 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:52:46 INFO - 2015-11-20 04:52:46,047 DEBUG : process_Request line: dromaeo_css 7672.03 graph.html#tests=[[72,64,59]] 04:52:46 INFO - 2015-11-20 04:52:46,047 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:46 INFO - 2015-11-20 04:52:46,069 DEBUG : process_Request line: kraken 1393.80 graph.html#tests=[[232,64,59]] 04:52:46 INFO - 2015-11-20 04:52:46,070 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:46 INFO - 2015-11-20 04:52:46,093 DEBUG : process_Request line: v8_7 20389.33 graph.html#tests=[[230,64,59]] 04:52:46 INFO - 2015-11-20 04:52:46,094 INFO : javascript benchmark 04:52:46 INFO - 2015-11-20 04:52:46,096 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3390.0, 3521.788692678438, 3577.8389972451237, 3579.7494175407733, 3615.2046549759043, 5682.0, 5805.912911306324, 5936.495397891179, 5945.554083443748, 5945.7027148642555, 5727.083666613343, 5825.213596164516, 5844.50321722653, 5861.7948371807, 5866.73599688014, 5385.515303622683, 5429.484199001108, 5478.726063696819, 5493.972530137364, 5527.0, 5501.0, 5531.668099913998, 5532.197831314457, 5534.52956498696, 5537.473939975695, 5487.039768040577, 5514.6691198528015, 5515.255440515539, 5517.531009864167, 5523.337199536061, 5504.4495550445035, 5515.448455154493, 5520.1167813149705, 5521.061419558685, 5522.420145884665, 5350.892982140335, 5361.383440904307, 5459.099248623972, 5489.64317319373, 5528.640638358494, 5880.911786323209, 6000.909986350208, 6026.819195424145, 6031.24609423822, 6071.939280607226, 6348.777792777277, 6355.3009168991375, 6360.459360954324, 6386.904196437057, 6404.4236018758065, 5084.898302033976, 6240.469560087398, 6284.591501552384, 6368.904466433008, 6405.19935008124, 5440.319960004999, 6075.149479072933, 6166.290876549165, 6167.229096362955, 6169.413905678908, 6521.184851893513, 6546.345365463416, 6553.311902250291, 6566.737330506822, 6571.934280657132, 5951.494122999594, 6058.575899687068, 6069.666168360783, 6278.623282603058, 6388.297287298394, 6432.51756118293, 6441.967790161019, 6453.548251622341, 6454.483641308684, 6467.062275969958, 6305.905411418832, 6317.6209427434505, 6369.808905732835, 6378.77674281398, 6391.328910464427, 6242.0, 6363.5863668861375, 6399.0, 6401.9039714404325, 6405.231372235268, 5002.624803139779, 5079.720615366116, 5090.083784918676, 5109.080365534165, 5124.846254612367, 4562.201614717411, 4596.563326484045, 4606.746628935373, 4611.723296602215, 4630.560096790799, 5801.680907550125, 5984.311804142492, 6016.157737916695, 6029.186059881948, 6034.064719968412, 6305.274893387227, 6333.050042493663, 6335.303116657164, 6340.904886426707, 6417.550771445954, 6013.428724271187, 6014.548908831855, 6041.305249896318, 6064.02975523914, 6070.119832624245, 5343.812966546152, 5591.937531868932, 5600.6919619420505, 5613.887722245532, 5655.349634791969, 6240.063990401294, 6391.424771770563, 6410.679466026773, 6411.711472983727, 6493.960966245378, 5642.5485961122195, 6354.4281014708895, 6396.71214795326, 6418.0, 6418.29398766126, 6229.065640154013, 6530.0, 6535.248446428722, 6542.051402546699, 6543.967280163569, 6275.686215689106, 6360.904586431115, 6376.585521941059, 6385.77649782274, 6385.840353991188, 6169.352218017223, 6323.620582765049, 6332.651704156316, 6351.30135685065, 6369.044643303541, 6337.524685648503, 6365.363463653597, 6377.202849643794, 6382.904256436064, 6407.711652975534, 4946.629002824874, 6081.300650425258, 6334.841628959129, 6367.140436041075, 6383.489320854414, 6045.76955676319, 6129.6671895451245, 6172.845678858064, 6185.134081228722, 6194.225721784777, 6335.493160547053, 6379.904301435575, 6383.0, 6383.840403989938, 6402.551821372459, 6172.845678857885, 6249.562530622813, 6264.561480696308, 6282.026285925689, 6284.08880712285], "unit": "ms", "name": "dojo.html", "value": 5888.08176552497}, {"lowerIsBetter": false, "replicates": [558.1571826541921, 594.215635361323, 600.3996003996006, 615.9692015399229, 623.1151764494421, 32201.19497012573, 40662.0, 40834.38748418769, 40974.18051638969, 41061.7946910265, 42772.14455710884, 43087.56912430875, 43135.92160195989, 43157.78421107898, 43283.350749738776, 8725.912740872605, 8873.112688731107, 9691.17625001874, 9869.457179855106, 9891.406515609087, 8665.39342246043, 11925.821112683318, 11950.282983021003, 11954.402279886015, 11964.102692298113, 11723.5896743614, 11855.0, 11857.0, 11862.703432414173, 11981.880181198163, 8877.067907869645, 8942.508162051085, 9018.819623607491, 11647.767044659102, 11744.7651046979, 8726.738197854074, 8846.15961483658, 11806.232594881305, 11875.703107422298, 11888.0, 40026.59973400258, 40369.59630403688, 40384.59615403867, 40466.39300410496, 40472.19055618901, 3171.1120886151684, 3296.192432853942, 3323.0861513083855, 3360.5631267935014, 3547.396942519778, 29319.0, 29425.55861662077, 29938.054026488207, 30175.0, 30271.091867244017, 2770.667519897625, 2830.674472435676, 2856.8571571421344, 2883.7116288371203, 2913.9708602914125, 511172.0, 514169.0, 514426.9999999963, 515091.0, 515773.0, 61065.694671526355, 61753.07370389448, 62011.6899415509, 70691.64654176697, 71965.0, 68442.31557684459, 68616.0, 68870.65564672244, 69140.6542967282, 69152.6542367285, 16436.589085272724, 16681.832271740863, 16692.916535417244, 16728.247228874487, 16742.246598902835, 12600.936995314965, 12674.683132921566, 12695.809562856564, 12735.23588584688, 12784.0, 20647.79352206459, 20987.58024839495, 21004.47488812792, 21054.578908422052, 21062.946852657307, 8635.222829945335, 8851.33614978879, 8856.468611883307, 8874.600642971081, 8899.466032038099, 838.5471845203643, 986.6497393425374, 1045.895410458948, 1068.5832525315134, 1136.3579577538665, 28038.299042523693, 28303.71696283011, 28304.8584757079, 28553.428931421255, 29364.853175733984, 1100.7193165742685, 1111.9610813621484, 1154.3535620052796, 1160.5067846165346, 1191.713988642737, 14612.634684132769, 14707.0, 14767.40930362795, 15062.924685376722, 15080.698386032218, 541214.0, 545701.0, 546274.0, 547632.0, 547863.0, 58260.41739582635, 58950.705246474354, 59039.524011899186, 59058.0, 59242.40757592455, 1246.9563565275353, 1459.569427019032, 1482.78499617557, 1485.123776971592, 1487.5314276003025, 28405.857970710014, 28457.573136402556, 28740.577530978084, 29141.125766227047, 29165.0, 47704.04591908212, 48163.759181203866, 49047.754761225966, 49395.75302123466, 49412.0, 379455.0, 383091.0, 383417.0, 651881.0, 652217.0, 29367.559486608145, 29658.258543536584, 29943.85028074846, 29967.951121710634, 30040.098797036124, 41118.58881411267, 41167.0, 41295.380569290886, 42484.362734559625, 42703.5729642712, 35141.47287790736, 35290.94127176189, 35677.82161089178, 36007.459888102225, 36151.0, 36385.818070909474, 36520.0, 36561.45157822582, 37039.0, 37067.814660926524, 36254.0, 37188.81405593063, 37585.81207093947, 37734.43398348972, 37754.8112259437, 29730.70269297366, 31864.0, 31888.521672174473, 32203.51694724628, 32359.0, 18867.811321886606, 24368.63447048331, 24589.508209835345, 24670.753292466845, 24879.852679172505], "unit": "ms", "name": "ext.html", "value": 20205.858736708928}, {"lowerIsBetter": false, "replicates": [354.37983528824554, 357.4816516051725, 361.96018437971827, 362.6156274349192, 367.845504887947, 16423.932444391106, 16911.40810071648, 19586.922719250437, 20687.482812929684, 21510.784892151092, 17128.002599545092, 20879.060442280097, 20903.68644470334, 21026.789732102712, 21318.360449186548, 6436.613803171801, 6596.34036596339, 6622.602643841385, 6636.0377745226915, 6637.601743895381, 4639.559241872033, 4793.496682848303, 6570.704318305688, 6659.433948114416, 7613.581253031081, 6178.56750027496, 6384.585001974857, 7576.166621671612, 7577.090749110114, 7582.393408527305, 6408.0, 6423.325550817191, 6442.0014897690935, 6445.8710825783455, 6450.4194622483965, 5333.066713325153, 5339.09235429974, 5340.359156901158, 5349.251104845324, 5427.375851777057, 25003.0, 25229.61237131957, 25339.746602533924, 25775.484490310275, 25807.83864726073, 2157.7302837145357, 2165.621016322153, 2213.236433430464, 2220.622494175978, 2263.7736226377397, 9688.564014619358, 9804.166645835112, 10069.748256293651, 10693.679189624323, 13026.088173827837, 1729.8097209306966, 1730.4462571976972, 1732.3763445159732, 1775.2189036823886, 1779.1015537153655, 91115.17769644636, 97916.51041744817, 98711.0, 99985.0, 100300.99999999927, 10877.83683244752, 10904.50929708165, 10948.890511094787, 10956.506957186946, 10964.945175274232, 12981.675458113434, 13019.544315948897, 13023.47906083746, 13030.08789384734, 13034.348282585834, 8370.95363079615, 8388.035375931724, 8389.790255243668, 8455.154484551496, 8459.02721187059, 8505.021922478994, 8517.276031537265, 8521.659133634585, 8574.871376929352, 8587.22714955657, 3974.4038394241097, 4130.793460327031, 4276.016516201229, 4303.419038429772, 4375.256206444912, 1731.6622559544514, 1756.5169578365796, 1780.2167046499499, 1785.749995000701, 1791.9820801792075, 803.606232945864, 930.6835675870236, 934.9859752103724, 954.5036580977992, 1005.4520286443906, 19616.509587260432, 20607.381778546667, 20891.854634087915, 21233.469163271042, 21326.10268968051, 870.7939503787301, 961.077365728894, 996.0736515041082, 1010.3836659637615, 1060.3319908457622, 8713.869291960626, 10773.245872788986, 11463.598774042868, 11481.253718508271, 11568.826467602992, 593216.0, 634121.2939353014, 691137.5443122752, 693800.0, 754679.0, 101198.0, 112320.19199520077, 118505.0, 125197.0, 128925.0, 471.9551642593948, 482.6380214838941, 1167.626359564948, 1195.3246415775059, 1199.6700907250402, 10904.964028417287, 10975.945120274348, 11000.779984400107, 11087.55649774, 11123.833142502706, 46928.061438771714, 47393.630318484626, 52950.205746914595, 53487.0, 53799.0, 72888.635556824, 73339.0, 76559.0, 79337.60331198307, 81047.3790524198, 9905.603775848886, 10057.49712514386, 10142.29003969715, 10221.795564088825, 10243.84634230502, 20394.490137746674, 20467.692984604946, 20562.383128506168, 20662.863542505307, 21122.0, 15958.281877315781, 16043.359895077927, 16528.25622846951, 16529.090900000614, 16539.255733492264, 15641.217939103228, 15827.604309892346, 16154.919225404268, 16282.837171628606, 16494.83505164981, 16650.58373540671, 17025.574360641083, 17282.740758888376, 17293.22180501855, 17294.308227670754, 9806.705798826046, 9934.602615895283, 9947.602095916081, 9949.900500994898, 10001.049900259464, 16084.517464476085, 16096.0, 16428.835711642732, 16570.66858662796, 16683.91658041702], "unit": "ms", "name": "jquery.html", "value": 10000.398630761492}, {"lowerIsBetter": false, "replicates": [1569.5212960047181, 1576.227648452258, 1714.9485515434542, 1863.5713785829257, 1883.5385330594002, 7395.889061664079, 7788.299053085221, 8232.341412686985, 8424.663013479454, 8445.28215101717, 8183.836323273531, 8261.710840120597, 8324.33405327574, 8328.75013749587, 8333.0, 2373.8931748071336, 2380.571497130516, 2383.6067048936907, 2384.8807559622037, 2387.1883559589737, 2018.3944816555047, 2409.325388891113, 2427.356750461129, 2433.4646377796857, 2433.610622300432, 2353.8116950643994, 2380.8452450590657, 2381.785639292463, 2392.3660230039054, 2401.7478164792706, 2351.318117745852, 2378.3816207785926, 2383.940401489959, 2391.402149462643, 2393.0906255622926, 1980.3266889257723, 2359.304005318435, 2361.456864921078, 2364.7162340519076, 2369.158948573266, 7376.963115184443, 8237.711680091168, 8287.917120828775, 8305.127961564009, 8317.126701696356, 4691.249400095969, 4803.951960480385, 5031.144705400091, 5195.584353251731, 5196.714180720059, 3428.400029994766, 3465.9480107798404, 3538.752287339887, 3541.4687796830426, 3542.8582856685703, 972.2173650211577, 1010.5048526222098, 1046.7278507588005, 1059.6820953713932, 1071.6945670483874, 10817.567297308098, 10865.239433239676, 10872.347659140398, 10877.456127193687, 10899.891001089967, 4602.0, 4687.484376718558, 4734.668573199911, 4748.643851711066, 4752.239641657318, 9586.616535338648, 9591.088846559565, 9602.855957160647, 9615.759606009906, 9640.4215747054, 5182.896342073137, 5194.870128246824, 5194.896102077937, 5219.791208351699, 5225.869353266199, 4690.390249267573, 4719.811207551728, 4736.5500277474275, 4737.763111844394, 4754.881127971828, 3701.555813302421, 3757.9812100939866, 3765.4163604641326, 3787.5265591801026, 3789.4694742736037, 1207.8429804125408, 1227.2943057741657, 1233.9383030848421, 1234.7530493901256, 1236.5548402575066, 1027.9743006424749, 1338.7322535492747, 1374.0381732787089, 1398.601398601414, 1406.0228141441805, 7434.925650743531, 7462.514936529108, 7511.51175173612, 7530.698772049166, 7534.0, 500.4320096690283, 504.9368828896388, 509.0404587352867, 511.36590627622223, 514.362190883302, 5832.912506312408, 5994.400559943971, 6132.846678833065, 6158.753649854045, 6175.59858609189, 9044.186023257938, 9803.852942205873, 9857.063578960131, 9857.30998830075, 9957.452340121217, 9755.073268039525, 9776.9022309776, 9832.115109640166, 9970.40177589347, 10113.140383067375, 7827.373810095179, 7880.369570434466, 7902.68389264423, 7920.4059695523065, 7966.880496792553, 7542.2834830691, 7714.074311082706, 7741.1871753465075, 7747.186545412876, 7775.339096176888, 8632.697855575025, 8936.24041956441, 8972.0, 9048.50233237152, 9106.772330691785, 9058.230050445785, 9276.1651451367, 9347.766305842408, 9363.344565880323, 9374.062593740571, 7147.749828755968, 7258.274172582699, 7272.0, 7325.816854578678, 7326.120865496175, 7957.920420795949, 7993.640286187252, 8007.279344858757, 8010.599470026592, 8012.679492820455, 7334.889976650248, 7448.106227252764, 7460.253974602496, 7604.961975190088, 7643.503172293783, 7319.634018298957, 7332.19345871943, 7341.229170937188, 7366.226546212785, 7368.56739955127, 7420.332170104716, 7467.701291948261, 7486.51337663072, 7504.587247701429, 7510.511816731895, 6770.729170833111, 6795.45636349081, 6852.349026842442, 6854.862902742017, 6855.383015528626, 6830.419414349836, 6886.311368863274, 6898.620575868375, 6915.377616014583, 6931.757388491378], "unit": "ms", "name": "mootools.html", "value": 4656.415097903315}, {"lowerIsBetter": false, "replicates": [321.23706197780274, 327.18530858163166, 329.6653896295262, 332.33201265456427, 333.8113965609432, 6801.455883529318, 6867.038614593961, 6896.413804826596, 6961.060256865321, 7007.789766307006, 6845.452363810896, 6870.1068861048, 6872.518923675345, 6875.106236189288, 6885.896711549331, 4957.033378491195, 5074.264231686403, 5077.466865979074, 5111.2333150027425, 5114.207297868837, 5071.974640126794, 5078.238264260372, 5086.389633244016, 5103.2855400244, 5111.4121875984365, 3675.705943524525, 4447.777611119447, 4992.800287988494, 5026.97486512567, 5030.7987680492915, 4797.8320758773625, 4865.82969596066, 4867.904721437683, 4890.975545122287, 5056.443791182967, 3442.862285508577, 4139.958600413987, 4163.791810409498, 4169.478815148106, 4208.600182982612, 6532.804015879484, 6582.308857569982, 6596.670166491705, 6603.042558828991, 6612.0, 5971.880562388771, 5977.8804423911715, 5981.5214782817275, 5989.880202395928, 5990.161377407167, 5905.0, 6972.372486476242, 6994.300569943016, 7131.894556343775, 7232.674529646179, 4434.334849772527, 4632.18936686082, 4711.48173700896, 4719.433667959833, 4824.927626085611, 6492.383223593751, 7042.964785176093, 7309.086364204474, 7437.590932498711, 7478.8878166827, 4738.384010078667, 4739.289106634033, 4741.620670346364, 4750.358701575243, 4856.80572777092, 4407.955920440754, 4508.729476231371, 4959.752012399365, 4969.875753106201, 4996.850094497171, 4791.401074865642, 5770.567207459458, 5937.495312898365, 5968.910466343008, 5976.163337132805, 5999.880002399927, 7375.483716139926, 7389.076365454318, 7390.260973902567, 7391.445641576904, 1721.9827801721822, 1745.2495426966527, 1745.9214335354939, 1747.2399506214583, 1751.0281793604672, 1111.6220485034964, 1127.6842484104463, 1127.973544074888, 1137.5734099712608, 1153.8846115388394, 6741.292164322774, 6757.054012438164, 6765.966170169216, 6780.457563394916, 6789.117414736152, 7600.80997975055, 7643.4267429942975, 7650.1202361728, 7656.961715191388, 7667.731629392944, 6615.338466153443, 6763.391294783395, 6766.25571187169, 6767.898481522781, 6795.320467953264, 3388.322335532854, 4028.657564107025, 4032.2540330039037, 4038.1318016626565, 4062.4921884764403, 6234.750609975641, 7906.011748531434, 7921.881171782428, 7945.12603613602, 7973.760787176394, 7802.219778022266, 7904.960475197702, 7979.441439099207, 7991.120976692559, 8001.8399632008195, 7939.087004994384, 7942.801429964182, 7945.761627151194, 7947.920520794718, 7966.402519810921, 7442.62786860644, 7676.117246516722, 7679.424043196671, 7713.267239612228, 7720.189380115232, 7541.472096953161, 7564.810879728051, 7578.938948547318, 7579.696812127453, 7585.8001179657285, 7637.2362763725405, 7711.11322197932, 7732.961335193288, 7743.5353878767455, 7744.961275193588, 4648.883777905579, 4779.928301075417, 4780.976095119502, 4781.737004464649, 4787.40157480315, 7381.224971378143, 7555.8866616999685, 7602.581857997863, 7604.277593628596, 7607.657655405409, 6239.719212635351, 7334.376577990931, 7406.0, 7429.294217049372, 7435.144958329862, 7369.0, 7372.926270737438, 7376.668049937658, 7376.852462950818, 7401.48189626721, 7009.754658586925, 7187.101612298463, 7193.964030179815, 7210.387117095106, 7232.168300645493, 7346.33882950537, 7349.77950661481, 7363.042804435389, 7372.926270737224, 7377.26227377258, 6975.372216500539, 7210.495265331377, 7210.495265331377, 7211.413489032405, 7219.783406497813], "unit": "ms", "name": "prototype.html", "value": 5308.91908961385}, {"lowerIsBetter": false, "replicates": [743.4832791210108, 797.1271457753758, 806.959652017399, 809.550699361854, 869.8999615044268, 12462.501499940003, 13644.522441714542, 14469.63825904353, 14479.565613031626, 14501.129932204061, 12731.236125832456, 13906.304684765772, 13928.93035534821, 13934.721305573908, 13949.163050216968, 763.8777795552712, 776.1036003416064, 778.4434129597337, 801.5230937592123, 978.5645387802431, 773.4779024158698, 783.298947442039, 784.90973538043, 785.7603430953557, 963.3641796414367, 1015.2436434856006, 1015.9847602285971, 1030.1707125763794, 1032.1175395037249, 1036.3988886445843, 1022.642075273652, 1027.8509616105698, 1028.454918892988, 1028.83538633819, 1029.7425643589104, 593.2999061107892, 601.9886590527911, 602.7076867719196, 603.1194456094108, 604.585858686801, 12363.75272494545, 14074.788878166835, 14322.85677143236, 14327.856721432756, 14344.713105737826, 11324.584426946632, 11531.481083351186, 12080.0, 12151.210171338835, 12307.26156430617, 10043.799124017552, 10047.196224302039, 10094.041066098709, 10112.443815590139, 10182.54178561959, 3495.0563347895927, 3516.1385460562324, 3517.50754894315, 3525.506429099928, 3671.541057367829, 86232.0, 86927.13072869317, 87208.0, 88338.0, 88629.55685221597, 9508.0, 9511.762205944768, 9566.473843938651, 9616.471094089753, 10036.899631003742, 20290.492737681678, 20439.79560204379, 20670.0, 20671.069801858954, 20675.8966205168, 7209.639518024078, 7245.529040612343, 7285.854282914312, 7462.514936529108, 7501.362384197295, 4084.550699423061, 4088.0, 4124.670026397881, 4133.503979522477, 4136.648384887319, 3431.0, 3459.0, 3466.942582512358, 3472.7916325020074, 3475.9826200868833, 621.1087090025827, 629.9874002519924, 631.8041407163702, 640.0846789091551, 647.4205586000503, 490.2791202877853, 493.5262148337636, 510.6578592343065, 522.7229568328792, 554.3735578796015, 8355.582220888931, 8426.115257897955, 8515.701950431705, 8687.478751274944, 8705.390622656354, 524.7245196271912, 564.3650892745661, 575.1573944171724, 623.9157713708591, 630.8359826445158, 3706.703463722896, 3832.48261484696, 3868.845246190121, 4314.158739045856, 4420.005498762753, 94823.10353792885, 96774.51612741892, 97575.0, 104201.0, 104586.47706761418, 84399.0, 84854.0, 87214.69177962336, 87330.56334718286, 88222.55888720644, 77799.83300250501, 78345.0, 78489.60755196188, 78690.0, 79640.00899977547, 8794.42836215644, 8802.515861627671, 8948.149925757303, 8951.01538830741, 8979.46123232608, 45376.95803688908, 45749.77125114353, 50363.0, 50869.98260034853, 51946.74026629994, 57751.556211095056, 64924.0, 66737.0, 76471.61764191143, 79042.6047869757, 8992.28061755045, 11044.116470682166, 11201.60794372193, 11240.55037798479, 11613.30320180792, 11560.595379161688, 11859.762804744028, 12007.699807504881, 12373.814392783936, 12509.624711258677, 11714.472848721998, 11748.177627565989, 11749.706257343634, 11840.585579505021, 11853.466594003463, 11301.0, 11570.016548593463, 11574.421278936188, 11808.114391420506, 11915.880841191478, 11152.553897843994, 11466.77066458683, 11503.309801411942, 11543.653690389301, 11750.58872939443, 9687.757806054906, 9760.755981100529, 9782.510874456391, 9787.265955053543, 10093.596256149673, 9837.360571562825, 9928.354656947275, 9930.453825039693, 9932.404055756677, 9955.950220249142], "unit": "ms", "name": "yui.html", "value": 6932.609988827438}], "name": "dromaeo_css", "value": 7672.024138143426}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 110.0, 108.0, 108.0, 97.0, 109.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [146.0, 142.0, 129.0, 169.0, 140.0, 168.0, 134.0, 117.0, 156.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 180.0, 181.0, 182.0, 183.0, 183.0, 183.0, 185.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 182.5}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 71.0, 71.0, 56.0, 56.0, 57.0, 73.0, 72.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 63.9}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 112.0, 73.0, 78.0, 74.0, 113.0, 74.0, 75.0, 112.0], "unit": "ms", "name": "audio-oscillator", "value": 88.1}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 85.0, 87.0, 85.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 99.0, 93.0, 96.0, 93.0, 93.0, 93.0, 121.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 102.4}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 86.0, 84.0, 87.0, 87.0, 86.0, 86.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 53.0, 54.0, 53.0, 55.0, 64.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 63.0, 64.0, 66.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 80.0, 82.0, 81.0, 81.0, 83.0, 82.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [130.0, 125.0, 133.0, 130.0, 122.0, 119.0, 120.0, 119.0, 109.0, 136.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [135.0, 135.0, 167.0, 170.0, 173.0, 122.0, 133.0, 131.0, 138.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 65.0, 64.0, 64.0, 63.0, 65.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.5}], "name": "kraken", "value": 1393.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [145.49687181725594], "unit": "score", "name": "Richards", "value": 242.63064599999993}, {"lowerIsBetter": false, "replicates": [161.16035455278], "unit": "score", "name": "DeltaBlue", "value": 410.26218999999986}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [4699.530516431925], "unit": "score", "name": "Decrypt", "value": 56.63991308691312}, {"lowerIsBetter": false, "replicates": [1709.4017094017095], "unit": "score", "name": "RayTrace", "value": 432.89356499999985}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [28162.162162162163], "unit": "score", "name": "RegExp", "value": 32.34783589251442}, {"lowerIsBetter": false, "replicates": [757.5757575757576], "unit": "score", "name": "Splay", "value": 107.56812000000001}, {"lowerIsBetter": false, "replicates": [4545.454545454545], "unit": "score", "name": "NavierStokes", "value": 326.4799999999998}], "name": "v8_7", "value": 20389.333146865763}]} 04:52:46 INFO - RETURN: dromaeo_css: 7672.03 04:52:46 INFO - RETURN: kraken: 1393.80 04:52:46 INFO - RETURN: v8_7: 20389.33 04:52:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20389.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1393.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7672.03"}}} 04:52:46 INFO - Return code: 0 04:52:46 INFO - # TBPL SUCCESS # 04:52:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:46 INFO - 2015-11-20 04:52:46.183 screenresolution[1988:14245] starting screenresolution argv=screenresolution get 04:52:46 INFO - 2015-11-20 04:52:46.185 screenresolution[1988:14245] Display 0: 1600x1200x32@60 04:52:46 INFO - 2015-11-20 04:52:46.191 screenresolution[1989:14248] starting screenresolution argv=screenresolution list 04:52:46 INFO - Available Modes on Display 0 04:52:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:46 INFO - Intel Iris: 04:52:46 INFO - Chipset Model: Intel Iris 04:52:46 INFO - Type: GPU 04:52:46 INFO - Bus: Built-In 04:52:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:46 INFO - Vendor: Intel (0x8086) 04:52:46 INFO - Device ID: 0x0a2e 04:52:46 INFO - Revision ID: 0x0009 04:52:46 INFO - Displays: 04:52:46 INFO - Display: 04:52:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:46 INFO - Display Serial Number: 1600x1200 60 04:52:46 INFO - Main Display: Yes 04:52:46 INFO - Mirror: Off 04:52:46 INFO - Online: Yes 04:52:46 INFO - Rotation: Supported 04:52:46 INFO - Return code: 0 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - Running post-run listener: _resource_record_post_run 04:52:47 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 2424832; Write bytes: 688990720; Read time: 36; Write time: 2166 04:52:47 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336286208; Write bytes: 337098240; Read time: 26076; Write time: 652 04:52:47 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 2424832; Write bytes: 341525504; Read time: 36; Write time: 1481 04:52:47 INFO - Running post-run listener: _upload_blobber_files 04:52:47 INFO - Blob upload gear active. 04:52:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:52:47 INFO - Copying logs to upload dir... 04:52:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1324.195853 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-20 04:52:47.563167) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:52:47.566904) ========= 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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009476 build_url: 'https://queue.taskcluster.net/v1/task/_E-Pu4K9RFC4HJJ9OUOkgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:52:47.592783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:52:47.593532) ========= 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.TqvqUwfGnd/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.9ppifvkJeq/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005101 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:52:47.646331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:52:47.646979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:52:47.647592) ========= ========= Total master_lag: 0.27 =========