builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0013 starttime: 1447853192.43 results: success (0) buildid: 20151118030232 builduid: 5d9fcb0e271c46358d1a5024fa3f382a revision: eb3016abd37db2e6a6d923265047e84b12c0af61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.428219) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.428738) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.429069) ========= 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.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006166 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.480179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.480518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.512112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.512457) ========= 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.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005337 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.563223) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.563599) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.568138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.568496) ========= 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.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-18 05:26:32-- 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% 11.4M=0.001s 2015-11-18 05:26:32 (11.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.328283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.914796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.915208) ========= 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.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.019554 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.972379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.972730) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb3016abd37db2e6a6d923265047e84b12c0af61 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev eb3016abd37db2e6a6d923265047e84b12c0af61 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-18 05:26:33,051 truncating revision to first 12 chars 2015-11-18 05:26:33,051 Setting DEBUG logging. 2015-11-18 05:26:33,051 attempt 1/10 2015-11-18 05:26:33,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb3016abd37d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 05:26:33,296 unpacking tar archive at: mozilla-central-eb3016abd37d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.528532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.528869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.544078) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.544396) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.544840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2015-11-18 05:26:33.547759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:26:33 INFO - MultiFileLogger online at 20151118 05:26:33 in /builds/slave/test 05:26:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:26:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:33 INFO - {'append_to_log': False, 05:26:33 INFO - 'base_work_dir': '/builds/slave/test', 05:26:33 INFO - 'blob_upload_branch': 'Firefox', 05:26:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:33 INFO - 'branch': 'Firefox', 05:26:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:33 INFO - 'config_files': ('talos/mac_config.py',), 05:26:33 INFO - 'default_actions': ('clobber', 05:26:33 INFO - 'read-buildbot-config', 05:26:33 INFO - 'download-and-extract', 05:26:33 INFO - 'populate-webroot', 05:26:33 INFO - 'create-virtualenv', 05:26:33 INFO - 'install', 05:26:33 INFO - 'run-tests'), 05:26:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:33 INFO - 'download_minidump_stackwalk': True, 05:26:33 INFO - 'download_symbols': 'ondemand', 05:26:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:33 INFO - 'installer_path': 'installer.exe', 05:26:33 INFO - 'log_level': 'info', 05:26:33 INFO - 'log_name': 'talos', 05:26:33 INFO - 'log_to_console': True, 05:26:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:26:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:26:33 INFO - 'opt_config_files': (), 05:26:33 INFO - 'pip_index': False, 05:26:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:33 INFO - 'cmd': ('bash', 05:26:33 INFO - '-c', 05:26:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:33 INFO - 'enabled': True, 05:26:33 INFO - 'halt_on_failure': False, 05:26:33 INFO - 'name': 'check_screen_resolution'},), 05:26:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:33 INFO - 'cmd': ('bash', 05:26:33 INFO - '-c', 05:26:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:33 INFO - 'enabled': True, 05:26:33 INFO - 'halt_on_failure': False, 05:26:33 INFO - 'name': 'check_screen_resolution'},), 05:26:33 INFO - 'run_cmd_checks_enabled': True, 05:26:33 INFO - 'sps_profile': False, 05:26:33 INFO - 'sps_profile_interval': 0, 05:26:33 INFO - 'suite': 'dromaeojs', 05:26:33 INFO - 'system_bits': '64', 05:26:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:33 INFO - 'title': 't-yosemite-r5-0013', 05:26:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:33 INFO - 'use_talos_json': True, 05:26:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:33 INFO - 'work_dir': 'build'} 05:26:33 INFO - ##### 05:26:33 INFO - ##### Running clobber step. 05:26:33 INFO - ##### 05:26:33 INFO - Running pre-action listener: _resource_record_pre_action 05:26:33 INFO - Running main action method: clobber 05:26:33 INFO - rmtree: /builds/slave/test/build 05:26:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:35 INFO - Running post-action listener: _resource_record_post_action 05:26:35 INFO - ##### 05:26:35 INFO - ##### Running read-buildbot-config step. 05:26:35 INFO - ##### 05:26:35 INFO - Running pre-action listener: _resource_record_pre_action 05:26:35 INFO - Running main action method: read_buildbot_config 05:26:35 INFO - Using buildbot properties: 05:26:35 INFO - { 05:26:35 INFO - "properties": { 05:26:35 INFO - "buildnumber": 612, 05:26:35 INFO - "product": "firefox", 05:26:35 INFO - "script_repo_revision": "production", 05:26:35 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 05:26:35 INFO - "repository": "", 05:26:35 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 05:26:35 INFO - "buildid": "20151118030232", 05:26:35 INFO - "slavename": "t-yosemite-r5-0013", 05:26:35 INFO - "stage_platform": "macosx64", 05:26:35 INFO - "basedir": "/builds/slave/test", 05:26:35 INFO - "nightly_build": "True", 05:26:35 INFO - "project": "", 05:26:35 INFO - "platform": "yosemite", 05:26:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:26:35 INFO - "slavebuilddir": "test", 05:26:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:26:35 INFO - "branch": "mozilla-central", 05:26:35 INFO - "repo_path": "mozilla-central", 05:26:35 INFO - "pgo_build": "False", 05:26:35 INFO - "builduid": "5d9fcb0e271c46358d1a5024fa3f382a", 05:26:35 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 05:26:35 INFO - }, 05:26:35 INFO - "sourcestamp": { 05:26:35 INFO - "repository": "", 05:26:35 INFO - "hasPatch": false, 05:26:35 INFO - "project": "", 05:26:35 INFO - "branch": "mozilla-central-macosx64-talos", 05:26:35 INFO - "changes": [ 05:26:35 INFO - { 05:26:35 INFO - "category": null, 05:26:35 INFO - "files": [ 05:26:35 INFO - { 05:26:35 INFO - "url": null, 05:26:35 INFO - "name": "https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:26:35 INFO - } 05:26:35 INFO - ], 05:26:35 INFO - "repository": "", 05:26:35 INFO - "rev": "eb3016abd37db2e6a6d923265047e84b12c0af61", 05:26:35 INFO - "who": "sendchange", 05:26:35 INFO - "when": 1447853135, 05:26:35 INFO - "number": 6676914, 05:26:35 INFO - "comments": "", 05:26:35 INFO - "project": "", 05:26:35 INFO - "at": "Wed 18 Nov 2015 05:25:35", 05:26:35 INFO - "branch": "mozilla-central-macosx64-talos", 05:26:35 INFO - "revlink": "", 05:26:35 INFO - "properties": [ 05:26:35 INFO - [ 05:26:35 INFO - "buildid", 05:26:35 INFO - "20151118030232", 05:26:35 INFO - "Change" 05:26:35 INFO - ], 05:26:35 INFO - [ 05:26:35 INFO - "builduid", 05:26:35 INFO - "5d9fcb0e271c46358d1a5024fa3f382a", 05:26:35 INFO - "Change" 05:26:35 INFO - ], 05:26:35 INFO - [ 05:26:35 INFO - "nightly_build", 05:26:35 INFO - "True", 05:26:35 INFO - "Change" 05:26:35 INFO - ], 05:26:35 INFO - [ 05:26:35 INFO - "pgo_build", 05:26:35 INFO - "False", 05:26:35 INFO - "Change" 05:26:35 INFO - ] 05:26:35 INFO - ], 05:26:35 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 05:26:35 INFO - } 05:26:35 INFO - ], 05:26:35 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 05:26:35 INFO - } 05:26:35 INFO - } 05:26:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:26:35 INFO - Running post-action listener: _resource_record_post_action 05:26:35 INFO - ##### 05:26:35 INFO - ##### Running download-and-extract step. 05:26:35 INFO - ##### 05:26:35 INFO - Running pre-action listener: _resource_record_pre_action 05:26:35 INFO - Running main action method: download_and_extract 05:26:35 INFO - mkdir: /builds/slave/test/build/tests 05:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:35 INFO - https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:26:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json 05:26:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json 05:26:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:26:46 INFO - Downloaded 1149 bytes. 05:26:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:26:46 INFO - Using the following test package requirements: 05:26:46 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:26:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:26:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'jsshell-mac.zip'], 05:26:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:26:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:26:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:26:46 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:26:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:26:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:26:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:26:46 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:26:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:46 INFO - https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:27:01 INFO - Downloaded 17463610 bytes. 05:27:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:27:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:27:06 INFO - Return code: 0 05:27:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:06 INFO - https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:27:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:27:11 INFO - Downloaded 17463610 bytes. 05:27:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:27:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:27:18 INFO - Return code: 0 05:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:18 INFO - https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:27:19 INFO - Downloaded 11131693 bytes. 05:27:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:27:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:27:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:27:19 INFO - Return code: 0 05:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:19 INFO - https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:27:22 INFO - Downloaded 108959561 bytes. 05:27:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:27:22 INFO - mkdir: /builds/slave/test/properties 05:27:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:22 INFO - Contents: 05:27:22 INFO - build_url:https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:27:22 INFO - Running post-action listener: _resource_record_post_action 05:27:22 INFO - Running post-action listener: set_extra_try_arguments 05:27:22 INFO - ##### 05:27:22 INFO - ##### Running populate-webroot step. 05:27:22 INFO - ##### 05:27:22 INFO - Running pre-action listener: _resource_record_pre_action 05:27:22 INFO - Running main action method: populate_webroot 05:27:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:27:22 INFO - '../fennec_ids.txt'], 05:27:22 INFO - 'tests': ['tcheck2']}, 05:27:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:22 INFO - '--tppagecycles', 05:27:22 INFO - '7'], 05:27:22 INFO - 'tests': ['tsvgm']}}, 05:27:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:27:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:27:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:27:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'tests': ['damp', 'tps']}, 05:27:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['damp', 'tps']}, 05:27:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:27:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:22 INFO - 'other': {'tests': ['a11yr', 05:27:22 INFO - 'ts_paint', 05:27:22 INFO - 'tpaint', 05:27:22 INFO - 'sessionrestore', 05:27:22 INFO - 'sessionrestore_no_auto_restore']}, 05:27:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['a11yr', 05:27:22 INFO - 'ts_paint', 05:27:22 INFO - 'tpaint', 05:27:22 INFO - 'sessionrestore', 05:27:22 INFO - 'sessionrestore_no_auto_restore']}, 05:27:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['a11yr', 05:27:22 INFO - 'ts_paint', 05:27:22 INFO - 'tpaint', 05:27:22 INFO - 'sessionrestore', 05:27:22 INFO - 'sessionrestore_no_auto_restore']}, 05:27:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['a11yr', 05:27:22 INFO - 'ts_paint', 05:27:22 INFO - 'tpaint', 05:27:22 INFO - 'sessionrestore', 05:27:22 INFO - 'sessionrestore_no_auto_restore']}, 05:27:22 INFO - 'other_l64': {'tests': ['a11yr', 05:27:22 INFO - 'ts_paint', 05:27:22 INFO - 'tpaint', 05:27:22 INFO - 'sessionrestore', 05:27:22 INFO - 'sessionrestore_no_auto_restore']}, 05:27:22 INFO - 'other_nol64': {'tests': ['a11yr', 05:27:22 INFO - 'ts_paint', 05:27:22 INFO - 'tpaint', 05:27:22 INFO - 'sessionrestore', 05:27:22 INFO - 'sessionrestore_no_auto_restore']}, 05:27:22 INFO - 'svgr': {'tests': ['tsvgx', 05:27:22 INFO - 'tsvgr_opacity', 05:27:22 INFO - 'tart', 05:27:22 INFO - 'tscrollx', 05:27:22 INFO - 'cart']}, 05:27:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['tsvgx', 05:27:22 INFO - 'tsvgr_opacity', 05:27:22 INFO - 'tart', 05:27:22 INFO - 'tscrollx', 05:27:22 INFO - 'cart']}, 05:27:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'tests': ['tp5o']}, 05:27:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'talos_options': ['--e10s'], 05:27:22 INFO - 'tests': ['tp5o']}, 05:27:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'talos_options': ['--xperf_path', 05:27:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:22 INFO - 'tests': ['tp5n']}, 05:27:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:22 INFO - 'talos_options': ['--e10s', 05:27:22 INFO - '--xperf_path', 05:27:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:22 INFO - 'tests': ['tp5n']}}, 05:27:22 INFO - 'talos.zip': {'path': '', 05:27:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:22 INFO - Running post-action listener: _resource_record_post_action 05:27:22 INFO - ##### 05:27:22 INFO - ##### Running create-virtualenv step. 05:27:22 INFO - ##### 05:27:22 INFO - Running pre-action listener: _resource_record_pre_action 05:27:22 INFO - Running main action method: create_virtualenv 05:27:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:27:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:22 INFO - Using real prefix '/tools/python27' 05:27:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:27 INFO - Installing pip.................done. 05:27:27 INFO - Return code: 0 05:27:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:27 INFO - 'HOME': '/Users/cltbld', 05:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:27 INFO - 'LOGNAME': 'cltbld', 05:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:27 INFO - 'MOZ_NO_REMOTE': '1', 05:27:27 INFO - 'NO_EM_RESTART': '1', 05:27:27 INFO - 'PAGER': '/bin/cat', 05:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:27 INFO - 'PWD': '/builds/slave/test', 05:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:27 INFO - 'SHELL': '/bin/bash', 05:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:27 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:27 INFO - 'USER': 'cltbld', 05:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:27 INFO - 'XPC_FLAGS': '0x0', 05:27:27 INFO - 'XPC_SERVICE_NAME': '0', 05:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:27:27 INFO - Cleaning up... 05:27:27 INFO - Return code: 0 05:27:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:27 INFO - 'HOME': '/Users/cltbld', 05:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:27 INFO - 'LOGNAME': 'cltbld', 05:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:27 INFO - 'MOZ_NO_REMOTE': '1', 05:27:27 INFO - 'NO_EM_RESTART': '1', 05:27:27 INFO - 'PAGER': '/bin/cat', 05:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:27 INFO - 'PWD': '/builds/slave/test', 05:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:27 INFO - 'SHELL': '/bin/bash', 05:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:27 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:27 INFO - 'USER': 'cltbld', 05:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:27 INFO - 'XPC_FLAGS': '0x0', 05:27:27 INFO - 'XPC_SERVICE_NAME': '0', 05:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:28 INFO - Downloading/unpacking psutil>=0.7.1 05:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:27:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:30 INFO - Installing collected packages: psutil 05:27:30 INFO - Running setup.py install for psutil 05:27:30 INFO - building 'psutil._psutil_osx' extension 05:27:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:27:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:27:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:27:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:27:31 INFO - building 'psutil._psutil_posix' extension 05:27:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:27:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:27:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:27:31 INFO - ^ 05:27:31 INFO - 1 warning generated. 05:27:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:27:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:31 INFO - Successfully installed psutil 05:27:31 INFO - Cleaning up... 05:27:31 INFO - Return code: 0 05:27:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:31 INFO - 'HOME': '/Users/cltbld', 05:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:31 INFO - 'LOGNAME': 'cltbld', 05:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:31 INFO - 'MOZ_NO_REMOTE': '1', 05:27:31 INFO - 'NO_EM_RESTART': '1', 05:27:31 INFO - 'PAGER': '/bin/cat', 05:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:31 INFO - 'PWD': '/builds/slave/test', 05:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:31 INFO - 'SHELL': '/bin/bash', 05:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:31 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:31 INFO - 'USER': 'cltbld', 05:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:31 INFO - 'XPC_FLAGS': '0x0', 05:27:31 INFO - 'XPC_SERVICE_NAME': '0', 05:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:27:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:27:34 INFO - Installing collected packages: mozsystemmonitor 05:27:34 INFO - Running setup.py install for mozsystemmonitor 05:27:34 INFO - Successfully installed mozsystemmonitor 05:27:34 INFO - Cleaning up... 05:27:34 INFO - Return code: 0 05:27:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 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 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:34 INFO - 'HOME': '/Users/cltbld', 05:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:34 INFO - 'LOGNAME': 'cltbld', 05:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:34 INFO - 'MOZ_NO_REMOTE': '1', 05:27:34 INFO - 'NO_EM_RESTART': '1', 05:27:34 INFO - 'PAGER': '/bin/cat', 05:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:34 INFO - 'PWD': '/builds/slave/test', 05:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:34 INFO - 'SHELL': '/bin/bash', 05:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:34 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:34 INFO - 'USER': 'cltbld', 05:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:34 INFO - 'XPC_FLAGS': '0x0', 05:27:34 INFO - 'XPC_SERVICE_NAME': '0', 05:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:38 INFO - Downloading docopt-0.6.1.tar.gz 05:27:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:38 INFO - Running setup.py install for blobuploader 05:27:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:38 INFO - Running setup.py install for requests 05:27:39 INFO - Running setup.py install for docopt 05:27:39 INFO - Successfully installed blobuploader requests docopt 05:27:39 INFO - Cleaning up... 05:27:39 INFO - Return code: 0 05:27:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:39 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 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:39 INFO - 'HOME': '/Users/cltbld', 05:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:39 INFO - 'LOGNAME': 'cltbld', 05:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:39 INFO - 'MOZ_NO_REMOTE': '1', 05:27:39 INFO - 'NO_EM_RESTART': '1', 05:27:39 INFO - 'PAGER': '/bin/cat', 05:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:39 INFO - 'PWD': '/builds/slave/test', 05:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:39 INFO - 'SHELL': '/bin/bash', 05:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:39 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:39 INFO - 'USER': 'cltbld', 05:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:39 INFO - 'XPC_FLAGS': '0x0', 05:27:39 INFO - 'XPC_SERVICE_NAME': '0', 05:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:39 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-g9vAgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:39 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-CVYTCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:39 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-1FIABa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-snlIqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-TRrs3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-uL96v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-ZsX7QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-oO51nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-yxmPVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-SLH6AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:40 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-pTF5ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:41 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-0Tmbfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:41 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-N3lLpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:41 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-bWU76J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:41 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-XDsthi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:41 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-qQZtJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:41 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-BuKU5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:41 INFO - Running setup.py install for manifestparser 05:27:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:41 INFO - Running setup.py install for mozcrash 05:27:42 INFO - Running setup.py install for mozdebug 05:27:42 INFO - Running setup.py install for mozdevice 05:27:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:42 INFO - Running setup.py install for mozfile 05:27:42 INFO - Running setup.py install for mozhttpd 05:27:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:42 INFO - Running setup.py install for mozinfo 05:27:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Running setup.py install for mozInstall 05:27:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Running setup.py install for mozleak 05:27:43 INFO - Running setup.py install for mozlog 05:27:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Running setup.py install for moznetwork 05:27:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:43 INFO - Running setup.py install for mozprocess 05:27:43 INFO - Running setup.py install for mozprofile 05:27:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:44 INFO - Running setup.py install for mozrunner 05:27:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:44 INFO - Running setup.py install for mozscreenshot 05:27:44 INFO - Running setup.py install for moztest 05:27:44 INFO - Running setup.py install for mozversion 05:27:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:45 INFO - Cleaning up... 05:27:45 INFO - Return code: 0 05:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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', '-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 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:45 INFO - 'HOME': '/Users/cltbld', 05:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:45 INFO - 'LOGNAME': 'cltbld', 05:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:45 INFO - 'MOZ_NO_REMOTE': '1', 05:27:45 INFO - 'NO_EM_RESTART': '1', 05:27:45 INFO - 'PAGER': '/bin/cat', 05:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:45 INFO - 'PWD': '/builds/slave/test', 05:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:45 INFO - 'SHELL': '/bin/bash', 05:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:45 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:45 INFO - 'USER': 'cltbld', 05:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:45 INFO - 'XPC_FLAGS': '0x0', 05:27:45 INFO - 'XPC_SERVICE_NAME': '0', 05:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:45 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-4QIB9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:45 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-d0jjew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:45 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-K6N6XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:45 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-JiiqLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-O295ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-8bcPYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-YnW_lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-tZaM9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-hVAPO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-waYX0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-t0_N6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:46 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Em5WSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:47 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-CqDzwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:47 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Xh5aDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:47 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-tcyqIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:47 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-vAhpbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:47 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-1ahgmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:50 INFO - Downloading blessings-1.5.1.tar.gz 05:27:50 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:50 INFO - Installing collected packages: blessings 05:27:50 INFO - Running setup.py install for blessings 05:27:50 INFO - Successfully installed blessings 05:27:50 INFO - Cleaning up... 05:27:50 INFO - Return code: 0 05:27:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:50 INFO - Reading from file tmpfile_stdout 05:27:50 INFO - Current package versions: 05:27:50 INFO - blessings == 1.5.1 05:27:50 INFO - blobuploader == 1.2.4 05:27:50 INFO - docopt == 0.6.1 05:27:50 INFO - manifestparser == 1.1 05:27:50 INFO - mozInstall == 1.12 05:27:50 INFO - mozcrash == 0.16 05:27:50 INFO - mozdebug == 0.1 05:27:50 INFO - mozdevice == 0.47 05:27:50 INFO - mozfile == 1.2 05:27:50 INFO - mozhttpd == 0.7 05:27:50 INFO - mozinfo == 0.9 05:27:50 INFO - mozleak == 0.1 05:27:50 INFO - mozlog == 3.0 05:27:50 INFO - moznetwork == 0.27 05:27:50 INFO - mozprocess == 0.22 05:27:50 INFO - mozprofile == 0.27 05:27:50 INFO - mozrunner == 6.11 05:27:50 INFO - mozscreenshot == 0.1 05:27:50 INFO - mozsystemmonitor == 0.0 05:27:50 INFO - moztest == 0.7 05:27:50 INFO - mozversion == 1.4 05:27:50 INFO - psutil == 3.1.1 05:27:50 INFO - requests == 1.2.3 05:27:50 INFO - wsgiref == 0.1.2 05:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9719e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/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.WuhzcEubp3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:50 INFO - 'HOME': '/Users/cltbld', 05:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:50 INFO - 'LOGNAME': 'cltbld', 05:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:50 INFO - 'MOZ_NO_REMOTE': '1', 05:27:50 INFO - 'NO_EM_RESTART': '1', 05:27:50 INFO - 'PAGER': '/bin/cat', 05:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:50 INFO - 'PWD': '/builds/slave/test', 05:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:50 INFO - 'SHELL': '/bin/bash', 05:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:27:50 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:50 INFO - 'USER': 'cltbld', 05:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:50 INFO - 'XPC_FLAGS': '0x0', 05:27:50 INFO - 'XPC_SERVICE_NAME': '0', 05:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:51 INFO - Cleaning up... 05:27:51 INFO - Return code: 0 05:27:51 INFO - Running post-action listener: _resource_record_post_action 05:27:51 INFO - Running post-action listener: _start_resource_monitoring 05:27:51 INFO - Starting resource monitoring. 05:27:51 INFO - ##### 05:27:51 INFO - ##### Running install step. 05:27:51 INFO - ##### 05:27:51 INFO - Running pre-action listener: _resource_record_pre_action 05:27:51 INFO - Running main action method: install 05:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:51 INFO - Reading from file tmpfile_stdout 05:27:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:51 INFO - Reading from file tmpfile_stdout 05:27:51 INFO - Output received: 05:27:51 INFO - Usage: mozinstall [options] installer 05:27:51 INFO - Options: 05:27:51 INFO - -h, --help show this help message and exit 05:27:51 INFO - -d DEST, --destination=DEST 05:27:51 INFO - Directory to install application into. [default: 05:27:51 INFO - "/builds/slave/test"] 05:27:51 INFO - --app=APP Application being installed. [default: firefox] 05:27:51 INFO - mkdir: /builds/slave/test/build/application 05:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:28:30 INFO - Reading from file tmpfile_stdout 05:28:30 INFO - Output received: 05:28:30 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:28:30 INFO - Running post-action listener: _resource_record_post_action 05:28:30 INFO - ##### 05:28:30 INFO - ##### Running run-tests step. 05:28:30 INFO - ##### 05:28:30 INFO - Running pre-action listener: _resource_record_pre_action 05:28:30 INFO - Running main action method: run_tests 05:28:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:30 INFO - 2015-11-18 05:28:30.566 screenresolution[2010:21636] starting screenresolution argv=screenresolution get 05:28:30 INFO - 2015-11-18 05:28:30.569 screenresolution[2010:21636] Display 0: 1600x1200x32@60 05:28:30 INFO - 2015-11-18 05:28:30.576 screenresolution[2011:21638] starting screenresolution argv=screenresolution list 05:28:30 INFO - Available Modes on Display 0 05:28:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:30 INFO - Intel HD Graphics 3000: 05:28:30 INFO - Chipset Model: Intel HD Graphics 3000 05:28:30 INFO - Type: GPU 05:28:30 INFO - Bus: Built-In 05:28:30 INFO - VRAM (Total): 512 MB 05:28:30 INFO - VRAM (Dynamic, Max): 10 05:28:30 INFO - Vendor: Intel (0x8086) 05:28:30 INFO - Device ID: 0x0116 05:28:30 INFO - Revision ID: 0x0009 05:28:30 INFO - Displays: 05:28:30 INFO - Display: 05:28:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:30 INFO - Display Serial Number: 1600x1200 60 05:28:30 INFO - Main Display: Yes 05:28:30 INFO - Mirror: Off 05:28:30 INFO - Online: Yes 05:28:30 INFO - Rotation: Supported 05:28:30 INFO - Return code: 0 05:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:30 INFO - Python 2.7.3 05:28:30 INFO - Return code: 0 05:28:30 INFO - grabbing minidump binary from tooltool 05:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:30 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 0x10b4bc9f0>, '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 0x10b21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b08c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:28:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:28:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:30 INFO - Return code: 0 05:28:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:28:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:28:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] in /builds/slave/test/build 05:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0013 --webServer localhost 05:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8vz4ufKrkc/Render', 05:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:30 INFO - 'HOME': '/Users/cltbld', 05:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:30 INFO - 'LOGNAME': 'cltbld', 05:28:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:30 INFO - 'MOZ_NO_REMOTE': '1', 05:28:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:30 INFO - 'NO_EM_RESTART': '1', 05:28:30 INFO - 'PAGER': '/bin/cat', 05:28:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:30 INFO - 'PWD': '/builds/slave/test', 05:28:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:30 INFO - 'SHELL': '/bin/bash', 05:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WuhzcEubp3/Listeners', 05:28:30 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 05:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:30 INFO - 'USER': 'cltbld', 05:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:30 INFO - 'XPC_FLAGS': '0x0', 05:28:30 INFO - 'XPC_SERVICE_NAME': '0', 05:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:28:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] with output_timeout 3600 05:28:31 INFO - mozversion INFO | application_buildid: 20151118030232 05:28:31 INFO - mozversion INFO | application_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 05:28:31 INFO - mozversion INFO | application_display_name: Nightly 05:28:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:31 INFO - mozversion INFO | application_name: Firefox 05:28:31 INFO - mozversion INFO | application_remotingname: firefox 05:28:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:28:31 INFO - mozversion INFO | application_vendor: Mozilla 05:28:31 INFO - mozversion INFO | application_version: 45.0a1 05:28:31 INFO - mozversion INFO | platform_buildid: 20151118030232 05:28:31 INFO - mozversion INFO | platform_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 05:28:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:28:31 INFO - mozversion INFO | platform_version: 45.0a1 05:28:31 INFO - 2015-11-18 05:28:31,216 DEBUG : using testdate: 1447853311 05:28:31 INFO - 2015-11-18 05:28:31,216 DEBUG : actual date: 1447853311 05:28:31 INFO - 2015-11-18 05:28:31,264 INFO : starting webserver on 'localhost:51242' 05:28:31 INFO - 2015-11-18 05:28:31,265 INFO : Starting test suite t-yosemite-r5-0013 05:28:31 INFO - 2015-11-18 05:28:31,266 INFO : Starting test dromaeo_css 05:28:31 INFO - 2015-11-18 05:28:31,266 DEBUG : operating with platform_type : mac_ 05:28:31 INFO - 2015-11-18 05:28:31,267 INFO : Initialising browser for dromaeo_css test... 05:28:31 INFO - 2015-11-18 05:28:31,280 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpkhSqT5/profile http://localhost:51242/getInfo.html 05:28:33 INFO - 2015-11-18 05:28:33,937 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:33 INFO - 2015-11-18 05:28:33,938 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:33 INFO - 2015-11-18 05:28:33,938 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:28:33 INFO - 2015-11-18 05:28:33,938 DEBUG : BROWSER_OUTPUT: __metrics 05:28:33 INFO - 2015-11-18 05:28:33,955 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:34 INFO - 2015-11-18 05:28:34,692 INFO : Browser initialized. 05:28:34 INFO - 2015-11-18 05:28:34,693 INFO : Running cycle 1/1 for dromaeo_css test... 05:28:34 INFO - 2015-11-18 05:28:34,693 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpkhSqT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:46 INFO - 2015-11-18 05:28:46,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 228683776 05:28:46 INFO - 2015-11-18 05:28:46,784 DEBUG : BROWSER_OUTPUT: 05:29:38 INFO - 2015-11-18 05:29:38,579 DEBUG : BROWSER_OUTPUT: 1447853378576 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:31:48 INFO - 2015-11-18 05:31:48,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51242/tests/dromaeo/cssquery-ext.html) 05:31:49 INFO - 2015-11-18 05:31:49,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 345165824 05:31:49 INFO - 2015-11-18 05:31:49,949 DEBUG : BROWSER_OUTPUT: 05:34:52 INFO - 2015-11-18 05:34:52,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-ext.html (next: http://localhost:51242/tests/dromaeo/cssquery-jquery.html) 05:34:53 INFO - 2015-11-18 05:34:53,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 370061312 05:34:53 INFO - 2015-11-18 05:34:53,340 DEBUG : BROWSER_OUTPUT: 05:37:55 INFO - 2015-11-18 05:37:55,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51242/tests/dromaeo/cssquery-mootools.html) 05:37:56 INFO - 2015-11-18 05:37:56,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 336031744 05:37:56 INFO - 2015-11-18 05:37:56,171 DEBUG : BROWSER_OUTPUT: 05:40:58 INFO - 2015-11-18 05:40:58,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51242/tests/dromaeo/cssquery-prototype.html) 05:40:58 INFO - 2015-11-18 05:40:58,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 326668288 05:40:58 INFO - 2015-11-18 05:40:58,850 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-18 05:44:02,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51242/tests/dromaeo/cssquery-yui.html) 05:44:02 INFO - 2015-11-18 05:44:02,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 329580544 05:44:02 INFO - 2015-11-18 05:44:02,689 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/dromaeo/cssquery-yui.html (next: http://localhost:51242/tests/dromaeo/cssquery-dojo.html) 05:47:05 INFO - 2015-11-18 05:47:05,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 378839040 05:47:05 INFO - 2015-11-18 05:47:05,851 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,853 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:47:05 INFO - 2015-11-18 05:47:05,853 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:47:05 INFO - 2015-11-18 05:47:05,853 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:47:05 INFO - 2015-11-18 05:47:05,853 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:47:05 INFO - 2015-11-18 05:47:05,854 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2867.2258490207646;2894.9565756513643;2906.956395654064;2947.6757556668763;3126.218445388653;4616.861494155172;4736.976315118428;4841.249606311018;4856;4895.437024742156;4794.304825800257;4822.831200907969;4872.683275587093;4991.775370108345;5004.12427825131;4501;4520.434945631796;4534.6372290216705;4567.725936443824;4601.516840731725;4510.729356238619;4618.97690511547;4624.953750462503;4663.207254766698;4666.696664716799;4284.528701842794;4414.227510185705;4423.093265880487;4590.839320623762;4612.930806037895;4422.734635921823;4441.289393696993;4485.618722408599;4501.527339629357;4563.863084107482;4418.248897687401;4444.333349997494;4473.597376236155;4481.887952801173;4527.841525546623;4812.037592481518;4825.010872771073;4845.466998630148;4850.660453768238;4947.653664243504;4925.827596034157;5027.245913113063;5043.5460808527405;5072.82245121419;5135.64050516464;5317.308749862532;5343.706096164709;5349.786008559653;5351.652142610717;5405.081136206815;4939.110960027194;4957.201339784146;4961.801527938878;4964.329815474937;4996.275540046673;5211.140161873324;5303;5354.464553544614;5435.320584926884;5491.423400542965;5024.698518088926;5041.924371134362;5053.36832895888;5126.8974620508125;5140.1004824155625;5228.424873263938;5267.894642107136;5333.200019996954;5363.865903352369;5374.892502149935;4980.676256043345;5088.949110508847;5193.039287731782;5197.558207552324;5228.2680424740565;5033.84898453047;5124.743762811844;5139.331886854685;5143.074246635567;5156.716380599103;4044.4337792709043;4047.170330082326;4055.878323650295;4074.3277359235985;4087.2438598859308;3659.1035196377056;3678.393065144221;3695.852165913387;3708.7589306694977;3722.590515043343;4760.309755085494;4893.486183950634;4896.6572339935865;4905.9264111038365;4961.776720047606;5229.372475302988;5301;5325.174597937326;5344.144936810092;5416.160495123262;4930;4960.677555958851;4966.726830024311;4985.376827896513;5001.699898006132;4410.801513931817;4674.11191873543;4678;4679.368285281512;4733.810647574059;5329.733513324396;5338.546223570962;5353.732313384316;5393.8112166074;5447.891042179055;5227.869303267449;5228.738563071907;5239.89520209586;5252.5535329497425;5269.604779641466;5284.894302113859;5466.125419932791;5466.562674986071;5496.560275178056;5541.3904470509015;5155.43290238081;5170.276161337491;5170.353705786777;5252.894942101213;5264.842054738364;5332.78668853257;5340.732963351895;5358.035553600389;5362.65142765719;5363.624546281723;5187.481251874782;5192.45479224676;5217.060929032658;5224.05966925957;5315.3621565412395;4909.852704418873;4974.303597496281;4982.277569752293;5035.345405097314;5187.066328060985;4921.680090794087;5025.120603894231;5031;5037.546620804145;5048.7475626219275;5098.898022039464;5152.819651312186;5178.948210517998;5185.714785686672;5212.9739351304515;4863;4966.900661986812;4973.726445045412;5056.772445240046;5068.391792984866 05:47:05 INFO - 2015-11-18 05:47:05,858 DEBUG : BROWSER_OUTPUT: |1;ext.html;506.4353246130564;509.29971289476947;512.142161878853;524.1325606121867;528.6590149353669;26997.73002269977;28250.858745706268;36041.45937810931;36862.44706329401;36959.07602309937;38634.80682596583;38920;39226.607733922654;39339.40990885139;39363.80318098413;7189.065421495198;8372.497650140996;8529.97640283167;8587.313014958789;8642.740717778477;7678.808029799244;10106.898931010706;10331.32846364984;10358.896411035868;10385;10078.647247346344;10195.949020254926;10209.438480883548;10216.38701677898;10222.437765922872;7714.19001004892;7967.760967170936;10081.596736130583;10161;10218.18254539635;9935.850962235572;10112.646057387956;10112.89887101127;10115.544800483996;10215.540300686487;36017;36475.81762091172;36527.26945461076;36563.085922852144;36569.45145822815;2737.86310684467;2780.6802217745017;2791.9720802792117;2798.4403119376;2911.213972227487;25822;25936.351591210183;25977;26143.266248501288;26193.345166370804;2177.684235785818;2190.3100523335256;2216.833737469696;2217.5897458970144;2335.089315167086;242056;242452;243362;243592;243946;45251;45963.77018114888;46448.07103857904;52330.47669523332;58283.41716582865;53340.46659533355;53742.73128634332;53844;54247.72876135594;54384.72807636016;13141.868581314257;13152.013598980115;13176.407061682246;13199.20804751718;13203.603891883258;11675.824862627067;11681.824772628417;11758.3532905691;11819.172657913863;11901.226420282654;16649.750253746202;16964.473197412044;17044.744328835077;17052.829471705372;17186.570335741708;7708.417680077237;7834.4907581007055;7903.723369682033;7907.130215676271;7962.482438641469;865.3380164174412;926.2589928057527;959.9968033404969;989.6140505202976;989.9752506187259;23626.29121126369;23804.404889877544;23855.880720596288;23917.16289929844;23993.760062399153;933.2300851797295;959.1990687775785;1053.3311347294523;1100.8513850630063;1122.6912599035168;12538.310392928477;12588.244705317711;12708.872911270953;12750.171238869443;12820.743585128244;280594;286701;286987;290236;290285;48868.51131488711;49049;49135.26297105546;49145.26282105771;49151.508484914695;1262.8547717012477;1284.9229046257067;1301.5899991502647;1305.2560040776666;1306.2293246984134;24250.636240456053;24801.50396992014;24827.255182344557;24843.378915527257;24923;41457.58542414658;41556.168876622905;41635.1672966545;41638.37542436927;41669.1666166681;262605;263690;266569;267961;268748;25346.873265633552;25523.106691265715;26715.86642066777;28817.279568010967;29061.85469072641;34595.82702086474;34768;34917.30165396627;35154.64845351514;35205.47191792074;28263.576046359733;28937.855310723313;30649.846750766104;31575.21061973469;31867.20331991626;25699.020125799387;30324.5451318226;31184.22039449032;31704;31772.364552708354;31058.844705776326;31705.841470792497;31949.520757189126;31954.201144970633;31977.36045279128;24681.259562213163;26199.869000654875;27374.45251095007;27501.287326211506;27574.310642234104;20877.478063048544;22124.77875221227;22178.646628546416;22204.222852200095;22226.44433889166 05:47:05 INFO - 2015-11-18 05:47:05,858 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.27430578071306;304.96645369009417;309.41983780411726;311.6291612980553;313.3607440820726;13316.933415332935;13802.102863313878;15838;16280.592985175377;16333.509994700164;12449.937750311236;13817;14127.081739686913;14575.416983320654;17628.911855440736;5104.387473503185;5243.842684719445;5257.36911570612;5275;5282.709450980214;3735.8132093395357;5190.636655434121;5250.868728281805;5259.6055295852775;5324.733763311839;3820.6370394812448;3828.0429892526868;3850.653441190292;4584.77076146193;5656.151577263423;5374.596905232123;5593.804216852432;5668.546516278709;5678.6024978251535;5685.4883060524335;4953.777080031407;5032.974835125838;5036.244563315532;5047.596192304643;5067.03726292007;11663.183577149603;20997.68503472449;21321.786782132134;21444.57110857774;21526.784732152635;1545.296889915086;1753.7544743735887;1774.6894293498585;1783.456045905998;1865.6082222733241;8551.74344769658;8556.82886342276;8678.783030424227;8722.30221582272;8738.432001919855;1419.410944458059;1429.6711756296006;1453.273363318341;1468.6768910839598;1478.3716920308934;52362.47637523614;54824.45175548233;55463;55911.60220994467;56006;5867.413258674183;5886.529077673776;5930.940690593039;5936.465718085393;5946.345901950782;6774.762883299061;6800.047993280945;6801.65991700413;6812;6816.318368163144;5065.8733531662;5080.298100136496;5084.51697088776;5089.058524172966;5130.948690513047;5453.400125986138;5466.753996070186;5500.312460942382;5517.44825517445;5572.164175373727;2652.164568161023;2660.9467810643678;2676.906308279201;2677.558202896539;2682.785377169822;933.780561568031;943.8395472769646;948.8434408322549;950.0736781637847;997.0328781082338;351.2611119198672;385.91895701902916;399.7561487492627;404.98177582008293;428.48795689151166;10325.535350909227;10769.730756731144;10872.347659140476;10986.066184374258;10990.670279891616;363.8108183744438;416.35465029205216;421.1639894808802;427.5468003915859;436.55471419152286;5733.88532229353;5756.481916627524;5844.415558444121;5888.646681199141;5889.146073819358;428130;454186;473616;476508;478744;65074.67462662656;65428;65705.34294657088;66514.66742666352;66932.99999999903;448.2984129836795;450.7678545549045;451.0662927739613;452.01911851282796;452.49546755367527;10055.497225138568;10064.647737329158;10136.645217417356;10277.845832312372;10322.380657160595;28627.856860715565;30836.074917752503;30984.380312393176;31032.84483577658;32386.83806580952;39381.80309098436;40179.19641607093;40190.59809401986;42022.7898860516;42448.1510369797;5450.373207081077;5628.465295796893;5633.774649013993;5638.013347664224;5639.041362968223;10580.788384232119;10818.29681070728;10823.404712740874;10840.945795270973;10920.890791091988;9058.592363343798;9257.814843703223;9385.06149385056;9439.480828554495;9463.668771592962;8973;9037.548122593975;9043.683471078744;9222.538873056186;9274.629014839331;7872.094709108525;8138.4303098784885;8975.147361000694;9537.093976072261;9558.378705384128;5150.510701483353;5270.367555893164;5446.237526746338;5689.293212036455;5704.401037890962;9069.455832650063;9111.681091161778;9474.431534107976;9480.715578532656;9487.620495180116 05:47:05 INFO - 2015-11-18 05:47:05,862 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1158.5018442069907;1272.0650322013325;1324.5893772930392;1539.3073117097306;1647.9423220187296;5846.152307915349;6224.221972253468;6238.688065596719;6373.426391624753;6386.808395748135;6606.10817539632;6660.567063140892;6713.731450741964;6732.596044237349;6762.0871182390365;1973.0923775063488;1976.041619814389;1976.8122028407279;1991.4224874786366;1998.6402447559433;1989.3136867780593;1990.4526255279768;1992.2130758350515;2038.8674736142177;2042.693595960603;1952.0630097553183;1968.9803101969012;1977.8219960203578;1980.7722111957094;1985.2555291765589;1952.336205690065;1963.1460314763124;1966.1250743419184;1967.7540307461568;1968.1930408532432;1958.1384190955935;1982;1982.246746236421;1982.9603407931904;1990.4725247809342;6012.428819262163;6610.7355705771715;6618.635975021371;6662.933370666328;6677.866442671119;3802.543694756619;4045.656119229869;4191.098913733532;4192.853250136231;4209.20025195215;2574.3950171709635;2586.8318559293584;2628.4086080631896;2661.534231509478;2673.1579552440917;851.05957916502;857.2670366836328;1418.1491105336715;1458.6134674311315;1489.6424858034102;8630.525321107336;8659.826803463895;8699.13008699125;8734.2139207471;8784.51685157316;3654.543182102237;3670.0274427276795;3724.1806802503947;3733.533308336458;3768.2840260350445;7201.13586369639;7331;7352.338289553859;7357.117145942521;7364.815879603053;4181.519125300569;4209.726367786146;4212.220739163265;4222.986483243999;4228.429162063082;3860.517435320585;3896.376579747227;3899.200663863901;3907.4138879168354;3913.9021524461546;2920.2261400728826;2947.9263018424713;2956.364381657954;2967.302683869289;2978.657454392729;914.3051281026468;915.2769312243254;916.4730280088842;919.0579655852671;923.459776031016;1157.2767020612118;1162.8895254950767;1190.220405634311;1203.789336866045;1204.5362535423749;6317.210348706411;6439.581427207217;6498.967505162444;6507.414332710079;6517.706703198368;439.20723094814167;448.91246206989325;451.3410420785624;452.09580838323353;452.27861560810453;4700.2009658358165;5025.120603894304;5058.165402708585;5058.797648094109;5068.847934561969;7031.578105313698;7755.418343624251;7993.240642138988;7994.6002699864775;8017.6792928283385;7852.960735196288;7870.370370370357;7882.369410447151;7888.1323054463965;7915.089764677021;6118.632882027093;6286.591371560834;6310.021946598285;6328.7152078157515;6348.587341822767;6217.285012223652;6233.158523599437;6240.188775459343;6268.122462855295;6277.717502712298;6805.9659701701175;6870.862582748417;6922.619255940972;7006.019157317877;7032.085828842422;6954.3393377629045;7215.783526494213;7230.457715671451;7234.059572255573;7244.746433874789;5653.943460565341;5752.7698892043845;5758.942410575841;5761.567882408753;5800.303963524235;6403.231612206565;6488.221413430419;6501.577397469149;6520.467690092919;6523.869522609616;6073.119397687399;6092.847678808065;6096.811121831201;6214.5028397727165;6249.687515624109;5946.583739138392;5969.820905372846;6019.157317975574;6072.969635151796;6096;5855.59010869235;5982.820515384371;6031.7587296507645;6034.939650603438;6111.266648002268;5536.972315138399;5559.72201389937;5589.469000444951;5609.074502707171;5616.38219795814;5652.321721393295;5695.202671626059;5701.657900525982;5713.428657134254;5715.657060576379 05:47:05 INFO - 2015-11-18 05:47:05,862 DEBUG : BROWSER_OUTPUT: |4;prototype.html;282.84867595836226;287.26316996902943;287.93089658481966;294.5478690210526;296.09395250533356;5645.9999999999945;5677.829665110048;5700.857478563033;5741.784600623654;5756.165356023384;5716.942830571693;5725.969325521404;5740.225069615601;5740.397258287882;5760.395158508359;4398.824047038114;4399.9780001100025;4407.096545208241;4417.072414792898;4419.801108950089;4205.747655140702;4307.440032795732;4345.913081738363;4396.692231543793;4404.603585677289;4355.782210889459;4356.869293921188;4364.127174565084;4371.3661519079715;4374.168907907503;4159.584041595846;4343.326784348431;4366.8253269869165;4396.164728701552;4403.295472724349;3634.545681789776;3700.5744339401044;3730.776153430803;3733.4773131761576;3748.925021499582;5539.279893613845;5541.0580201365865;5543.889122217533;5547.472990065938;5550.417206193372;4923.704577725348;4926.507349265081;4929.778159982773;4936.33359496467;4948.826791062332;5844.327902291248;6024.518038556905;6037.909431358533;6039.365866584033;6049.364816694272;3998.460207871929;3998.7600743955454;4001.7198796083994;4004.659603933669;4012.4181993611055;6269.216347956505;6351.555391122623;6360.427561519486;6363.554551181419;6364.01357789548;3907.29668659644;3951.229510245532;3958.148997965451;3983;3983.143624120828;3617.3774013839757;3867.3232184368185;3997.5402828675074;4005.239004589177;4017.3170561004113;4656.4877863434995;4727.669063165614;4753.857384278477;4755.500672429414;4758.690685105457;5745.109508026263;5875.9118613220835;5974.522038236931;6000.459958603659;6016.759329626853;1442.4879167895247;1462.9414823406944;1464.0776310924264;1464.816897887764;1465.142891408538;905.0813424374265;911.0570559470916;919.8942121656095;940.2571968145226;940.7601061729215;5816.272965879265;5819.039858423397;5828;5836.824895253149;5851.912221316684;6265.122882796412;6294.622322660655;6301.747930082745;6302.180716506825;6324.683765811691;5848.5321174305955;5856;5867.559933005042;5873.148393482921;5879.118132280107;3244.0754385000632;3309.12308238317;3379.6282408935;3380.881669141568;3392.508086327518;6413.230412350548;6550.639714815731;6574.474042076622;6601.801945941629;6602.7689030883685;6529.608223506605;6556.606603603799;6559.344065593498;6560.671966401661;6563.081168636395;6371.585846919843;6567.047778072249;6597.703103360361;6613.272540020594;6625.801225963229;6394.0408938659575;6412.775552855815;6413;6421.325760795236;6435.356464353715;6264.655443950626;6268.27914789805;6273.71768270438;6278.780242691667;6300.59046161998;6435.388638079375;6612.0743095965645;6621.238557565942;6634.933650663432;6639.867202656016;4099.036726369361;4138.730982486129;4147.52303485103;4149.107941792529;4150.418941348154;6371.96814015927;6373.139626150411;6373.521985851173;6373.904391434039;6378.968105159444;5962.5528085394635;6128.264608247039;6146.262448506208;6177.073438984188;6177.84555386101;6120.816375508742;6130.356312587114;6132.9080063799975;6152.907706384318;6161.106639537332;5984.581079324405;5984.640921544547;5996.730147143477;6019.909701354571;6023.427774361428;5963.194968679173;6100.267967843887;6132.264128304632;6147.907781383372;6151.630902145886;5984.700764961822;6045.244344456943;6045.667488288186;6064.181335519825;6081.665508397081 05:47:05 INFO - 2015-11-18 05:47:05,865 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.874778166039;679.5287011464561;687.3641881259837;698.8148140742703;710.8827043537816;12461.127721059529;12769.23384596925;12783.872161278385;12804.231746095218;12883.871161288384;11698.941505292461;11760.823587646191;12096.455659495321;12111.333876636781;12147.028237740982;639.063771574643;645.241840837017;793.8848866914294;798.9840203195962;826.8677011678133;785.7917651822272;796.55791035975;797.103258833812;803.2971150243537;804.7585724282721;862.6549380247889;869.382738255836;870.0342619692136;870.8258348330328;872.1540106097108;663.8141320430287;676.7698982346026;677.7356830835978;681.7681988124012;833.5540485840107;638.3170008091344;638.7572722365518;640.1038546035587;641.8299150725062;643.1060825452624;12821.294828784414;12988.480460781557;13026;13041.608751737464;13043.282619455926;10584.259101862872;10619.734506637396;10687.893121068768;10786.622468213574;11056.723581910435;8731.083236260165;8752.693655722083;8836.425632333941;8853.955730221373;9185.908140918573;2990.386970671007;3037.8632961516787;3082.9075127746205;3113.066080175938;3164.1931307516666;44393.11213775739;44895.77552112251;45183.71004679896;45739;46003.53996460026;7705;8153.306968907709;8551.74344769658;8678.6528538859;8881.600327985256;15033.624159396102;15051.774223386657;15074.773878391832;15169.62075948088;15255.771163432557;6474.12599299098;6491.8701625967215;6592.30780768022;6600.702968366435;6881.518293719391;3414.573178352706;3434.536337594393;3461.4115600348;3496.7027802637062;3564.7682900611376;2730.7269273072534;2773.2789474736715;2803.971960280371;2820.323122450597;2831.4195589904434;399.3729844144723;404.7915323608285;409.7500524679943;410.24719639461324;412.7420362273579;509.54141272853985;542.8914217156585;548.5638917060946;557.2004174010308;574.1789241384777;6516.57642253252;7068.92931070693;7088.220295767462;7239.167495737952;7346.6326683666675;545.2339463054415;554.7919530176184;564.9265595472644;566.2977907394883;575.2923903598597;3172.667479658549;3414.914627134292;3435.707964822968;3451.5685539307588;3541.13242255649;46326.305105423446;46499.53500464952;46886.76556617195;47002.76498617485;47036.05927881423;44257.557424425984;44363.55636443659;46515.30227046597;46714.299285510744;47749;43068.353974690406;43271;43509;43604.12791744211;43762.905927351436;7454.3310260403705;7486.5508069516;7540.245975402416;7628.313451789366;7817.765467035998;29515.262118447212;30417.391652167276;30509;31198.37603247877;32521.837390812896;39939.40090898697;40279.798601006805;40421.59578404178;41054;41825.16349673051;6324.335944725922;6595.703193356215;6874.587524748531;6913.274106218976;6918.792436226921;9524.761880953032;10097.899021009696;10244.436555989492;10269.948650256702;10883.346999180074;9304.72085837426;9404.858927115962;9424.104710052534;9479.905200947902;9508.714738557854;9380;9380.95309523448;9453.716388508356;9507.809843803223;9533.094356036165;9083.409578377385;9167.266618670623;9179.495127768037;9208.815823683623;9209.447433154031;7927.881081783893;8027.357811375193;8542.231199191854;8562.74311770648;8665.17680820321;7922.0889597697005;8031.1567285434185;8241.340692744687;8388.161183881562;8449.155084491502 05:47:05 INFO - 2015-11-18 05:47:05,865 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:47:05 INFO - 2015-11-18 05:47:05,866 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:47:05 INFO - 2015-11-18 05:47:05,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,998 05:47:05 INFO - 2015-11-18 05:47:05,866 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:47:05 INFO - 2015-11-18 05:47:05,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1447854425851__endTimestamp 05:47:05 INFO - 2015-11-18 05:47:05,866 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:47:05 INFO - 2015-11-18 05:47:05,867 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:47:05 INFO - 2015-11-18 05:47:05,867 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,867 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4879.79 Median:5001.70 stddev:524.26 (10.5%) stddev-sans-first:501.53 05:47:05 INFO - 2015-11-18 05:47:05,867 DEBUG : BROWSER_OUTPUT: Values: 2867.2 2895.0 2907.0 2947.7 3126.2 4616.9 4737.0 4841.2 4856.0 4895.4 4794.3 4822.8 4872.7 4991.8 5004.1 4501.0 4520.4 4534.6 4567.7 4601.5 4510.7 4619.0 4625.0 4663.2 4666.7 4284.5 4414.2 4423.1 4590.8 4612.9 4422.7 4441.3 4485.6 4501.5 4563.9 4418.2 4444.3 4473.6 4481.9 4527.8 4812.0 4825.0 4845.5 4850.7 4947.7 4925.8 5027.2 5043.5 5072.8 5135.6 5317.3 5343.7 5349.8 5351.7 5405.1 4939.1 4957.2 4961.8 4964.3 4996.3 5211.1 5303.0 5354.5 5435.3 5491.4 5024.7 5041.9 5053.4 5126.9 5140.1 5228.4 5267.9 5333.2 5363.9 5374.9 4980.7 5088.9 5193.0 5197.6 5228.3 5033.8 5124.7 5139.3 5143.1 5156.7 4044.4 4047.2 4055.9 4074.3 4087.2 3659.1 3678.4 3695.9 3708.8 3722.6 4760.3 4893.5 4896.7 4905.9 4961.8 5229.4 5301.0 5325.2 5344.1 5416.2 4930.0 4960.7 4966.7 4985.4 5001.7 4410.8 4674.1 4678.0 4679.4 4733.8 5329.7 5338.5 5353.7 5393.8 5447.9 5227.9 5228.7 5239.9 5252.6 5269.6 5284.9 5466.1 5466.6 5496.6 5541.4 5155.4 5170.3 5170.4 5252.9 5264.8 5332.8 5340.7 5358.0 5362.7 5363.6 5187.5 5192.5 5217.1 5224.1 5315.4 4909.9 4974.3 4982.3 5035.3 5187.1 4921.7 5025.1 5031.0 5037.5 5048.7 5098.9 5152.8 5178.9 5185.7 5213.0 4863.0 4966.9 4973.7 5056.8 5068.4 05:47:05 INFO - 2015-11-18 05:47:05,867 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,867 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41524.63 Median:2786.33 stddev:69461.66 (2492.9%) stddev-sans-first:69588.25 05:47:05 INFO - 2015-11-18 05:47:05,869 DEBUG : BROWSER_OUTPUT: Values: 506.4 509.3 512.1 524.1 528.7 26997.7 28250.9 36041.5 36862.4 36959.1 38634.8 38920.0 39226.6 39339.4 39363.8 7189.1 8372.5 8530.0 8587.3 8642.7 7678.8 10106.9 10331.3 10358.9 10385.0 10078.6 10195.9 10209.4 10216.4 10222.4 7714.2 7967.8 10081.6 10161.0 10218.2 9935.9 10112.6 10112.9 10115.5 10215.5 36017.0 36475.8 36527.3 36563.1 36569.5 2737.9 2780.7 2792.0 2798.4 2911.2 25822.0 25936.4 25977.0 26143.3 26193.3 2177.7 2190.3 2216.8 2217.6 2335.1 242056.0 242452.0 243362.0 243592.0 243946.0 45251.0 45963.8 46448.1 52330.5 58283.4 53340.5 53742.7 53844.0 54247.7 54384.7 13141.9 13152.0 13176.4 13199.2 13203.6 11675.8 11681.8 11758.4 11819.2 11901.2 16649.8 16964.5 17044.7 17052.8 17186.6 7708.4 7834.5 7903.7 7907.1 7962.5 865.3 926.3 960.0 989.6 990.0 23626.3 23804.4 23855.9 23917.2 23993.8 933.2 959.2 1053.3 1100.9 1122.7 12538.3 12588.2 12708.9 12750.2 12820.7 280594.0 286701.0 286987.0 290236.0 290285.0 48868.5 49049.0 49135.3 49145.3 49151.5 1262.9 1284.9 1301.6 1305.3 1306.2 24250.6 24801.5 24827.3 24843.4 24923.0 41457.6 41556.2 41635.2 41638.4 41669.2 262605.0 263690.0 266569.0 267961.0 268748.0 25346.9 25523.1 26715.9 28817.3 29061.9 34595.8 34768.0 34917.3 35154.6 35205.5 28263.6 28937.9 30649.8 31575.2 31867.2 25699.0 30324.5 31184.2 31704.0 31772.4 31058.8 31705.8 31949.5 31954.2 31977.4 24681.3 26199.9 27374.5 27501.3 27574.3 20877.5 22124.8 22178.6 22204.2 22226.4 05:47:05 INFO - 2015-11-18 05:47:05,869 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,869 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23734.15 Median:5073.67 stddev:75799.12 (1494.0%) stddev-sans-first:75991.34 05:47:05 INFO - 2015-11-18 05:47:05,869 DEBUG : BROWSER_OUTPUT: Values: 304.3 305.0 309.4 311.6 313.4 13316.9 13802.1 15838.0 16280.6 16333.5 12449.9 13817.0 14127.1 14575.4 17628.9 5104.4 5243.8 5257.4 5275.0 5282.7 3735.8 5190.6 5250.9 5259.6 5324.7 3820.6 3828.0 3850.7 4584.8 5656.2 5374.6 5593.8 5668.5 5678.6 5685.5 4953.8 5033.0 5036.2 5047.6 5067.0 11663.2 20997.7 21321.8 21444.6 21526.8 1545.3 1753.8 1774.7 1783.5 1865.6 8551.7 8556.8 8678.8 8722.3 8738.4 1419.4 1429.7 1453.3 1468.7 1478.4 52362.5 54824.5 55463.0 55911.6 56006.0 5867.4 5886.5 5930.9 5936.5 5946.3 6774.8 6800.0 6801.7 6812.0 6816.3 5065.9 5080.3 5084.5 5089.1 5130.9 5453.4 5466.8 5500.3 5517.4 5572.2 2652.2 2660.9 2676.9 2677.6 2682.8 933.8 943.8 948.8 950.1 997.0 351.3 385.9 399.8 405.0 428.5 10325.5 10769.7 10872.3 10986.1 10990.7 363.8 416.4 421.2 427.5 436.6 5733.9 5756.5 5844.4 5888.6 5889.1 428130.0 454186.0 473616.0 476508.0 478744.0 65074.7 65428.0 65705.3 66514.7 66933.0 448.3 450.8 451.1 452.0 452.5 10055.5 10064.6 10136.6 10277.8 10322.4 28627.9 30836.1 30984.4 31032.8 32386.8 39381.8 40179.2 40190.6 42022.8 42448.2 5450.4 5628.5 5633.8 5638.0 5639.0 10580.8 10818.3 10823.4 10840.9 10920.9 9058.6 9257.8 9385.1 9439.5 9463.7 8973.0 9037.5 9043.7 9222.5 9274.6 7872.1 8138.4 8975.1 9537.1 9558.4 5150.5 5270.4 5446.2 5689.3 5704.4 9069.5 9111.7 9474.4 9480.7 9487.6 05:47:05 INFO - 2015-11-18 05:47:05,869 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,870 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4649.55 Median:5760.26 stddev:2348.43 (40.8%) stddev-sans-first:2340.35 05:47:05 INFO - 2015-11-18 05:47:05,871 DEBUG : BROWSER_OUTPUT: Values: 1158.5 1272.1 1324.6 1539.3 1647.9 5846.2 6224.2 6238.7 6373.4 6386.8 6606.1 6660.6 6713.7 6732.6 6762.1 1973.1 1976.0 1976.8 1991.4 1998.6 1989.3 1990.5 1992.2 2038.9 2042.7 1952.1 1969.0 1977.8 1980.8 1985.3 1952.3 1963.1 1966.1 1967.8 1968.2 1958.1 1982.0 1982.2 1983.0 1990.5 6012.4 6610.7 6618.6 6662.9 6677.9 3802.5 4045.7 4191.1 4192.9 4209.2 2574.4 2586.8 2628.4 2661.5 2673.2 851.1 857.3 1418.1 1458.6 1489.6 8630.5 8659.8 8699.1 8734.2 8784.5 3654.5 3670.0 3724.2 3733.5 3768.3 7201.1 7331.0 7352.3 7357.1 7364.8 4181.5 4209.7 4212.2 4223.0 4228.4 3860.5 3896.4 3899.2 3907.4 3913.9 2920.2 2947.9 2956.4 2967.3 2978.7 914.3 915.3 916.5 919.1 923.5 1157.3 1162.9 1190.2 1203.8 1204.5 6317.2 6439.6 6499.0 6507.4 6517.7 439.2 448.9 451.3 452.1 452.3 4700.2 5025.1 5058.2 5058.8 5068.8 7031.6 7755.4 7993.2 7994.6 8017.7 7853.0 7870.4 7882.4 7888.1 7915.1 6118.6 6286.6 6310.0 6328.7 6348.6 6217.3 6233.2 6240.2 6268.1 6277.7 6806.0 6870.9 6922.6 7006.0 7032.1 6954.3 7215.8 7230.5 7234.1 7244.7 5653.9 5752.8 5758.9 5761.6 5800.3 6403.2 6488.2 6501.6 6520.5 6523.9 6073.1 6092.8 6096.8 6214.5 6249.7 5946.6 5969.8 6019.2 6073.0 6096.0 5855.6 5982.8 6031.8 6034.9 6111.3 5537.0 5559.7 5589.5 5609.1 5616.4 5652.3 5695.2 5701.7 5713.4 5715.7 05:47:05 INFO - 2015-11-18 05:47:05,871 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,871 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5049.51 Median:5846.43 stddev:1592.19 (27.2%) stddev-sans-first:1555.94 05:47:05 INFO - 2015-11-18 05:47:05,873 DEBUG : BROWSER_OUTPUT: Values: 282.8 287.3 287.9 294.5 296.1 5646.0 5677.8 5700.9 5741.8 5756.2 5716.9 5726.0 5740.2 5740.4 5760.4 4398.8 4400.0 4407.1 4417.1 4419.8 4205.7 4307.4 4345.9 4396.7 4404.6 4355.8 4356.9 4364.1 4371.4 4374.2 4159.6 4343.3 4366.8 4396.2 4403.3 3634.5 3700.6 3730.8 3733.5 3748.9 5539.3 5541.1 5543.9 5547.5 5550.4 4923.7 4926.5 4929.8 4936.3 4948.8 5844.3 6024.5 6037.9 6039.4 6049.4 3998.5 3998.8 4001.7 4004.7 4012.4 6269.2 6351.6 6360.4 6363.6 6364.0 3907.3 3951.2 3958.1 3983.0 3983.1 3617.4 3867.3 3997.5 4005.2 4017.3 4656.5 4727.7 4753.9 4755.5 4758.7 5745.1 5875.9 5974.5 6000.5 6016.8 1442.5 1462.9 1464.1 1464.8 1465.1 905.1 911.1 919.9 940.3 940.8 5816.3 5819.0 5828.0 5836.8 5851.9 6265.1 6294.6 6301.7 6302.2 6324.7 5848.5 5856.0 5867.6 5873.1 5879.1 3244.1 3309.1 3379.6 3380.9 3392.5 6413.2 6550.6 6574.5 6601.8 6602.8 6529.6 6556.6 6559.3 6560.7 6563.1 6371.6 6567.0 6597.7 6613.3 6625.8 6394.0 6412.8 6413.0 6421.3 6435.4 6264.7 6268.3 6273.7 6278.8 6300.6 6435.4 6612.1 6621.2 6634.9 6639.9 4099.0 4138.7 4147.5 4149.1 4150.4 6372.0 6373.1 6373.5 6373.9 6379.0 5962.6 6128.3 6146.3 6177.1 6177.8 6120.8 6130.4 6132.9 6152.9 6161.1 5984.6 5984.6 5996.7 6019.9 6023.4 5963.2 6100.3 6132.3 6147.9 6151.6 5984.7 6045.2 6045.7 6064.2 6081.7 05:47:05 INFO - 2015-11-18 05:47:05,873 DEBUG : BROWSER_OUTPUT: 05:47:05 INFO - 2015-11-18 05:47:05,873 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12088.60 Median:565.61 stddev:14271.41 (2523.2%) stddev-sans-first:14285.71 05:47:05 INFO - 2015-11-18 05:47:05,874 DEBUG : BROWSER_OUTPUT: Values: 676.9 679.5 687.4 698.8 710.9 12461.1 12769.2 12783.9 12804.2 12883.9 11698.9 11760.8 12096.5 12111.3 12147.0 639.1 645.2 793.9 799.0 826.9 785.8 796.6 797.1 803.3 804.8 862.7 869.4 870.0 870.8 872.2 663.8 676.8 677.7 681.8 833.6 638.3 638.8 640.1 641.8 643.1 12821.3 12988.5 13026.0 13041.6 13043.3 10584.3 10619.7 10687.9 10786.6 11056.7 8731.1 8752.7 8836.4 8854.0 9185.9 2990.4 3037.9 3082.9 3113.1 3164.2 44393.1 44895.8 45183.7 45739.0 46003.5 7705.0 8153.3 8551.7 8678.7 8881.6 15033.6 15051.8 15074.8 15169.6 15255.8 6474.1 6491.9 6592.3 6600.7 6881.5 3414.6 3434.5 3461.4 3496.7 3564.8 2730.7 2773.3 2804.0 2820.3 2831.4 399.4 404.8 409.8 410.2 412.7 509.5 542.9 548.6 557.2 574.2 6516.6 7068.9 7088.2 7239.2 7346.6 545.2 554.8 564.9 566.3 575.3 3172.7 3414.9 3435.7 3451.6 3541.1 46326.3 46499.5 46886.8 47002.8 47036.1 44257.6 44363.6 46515.3 46714.3 47749.0 43068.4 43271.0 43509.0 43604.1 43762.9 7454.3 7486.6 7540.2 7628.3 7817.8 29515.3 30417.4 30509.0 31198.4 32521.8 39939.4 40279.8 40421.6 41054.0 41825.2 6324.3 6595.7 6874.6 6913.3 6918.8 9524.8 10097.9 10244.4 10269.9 10883.3 9304.7 9404.9 9424.1 9479.9 9508.7 9380.0 9381.0 9453.7 9507.8 9533.1 9083.4 9167.3 9179.5 9208.8 9209.4 7927.9 8027.4 8542.2 8562.7 8665.2 7922.1 8031.2 8241.3 8388.2 8449.2 05:47:05 INFO - 2015-11-18 05:47:05,874 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:47:05 INFO - 2015-11-18 05:47:05,875 DEBUG : BROWSER_OUTPUT: 05:47:06 INFO - 2015-11-18 05:47:06,561 INFO : Browser exited with error code: 0 05:47:06 INFO - 2015-11-18 05:47:06,592 INFO : Completed test dromaeo_css (00:18:35) 05:47:06 INFO - 2015-11-18 05:47:06,592 INFO : Starting test kraken 05:47:06 INFO - 2015-11-18 05:47:06,593 DEBUG : operating with platform_type : mac_ 05:47:06 INFO - 2015-11-18 05:47:06,593 INFO : Initialising browser for kraken test... 05:47:06 INFO - 2015-11-18 05:47:06,609 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpUJm64g/profile http://localhost:51242/getInfo.html 05:47:09 INFO - 2015-11-18 05:47:09,079 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:47:09 INFO - 2015-11-18 05:47:09,079 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:47:09 INFO - 2015-11-18 05:47:09,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:47:09 INFO - 2015-11-18 05:47:09,079 DEBUG : BROWSER_OUTPUT: __metrics 05:47:09 INFO - 2015-11-18 05:47:09,096 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:09 INFO - 2015-11-18 05:47:09,812 INFO : Browser initialized. 05:47:09 INFO - 2015-11-18 05:47:09,812 INFO : Running cycle 1/1 for kraken test... 05:47:09 INFO - 2015-11-18 05:47:09,812 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpUJm64g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:47:21 INFO - 2015-11-18 05:47:21,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 228970496 05:47:21 INFO - 2015-11-18 05:47:21,839 DEBUG : BROWSER_OUTPUT: 05:47:24 INFO - 2015-11-18 05:47:24,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:24 INFO - 2015-11-18 05:47:24,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 285171712 05:47:24 INFO - 2015-11-18 05:47:24,993 DEBUG : BROWSER_OUTPUT: 05:47:27 INFO - 2015-11-18 05:47:27,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-dft) 05:47:28 INFO - 2015-11-18 05:47:28,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 298283008 05:47:28 INFO - 2015-11-18 05:47:28,405 DEBUG : BROWSER_OUTPUT: 05:47:31 INFO - 2015-11-18 05:47:31,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-fft) 05:47:32 INFO - 2015-11-18 05:47:32,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 282087424 05:47:32 INFO - 2015-11-18 05:47:32,148 DEBUG : BROWSER_OUTPUT: 05:47:34 INFO - 2015-11-18 05:47:34,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51242/tests/kraken/driver.html?testName=audio-oscillator) 05:47:34 INFO - 2015-11-18 05:47:34,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 282234880 05:47:34 INFO - 2015-11-18 05:47:34,860 DEBUG : BROWSER_OUTPUT: 05:47:37 INFO - 2015-11-18 05:47:37,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:37 INFO - 2015-11-18 05:47:37,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 283217920 05:47:37 INFO - 2015-11-18 05:47:37,764 DEBUG : BROWSER_OUTPUT: 05:47:41 INFO - 2015-11-18 05:47:41,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51242/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:41 INFO - 2015-11-18 05:47:41,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 283779072 05:47:41 INFO - 2015-11-18 05:47:41,659 DEBUG : BROWSER_OUTPUT: 05:47:45 INFO - 2015-11-18 05:47:45,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51242/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:45 INFO - 2015-11-18 05:47:45,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 283893760 05:47:45 INFO - 2015-11-18 05:47:45,646 DEBUG : BROWSER_OUTPUT: 05:47:48 INFO - 2015-11-18 05:47:48,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51242/tests/kraken/driver.html?testName=json-parse-financial) 05:47:49 INFO - 2015-11-18 05:47:49,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 283676672 05:47:49 INFO - 2015-11-18 05:47:49,293 DEBUG : BROWSER_OUTPUT: 05:47:50 INFO - 2015-11-18 05:47:50,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:51 INFO - 2015-11-18 05:47:51,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 320352256 05:47:51 INFO - 2015-11-18 05:47:51,532 DEBUG : BROWSER_OUTPUT: 05:47:53 INFO - 2015-11-18 05:47:53,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:54 INFO - 2015-11-18 05:47:54,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 321982464 05:47:54 INFO - 2015-11-18 05:47:54,101 DEBUG : BROWSER_OUTPUT: 05:47:56 INFO - 2015-11-18 05:47:56,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:56 INFO - 2015-11-18 05:47:56,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 328507392 05:47:56 INFO - 2015-11-18 05:47:56,918 DEBUG : BROWSER_OUTPUT: 05:47:59 INFO - 2015-11-18 05:47:59,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:00 INFO - 2015-11-18 05:48:00,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 329588736 05:48:00 INFO - 2015-11-18 05:48:00,311 DEBUG : BROWSER_OUTPUT: 05:48:03 INFO - 2015-11-18 05:48:03,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:03 INFO - 2015-11-18 05:48:03,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 329031680 05:48:03 INFO - 2015-11-18 05:48:03,736 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51242/tests/kraken/driver.html?testName=ai-astar) 05:48:05 INFO - 2015-11-18 05:48:05,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 388214784 05:48:05 INFO - 2015-11-18 05:48:05,824 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,826 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:48:05 INFO - 2015-11-18 05:48:05,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:48:05 INFO - 2015-11-18 05:48:05,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:48:05 INFO - 2015-11-18 05:48:05,826 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;108;108;110;106;110;102;105;116;108 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;133;168;181;141;168;166;144;181;140 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |2;audio-dft;174;177;182;178;174;175;182;181;171;175 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;89;100;95;77;78;79;92;93;74 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;103;105;146;100;99;101;146;100;98;145 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;130;135;129;134;135;135;135;128;124;135 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;137;142;141;141;142;139;136;142;143;141 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;105;105;105;112;109;114;113;103;104 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;60;63;64;67;68;68;76;66;66 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;73;75;79;79;80;79;79;79;88 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;97;96;96;96;96;96;98;97;97 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;139;145;144;146;136;146;147;148;145;139 05:48:05 INFO - 2015-11-18 05:48:05,827 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;179;182;173;175;156;170;172;170;163 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;75;80;80;79;80;81;80;80;79 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: __startTimestamp1447854485825__endTimestamp 05:48:05 INFO - 2015-11-18 05:48:05,828 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,831 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:48:05 INFO - 2015-11-18 05:48:05,831 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:48:05 INFO - 2015-11-18 05:48:05,831 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,831 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:108.00 stddev:3.79 (3.5%) stddev-sans-first:3.89 05:48:05 INFO - 2015-11-18 05:48:05,831 DEBUG : BROWSER_OUTPUT: Values: 105.0 108.0 108.0 110.0 106.0 110.0 102.0 105.0 116.0 108.0 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:158.60 Median:167.00 stddev:17.60 (10.5%) stddev-sans-first:18.56 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: Values: 164.0 133.0 168.0 181.0 141.0 168.0 166.0 144.0 181.0 140.0 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:176.90 Median:177.50 stddev:3.78 (2.1%) stddev-sans-first:3.87 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: Values: 174.0 177.0 182.0 178.0 174.0 175.0 182.0 181.0 171.0 175.0 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.40 Median:84.00 stddev:9.35 (11.1%) stddev-sans-first:9.41 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: Values: 77.0 89.0 100.0 95.0 77.0 78.0 79.0 92.0 93.0 74.0 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.30 Median:145.50 stddev:21.74 (14.9%) stddev-sans-first:22.67 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 146.0 100.0 99.0 101.0 146.0 100.0 98.0 145.0 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,832 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:132.00 Median:135.00 stddev:3.97 (2.9%) stddev-sans-first:4.15 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: Values: 130.0 135.0 129.0 134.0 135.0 135.0 135.0 128.0 124.0 135.0 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:140.40 Median:141.50 stddev:2.32 (1.6%) stddev-sans-first:2.11 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: Values: 137.0 142.0 141.0 141.0 142.0 139.0 136.0 142.0 143.0 141.0 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:108.00 Median:109.50 stddev:4.08 (3.7%) stddev-sans-first:4.27 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 105.0 105.0 112.0 109.0 114.0 113.0 103.0 104.0 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.50 stddev:4.40 (6.6%) stddev-sans-first:4.42 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: Values: 62.0 60.0 63.0 64.0 67.0 68.0 68.0 76.0 66.0 66.0 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.00 Median:79.00 stddev:4.99 (6.3%) stddev-sans-first:4.09 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: Values: 69.0 73.0 75.0 79.0 79.0 80.0 79.0 79.0 79.0 88.0 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,833 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.10 Median:96.50 stddev:1.60 (1.7%) stddev-sans-first:0.73 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: Values: 92.0 97.0 96.0 96.0 96.0 96.0 96.0 98.0 97.0 97.0 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:145.50 stddev:4.03 (2.8%) stddev-sans-first:3.94 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: Values: 139.0 145.0 144.0 146.0 136.0 146.0 147.0 148.0 145.0 139.0 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:172.50 stddev:8.83 (5.1%) stddev-sans-first:7.88 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: Values: 156.0 179.0 182.0 173.0 175.0 156.0 170.0 172.0 170.0 163.0 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:80.00 stddev:2.58 (3.2%) stddev-sans-first:1.73 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 80.0 80.0 79.0 80.0 81.0 80.0 80.0 79.0 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:48:05 INFO - 2015-11-18 05:48:05,834 DEBUG : BROWSER_OUTPUT: 05:48:06 INFO - 2015-11-18 05:48:06,550 INFO : Browser exited with error code: 0 05:48:06 INFO - 2015-11-18 05:48:06,602 INFO : Completed test kraken (00:01:00) 05:48:06 INFO - 2015-11-18 05:48:06,602 INFO : Starting test v8_7 05:48:06 INFO - 2015-11-18 05:48:06,602 DEBUG : operating with platform_type : mac_ 05:48:06 INFO - 2015-11-18 05:48:06,602 INFO : Initialising browser for v8_7 test... 05:48:06 INFO - 2015-11-18 05:48:06,618 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpSy7zA4/profile http://localhost:51242/getInfo.html 05:48:09 INFO - 2015-11-18 05:48:08,999 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:48:09 INFO - 2015-11-18 05:48:09,000 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:48:09 INFO - 2015-11-18 05:48:09,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:48:09 INFO - 2015-11-18 05:48:09,000 DEBUG : BROWSER_OUTPUT: __metrics 05:48:09 INFO - 2015-11-18 05:48:09,016 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:09 INFO - 2015-11-18 05:48:09,801 INFO : Browser initialized. 05:48:09 INFO - 2015-11-18 05:48:09,802 INFO : Running cycle 1/1 for v8_7 test... 05:48:09 INFO - 2015-11-18 05:48:09,802 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpSy7zA4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:48:21 INFO - 2015-11-18 05:48:21,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 230010880 05:48:21 INFO - 2015-11-18 05:48:21,848 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51242/tests/v8_7/run.html (next: http://localhost:51242/tests/v8_7/run.html) 05:48:44 INFO - 2015-11-18 05:48:44,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 748081152 05:48:44 INFO - 2015-11-18 05:48:44,692 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:48:44 INFO - 2015-11-18 05:48:44,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:48:44 INFO - 2015-11-18 05:48:44,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:48:44 INFO - 2015-11-18 05:48:44,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:48:44 INFO - 2015-11-18 05:48:44,692 DEBUG : BROWSER_OUTPUT: |0;Richards;172.80110592707794 05:48:44 INFO - 2015-11-18 05:48:44,693 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;218.34061135371178 05:48:44 INFO - 2015-11-18 05:48:44,693 DEBUG : BROWSER_OUTPUT: |2;Encrypt;352.60930888575456 05:48:44 INFO - 2015-11-18 05:48:44,693 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6217.391304347826 05:48:44 INFO - 2015-11-18 05:48:44,693 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2087.6826722338205 05:48:44 INFO - 2015-11-18 05:48:44,693 DEBUG : BROWSER_OUTPUT: |5;Earley;1054.8523206751054 05:48:44 INFO - 2015-11-18 05:48:44,693 DEBUG : BROWSER_OUTPUT: |6;Boyer;14528.57142857143 05:48:44 INFO - 2015-11-18 05:48:44,694 DEBUG : BROWSER_OUTPUT: |7;RegExp;32380.95238095238 05:48:44 INFO - 2015-11-18 05:48:44,694 DEBUG : BROWSER_OUTPUT: |8;Splay;739.0983000739099 05:48:44 INFO - 2015-11-18 05:48:44,695 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6375.796178343949 05:48:44 INFO - 2015-11-18 05:48:44,695 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:48:44 INFO - 2015-11-18 05:48:44,695 DEBUG : BROWSER_OUTPUT: __startTimestamp1447854524691__endTimestamp 05:48:44 INFO - 2015-11-18 05:48:44,696 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,696 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:48:44 INFO - 2015-11-18 05:48:44,696 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:48:44 INFO - 2015-11-18 05:48:44,696 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,696 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.80 Median:172.80 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,696 DEBUG : BROWSER_OUTPUT: Values: 172.8 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:218.34 Median:218.34 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: Values: 218.3 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:352.61 Median:352.61 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: Values: 352.6 05:48:44 INFO - 2015-11-18 05:48:44,697 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6217.39 Median:6217.39 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: Values: 6217.4 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2087.68 Median:2087.68 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: Values: 2087.7 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1054.85 Median:1054.85 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: Values: 1054.9 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14528.57 Median:14528.57 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: Values: 14528.6 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32380.95 Median:32380.95 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: Values: 32381.0 05:48:44 INFO - 2015-11-18 05:48:44,698 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:739.10 Median:739.10 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: Values: 739.1 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6375.80 Median:6375.80 stddev:0.00 (0.0%) 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: Values: 6375.8 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:48:44 INFO - 2015-11-18 05:48:44,699 DEBUG : BROWSER_OUTPUT: 05:48:45 INFO - 2015-11-18 05:48:45,406 INFO : Browser exited with error code: 0 05:48:45 INFO - 2015-11-18 05:48:45,427 INFO : Completed test v8_7 (00:00:38) 05:48:45 INFO - 2015-11-18 05:48:45,685 INFO : Completed test suite (00:20:14) 05:48:45 INFO - 2015-11-18 05:48:45,685 DEBUG : Working with test: dromaeo_css 05:48:45 INFO - 2015-11-18 05:48:45,685 DEBUG : Generating results file: dromaeo_css 05:48:45 INFO - 2015-11-18 05:48:45,686 DEBUG : Working with test: kraken 05:48:45 INFO - 2015-11-18 05:48:45,686 DEBUG : Generating results file: kraken 05:48:45 INFO - 2015-11-18 05:48:45,686 INFO : javascript benchmark 05:48:45 INFO - 2015-11-18 05:48:45,686 DEBUG : Working with test: v8_7 05:48:45 INFO - 2015-11-18 05:48:45,687 DEBUG : Generating results file: v8_7 05:48:45 INFO - 2015-11-18 05:48:45,687 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:48:45 INFO - 2015-11-18 05:48:45,751 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:48:45 INFO - 2015-11-18 05:48:45,751 DEBUG : process_Request line: dromaeo_css 6025.70 graph.html#tests=[[72,1,55]] 05:48:45 INFO - 2015-11-18 05:48:45,751 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:48:45 INFO - 2015-11-18 05:48:45,778 DEBUG : process_Request line: kraken 1655.30 graph.html#tests=[[232,1,55]] 05:48:45 INFO - 2015-11-18 05:48:45,778 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:48:45 INFO - 2015-11-18 05:48:45,804 DEBUG : process_Request line: v8_7 16562.88 graph.html#tests=[[230,1,55]] 05:48:45 INFO - 2015-11-18 05:48:45,805 INFO : javascript benchmark 05:48:45 INFO - 2015-11-18 05:48:45,807 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [304.27430578071306, 304.96645369009417, 309.41983780411726, 311.6291612980553, 313.3607440820726, 13316.933415332935, 13802.102863313878, 15838.0, 16280.592985175377, 16333.509994700164, 12449.937750311236, 13817.0, 14127.081739686913, 14575.416983320654, 17628.911855440736, 5104.387473503185, 5243.842684719445, 5257.36911570612, 5275.0, 5282.709450980214, 3735.8132093395357, 5190.636655434121, 5250.868728281805, 5259.6055295852775, 5324.733763311839, 3820.6370394812448, 3828.0429892526868, 3850.653441190292, 4584.77076146193, 5656.151577263423, 5374.596905232123, 5593.804216852432, 5668.546516278709, 5678.6024978251535, 5685.4883060524335, 4953.777080031407, 5032.974835125838, 5036.244563315532, 5047.596192304643, 5067.03726292007, 11663.183577149603, 20997.68503472449, 21321.786782132134, 21444.57110857774, 21526.784732152635, 1545.296889915086, 1753.7544743735887, 1774.6894293498585, 1783.456045905998, 1865.6082222733241, 8551.74344769658, 8556.82886342276, 8678.783030424227, 8722.30221582272, 8738.432001919855, 1419.410944458059, 1429.6711756296006, 1453.273363318341, 1468.6768910839598, 1478.3716920308934, 52362.47637523614, 54824.45175548233, 55463.0, 55911.60220994467, 56006.0, 5867.413258674183, 5886.529077673776, 5930.940690593039, 5936.465718085393, 5946.345901950782, 6774.762883299061, 6800.047993280945, 6801.65991700413, 6812.0, 6816.318368163144, 5065.8733531662, 5080.298100136496, 5084.51697088776, 5089.058524172966, 5130.948690513047, 5453.400125986138, 5466.753996070186, 5500.312460942382, 5517.44825517445, 5572.164175373727, 2652.164568161023, 2660.9467810643678, 2676.906308279201, 2677.558202896539, 2682.785377169822, 933.780561568031, 943.8395472769646, 948.8434408322549, 950.0736781637847, 997.0328781082338, 351.2611119198672, 385.91895701902916, 399.7561487492627, 404.98177582008293, 428.48795689151166, 10325.535350909227, 10769.730756731144, 10872.347659140476, 10986.066184374258, 10990.670279891616, 363.8108183744438, 416.35465029205216, 421.1639894808802, 427.5468003915859, 436.55471419152286, 5733.88532229353, 5756.481916627524, 5844.415558444121, 5888.646681199141, 5889.146073819358, 428130.0, 454186.0, 473616.0, 476508.0, 478744.0, 65074.67462662656, 65428.0, 65705.34294657088, 66514.66742666352, 66932.99999999903, 448.2984129836795, 450.7678545549045, 451.0662927739613, 452.01911851282796, 452.49546755367527, 10055.497225138568, 10064.647737329158, 10136.645217417356, 10277.845832312372, 10322.380657160595, 28627.856860715565, 30836.074917752503, 30984.380312393176, 31032.84483577658, 32386.83806580952, 39381.80309098436, 40179.19641607093, 40190.59809401986, 42022.7898860516, 42448.1510369797, 5450.373207081077, 5628.465295796893, 5633.774649013993, 5638.013347664224, 5639.041362968223, 10580.788384232119, 10818.29681070728, 10823.404712740874, 10840.945795270973, 10920.890791091988, 9058.592363343798, 9257.814843703223, 9385.06149385056, 9439.480828554495, 9463.668771592962, 8973.0, 9037.548122593975, 9043.683471078744, 9222.538873056186, 9274.629014839331, 7872.094709108525, 8138.4303098784885, 8975.147361000694, 9537.093976072261, 9558.378705384128, 5150.510701483353, 5270.367555893164, 5446.237526746338, 5689.293212036455, 5704.401037890962, 9069.455832650063, 9111.681091161778, 9474.431534107976, 9480.715578532656, 9487.620495180116], "dojo.html": [2867.2258490207646, 2894.9565756513643, 2906.956395654064, 2947.6757556668763, 3126.218445388653, 4616.861494155172, 4736.976315118428, 4841.249606311018, 4856.0, 4895.437024742156, 4794.304825800257, 4822.831200907969, 4872.683275587093, 4991.775370108345, 5004.12427825131, 4501.0, 4520.434945631796, 4534.6372290216705, 4567.725936443824, 4601.516840731725, 4510.729356238619, 4618.97690511547, 4624.953750462503, 4663.207254766698, 4666.696664716799, 4284.528701842794, 4414.227510185705, 4423.093265880487, 4590.839320623762, 4612.930806037895, 4422.734635921823, 4441.289393696993, 4485.618722408599, 4501.527339629357, 4563.863084107482, 4418.248897687401, 4444.333349997494, 4473.597376236155, 4481.887952801173, 4527.841525546623, 4812.037592481518, 4825.010872771073, 4845.466998630148, 4850.660453768238, 4947.653664243504, 4925.827596034157, 5027.245913113063, 5043.5460808527405, 5072.82245121419, 5135.64050516464, 5317.308749862532, 5343.706096164709, 5349.786008559653, 5351.652142610717, 5405.081136206815, 4939.110960027194, 4957.201339784146, 4961.801527938878, 4964.329815474937, 4996.275540046673, 5211.140161873324, 5303.0, 5354.464553544614, 5435.320584926884, 5491.423400542965, 5024.698518088926, 5041.924371134362, 5053.36832895888, 5126.8974620508125, 5140.1004824155625, 5228.424873263938, 5267.894642107136, 5333.200019996954, 5363.865903352369, 5374.892502149935, 4980.676256043345, 5088.949110508847, 5193.039287731782, 5197.558207552324, 5228.2680424740565, 5033.84898453047, 5124.743762811844, 5139.331886854685, 5143.074246635567, 5156.716380599103, 4044.4337792709043, 4047.170330082326, 4055.878323650295, 4074.3277359235985, 4087.2438598859308, 3659.1035196377056, 3678.393065144221, 3695.852165913387, 3708.7589306694977, 3722.590515043343, 4760.309755085494, 4893.486183950634, 4896.6572339935865, 4905.9264111038365, 4961.776720047606, 5229.372475302988, 5301.0, 5325.174597937326, 5344.144936810092, 5416.160495123262, 4930.0, 4960.677555958851, 4966.726830024311, 4985.376827896513, 5001.699898006132, 4410.801513931817, 4674.11191873543, 4678.0, 4679.368285281512, 4733.810647574059, 5329.733513324396, 5338.546223570962, 5353.732313384316, 5393.8112166074, 5447.891042179055, 5227.869303267449, 5228.738563071907, 5239.89520209586, 5252.5535329497425, 5269.604779641466, 5284.894302113859, 5466.125419932791, 5466.562674986071, 5496.560275178056, 5541.3904470509015, 5155.43290238081, 5170.276161337491, 5170.353705786777, 5252.894942101213, 5264.842054738364, 5332.78668853257, 5340.732963351895, 5358.035553600389, 5362.65142765719, 5363.624546281723, 5187.481251874782, 5192.45479224676, 5217.060929032658, 5224.05966925957, 5315.3621565412395, 4909.852704418873, 4974.303597496281, 4982.277569752293, 5035.345405097314, 5187.066328060985, 4921.680090794087, 5025.120603894231, 5031.0, 5037.546620804145, 5048.7475626219275, 5098.898022039464, 5152.819651312186, 5178.948210517998, 5185.714785686672, 5212.9739351304515, 4863.0, 4966.900661986812, 4973.726445045412, 5056.772445240046, 5068.391792984866], "mootools.html": [1158.5018442069907, 1272.0650322013325, 1324.5893772930392, 1539.3073117097306, 1647.9423220187296, 5846.152307915349, 6224.221972253468, 6238.688065596719, 6373.426391624753, 6386.808395748135, 6606.10817539632, 6660.567063140892, 6713.731450741964, 6732.596044237349, 6762.0871182390365, 1973.0923775063488, 1976.041619814389, 1976.8122028407279, 1991.4224874786366, 1998.6402447559433, 1989.3136867780593, 1990.4526255279768, 1992.2130758350515, 2038.8674736142177, 2042.693595960603, 1952.0630097553183, 1968.9803101969012, 1977.8219960203578, 1980.7722111957094, 1985.2555291765589, 1952.336205690065, 1963.1460314763124, 1966.1250743419184, 1967.7540307461568, 1968.1930408532432, 1958.1384190955935, 1982.0, 1982.246746236421, 1982.9603407931904, 1990.4725247809342, 6012.428819262163, 6610.7355705771715, 6618.635975021371, 6662.933370666328, 6677.866442671119, 3802.543694756619, 4045.656119229869, 4191.098913733532, 4192.853250136231, 4209.20025195215, 2574.3950171709635, 2586.8318559293584, 2628.4086080631896, 2661.534231509478, 2673.1579552440917, 851.05957916502, 857.2670366836328, 1418.1491105336715, 1458.6134674311315, 1489.6424858034102, 8630.525321107336, 8659.826803463895, 8699.13008699125, 8734.2139207471, 8784.51685157316, 3654.543182102237, 3670.0274427276795, 3724.1806802503947, 3733.533308336458, 3768.2840260350445, 7201.13586369639, 7331.0, 7352.338289553859, 7357.117145942521, 7364.815879603053, 4181.519125300569, 4209.726367786146, 4212.220739163265, 4222.986483243999, 4228.429162063082, 3860.517435320585, 3896.376579747227, 3899.200663863901, 3907.4138879168354, 3913.9021524461546, 2920.2261400728826, 2947.9263018424713, 2956.364381657954, 2967.302683869289, 2978.657454392729, 914.3051281026468, 915.2769312243254, 916.4730280088842, 919.0579655852671, 923.459776031016, 1157.2767020612118, 1162.8895254950767, 1190.220405634311, 1203.789336866045, 1204.5362535423749, 6317.210348706411, 6439.581427207217, 6498.967505162444, 6507.414332710079, 6517.706703198368, 439.20723094814167, 448.91246206989325, 451.3410420785624, 452.09580838323353, 452.27861560810453, 4700.2009658358165, 5025.120603894304, 5058.165402708585, 5058.797648094109, 5068.847934561969, 7031.578105313698, 7755.418343624251, 7993.240642138988, 7994.6002699864775, 8017.6792928283385, 7852.960735196288, 7870.370370370357, 7882.369410447151, 7888.1323054463965, 7915.089764677021, 6118.632882027093, 6286.591371560834, 6310.021946598285, 6328.7152078157515, 6348.587341822767, 6217.285012223652, 6233.158523599437, 6240.188775459343, 6268.122462855295, 6277.717502712298, 6805.9659701701175, 6870.862582748417, 6922.619255940972, 7006.019157317877, 7032.085828842422, 6954.3393377629045, 7215.783526494213, 7230.457715671451, 7234.059572255573, 7244.746433874789, 5653.943460565341, 5752.7698892043845, 5758.942410575841, 5761.567882408753, 5800.303963524235, 6403.231612206565, 6488.221413430419, 6501.577397469149, 6520.467690092919, 6523.869522609616, 6073.119397687399, 6092.847678808065, 6096.811121831201, 6214.5028397727165, 6249.687515624109, 5946.583739138392, 5969.820905372846, 6019.157317975574, 6072.969635151796, 6096.0, 5855.59010869235, 5982.820515384371, 6031.7587296507645, 6034.939650603438, 6111.266648002268, 5536.972315138399, 5559.72201389937, 5589.469000444951, 5609.074502707171, 5616.38219795814, 5652.321721393295, 5695.202671626059, 5701.657900525982, 5713.428657134254, 5715.657060576379], "ext.html": [506.4353246130564, 509.29971289476947, 512.142161878853, 524.1325606121867, 528.6590149353669, 26997.73002269977, 28250.858745706268, 36041.45937810931, 36862.44706329401, 36959.07602309937, 38634.80682596583, 38920.0, 39226.607733922654, 39339.40990885139, 39363.80318098413, 7189.065421495198, 8372.497650140996, 8529.97640283167, 8587.313014958789, 8642.740717778477, 7678.808029799244, 10106.898931010706, 10331.32846364984, 10358.896411035868, 10385.0, 10078.647247346344, 10195.949020254926, 10209.438480883548, 10216.38701677898, 10222.437765922872, 7714.19001004892, 7967.760967170936, 10081.596736130583, 10161.0, 10218.18254539635, 9935.850962235572, 10112.646057387956, 10112.89887101127, 10115.544800483996, 10215.540300686487, 36017.0, 36475.81762091172, 36527.26945461076, 36563.085922852144, 36569.45145822815, 2737.86310684467, 2780.6802217745017, 2791.9720802792117, 2798.4403119376, 2911.213972227487, 25822.0, 25936.351591210183, 25977.0, 26143.266248501288, 26193.345166370804, 2177.684235785818, 2190.3100523335256, 2216.833737469696, 2217.5897458970144, 2335.089315167086, 242056.0, 242452.0, 243362.0, 243592.0, 243946.0, 45251.0, 45963.77018114888, 46448.07103857904, 52330.47669523332, 58283.41716582865, 53340.46659533355, 53742.73128634332, 53844.0, 54247.72876135594, 54384.72807636016, 13141.868581314257, 13152.013598980115, 13176.407061682246, 13199.20804751718, 13203.603891883258, 11675.824862627067, 11681.824772628417, 11758.3532905691, 11819.172657913863, 11901.226420282654, 16649.750253746202, 16964.473197412044, 17044.744328835077, 17052.829471705372, 17186.570335741708, 7708.417680077237, 7834.4907581007055, 7903.723369682033, 7907.130215676271, 7962.482438641469, 865.3380164174412, 926.2589928057527, 959.9968033404969, 989.6140505202976, 989.9752506187259, 23626.29121126369, 23804.404889877544, 23855.880720596288, 23917.16289929844, 23993.760062399153, 933.2300851797295, 959.1990687775785, 1053.3311347294523, 1100.8513850630063, 1122.6912599035168, 12538.310392928477, 12588.244705317711, 12708.872911270953, 12750.171238869443, 12820.743585128244, 280594.0, 286701.0, 286987.0, 290236.0, 290285.0, 48868.51131488711, 49049.0, 49135.26297105546, 49145.26282105771, 49151.508484914695, 1262.8547717012477, 1284.9229046257067, 1301.5899991502647, 1305.2560040776666, 1306.2293246984134, 24250.636240456053, 24801.50396992014, 24827.255182344557, 24843.378915527257, 24923.0, 41457.58542414658, 41556.168876622905, 41635.1672966545, 41638.37542436927, 41669.1666166681, 262605.0, 263690.0, 266569.0, 267961.0, 268748.0, 25346.873265633552, 25523.106691265715, 26715.86642066777, 28817.279568010967, 29061.85469072641, 34595.82702086474, 34768.0, 34917.30165396627, 35154.64845351514, 35205.47191792074, 28263.576046359733, 28937.855310723313, 30649.846750766104, 31575.21061973469, 31867.20331991626, 25699.020125799387, 30324.5451318226, 31184.22039449032, 31704.0, 31772.364552708354, 31058.844705776326, 31705.841470792497, 31949.520757189126, 31954.201144970633, 31977.36045279128, 24681.259562213163, 26199.869000654875, 27374.45251095007, 27501.287326211506, 27574.310642234104, 20877.478063048544, 22124.77875221227, 22178.646628546416, 22204.222852200095, 22226.44433889166], "prototype.html": [282.84867595836226, 287.26316996902943, 287.93089658481966, 294.5478690210526, 296.09395250533356, 5645.9999999999945, 5677.829665110048, 5700.857478563033, 5741.784600623654, 5756.165356023384, 5716.942830571693, 5725.969325521404, 5740.225069615601, 5740.397258287882, 5760.395158508359, 4398.824047038114, 4399.9780001100025, 4407.096545208241, 4417.072414792898, 4419.801108950089, 4205.747655140702, 4307.440032795732, 4345.913081738363, 4396.692231543793, 4404.603585677289, 4355.782210889459, 4356.869293921188, 4364.127174565084, 4371.3661519079715, 4374.168907907503, 4159.584041595846, 4343.326784348431, 4366.8253269869165, 4396.164728701552, 4403.295472724349, 3634.545681789776, 3700.5744339401044, 3730.776153430803, 3733.4773131761576, 3748.925021499582, 5539.279893613845, 5541.0580201365865, 5543.889122217533, 5547.472990065938, 5550.417206193372, 4923.704577725348, 4926.507349265081, 4929.778159982773, 4936.33359496467, 4948.826791062332, 5844.327902291248, 6024.518038556905, 6037.909431358533, 6039.365866584033, 6049.364816694272, 3998.460207871929, 3998.7600743955454, 4001.7198796083994, 4004.659603933669, 4012.4181993611055, 6269.216347956505, 6351.555391122623, 6360.427561519486, 6363.554551181419, 6364.01357789548, 3907.29668659644, 3951.229510245532, 3958.148997965451, 3983.0, 3983.143624120828, 3617.3774013839757, 3867.3232184368185, 3997.5402828675074, 4005.239004589177, 4017.3170561004113, 4656.4877863434995, 4727.669063165614, 4753.857384278477, 4755.500672429414, 4758.690685105457, 5745.109508026263, 5875.9118613220835, 5974.522038236931, 6000.459958603659, 6016.759329626853, 1442.4879167895247, 1462.9414823406944, 1464.0776310924264, 1464.816897887764, 1465.142891408538, 905.0813424374265, 911.0570559470916, 919.8942121656095, 940.2571968145226, 940.7601061729215, 5816.272965879265, 5819.039858423397, 5828.0, 5836.824895253149, 5851.912221316684, 6265.122882796412, 6294.622322660655, 6301.747930082745, 6302.180716506825, 6324.683765811691, 5848.5321174305955, 5856.0, 5867.559933005042, 5873.148393482921, 5879.118132280107, 3244.0754385000632, 3309.12308238317, 3379.6282408935, 3380.881669141568, 3392.508086327518, 6413.230412350548, 6550.639714815731, 6574.474042076622, 6601.801945941629, 6602.7689030883685, 6529.608223506605, 6556.606603603799, 6559.344065593498, 6560.671966401661, 6563.081168636395, 6371.585846919843, 6567.047778072249, 6597.703103360361, 6613.272540020594, 6625.801225963229, 6394.0408938659575, 6412.775552855815, 6413.0, 6421.325760795236, 6435.356464353715, 6264.655443950626, 6268.27914789805, 6273.71768270438, 6278.780242691667, 6300.59046161998, 6435.388638079375, 6612.0743095965645, 6621.238557565942, 6634.933650663432, 6639.867202656016, 4099.036726369361, 4138.730982486129, 4147.52303485103, 4149.107941792529, 4150.418941348154, 6371.96814015927, 6373.139626150411, 6373.521985851173, 6373.904391434039, 6378.968105159444, 5962.5528085394635, 6128.264608247039, 6146.262448506208, 6177.073438984188, 6177.84555386101, 6120.816375508742, 6130.356312587114, 6132.9080063799975, 6152.907706384318, 6161.106639537332, 5984.581079324405, 5984.640921544547, 5996.730147143477, 6019.909701354571, 6023.427774361428, 5963.194968679173, 6100.267967843887, 6132.264128304632, 6147.907781383372, 6151.630902145886, 5984.700764961822, 6045.244344456943, 6045.667488288186, 6064.181335519825, 6081.665508397081], "yui.html": [676.874778166039, 679.5287011464561, 687.3641881259837, 698.8148140742703, 710.8827043537816, 12461.127721059529, 12769.23384596925, 12783.872161278385, 12804.231746095218, 12883.871161288384, 11698.941505292461, 11760.823587646191, 12096.455659495321, 12111.333876636781, 12147.028237740982, 639.063771574643, 645.241840837017, 793.8848866914294, 798.9840203195962, 826.8677011678133, 785.7917651822272, 796.55791035975, 797.103258833812, 803.2971150243537, 804.7585724282721, 862.6549380247889, 869.382738255836, 870.0342619692136, 870.8258348330328, 872.1540106097108, 663.8141320430287, 676.7698982346026, 677.7356830835978, 681.7681988124012, 833.5540485840107, 638.3170008091344, 638.7572722365518, 640.1038546035587, 641.8299150725062, 643.1060825452624, 12821.294828784414, 12988.480460781557, 13026.0, 13041.608751737464, 13043.282619455926, 10584.259101862872, 10619.734506637396, 10687.893121068768, 10786.622468213574, 11056.723581910435, 8731.083236260165, 8752.693655722083, 8836.425632333941, 8853.955730221373, 9185.908140918573, 2990.386970671007, 3037.8632961516787, 3082.9075127746205, 3113.066080175938, 3164.1931307516666, 44393.11213775739, 44895.77552112251, 45183.71004679896, 45739.0, 46003.53996460026, 7705.0, 8153.306968907709, 8551.74344769658, 8678.6528538859, 8881.600327985256, 15033.624159396102, 15051.774223386657, 15074.773878391832, 15169.62075948088, 15255.771163432557, 6474.12599299098, 6491.8701625967215, 6592.30780768022, 6600.702968366435, 6881.518293719391, 3414.573178352706, 3434.536337594393, 3461.4115600348, 3496.7027802637062, 3564.7682900611376, 2730.7269273072534, 2773.2789474736715, 2803.971960280371, 2820.323122450597, 2831.4195589904434, 399.3729844144723, 404.7915323608285, 409.7500524679943, 410.24719639461324, 412.7420362273579, 509.54141272853985, 542.8914217156585, 548.5638917060946, 557.2004174010308, 574.1789241384777, 6516.57642253252, 7068.92931070693, 7088.220295767462, 7239.167495737952, 7346.6326683666675, 545.2339463054415, 554.7919530176184, 564.9265595472644, 566.2977907394883, 575.2923903598597, 3172.667479658549, 3414.914627134292, 3435.707964822968, 3451.5685539307588, 3541.13242255649, 46326.305105423446, 46499.53500464952, 46886.76556617195, 47002.76498617485, 47036.05927881423, 44257.557424425984, 44363.55636443659, 46515.30227046597, 46714.299285510744, 47749.0, 43068.353974690406, 43271.0, 43509.0, 43604.12791744211, 43762.905927351436, 7454.3310260403705, 7486.5508069516, 7540.245975402416, 7628.313451789366, 7817.765467035998, 29515.262118447212, 30417.391652167276, 30509.0, 31198.37603247877, 32521.837390812896, 39939.40090898697, 40279.798601006805, 40421.59578404178, 41054.0, 41825.16349673051, 6324.335944725922, 6595.703193356215, 6874.587524748531, 6913.274106218976, 6918.792436226921, 9524.761880953032, 10097.899021009696, 10244.436555989492, 10269.948650256702, 10883.346999180074, 9304.72085837426, 9404.858927115962, 9424.104710052534, 9479.905200947902, 9508.714738557854, 9380.0, 9380.95309523448, 9453.716388508356, 9507.809843803223, 9533.094356036165, 9083.409578377385, 9167.266618670623, 9179.495127768037, 9208.815823683623, 9209.447433154031, 7927.881081783893, 8027.357811375193, 8542.231199191854, 8562.74311770648, 8665.17680820321, 7922.0889597697005, 8031.1567285434185, 8241.340692744687, 8388.161183881562, 8449.155084491502]}, "summary": {"lowerIsBetter": false, "suite": 6025.699650314492, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6300.940166212421, "unit": "ms", "value": 6300.940166212421}, "dojo.html": {"lowerIsBetter": false, "filtered": 4847.090345815638, "unit": "ms", "value": 4847.090345815638}, "mootools.html": {"lowerIsBetter": false, "filtered": 3813.801983567862, "unit": "ms", "value": 3813.801983567862}, "ext.html": {"lowerIsBetter": false, "filtered": 16664.0632772285, "unit": "ms", "value": 16664.0632772285}, "prototype.html": {"lowerIsBetter": false, "filtered": 4513.273189196698, "unit": "ms", "value": 4513.273189196698}, "yui.html": {"lowerIsBetter": false, "filtered": 5463.689685109856, "unit": "ms", "value": 5463.689685109856}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1447853311, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151118030232", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}, {"talos_counters": {}, "results": {"audio-dft": [174.0, 177.0, 182.0, 178.0, 174.0, 175.0, 182.0, 181.0, 171.0, 175.0], "ai-astar": [105.0, 108.0, 108.0, 110.0, 106.0, 110.0, 102.0, 105.0, 116.0, 108.0], "imaging-gaussian-blur": [130.0, 135.0, 129.0, 134.0, 135.0, 135.0, 135.0, 128.0, 124.0, 135.0], "audio-beat-detection": [164.0, 133.0, 168.0, 181.0, 141.0, 168.0, 166.0, 144.0, 181.0, 140.0], "json-stringify-tinderbox": [69.0, 73.0, 75.0, 79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 88.0], "stanford-crypto-pbkdf2": [156.0, 179.0, 182.0, 173.0, 175.0, 156.0, 170.0, 172.0, 170.0, 163.0], "json-parse-financial": [62.0, 60.0, 63.0, 64.0, 67.0, 68.0, 68.0, 76.0, 66.0, 66.0], "stanford-crypto-sha256-iterative": [73.0, 75.0, 80.0, 80.0, 79.0, 80.0, 81.0, 80.0, 80.0, 79.0], "audio-fft": [77.0, 89.0, 100.0, 95.0, 77.0, 78.0, 79.0, 92.0, 93.0, 74.0], "imaging-darkroom": [137.0, 142.0, 141.0, 141.0, 142.0, 139.0, 136.0, 142.0, 143.0, 141.0], "stanford-crypto-ccm": [139.0, 145.0, 144.0, 146.0, 136.0, 146.0, 147.0, 148.0, 145.0, 139.0], "audio-oscillator": [103.0, 105.0, 146.0, 100.0, 99.0, 101.0, 146.0, 100.0, 98.0, 145.0], "stanford-crypto-aes": [92.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 97.0, 97.0], "imaging-desaturate": [110.0, 105.0, 105.0, 105.0, 112.0, 109.0, 114.0, 113.0, 103.0, 104.0]}, "summary": {"lowerIsBetter": true, "suite": 1655.2999999999997, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 169.6, "unit": "ms", "value": 169.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 158.6, "unit": "ms", "value": 158.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 143.5, "unit": "ms", "value": 143.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 140.4, "unit": "ms", "value": 140.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 66.0, "unit": "ms", "value": 66.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 114.3, "unit": "ms", "value": 114.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.8, "unit": "ms", "value": 107.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 176.9, "unit": "ms", "value": 176.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 78.7, "unit": "ms", "value": 78.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 78.0, "unit": "ms", "value": 78.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 132.0, "unit": "ms", "value": 132.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 108.0, "unit": "ms", "value": 108.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1447853311, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151118030232", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}, {"talos_counters": {}, "results": {"DeltaBlue": [218.34061135371178], "Encrypt": [352.60930888575456], "NavierStokes": [6375.796178343949], "Decrypt": [6217.391304347826], "Splay": [739.0983000739099], "Richards": [172.80110592707794], "RegExp": [32380.95238095238], "Earley": [1054.8523206751054], "Boyer": [14528.57142857143], "RayTrace": [2087.6826722338205]}, "summary": {"lowerIsBetter": false, "suite": 16562.876975842504, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 302.82044000000013, "unit": "score", "value": 302.82044000000013}, "Encrypt": {"lowerIsBetter": false, "filtered": 754.8893159999999, "unit": "score", "value": 754.8893159999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 232.75524475524475, "unit": "score", "value": 232.75524475524475}, "Decrypt": {"lowerIsBetter": false, "filtered": 42.812328671328686, "unit": "score", "value": 42.812328671328686}, "Splay": {"lowerIsBetter": false, "filtered": 110.257323, "unit": "score", "value": 110.257323}, "RegExp": {"lowerIsBetter": false, "filtered": 28.13336029411763, "unit": "score", "value": 28.13336029411763}, "Richards": {"lowerIsBetter": false, "filtered": 204.29267399999998, "unit": "score", "value": 204.29267399999998}, "Earley": {"lowerIsBetter": false, "filtered": 631.8069239999998, "unit": "score", "value": 631.8069239999998}, "Boyer": {"lowerIsBetter": false, "filtered": 45.87257620452313, "unit": "score", "value": 45.87257620452313}, "RayTrace": {"lowerIsBetter": false, "filtered": 354.454731, "unit": "score", "value": 354.454731}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1447853311, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151118030232", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}] 05:48:45 INFO - RETURN: dromaeo_css: 6025.70 05:48:45 INFO - RETURN: kraken: 1655.30 05:48:45 INFO - RETURN: v8_7: 16562.88 05:48:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "16562.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1655.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6025.70"}}} 05:48:45 INFO - Return code: 0 05:48:45 INFO - # TBPL SUCCESS # 05:48:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:45 INFO - 2015-11-18 05:48:45.904 screenresolution[2039:23926] starting screenresolution argv=screenresolution get 05:48:45 INFO - 2015-11-18 05:48:45.907 screenresolution[2039:23926] Display 0: 1600x1200x32@60 05:48:45 INFO - 2015-11-18 05:48:45.914 screenresolution[2040:23929] starting screenresolution argv=screenresolution list 05:48:45 INFO - Available Modes on Display 0 05:48:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:46 INFO - Intel HD Graphics 3000: 05:48:46 INFO - Chipset Model: Intel HD Graphics 3000 05:48:46 INFO - Type: GPU 05:48:46 INFO - Bus: Built-In 05:48:46 INFO - VRAM (Total): 512 MB 05:48:46 INFO - VRAM (Dynamic, Max): 10 05:48:46 INFO - Vendor: Intel (0x8086) 05:48:46 INFO - Device ID: 0x0116 05:48:46 INFO - Revision ID: 0x0009 05:48:46 INFO - Displays: 05:48:46 INFO - Display: 05:48:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:46 INFO - Display Serial Number: 1600x1200 60 05:48:46 INFO - Main Display: Yes 05:48:46 INFO - Mirror: Off 05:48:46 INFO - Online: Yes 05:48:46 INFO - Rotation: Supported 05:48:46 INFO - Return code: 0 05:48:46 INFO - Running post-action listener: _resource_record_post_action 05:48:46 INFO - Running post-run listener: _resource_record_post_run 05:48:47 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 761856; Write bytes: 687659008; Read time: 274; Write time: 62570 05:48:47 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 341365248; Write bytes: 335013888; Read time: 34384; Write time: 6097 05:48:47 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 761856; Write bytes: 341221376; Read time: 274; Write time: 55768 05:48:47 INFO - Running post-run listener: _upload_blobber_files 05:48:47 INFO - Blob upload gear active. 05:48:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:48:47 INFO - Copying logs to upload dir... 05:48:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1333.751722 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2015-11-18 05:48:47.334349) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 05:48:47.337808) ========= 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.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009900 build_url: 'https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/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-18 05:48:47.364556) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:48:47.365120) ========= 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.8vz4ufKrkc/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.WuhzcEubp3/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005309 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:48:47.415651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 05:48:47.416014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 05:48:47.416489) ========= ========= Total master_lag: 0.26 =========