builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0077 starttime: 1447853192.38 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.380533) ========= 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.380971) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.381316) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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.005993 basedir: '/builds/slave/test' ========= master_lag: 0.34 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.727055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.727408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.750247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.750602) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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.034965 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.801050) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.801410) ========= 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.801803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:32.802127) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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, 63.245.215.25, ... 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% 24.1M=0s 2015-11-18 05:26:33 (24.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.247489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.066865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.067223) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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.149249 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.231591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.231949) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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,312 truncating revision to first 12 chars 2015-11-18 05:26:33,313 Setting DEBUG logging. 2015-11-18 05:26:33,313 attempt 1/10 2015-11-18 05:26:33,313 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,557 unpacking tar archive at: mozilla-central-eb3016abd37d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.781652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.781973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.799779) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 05:26:33.800114) ========= 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.800543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2015-11-18 05:26:33.800884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:34 INFO - MultiFileLogger online at 20151118 05:26:34 in /builds/slave/test 05:26:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:34 INFO - {'append_to_log': False, 05:26:34 INFO - 'base_work_dir': '/builds/slave/test', 05:26:34 INFO - 'blob_upload_branch': 'Firefox', 05:26:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:34 INFO - 'branch': 'Firefox', 05:26:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:34 INFO - 'config_files': ('talos/mac_config.py',), 05:26:34 INFO - 'default_actions': ('clobber', 05:26:34 INFO - 'read-buildbot-config', 05:26:34 INFO - 'download-and-extract', 05:26:34 INFO - 'populate-webroot', 05:26:34 INFO - 'create-virtualenv', 05:26:34 INFO - 'install', 05:26:34 INFO - 'run-tests'), 05:26:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:34 INFO - 'download_minidump_stackwalk': True, 05:26:34 INFO - 'download_symbols': 'ondemand', 05:26:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:34 INFO - 'installer_path': 'installer.exe', 05:26:34 INFO - 'log_level': 'info', 05:26:34 INFO - 'log_name': 'talos', 05:26:34 INFO - 'log_to_console': True, 05:26:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:26:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:26:34 INFO - 'opt_config_files': (), 05:26:34 INFO - 'pip_index': False, 05:26:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:34 INFO - 'cmd': ('bash', 05:26:34 INFO - '-c', 05:26:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:34 INFO - 'enabled': True, 05:26:34 INFO - 'halt_on_failure': False, 05:26:34 INFO - 'name': 'check_screen_resolution'},), 05:26:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:34 INFO - 'cmd': ('bash', 05:26:34 INFO - '-c', 05:26:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:34 INFO - 'enabled': True, 05:26:34 INFO - 'halt_on_failure': False, 05:26:34 INFO - 'name': 'check_screen_resolution'},), 05:26:34 INFO - 'run_cmd_checks_enabled': True, 05:26:34 INFO - 'sps_profile': False, 05:26:34 INFO - 'sps_profile_interval': 0, 05:26:34 INFO - 'suite': 'dromaeojs-e10s', 05:26:34 INFO - 'system_bits': '64', 05:26:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:34 INFO - 'title': 't-yosemite-r5-0077', 05:26:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:34 INFO - 'use_talos_json': True, 05:26:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:34 INFO - 'work_dir': 'build'} 05:26:34 INFO - ##### 05:26:34 INFO - ##### Running clobber step. 05:26:34 INFO - ##### 05:26:34 INFO - Running pre-action listener: _resource_record_pre_action 05:26:34 INFO - Running main action method: clobber 05:26:34 INFO - rmtree: /builds/slave/test/build 05:26:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:38 INFO - Running post-action listener: _resource_record_post_action 05:26:38 INFO - ##### 05:26:38 INFO - ##### Running read-buildbot-config step. 05:26:38 INFO - ##### 05:26:38 INFO - Running pre-action listener: _resource_record_pre_action 05:26:38 INFO - Running main action method: read_buildbot_config 05:26:38 INFO - Using buildbot properties: 05:26:38 INFO - { 05:26:38 INFO - "properties": { 05:26:38 INFO - "buildnumber": 35, 05:26:38 INFO - "product": "firefox", 05:26:38 INFO - "script_repo_revision": "production", 05:26:38 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:26:38 INFO - "repository": "", 05:26:38 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:26:38 INFO - "buildid": "20151118030232", 05:26:38 INFO - "slavename": "t-yosemite-r5-0077", 05:26:38 INFO - "stage_platform": "macosx64", 05:26:38 INFO - "basedir": "/builds/slave/test", 05:26:38 INFO - "nightly_build": "True", 05:26:38 INFO - "project": "", 05:26:38 INFO - "platform": "yosemite", 05:26:38 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:26:38 INFO - "slavebuilddir": "test", 05:26:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:26:38 INFO - "branch": "mozilla-central", 05:26:38 INFO - "repo_path": "mozilla-central", 05:26:38 INFO - "pgo_build": "False", 05:26:38 INFO - "builduid": "5d9fcb0e271c46358d1a5024fa3f382a", 05:26:38 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 05:26:38 INFO - }, 05:26:38 INFO - "sourcestamp": { 05:26:38 INFO - "repository": "", 05:26:38 INFO - "hasPatch": false, 05:26:38 INFO - "project": "", 05:26:38 INFO - "branch": "mozilla-central-macosx64-talos", 05:26:38 INFO - "changes": [ 05:26:38 INFO - { 05:26:38 INFO - "category": null, 05:26:38 INFO - "files": [ 05:26:38 INFO - { 05:26:38 INFO - "url": null, 05:26:38 INFO - "name": "https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:26:38 INFO - } 05:26:38 INFO - ], 05:26:38 INFO - "repository": "", 05:26:38 INFO - "rev": "eb3016abd37db2e6a6d923265047e84b12c0af61", 05:26:38 INFO - "who": "sendchange", 05:26:38 INFO - "when": 1447853135, 05:26:38 INFO - "number": 6676914, 05:26:38 INFO - "comments": "", 05:26:38 INFO - "project": "", 05:26:38 INFO - "at": "Wed 18 Nov 2015 05:25:35", 05:26:38 INFO - "branch": "mozilla-central-macosx64-talos", 05:26:38 INFO - "revlink": "", 05:26:38 INFO - "properties": [ 05:26:38 INFO - [ 05:26:38 INFO - "buildid", 05:26:38 INFO - "20151118030232", 05:26:38 INFO - "Change" 05:26:38 INFO - ], 05:26:38 INFO - [ 05:26:38 INFO - "builduid", 05:26:38 INFO - "5d9fcb0e271c46358d1a5024fa3f382a", 05:26:38 INFO - "Change" 05:26:38 INFO - ], 05:26:38 INFO - [ 05:26:38 INFO - "nightly_build", 05:26:38 INFO - "True", 05:26:38 INFO - "Change" 05:26:38 INFO - ], 05:26:38 INFO - [ 05:26:38 INFO - "pgo_build", 05:26:38 INFO - "False", 05:26:38 INFO - "Change" 05:26:38 INFO - ] 05:26:38 INFO - ], 05:26:38 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 05:26:38 INFO - } 05:26:38 INFO - ], 05:26:38 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 05:26:38 INFO - } 05:26:38 INFO - } 05:26:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:26:38 INFO - Running post-action listener: _resource_record_post_action 05:26:38 INFO - ##### 05:26:38 INFO - ##### Running download-and-extract step. 05:26:38 INFO - ##### 05:26:38 INFO - Running pre-action listener: _resource_record_pre_action 05:26:38 INFO - Running main action method: download_and_extract 05:26:38 INFO - mkdir: /builds/slave/test/build/tests 05:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:38 INFO - https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json 05:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/test_packages.json 05:26:38 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:38 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:27:05 INFO - Downloaded 1149 bytes. 05:27:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:27:05 INFO - Using the following test package requirements: 05:27:05 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:27:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:27:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'jsshell-mac.zip'], 05:27:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:27:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:27:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:27:05 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:27:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:27:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:27:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:27:05 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:27:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:27:05 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:05 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:05 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:05 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:05 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:05 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:08 INFO - Downloaded 17463610 bytes. 05:27:08 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:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:08 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:13 INFO - Return code: 0 05:27:13 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:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:13 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:13 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:13 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:13 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:13 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:16 INFO - Downloaded 17463610 bytes. 05:27:16 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:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:27:16 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:21 INFO - Return code: 0 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:21 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:21 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:21 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:21 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:21 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:23 INFO - Downloaded 11131693 bytes. 05:27:23 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:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:27:23 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:23 INFO - Return code: 0 05:27:23 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:23 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:23 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:23 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:23 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:23 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:29 INFO - Downloaded 108959561 bytes. 05:27:29 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:29 INFO - mkdir: /builds/slave/test/properties 05:27:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:29 INFO - Contents: 05:27:29 INFO - build_url:https://queue.taskcluster.net/v1/task/hT8A35VCQaSxa1QhQsfeRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:27:29 INFO - Running post-action listener: _resource_record_post_action 05:27:29 INFO - Running post-action listener: set_extra_try_arguments 05:27:29 INFO - ##### 05:27:29 INFO - ##### Running populate-webroot step. 05:27:29 INFO - ##### 05:27:29 INFO - Running pre-action listener: _resource_record_pre_action 05:27:29 INFO - Running main action method: populate_webroot 05:27:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:29 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:27:29 INFO - '../fennec_ids.txt'], 05:27:29 INFO - 'tests': ['tcheck2']}, 05:27:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:29 INFO - '--tppagecycles', 05:27:29 INFO - '7'], 05:27:29 INFO - 'tests': ['tsvgm']}}, 05:27:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:27:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:27:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:27:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'tests': ['damp', 'tps']}, 05:27:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['damp', 'tps']}, 05:27:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:27:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:29 INFO - 'other': {'tests': ['a11yr', 05:27:29 INFO - 'ts_paint', 05:27:29 INFO - 'tpaint', 05:27:29 INFO - 'sessionrestore', 05:27:29 INFO - 'sessionrestore_no_auto_restore']}, 05:27:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['a11yr', 05:27:29 INFO - 'ts_paint', 05:27:29 INFO - 'tpaint', 05:27:29 INFO - 'sessionrestore', 05:27:29 INFO - 'sessionrestore_no_auto_restore']}, 05:27:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['a11yr', 05:27:29 INFO - 'ts_paint', 05:27:29 INFO - 'tpaint', 05:27:29 INFO - 'sessionrestore', 05:27:29 INFO - 'sessionrestore_no_auto_restore']}, 05:27:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['a11yr', 05:27:29 INFO - 'ts_paint', 05:27:29 INFO - 'tpaint', 05:27:29 INFO - 'sessionrestore', 05:27:29 INFO - 'sessionrestore_no_auto_restore']}, 05:27:29 INFO - 'other_l64': {'tests': ['a11yr', 05:27:29 INFO - 'ts_paint', 05:27:29 INFO - 'tpaint', 05:27:29 INFO - 'sessionrestore', 05:27:29 INFO - 'sessionrestore_no_auto_restore']}, 05:27:29 INFO - 'other_nol64': {'tests': ['a11yr', 05:27:29 INFO - 'ts_paint', 05:27:29 INFO - 'tpaint', 05:27:29 INFO - 'sessionrestore', 05:27:29 INFO - 'sessionrestore_no_auto_restore']}, 05:27:29 INFO - 'svgr': {'tests': ['tsvgx', 05:27:29 INFO - 'tsvgr_opacity', 05:27:29 INFO - 'tart', 05:27:29 INFO - 'tscrollx', 05:27:29 INFO - 'cart']}, 05:27:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['tsvgx', 05:27:29 INFO - 'tsvgr_opacity', 05:27:29 INFO - 'tart', 05:27:29 INFO - 'tscrollx', 05:27:29 INFO - 'cart']}, 05:27:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'tests': ['tp5o']}, 05:27:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'talos_options': ['--e10s'], 05:27:29 INFO - 'tests': ['tp5o']}, 05:27:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'talos_options': ['--xperf_path', 05:27:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:29 INFO - 'tests': ['tp5n']}, 05:27:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:29 INFO - 'talos_options': ['--e10s', 05:27:29 INFO - '--xperf_path', 05:27:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:29 INFO - 'tests': ['tp5n']}}, 05:27:29 INFO - 'talos.zip': {'path': '', 05:27:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:29 INFO - Running post-action listener: _resource_record_post_action 05:27:29 INFO - ##### 05:27:29 INFO - ##### Running create-virtualenv step. 05:27:29 INFO - ##### 05:27:29 INFO - Running pre-action listener: _resource_record_pre_action 05:27:29 INFO - Running main action method: create_virtualenv 05:27:29 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:29 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:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:30 INFO - Using real prefix '/tools/python27' 05:27:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:34 INFO - Installing pip.................done. 05:27:34 INFO - Return code: 0 05:27:34 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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', 'pip>=1.5'] 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 pip>=1.5 05:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 05:27:34 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:35 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:35 INFO - Cleaning up... 05:27:35 INFO - Return code: 0 05:27:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:27: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:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:35 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 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:35 INFO - 'HOME': '/Users/cltbld', 05:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:35 INFO - 'LOGNAME': 'cltbld', 05:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:35 INFO - 'MOZ_NO_REMOTE': '1', 05:27:35 INFO - 'NO_EM_RESTART': '1', 05:27:35 INFO - 'PAGER': '/bin/cat', 05:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:35 INFO - 'PWD': '/builds/slave/test', 05:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:35 INFO - 'SHELL': '/bin/bash', 05:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:27:35 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:35 INFO - 'USER': 'cltbld', 05:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:35 INFO - 'XPC_FLAGS': '0x0', 05:27:35 INFO - 'XPC_SERVICE_NAME': '0', 05:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:35 INFO - Downloading/unpacking psutil>=0.7.1 05:27:35 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:35 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:35 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:35 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:35 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:35 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 - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:27:37 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:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:38 INFO - Installing collected packages: psutil 05:27:38 INFO - Running setup.py install for psutil 05:27:38 INFO - building 'psutil._psutil_osx' extension 05:27:38 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:41 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:41 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:41 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:41 INFO - building 'psutil._psutil_posix' extension 05:27:41 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:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:27:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:27:41 INFO - ^ 05:27:41 INFO - 1 warning generated. 05:27:41 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:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:41 INFO - Successfully installed psutil 05:27:41 INFO - Cleaning up... 05:27:41 INFO - Return code: 0 05:27:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:27:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:41 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:41 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:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:41 INFO - 'HOME': '/Users/cltbld', 05:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:41 INFO - 'LOGNAME': 'cltbld', 05:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:41 INFO - 'MOZ_NO_REMOTE': '1', 05:27:41 INFO - 'NO_EM_RESTART': '1', 05:27:41 INFO - 'PAGER': '/bin/cat', 05:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:41 INFO - 'PWD': '/builds/slave/test', 05:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:41 INFO - 'SHELL': '/bin/bash', 05:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:27:41 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:41 INFO - 'USER': 'cltbld', 05:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:41 INFO - 'XPC_FLAGS': '0x0', 05:27:41 INFO - 'XPC_SERVICE_NAME': '0', 05:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:27:42 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:42 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:42 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:42 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:42 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:42 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:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:27:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:44 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:44 INFO - Installing collected packages: mozsystemmonitor 05:27:44 INFO - Running setup.py install for mozsystemmonitor 05:27:44 INFO - Successfully installed mozsystemmonitor 05:27:44 INFO - Cleaning up... 05:27:44 INFO - Return code: 0 05:27:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:44 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:44 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:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:44 INFO - 'HOME': '/Users/cltbld', 05:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:44 INFO - 'LOGNAME': 'cltbld', 05:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:44 INFO - 'MOZ_NO_REMOTE': '1', 05:27:44 INFO - 'NO_EM_RESTART': '1', 05:27:44 INFO - 'PAGER': '/bin/cat', 05:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:44 INFO - 'PWD': '/builds/slave/test', 05:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:44 INFO - 'SHELL': '/bin/bash', 05:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:27:44 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:44 INFO - 'USER': 'cltbld', 05:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:44 INFO - 'XPC_FLAGS': '0x0', 05:27:44 INFO - 'XPC_SERVICE_NAME': '0', 05:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:45 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:45 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:45 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:45 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:45 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:45 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 - Downloading blobuploader-1.2.4.tar.gz 05:27:47 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:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:48 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:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:48 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:48 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:48 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:48 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:48 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:48 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:48 INFO - Downloading docopt-0.6.1.tar.gz 05:27:48 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:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:48 INFO - Running setup.py install for blobuploader 05:27:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:48 INFO - Running setup.py install for requests 05:27:49 INFO - Running setup.py install for docopt 05:27:49 INFO - Successfully installed blobuploader requests docopt 05:27:49 INFO - Cleaning up... 05:27:49 INFO - Return code: 0 05:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:49 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 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:49 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:49 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:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:49 INFO - 'HOME': '/Users/cltbld', 05:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:49 INFO - 'LOGNAME': 'cltbld', 05:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:49 INFO - 'MOZ_NO_REMOTE': '1', 05:27:49 INFO - 'NO_EM_RESTART': '1', 05:27:49 INFO - 'PAGER': '/bin/cat', 05:27:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:49 INFO - 'PWD': '/builds/slave/test', 05:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:49 INFO - 'SHELL': '/bin/bash', 05:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:27:49 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:49 INFO - 'USER': 'cltbld', 05:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:49 INFO - 'XPC_FLAGS': '0x0', 05:27:49 INFO - 'XPC_SERVICE_NAME': '0', 05:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-kRTvyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-2Sdwi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-wh6HKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-I9K8en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-r46aXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-Nz5XDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-OTw30a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-c4ogBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:50 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-Q8RqAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-Itkps6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-NtHjwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-oCwzVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-JcGqnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-IDMX7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-be09Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-F_JfS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:51 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-m6ipVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:52 INFO - Running setup.py install for manifestparser 05:27:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozcrash 05:27:52 INFO - Running setup.py install for mozdebug 05:27:52 INFO - Running setup.py install for mozdevice 05:27:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:52 INFO - Running setup.py install for mozfile 05:27:52 INFO - Running setup.py install for mozhttpd 05:27:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for mozinfo 05:27:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for mozInstall 05:27:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for mozleak 05:27:53 INFO - Running setup.py install for mozlog 05:27:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for moznetwork 05:27:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:53 INFO - Running setup.py install for mozprocess 05:27:54 INFO - Running setup.py install for mozprofile 05:27:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:54 INFO - Running setup.py install for mozrunner 05:27:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:54 INFO - Running setup.py install for mozscreenshot 05:27:54 INFO - Running setup.py install for moztest 05:27:54 INFO - Running setup.py install for mozversion 05:27:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:55 INFO - Cleaning up... 05:27:55 INFO - Return code: 0 05:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:55 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 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:55 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:55 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:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:55 INFO - 'HOME': '/Users/cltbld', 05:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:55 INFO - 'LOGNAME': 'cltbld', 05:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:55 INFO - 'MOZ_NO_REMOTE': '1', 05:27:55 INFO - 'NO_EM_RESTART': '1', 05:27:55 INFO - 'PAGER': '/bin/cat', 05:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:55 INFO - 'PWD': '/builds/slave/test', 05:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:55 INFO - 'SHELL': '/bin/bash', 05:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:27:55 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:55 INFO - 'USER': 'cltbld', 05:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:55 INFO - 'XPC_FLAGS': '0x0', 05:27:55 INFO - 'XPC_SERVICE_NAME': '0', 05:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:55 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-q20yRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:55 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-d8y4s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:55 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-GQryu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:55 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-2fAmR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-xIBdNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-IMb6NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-CUG8VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-nQUSiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-fWmB_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-aev5Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-6wheu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:56 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-EV9M_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:57 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-6xyOAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:57 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-E6lh3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:57 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-0czals-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:57 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-i8xt47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:57 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-29POJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:57 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:57 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:57 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:57 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:57 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:57 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:28:00 INFO - Downloading blessings-1.5.1.tar.gz 05:28:00 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:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:00 INFO - Installing collected packages: blessings 05:28:00 INFO - Running setup.py install for blessings 05:28:00 INFO - Successfully installed blessings 05:28:00 INFO - Cleaning up... 05:28:00 INFO - Return code: 0 05:28:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:00 INFO - Reading from file tmpfile_stdout 05:28:00 INFO - Current package versions: 05:28:00 INFO - blessings == 1.5.1 05:28:00 INFO - blobuploader == 1.2.4 05:28:00 INFO - docopt == 0.6.1 05:28:00 INFO - manifestparser == 1.1 05:28:00 INFO - mozInstall == 1.12 05:28:00 INFO - mozcrash == 0.16 05:28:00 INFO - mozdebug == 0.1 05:28:00 INFO - mozdevice == 0.47 05:28:00 INFO - mozfile == 1.2 05:28:00 INFO - mozhttpd == 0.7 05:28:00 INFO - mozinfo == 0.9 05:28:00 INFO - mozleak == 0.1 05:28:00 INFO - mozlog == 3.0 05:28:00 INFO - moznetwork == 0.27 05:28:00 INFO - mozprocess == 0.22 05:28:00 INFO - mozprofile == 0.27 05:28:00 INFO - mozrunner == 6.11 05:28:00 INFO - mozscreenshot == 0.1 05:28:00 INFO - mozsystemmonitor == 0.0 05:28:00 INFO - moztest == 0.7 05:28:00 INFO - mozversion == 1.4 05:28:00 INFO - psutil == 3.1.1 05:28:00 INFO - requests == 1.2.3 05:28:00 INFO - wsgiref == 0.1.2 05:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x106f27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e486440d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, '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.CtvCvJvdkY/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.40HqTcOuaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:28:00 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:28:00 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:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:00 INFO - 'HOME': '/Users/cltbld', 05:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:00 INFO - 'LOGNAME': 'cltbld', 05:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:00 INFO - 'MOZ_NO_REMOTE': '1', 05:28:00 INFO - 'NO_EM_RESTART': '1', 05:28:00 INFO - 'PAGER': '/bin/cat', 05:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:00 INFO - 'PWD': '/builds/slave/test', 05:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:00 INFO - 'SHELL': '/bin/bash', 05:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:28:00 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:00 INFO - 'USER': 'cltbld', 05:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:00 INFO - 'XPC_FLAGS': '0x0', 05:28:00 INFO - 'XPC_SERVICE_NAME': '0', 05:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 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:28:01 INFO - Cleaning up... 05:28:01 INFO - Return code: 0 05:28:01 INFO - Running post-action listener: _resource_record_post_action 05:28:01 INFO - Running post-action listener: _start_resource_monitoring 05:28:01 INFO - Starting resource monitoring. 05:28:01 INFO - ##### 05:28:01 INFO - ##### Running install step. 05:28:01 INFO - ##### 05:28:01 INFO - Running pre-action listener: _resource_record_pre_action 05:28:01 INFO - Running main action method: install 05:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:01 INFO - Reading from file tmpfile_stdout 05:28:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:01 INFO - Reading from file tmpfile_stdout 05:28:01 INFO - Output received: 05:28:01 INFO - Usage: mozinstall [options] installer 05:28:01 INFO - Options: 05:28:01 INFO - -h, --help show this help message and exit 05:28:01 INFO - -d DEST, --destination=DEST 05:28:01 INFO - Directory to install application into. [default: 05:28:01 INFO - "/builds/slave/test"] 05:28:01 INFO - --app=APP Application being installed. [default: firefox] 05:28:01 INFO - mkdir: /builds/slave/test/build/application 05:28:01 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:28:01 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:39 INFO - Reading from file tmpfile_stdout 05:28:39 INFO - Output received: 05:28:39 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:28:39 INFO - Running post-action listener: _resource_record_post_action 05:28:39 INFO - ##### 05:28:39 INFO - ##### Running run-tests step. 05:28:39 INFO - ##### 05:28:39 INFO - Running pre-action listener: _resource_record_pre_action 05:28:39 INFO - Running main action method: run_tests 05:28:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:39 INFO - 2015-11-18 05:28:39.664 screenresolution[1665:10686] starting screenresolution argv=screenresolution get 05:28:39 INFO - 2015-11-18 05:28:39.668 screenresolution[1665:10686] Display 0: 1600x1200x32@60 05:28:39 INFO - 2015-11-18 05:28:39.674 screenresolution[1666:10688] starting screenresolution argv=screenresolution list 05:28:39 INFO - Available Modes on Display 0 05:28:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:39 INFO - Intel HD Graphics 3000: 05:28:39 INFO - Chipset Model: Intel HD Graphics 3000 05:28:39 INFO - Type: GPU 05:28:39 INFO - Bus: Built-In 05:28:39 INFO - VRAM (Total): 512 MB 05:28:39 INFO - VRAM (Dynamic, Max): 10 05:28:39 INFO - Vendor: Intel (0x8086) 05:28:39 INFO - Device ID: 0x0116 05:28:39 INFO - Revision ID: 0x0009 05:28:39 INFO - Displays: 05:28:39 INFO - Display: 05:28:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:39 INFO - Display Serial Number: 1600x1200 60 05:28:39 INFO - Main Display: Yes 05:28:39 INFO - Mirror: Off 05:28:39 INFO - Online: Yes 05:28:39 INFO - Rotation: Supported 05:28:39 INFO - Return code: 0 05:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:39 INFO - Python 2.7.3 05:28:39 INFO - Return code: 0 05:28:39 INFO - grabbing minidump binary from tooltool 05:28: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:28:39 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 0x106e4a9f0>, '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 0x106baadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e3e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:39 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:39 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:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:40 INFO - Return code: 0 05:28:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:28:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:28:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:40 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-e10s', '--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-0077', '--webServer', 'localhost'] in /builds/slave/test/build 05:28:40 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-e10s --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-0077 --webServer localhost 05:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CtvCvJvdkY/Render', 05:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:40 INFO - 'HOME': '/Users/cltbld', 05:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:40 INFO - 'LOGNAME': 'cltbld', 05:28:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:40 INFO - 'MOZ_NO_REMOTE': '1', 05:28:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:40 INFO - 'NO_EM_RESTART': '1', 05:28:40 INFO - 'PAGER': '/bin/cat', 05:28:40 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:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:40 INFO - 'PWD': '/builds/slave/test', 05:28:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:40 INFO - 'SHELL': '/bin/bash', 05:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40HqTcOuaI/Listeners', 05:28:40 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 05:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:40 INFO - 'USER': 'cltbld', 05:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:40 INFO - 'XPC_FLAGS': '0x0', 05:28:40 INFO - 'XPC_SERVICE_NAME': '0', 05:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:28:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--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-0077', '--webServer', 'localhost'] with output_timeout 3600 05:28:40 INFO - mozversion INFO | application_buildid: 20151118030232 05:28:40 INFO - mozversion INFO | application_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 05:28:40 INFO - mozversion INFO | application_display_name: Nightly 05:28:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:40 INFO - mozversion INFO | application_name: Firefox 05:28:40 INFO - mozversion INFO | application_remotingname: firefox 05:28:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:28:40 INFO - mozversion INFO | application_vendor: Mozilla 05:28:40 INFO - mozversion INFO | application_version: 45.0a1 05:28:40 INFO - mozversion INFO | platform_buildid: 20151118030232 05:28:40 INFO - mozversion INFO | platform_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 05:28:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:28:40 INFO - mozversion INFO | platform_version: 45.0a1 05:28:40 INFO - 2015-11-18 05:28:40,377 DEBUG : using testdate: 1447853320 05:28:40 INFO - 2015-11-18 05:28:40,378 DEBUG : actual date: 1447853320 05:28:40 INFO - 2015-11-18 05:28:40,466 INFO : starting webserver on 'localhost:49264' 05:28:40 INFO - 2015-11-18 05:28:40,467 INFO : Starting test suite t-yosemite-r5-0077.e 05:28:40 INFO - 2015-11-18 05:28:40,467 INFO : Starting test dromaeo_css 05:28:40 INFO - 2015-11-18 05:28:40,467 DEBUG : operating with platform_type : mac_ 05:28:40 INFO - 2015-11-18 05:28:40,468 INFO : Initialising browser for dromaeo_css test... 05:28:40 INFO - 2015-11-18 05:28:40,496 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpr3WXaI/profile http://localhost:49264/getInfo.html 05:28:44 INFO - 2015-11-18 05:28:44,903 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:44 INFO - 2015-11-18 05:28:44,903 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:44 INFO - 2015-11-18 05:28:44,903 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:28:44 INFO - 2015-11-18 05:28:44,904 DEBUG : BROWSER_OUTPUT: __metrics 05:28:45 INFO - 2015-11-18 05:28:45,559 INFO : Browser initialized. 05:28:45 INFO - 2015-11-18 05:28:45,559 INFO : Running cycle 1/1 for dromaeo_css test... 05:28:45 INFO - 2015-11-18 05:28:45,559 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpr3WXaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:57 INFO - 2015-11-18 05:28:57,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 241864704 05:28:57 INFO - 2015-11-18 05:28:57,644 DEBUG : BROWSER_OUTPUT: 05:29:47 INFO - 2015-11-18 05:29:47,503 DEBUG : BROWSER_OUTPUT: 1447853387497 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:58 INFO - 2015-11-18 05:31:58,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 05:32:00 INFO - 2015-11-18 05:32:00,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 265269248 05:32:00 INFO - 2015-11-18 05:32:00,254 DEBUG : BROWSER_OUTPUT: 05:35:02 INFO - 2015-11-18 05:35:02,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 05:35:03 INFO - 2015-11-18 05:35:03,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 270708736 05:35:03 INFO - 2015-11-18 05:35:03,013 DEBUG : BROWSER_OUTPUT: 05:38:04 INFO - 2015-11-18 05:38:04,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 05:38:05 INFO - 2015-11-18 05:38:05,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 273506304 05:38:05 INFO - 2015-11-18 05:38:05,364 DEBUG : BROWSER_OUTPUT: 05:41:07 INFO - 2015-11-18 05:41:07,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 05:41:07 INFO - 2015-11-18 05:41:07,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 278327296 05:41:07 INFO - 2015-11-18 05:41:07,659 DEBUG : BROWSER_OUTPUT: 05:44:10 INFO - 2015-11-18 05:44:10,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 05:44:10 INFO - 2015-11-18 05:44:10,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 284491776 05:44:10 INFO - 2015-11-18 05:44:10,792 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 05:47:13 INFO - 2015-11-18 05:47:13,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 289468416 05:47:13 INFO - 2015-11-18 05:47:13,452 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,453 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:47:13 INFO - 2015-11-18 05:47:13,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:47:13 INFO - 2015-11-18 05:47:13,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:47:13 INFO - 2015-11-18 05:47:13,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:47:13 INFO - 2015-11-18 05:47:13,453 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2983.8806447742104;3047.2077259912444;3154.936901261975;3195.9680403195966;3272.5418441418205;5089.974550127245;5105.948940510594;5136.5633921116705;5169.276301317814;5233.816816411427;4919.991401762639;5017.698938063719;5059.06407314647;5073.112205364056;5144.408393034802;4721.740304283272;4746.121967436018;4816.83141090062;4841.757912104398;4922.286268491067;4702.952970470285;4745.928811067837;4761.47623761386;4773.06925149596;4789.353437285957;4552.4764652065105;4622.237330840408;4688.179568575486;4755.191617425046;4760.381150450454;4754.405699287589;4780.641451891122;4788.18600837855;4815.446223684286;4863.8297659582095;4676;4736.3369128322065;4757.833475828364;4800.927986080212;4825.986542826011;4851.27230915362;4901.950980490221;5028.698278103326;5106.157484015133;5119.052975199563;5490.149026900836;5496.725163741797;5508.118701007819;5520.254765606632;5532.336119665626;5391.892162156735;5580.832575022756;5598.328200615912;5626.268585083953;5638.182463542763;5020.221865610873;5051.520105589963;5072.797088116434;5072.923906141411;5122.871928201825;5640.182173584807;5658.91511627326;5664.745086471119;5685.090385538294;5719.7426115824055;5110.897782044338;5241.397239317451;5439.728013599304;5444.373897001817;5494.917576236359;5420.24116623673;5541;5601.579881508903;5603.579731520153;5650.152477128381;5429.647072940246;5448.291722076184;5468.835934921959;5476.315460567429;5477.643953143033;5329.626926115135;5421.83734487966;5483.341998960151;5495.835124946258;5550.27846379968;4257.510386305553;4260.829566817292;4268.210381079511;4291.31338985767;4315.6763242756915;3869.7484663496784;3878.825452854628;3886.9222615548097;3904.1606054698377;3921.392184211452;5011.974940125276;5097.847064588068;5165.793368265227;5167.715775632376;5296.973515132399;5627.971860140673;5635.887282254414;5637.605367624227;5638.4925356718095;5640.605157639008;5266.052110620049;5269.077911365495;5274.472552744694;5285.31290932184;5302.496262855023;4713.2458806590785;4797.808087676523;4817.927731084036;4843.975780121147;4918;5684.175794509855;5696.54427645779;5733.3406658234835;5743.59794814359;5773.076307790733;5427.565794736491;5585.553155747449;5601.80393686219;5601.915971260353;5649.096144616841;5646.407127251579;5689.487946084707;5698;5702.8289151325525;5793.449622285876;5497;5505.256790333254;5512.035393806148;5528.06022976103;5531.917021244604;5413.539849112712;5564.054110801093;5584.357798853021;5594.664320140804;5605.355384130877;5039.773210205476;5260.500252476008;5337;5342.9198562022375;5420.241166236809;5442.918356224739;5448.155535891943;5454.427285135003;5464.972675136599;5497.532709719559;5029.27075574047;5147.58819294448;5182.559482444034;5332.68003919766;5342.0384330820825;5344.171653393731;5351.3043304370185;5358.732063396893;5377.784888604569;5379.892402151857;5284.524392804666;5287.841364759063;5288.074586947346;5296.867578310573;5307.920381194363 05:47:13 INFO - 2015-11-18 05:47:13,455 DEBUG : BROWSER_OUTPUT: |1;ext.html;530.157050290039;530.631211308141;538.7360193505182;549.9037668408027;555.7026990560051;37497.62502374975;38511.422328665096;38667.80666096673;38698.80650596746;38731.419028714525;40924.59075409245;41040;41048.794756026175;41080.17839643213;41247.38128928068;8677.566121693922;8904.777380565472;8911.509866957314;8959.641614335418;9002.189802917736;8709.43388679737;8775.64897404103;8838.690645827397;8848.690295839648;8864.911350886505;8736.301095912311;8811.691590794324;8856.51289179095;8877;8927.776805579848;8748.25639820616;8852.159044890725;8862.423942443786;8885.422447540921;8906.376553641248;8662.956685216597;8802.339824513123;8810.427322224035;8854.86717699235;8861.379703420764;37106;37175.81412092949;37200.62799371999;37325.626743732486;37647.4352884707;2516.3709072731817;2724.428113083117;2889.653241610999;3111.1910903165112;3515.9979405869462;26053.60919586208;26594;26608.866955665097;27208.727912720817;27685.307867303276;2329.2895666821614;2335.497867958397;2350.5063936573342;2352.741198468167;2457.5453541094776;223693;223802;225790;226751;394845;57866;57994.4200557989;58398.708006459696;58420.7078964611;58616.70691646515;62411;62491.375086248554;62621;62665.686671567266;62772.68613656903;16161;16372.345106195618;16379.672406551803;16389.67220655604;16393.262303196385;12284.14011019238;12525.498980040697;12584;12584.37078146089;12594.748105037848;19452.416427507196;19774.110165042606;19778.406647800588;19785;19818.70271945922;8484.236418722345;8686.95656521726;8706.695265665672;8722.215000649972;8790.956045219733;888.9244414224734;935.742670765545;989.2036910287144;1010.9747256318651;1095.2606990281529;27225.183244502696;30211.546826797614;30636.54045189324;30858.845705771328;30928.226794330323;954.8090381923643;970.1753509516996;1026.4046852825493;1038.8026275007876;1127.3517727306667;13454.596362109152;13961.964580826547;14172.433102675983;14195.148291102567;14211.92894035544;368451;381656;382132;382208;386116;52133.218001730005;52627.73686131545;52969.73515132477;53065.2040219397;53088;1291.438224372401;1309.0640192262579;1309.1294289297512;1324.0202250334683;1337.9665508362368;26179.607305890047;26482.735172648026;26756.331091722863;26757.19728408073;26823.463530729667;43036.569634303254;43891.34162987622;43918.780406097765;43933.56066439295;44471.33293000672;262313;263260;264517;264641;264914;31194;42205.366919496846;44114.779426102665;44122;44205.33691994687;40176.598234017285;41328.79335603303;41343.37984930168;41506.58493415027;42025.78987105045;35007;35061.64938350686;35231.47152792659;35298.64701352954;35567;34937.30125397529;34984.650153498136;35024.64975350316;35201.82399087988;35246.64753352536;34361;34912;35090.649093508735;35100.94697159089;35585;29733;31323.84338078295;31381.529277060406;31448.685513144577;31507.84246078755;23516.76483235146;23576.29271121869;23701.170459033852;23733.52532949366;23797.405064873517 05:47:13 INFO - 2015-11-18 05:47:13,456 DEBUG : BROWSER_OUTPUT: |2;jquery.html;320.98395080245984;327.4400774675305;327.988520401786;329.37090157798593;333.9448990916499;11682.591109311175;12098.576549820758;16214.351425942963;16998.20071971212;18293.45119646411;11518.424078796048;11600.767984640303;11626.883731162687;11743.119266055037;11986.640400787968;4275.5724427557225;4347.60871521563;4356.150550642626;4402.25161722508;4407.427034485512;4308.138372325532;4411.316245981878;4588.701734387254;4613.8154473821005;4617.976910115444;4291.141771645668;4484.23767959446;4541.114482675879;4552.499225085238;4616.469106052813;4413.271810151337;4437.1125774844995;4439.711418757771;4471;4506.684532082755;3718.9070273243115;3793.2982398256413;3822.751521151144;3825.7895815730126;3843.461915331856;12713.237205767591;12941.352932353344;12964;13218.66953326165;13249.337533123306;1858.210260639223;1870.635226130905;1883.8304552590332;1999.530110424049;2011.5474018345901;9155.542222888895;9244.537773111317;9568.473733944631;9597.712068637951;9689.806203875953;1534.3172288331698;1557.3692654474955;1597.456864666019;1601.2474137155518;1632.2817960097518;53878.73060634672;55949.160762589;56130.43869561293;56298.43701563014;56876.43123568753;6260.40526150015;6318.273398559225;6362.9045564316575;6383.425491705769;6451.548391612542;7238.638068096574;7258.745943891939;7268.636568171571;7278.818029549304;7394.334509894135;5314.202869569595;5326.6005049621435;5364;5380.192971054373;5381.165919282517;5761.567882408836;5792.82621521355;5795.304563452412;5800.970995145081;5825.533957283407;2854.685984541699;2873.0088119598704;2881.697421770684;2896.5075937090746;2904.8111872728628;1005.6681295172575;1018.4856647393167;1019.3476175247847;1031.7626945802358;1075.4085253110914;395.7605648582566;399.0243853777486;402.9844791126345;404.33486914026264;426.14770459081836;9749.658761943298;10181.083702466814;10244.078032976919;10400.687979360631;10540;441.4239417560051;451.99431265434805;454.8908262017158;464.4194756554307;465.1882465098425;5795.8551036224435;5965.433283838029;5990.64056156632;6026.306974697878;6059.121427393092;505099;508186;518735;524257;524496;69908.3009169912;71703.28296716967;71729.2827071733;71804.64097679582;72941.63529182426;491.0424671889829;492.67237287204324;493.29705170132416;494.7427337784332;496.0624419846493;10163.847542286723;10303.690889273334;10322.896771032194;10364.844527332247;10421.166306695597;32094.83952580222;32235.677643224204;32279.193020174684;32311.51532727058;32625.510617341235;47508;47841.760791197215;47954;48209.75895120642;48518;5954.136650185612;6100.603460775035;6133.233345831771;6134.9079763804475;6146.477549408351;10612.363258204532;11246.718832029264;11341.886581134413;11470.483828227583;11714.414279286171;9416.670416535388;9750.60997560118;9763.365381250196;9811.80376392454;9917.206623470249;9223.49270790113;9240.676576319796;9466.668666596635;9717.80564388694;9839.311248212844;9729.85405218908;9898.752531186778;9958.302918795614;9977.151942084714;10106.545205465625;5898.852528686817;5926.318473375617;5995.520358371407;5998.190244316961;6026.819195424145;9799.461029643153;9929.304948653526;10051.798964020825;10074.798504029732;10129.746756331151 05:47:13 INFO - 2015-11-18 05:47:13,460 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1298.6688394459418;1337.8193943817594;1338.0299283019813;1669.7328427451607;1724.2327164411843;6911.274316196802;7121;7189;7303.963480182599;7327.596982165979;6809.863802723955;6871.312868713127;6893.069435626189;6902.17173939128;6954.895676564843;2113.6089823382645;2145.6996020557135;2151.7202763640703;2158.6006588781047;2160.8703477791382;2140.283005193262;2173.282816670495;2207.9448013799624;2217.966730499044;2218.5895609312247;2084.062172022588;2103.7159983402275;2120.268507364957;2123.819475344598;2127.4362293992103;2099.653557163066;2179.6730490426403;2191.463091542574;2191.8465707400487;2195.868247905115;2162.4485756132085;2165.1339464214284;2172.011734660726;2173.1307477009323;2175.2277941330917;7113.964430177816;7187.532810367362;7213.603251821148;7218.494705370626;7230.60231687257;4510.21071312519;4603.148417542765;4603.171429142753;4616.0767846430845;4647;2699.85150816705;2704.580789977557;2733.3986522964915;2758.613794068832;2778.763805076571;882.1355072029382;894.8657701344786;908.4231512989234;927.0266220468549;930.4370855632312;9329;9457.716268511957;9469.952650236704;9526.095020973065;9537.618495260182;4120.587941205916;4184.5187803403;4253.468316460442;4269.210196113729;4285.185814695198;8396.874046889301;8399.832003360021;8427.873581896276;8435.283000944866;8473.449225800427;4582.175208462509;4602.194615942197;4628.213203755369;4630.351750754897;4631.143238500888;4220.683448741295;4246.129543443587;4257.978710106491;4274.358846173037;4275.315949448073;3359.983200083984;3448.3620530201993;3450.068481509978;3455.395305821471;3456.70617997468;1097.7694684116425;1118.5022664914197;1120.2998126171144;1127.4419162514607;1131.2025022359383;1032.5714828346302;1034.3483605328595;1155.566662501562;1168.742876567171;1227.4415141110774;6783.3555812197765;6836.316368363124;6840.281770414035;6847.383735463733;6855.143107111611;1077.6874706335232;1105.0929508164222;1110.4225802582612;1118.1278602689915;1126.8422420861086;5386.811461598825;5409.269748583891;5435.211894275387;5439.700816455053;5482.506574408322;8041.718539851077;8146.0632027317615;8159.836803263902;8212.630431630472;8394.286485648667;8275.668973241123;8313.750587482386;8352.12302708219;8418.621162047722;8428.578571071545;6571.178602674666;6614.636195009224;6700.6984685688285;6754.257031726506;6759.391654750998;6647.833804154935;6697.263301036979;6718.764843230463;6781.050652908695;6799.456043516408;7258.3104605062435;7403.5928023959195;7485.625718713934;7522.6614802335125;7652.923470765444;7510.474266801271;7668.693252269847;7707.961460192663;7756.767296981099;7813.687452501837;6279.560430769802;6361.809145725636;6365.204349456318;6365.840853978502;6417.2620148681635;6633.535652504278;6754.527183097136;6807.047013418224;6812.0122582226295;6828.419584335387;6288.465480434214;6314.747410103544;6406.775762848278;6426.646534440463;6445.097686323825;5664.716764161858;6256.249250089836;6288.11966324724;6342.619442833445;6381.8085457436355;6414.326495718069;6445.516586255956;6462.4506916910705;6471.288158302677;6502.73989040452;5861.413858614104;5866.6186697864505;5870.972579798604;5878.500327472213;5881.117832325014;5933.2880054393745;5967.194428752063;5970.910436343372;5976.193213916065;6022.488088512526 05:47:13 INFO - 2015-11-18 05:47:13,461 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.444388990093;306.7377392329558;311.05749578776306;311.5015974440893;311.995320070199;6136.969315153429;6150.231221097363;6166.753329866806;6298.779542716006;6306.6846657667165;6075.726592303346;6149.692515374236;6190.938090619093;6191.288001879785;6271.623702577837;4466.151431228072;4589.954100458986;4597.356370108188;4613.008203236303;4640.559146881041;4581.106684196583;4604.746738929358;4612.677112602119;4622.6070783983405;4649.837255696051;4538.205813982557;4553.066621342617;4553.317002449642;4565.520620334867;4587.42657167854;4521.59305662492;4529.682922195448;4542.863714088583;4554.407926969506;4618.584327410549;3813.161104556993;3886.902827429337;3890.0858298299877;3909.159530700913;3928.8035598219976;5916.4675179233645;5930.584859059867;6012.819615411545;6093.756249750005;6099.6950152492645;5152.665076770036;5161.7161056141895;5163.1480805667015;5177.37871455424;5234.136367499358;6432.871342573122;6446;6500.4799616030605;6502.674866256668;6523;4149.564295748964;4216.114615930658;4232.32282834745;4241.088166044285;4249.553796851317;6692.397684208445;6754.9662251688915;6775.4918381121615;6791.3208679132185;6855.794326170173;4295.82816687329;4296.3555466680245;4298.828046878152;4304.978475107604;4313.029568347097;4368.759718215529;4372.519022907478;4381.014271788886;4381.890452738707;4384.649228061748;5017.774200161001;5125.897482050338;5129.615278854101;5131.743412829418;5164.741762911839;6452.290248072708;6459;6486.4486518646445;6493.805185844338;6523.902141467882;1524.9161296128598;1540.7996960395076;1542.3753379881166;1551.8525740054677;1554.7901033360351;979.485769970771;988.8516722491684;998.8901220865699;1001.2640709078821;1006.8741407324085;6160.722767475474;6188.8762224755255;6192.195014648067;6215.098810672427;6250.281217659936;6712.127423434922;6749.156355455568;6771.762988295484;6780.457563394916;6847.383735463832;6007.729652165663;6181.227346581677;6202.751889924352;6211.9689401553605;6227.844303892439;3632.2735452909524;3675.283319752676;3678.576963649161;3681.5950245472977;3691.9261614768093;6875.243723190445;6944.826379340557;7048.365647091787;7052.717891284394;7090.787276381717;6952.374286314155;7000.824979375557;7038.3665470107935;7055.611941343275;7066.222715501291;6829.829254268584;7028.297170283033;7035.401990830836;7095.609741464165;7117.074780278531;6798.490113241428;6799.660016999229;6810.965945170243;6851.383375496229;6885.208201056943;6607.141071660653;6617.966910165418;6626.867462650624;6690.29751876046;6694.263631000488;6826.180858296838;7016;7079.1505019398;7094;7112.644367781487;4282.80727367263;4337;4338.913221735611;4364.08354245612;4369.300911854215;6722.193336799615;6728.764493242713;6734.427573656294;6747.797566073025;6800.625965571941;6383.553151279366;6477.514186435942;6519.152510173647;6523.967380163259;6568.47452203813;6482.384173503509;6510.609363438209;6520.510961677798;6565.540412171294;6565.737370505318;6321.52588555851;6331.366863313632;6355.1420558224045;6406.391392817675;6407.775727849503;6337.9366206337345;6506.707198176188;6527.2167339919515;6595.1096601958125;6624.768133115318;6407.231132264158;6437.839054023687;6441.516886233645;6456.903146452713;6469.5794773339585 05:47:13 INFO - 2015-11-18 05:47:13,464 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.5584009993754;720.3408880874;725.8983742276082;743.9070116235469;767.3707559800964;12571.685707857308;12653.240805551673;12765.489380424784;12890.613281601556;12915.547955821548;12584.370781460937;12597.370131493435;12643.051771117158;12751.426185821638;12768.233905965648;675.8850995330781;677.9796606101825;811.9594020298991;826.3348004856089;852.3011130872687;784.4430454377399;812.4800127918107;822.6421506644599;823.2467292427422;825.8678611422174;900.6622516556291;905.85053466178;909.5725009245677;911.968081117161;913.1051569461931;873.7378786364065;900.9549522523847;901.3915606965338;901.8106197698426;901.9098090190961;653.9373518033196;658.1378394303478;658.720043981306;660.1088530483856;670.7082419147687;13000.479980800757;13145.802812957812;13166.210027398387;13166.539171128965;13191.208527488285;11010.724731881686;11163.265000075033;11407.942960285229;11448.484818183202;11460.14048946324;9024.954875225647;9045.231155351803;9088.363814532986;9231;9470.431774093577;3123.9687603123907;3198.8880389186265;3251.9349613007607;3351;3355.429576971896;46489.53510464886;46561.767191163824;46781.06437871223;46861.76569117167;46900.06199875983;8410.621522031523;8519.488830670056;8550.572471376407;8602.397832151815;9163.358564900527;11438.256513326607;11593.304401735923;11599.536018559163;11683.941580292045;18597.16312765929;5668.0647693130995;5780;5856.443637854397;5873.941260587425;5990.430909063632;3495.580530336325;3548.9467657984633;3571.535700358989;3577.7853328800356;3637.927241455209;2652.1910817200937;2687.3953360494124;2690.8250963687296;2696.703362630109;2709;355.2787840683417;363.7599184538245;363.93994990826747;368.7234574069448;368.85614610302;465.4437946653716;486.05324762924573;500.39202369120966;544.863958646227;566.8724536979147;7313.853722925512;7501.399888008947;7577.280158384945;7794.41541884361;7839.608019598997;561.9775208991595;573.3893403525233;583.7110630238059;592.8932792097464;596.2904144068544;3538.929221415557;3614.2590768892314;3647.343478173901;3743.831527581265;3780.4707340972286;56852.71573642105;56941.14588281179;57506;58728.41271587315;59360.40639593635;47265.5273447268;47673.76163119232;48339.27491087637;49163.01673966572;50303;45423.31865021961;45477.77261113739;45924.770376148575;46352.07295854064;46393.7680311603;7560.8487830244185;7662.118856331594;7769.417293702882;7817.843643126992;8167.83664326722;33153.83423082869;33290.334193316485;33592.32815343728;33863.49204761881;34208.82895585506;45101.54898450973;45553;45780.77109614431;45891.77054114708;46343;6679.131712877489;6781.6270105144695;6808.863822723617;6943.236244013054;7007.509474336747;10526.263161578616;10661.360318380923;10902.618408355669;11089.778204436028;11606.361650109326;9667.564959576977;9751.268654850772;9983.351082179635;10072.54673539707;10424.947875260576;9512.667056652985;9616.75958101053;9628.855567166358;9677.758056048655;10487.790244195226;8168.183181681784;8346.666133354598;9637.662681806383;9832.967538408364;9850.556724947537;8070.1122876484715;8220.095789463274;8419;8449.197326253996;8734.868976965477;8153.22544358285;8257.339412846837;8264.917350826414;8604.268637165911;8712.520811355436 05:47:13 INFO - 2015-11-18 05:47:13,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:47:13 INFO - 2015-11-18 05:47:13,465 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:47:13 INFO - 2015-11-18 05:47:13,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,286 05:47:13 INFO - 2015-11-18 05:47:13,465 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:47:13 INFO - 2015-11-18 05:47:13,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1447854433449__endTimestamp 05:47:13 INFO - 2015-11-18 05:47:13,465 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,465 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:47:13 INFO - 2015-11-18 05:47:13,466 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:47:13 INFO - 2015-11-18 05:47:13,466 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,466 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5136.24 Median:5288.07 stddev:552.50 (10.4%) stddev-sans-first:527.77 05:47:13 INFO - 2015-11-18 05:47:13,466 DEBUG : BROWSER_OUTPUT: Values: 2983.9 3047.2 3154.9 3196.0 3272.5 5090.0 5105.9 5136.6 5169.3 5233.8 4920.0 5017.7 5059.1 5073.1 5144.4 4721.7 4746.1 4816.8 4841.8 4922.3 4703.0 4745.9 4761.5 4773.1 4789.4 4552.5 4622.2 4688.2 4755.2 4760.4 4754.4 4780.6 4788.2 4815.4 4863.8 4676.0 4736.3 4757.8 4800.9 4826.0 4851.3 4902.0 5028.7 5106.2 5119.1 5490.1 5496.7 5508.1 5520.3 5532.3 5391.9 5580.8 5598.3 5626.3 5638.2 5020.2 5051.5 5072.8 5072.9 5122.9 5640.2 5658.9 5664.7 5685.1 5719.7 5110.9 5241.4 5439.7 5444.4 5494.9 5420.2 5541.0 5601.6 5603.6 5650.2 5429.6 5448.3 5468.8 5476.3 5477.6 5329.6 5421.8 5483.3 5495.8 5550.3 4257.5 4260.8 4268.2 4291.3 4315.7 3869.7 3878.8 3886.9 3904.2 3921.4 5012.0 5097.8 5165.8 5167.7 5297.0 5628.0 5635.9 5637.6 5638.5 5640.6 5266.1 5269.1 5274.5 5285.3 5302.5 4713.2 4797.8 4817.9 4844.0 4918.0 5684.2 5696.5 5733.3 5743.6 5773.1 5427.6 5585.6 5601.8 5601.9 5649.1 5646.4 5689.5 5698.0 5702.8 5793.4 5497.0 5505.3 5512.0 5528.1 5531.9 5413.5 5564.1 5584.4 5594.7 5605.4 5039.8 5260.5 5337.0 5342.9 5420.2 5442.9 5448.2 5454.4 5465.0 5497.5 5029.3 5147.6 5182.6 5332.7 5342.0 5344.2 5351.3 5358.7 5377.8 5379.9 5284.5 5287.8 5288.1 5296.9 5307.9 05:47:13 INFO - 2015-11-18 05:47:13,466 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,466 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46883.67 Median:202778.50 stddev:81154.37 (40.0%) stddev-sans-first:81307.40 05:47:13 INFO - 2015-11-18 05:47:13,468 DEBUG : BROWSER_OUTPUT: Values: 530.2 530.6 538.7 549.9 555.7 37497.6 38511.4 38667.8 38698.8 38731.4 40924.6 41040.0 41048.8 41080.2 41247.4 8677.6 8904.8 8911.5 8959.6 9002.2 8709.4 8775.6 8838.7 8848.7 8864.9 8736.3 8811.7 8856.5 8877.0 8927.8 8748.3 8852.2 8862.4 8885.4 8906.4 8663.0 8802.3 8810.4 8854.9 8861.4 37106.0 37175.8 37200.6 37325.6 37647.4 2516.4 2724.4 2889.7 3111.2 3516.0 26053.6 26594.0 26608.9 27208.7 27685.3 2329.3 2335.5 2350.5 2352.7 2457.5 223693.0 223802.0 225790.0 226751.0 394845.0 57866.0 57994.4 58398.7 58420.7 58616.7 62411.0 62491.4 62621.0 62665.7 62772.7 16161.0 16372.3 16379.7 16389.7 16393.3 12284.1 12525.5 12584.0 12584.4 12594.7 19452.4 19774.1 19778.4 19785.0 19818.7 8484.2 8687.0 8706.7 8722.2 8791.0 888.9 935.7 989.2 1011.0 1095.3 27225.2 30211.5 30636.5 30858.8 30928.2 954.8 970.2 1026.4 1038.8 1127.4 13454.6 13962.0 14172.4 14195.1 14211.9 368451.0 381656.0 382132.0 382208.0 386116.0 52133.2 52627.7 52969.7 53065.2 53088.0 1291.4 1309.1 1309.1 1324.0 1338.0 26179.6 26482.7 26756.3 26757.2 26823.5 43036.6 43891.3 43918.8 43933.6 44471.3 262313.0 263260.0 264517.0 264641.0 264914.0 31194.0 42205.4 44114.8 44122.0 44205.3 40176.6 41328.8 41343.4 41506.6 42025.8 35007.0 35061.6 35231.5 35298.6 35567.0 34937.3 34984.7 35024.6 35201.8 35246.6 34361.0 34912.0 35090.6 35100.9 35585.0 29733.0 31323.8 31381.5 31448.7 31507.8 23516.8 23576.3 23701.2 23733.5 23797.4 05:47:13 INFO - 2015-11-18 05:47:13,468 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,468 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25490.43 Median:4546.81 stddev:84630.61 (1861.3%) stddev-sans-first:84846.92 05:47:13 INFO - 2015-11-18 05:47:13,468 DEBUG : BROWSER_OUTPUT: Values: 321.0 327.4 328.0 329.4 333.9 11682.6 12098.6 16214.4 16998.2 18293.5 11518.4 11600.8 11626.9 11743.1 11986.6 4275.6 4347.6 4356.2 4402.3 4407.4 4308.1 4411.3 4588.7 4613.8 4618.0 4291.1 4484.2 4541.1 4552.5 4616.5 4413.3 4437.1 4439.7 4471.0 4506.7 3718.9 3793.3 3822.8 3825.8 3843.5 12713.2 12941.4 12964.0 13218.7 13249.3 1858.2 1870.6 1883.8 1999.5 2011.5 9155.5 9244.5 9568.5 9597.7 9689.8 1534.3 1557.4 1597.5 1601.2 1632.3 53878.7 55949.2 56130.4 56298.4 56876.4 6260.4 6318.3 6362.9 6383.4 6451.5 7238.6 7258.7 7268.6 7278.8 7394.3 5314.2 5326.6 5364.0 5380.2 5381.2 5761.6 5792.8 5795.3 5801.0 5825.5 2854.7 2873.0 2881.7 2896.5 2904.8 1005.7 1018.5 1019.3 1031.8 1075.4 395.8 399.0 403.0 404.3 426.1 9749.7 10181.1 10244.1 10400.7 10540.0 441.4 452.0 454.9 464.4 465.2 5795.9 5965.4 5990.6 6026.3 6059.1 505099.0 508186.0 518735.0 524257.0 524496.0 69908.3 71703.3 71729.3 71804.6 72941.6 491.0 492.7 493.3 494.7 496.1 10163.8 10303.7 10322.9 10364.8 10421.2 32094.8 32235.7 32279.2 32311.5 32625.5 47508.0 47841.8 47954.0 48209.8 48518.0 5954.1 6100.6 6133.2 6134.9 6146.5 10612.4 11246.7 11341.9 11470.5 11714.4 9416.7 9750.6 9763.4 9811.8 9917.2 9223.5 9240.7 9466.7 9717.8 9839.3 9729.9 9898.8 9958.3 9977.2 10106.5 5898.9 5926.3 5995.5 5998.2 6026.8 9799.5 9929.3 10051.8 10074.8 10129.7 05:47:13 INFO - 2015-11-18 05:47:13,468 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,469 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5024.76 Median:6139.37 stddev:2507.17 (40.8%) stddev-sans-first:2498.56 05:47:13 INFO - 2015-11-18 05:47:13,470 DEBUG : BROWSER_OUTPUT: Values: 1298.7 1337.8 1338.0 1669.7 1724.2 6911.3 7121.0 7189.0 7304.0 7327.6 6809.9 6871.3 6893.1 6902.2 6954.9 2113.6 2145.7 2151.7 2158.6 2160.9 2140.3 2173.3 2207.9 2218.0 2218.6 2084.1 2103.7 2120.3 2123.8 2127.4 2099.7 2179.7 2191.5 2191.8 2195.9 2162.4 2165.1 2172.0 2173.1 2175.2 7114.0 7187.5 7213.6 7218.5 7230.6 4510.2 4603.1 4603.2 4616.1 4647.0 2699.9 2704.6 2733.4 2758.6 2778.8 882.1 894.9 908.4 927.0 930.4 9329.0 9457.7 9470.0 9526.1 9537.6 4120.6 4184.5 4253.5 4269.2 4285.2 8396.9 8399.8 8427.9 8435.3 8473.4 4582.2 4602.2 4628.2 4630.4 4631.1 4220.7 4246.1 4258.0 4274.4 4275.3 3360.0 3448.4 3450.1 3455.4 3456.7 1097.8 1118.5 1120.3 1127.4 1131.2 1032.6 1034.3 1155.6 1168.7 1227.4 6783.4 6836.3 6840.3 6847.4 6855.1 1077.7 1105.1 1110.4 1118.1 1126.8 5386.8 5409.3 5435.2 5439.7 5482.5 8041.7 8146.1 8159.8 8212.6 8394.3 8275.7 8313.8 8352.1 8418.6 8428.6 6571.2 6614.6 6700.7 6754.3 6759.4 6647.8 6697.3 6718.8 6781.1 6799.5 7258.3 7403.6 7485.6 7522.7 7652.9 7510.5 7668.7 7708.0 7756.8 7813.7 6279.6 6361.8 6365.2 6365.8 6417.3 6633.5 6754.5 6807.0 6812.0 6828.4 6288.5 6314.7 6406.8 6426.6 6445.1 5664.7 6256.2 6288.1 6342.6 6381.8 6414.3 6445.5 6462.5 6471.3 6502.7 5861.4 5866.6 5871.0 5878.5 5881.1 5933.3 5967.2 5970.9 5976.2 6022.5 05:47:13 INFO - 2015-11-18 05:47:13,470 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,470 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5393.37 Median:6213.53 stddev:1702.65 (27.4%) stddev-sans-first:1664.04 05:47:13 INFO - 2015-11-18 05:47:13,472 DEBUG : BROWSER_OUTPUT: Values: 304.4 306.7 311.1 311.5 312.0 6137.0 6150.2 6166.8 6298.8 6306.7 6075.7 6149.7 6190.9 6191.3 6271.6 4466.2 4590.0 4597.4 4613.0 4640.6 4581.1 4604.7 4612.7 4622.6 4649.8 4538.2 4553.1 4553.3 4565.5 4587.4 4521.6 4529.7 4542.9 4554.4 4618.6 3813.2 3886.9 3890.1 3909.2 3928.8 5916.5 5930.6 6012.8 6093.8 6099.7 5152.7 5161.7 5163.1 5177.4 5234.1 6432.9 6446.0 6500.5 6502.7 6523.0 4149.6 4216.1 4232.3 4241.1 4249.6 6692.4 6755.0 6775.5 6791.3 6855.8 4295.8 4296.4 4298.8 4305.0 4313.0 4368.8 4372.5 4381.0 4381.9 4384.6 5017.8 5125.9 5129.6 5131.7 5164.7 6452.3 6459.0 6486.4 6493.8 6523.9 1524.9 1540.8 1542.4 1551.9 1554.8 979.5 988.9 998.9 1001.3 1006.9 6160.7 6188.9 6192.2 6215.1 6250.3 6712.1 6749.2 6771.8 6780.5 6847.4 6007.7 6181.2 6202.8 6212.0 6227.8 3632.3 3675.3 3678.6 3681.6 3691.9 6875.2 6944.8 7048.4 7052.7 7090.8 6952.4 7000.8 7038.4 7055.6 7066.2 6829.8 7028.3 7035.4 7095.6 7117.1 6798.5 6799.7 6811.0 6851.4 6885.2 6607.1 6618.0 6626.9 6690.3 6694.3 6826.2 7016.0 7079.2 7094.0 7112.6 4282.8 4337.0 4338.9 4364.1 4369.3 6722.2 6728.8 6734.4 6747.8 6800.6 6383.6 6477.5 6519.2 6524.0 6568.5 6482.4 6510.6 6520.5 6565.5 6565.7 6321.5 6331.4 6355.1 6406.4 6407.8 6337.9 6506.7 6527.2 6595.1 6624.8 6407.2 6437.8 6441.5 6456.9 6469.6 05:47:13 INFO - 2015-11-18 05:47:13,472 DEBUG : BROWSER_OUTPUT: 05:47:13 INFO - 2015-11-18 05:47:13,472 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12867.72 Median:56896.93 stddev:15864.15 (27.9%) stddev-sans-first:15882.37 05:47:13 INFO - 2015-11-18 05:47:13,473 DEBUG : BROWSER_OUTPUT: Values: 706.6 720.3 725.9 743.9 767.4 12571.7 12653.2 12765.5 12890.6 12915.5 12584.4 12597.4 12643.1 12751.4 12768.2 675.9 678.0 812.0 826.3 852.3 784.4 812.5 822.6 823.2 825.9 900.7 905.9 909.6 912.0 913.1 873.7 901.0 901.4 901.8 901.9 653.9 658.1 658.7 660.1 670.7 13000.5 13145.8 13166.2 13166.5 13191.2 11010.7 11163.3 11407.9 11448.5 11460.1 9025.0 9045.2 9088.4 9231.0 9470.4 3124.0 3198.9 3251.9 3351.0 3355.4 46489.5 46561.8 46781.1 46861.8 46900.1 8410.6 8519.5 8550.6 8602.4 9163.4 11438.3 11593.3 11599.5 11683.9 18597.2 5668.1 5780.0 5856.4 5873.9 5990.4 3495.6 3548.9 3571.5 3577.8 3637.9 2652.2 2687.4 2690.8 2696.7 2709.0 355.3 363.8 363.9 368.7 368.9 465.4 486.1 500.4 544.9 566.9 7313.9 7501.4 7577.3 7794.4 7839.6 562.0 573.4 583.7 592.9 596.3 3538.9 3614.3 3647.3 3743.8 3780.5 56852.7 56941.1 57506.0 58728.4 59360.4 47265.5 47673.8 48339.3 49163.0 50303.0 45423.3 45477.8 45924.8 46352.1 46393.8 7560.8 7662.1 7769.4 7817.8 8167.8 33153.8 33290.3 33592.3 33863.5 34208.8 45101.5 45553.0 45780.8 45891.8 46343.0 6679.1 6781.6 6808.9 6943.2 7007.5 10526.3 10661.4 10902.6 11089.8 11606.4 9667.6 9751.3 9983.4 10072.5 10424.9 9512.7 9616.8 9628.9 9677.8 10487.8 8168.2 8346.7 9637.7 9833.0 9850.6 8070.1 8220.1 8419.0 8449.2 8734.9 8153.2 8257.3 8264.9 8604.3 8712.5 05:47:13 INFO - 2015-11-18 05:47:13,473 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:47:13 INFO - 2015-11-18 05:47:13,473 DEBUG : BROWSER_OUTPUT: 05:47:14 INFO - 2015-11-18 05:47:14,119 INFO : Browser exited with error code: 0 05:47:14 INFO - 2015-11-18 05:47:14,147 INFO : Completed test dromaeo_css (00:18:33) 05:47:14 INFO - 2015-11-18 05:47:14,147 INFO : Starting test kraken 05:47:14 INFO - 2015-11-18 05:47:14,147 DEBUG : operating with platform_type : mac_ 05:47:14 INFO - 2015-11-18 05:47:14,147 INFO : Initialising browser for kraken test... 05:47:14 INFO - 2015-11-18 05:47:14,160 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpz7cYYy/profile http://localhost:49264/getInfo.html 05:47:17 INFO - 2015-11-18 05:47:17,229 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:47:17 INFO - 2015-11-18 05:47:17,229 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:47:17 INFO - 2015-11-18 05:47:17,229 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:47:17 INFO - 2015-11-18 05:47:17,229 DEBUG : BROWSER_OUTPUT: __metrics 05:47:17 INFO - 2015-11-18 05:47:17,887 INFO : Browser initialized. 05:47:17 INFO - 2015-11-18 05:47:17,887 INFO : Running cycle 1/1 for kraken test... 05:47:17 INFO - 2015-11-18 05:47:17,887 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpz7cYYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:47:29 INFO - 2015-11-18 05:47:29,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 240881664 05:47:29 INFO - 2015-11-18 05:47:29,953 DEBUG : BROWSER_OUTPUT: 05:47:32 INFO - 2015-11-18 05:47:32,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:33 INFO - 2015-11-18 05:47:33,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 258805760 05:47:33 INFO - 2015-11-18 05:47:33,122 DEBUG : BROWSER_OUTPUT: 05:47:35 INFO - 2015-11-18 05:47:35,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 05:47:36 INFO - 2015-11-18 05:47:36,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 267677696 05:47:36 INFO - 2015-11-18 05:47:36,342 DEBUG : BROWSER_OUTPUT: 05:47:39 INFO - 2015-11-18 05:47:39,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 05:47:39 INFO - 2015-11-18 05:47:39,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 267993088 05:47:39 INFO - 2015-11-18 05:47:39,841 DEBUG : BROWSER_OUTPUT: 05:47:41 INFO - 2015-11-18 05:47:41,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 05:47:42 INFO - 2015-11-18 05:47:42,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 268247040 05:47:42 INFO - 2015-11-18 05:47:42,466 DEBUG : BROWSER_OUTPUT: 05:47:44 INFO - 2015-11-18 05:47:44,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:45 INFO - 2015-11-18 05:47:45,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 267804672 05:47:45 INFO - 2015-11-18 05:47:45,186 DEBUG : BROWSER_OUTPUT: 05:47:48 INFO - 2015-11-18 05:47:48,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:48 INFO - 2015-11-18 05:47:48,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 268566528 05:47:48 INFO - 2015-11-18 05:47:48,862 DEBUG : BROWSER_OUTPUT: 05:47:52 INFO - 2015-11-18 05:47:52,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:52 INFO - 2015-11-18 05:47:52,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 266895360 05:47:52 INFO - 2015-11-18 05:47:52,658 DEBUG : BROWSER_OUTPUT: 05:47:55 INFO - 2015-11-18 05:47:55,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 05:47:56 INFO - 2015-11-18 05:47:56,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 266993664 05:47:56 INFO - 2015-11-18 05:47:56,163 DEBUG : BROWSER_OUTPUT: 05:47:57 INFO - 2015-11-18 05:47:57,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:58 INFO - 2015-11-18 05:47:58,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 268357632 05:47:58 INFO - 2015-11-18 05:47:58,340 DEBUG : BROWSER_OUTPUT: 05:48:00 INFO - 2015-11-18 05:48:00,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:00 INFO - 2015-11-18 05:48:00,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 267845632 05:48:00 INFO - 2015-11-18 05:48:00,815 DEBUG : BROWSER_OUTPUT: 05:48:02 INFO - 2015-11-18 05:48:02,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:03 INFO - 2015-11-18 05:48:03,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 268197888 05:48:03 INFO - 2015-11-18 05:48:03,520 DEBUG : BROWSER_OUTPUT: 05:48:06 INFO - 2015-11-18 05:48:06,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:06 INFO - 2015-11-18 05:48:06,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 268402688 05:48:06 INFO - 2015-11-18 05:48:06,736 DEBUG : BROWSER_OUTPUT: 05:48:09 INFO - 2015-11-18 05:48:09,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:10 INFO - 2015-11-18 05:48:10,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 268271616 05:48:10 INFO - 2015-11-18 05:48:10,038 DEBUG : BROWSER_OUTPUT: 05:48:11 INFO - 2015-11-18 05:48:11,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 05:48:12 INFO - 2015-11-18 05:48:12,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 267939840 05:48:12 INFO - 2015-11-18 05:48:12,006 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,006 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:48:12 INFO - 2015-11-18 05:48:12,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:48:12 INFO - 2015-11-18 05:48:12,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;101;108;108;109;117;109;108;110;107 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;133;150;160;129;153;150;127;163;132 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;163;166;166;165;170;174;177;183;179 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;77;65;70;70;71;124;67;74 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;129;86;89;91;124;91;96;139 05:48:12 INFO - 2015-11-18 05:48:12,007 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;115;117;119;130;125;124;124;124;121 05:48:12 INFO - 2015-11-18 05:48:12,008 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;126;128;126;132;137;138;139;136;137;137 05:48:12 INFO - 2015-11-18 05:48:12,008 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;99;106;103;107;104;108;105;106;112;103 05:48:12 INFO - 2015-11-18 05:48:12,008 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;64;64;64;63;63;63;70;63;62 05:48:12 INFO - 2015-11-18 05:48:12,008 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;72;69;71;71;73;71;72;72;75 05:48:12 INFO - 2015-11-18 05:48:12,008 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;87;87;88;88;93;93;94;96;95 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;127;133;132;133;142;147;138;133;136 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;158;157;147;163;172;173;169;170;171 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;73;70;72;73;74;71;73;73;75 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,713 05:48:12 INFO - 2015-11-18 05:48:12,009 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:48:12 INFO - 2015-11-18 05:48:12,010 DEBUG : BROWSER_OUTPUT: __startTimestamp1447854492002__endTimestamp 05:48:12 INFO - 2015-11-18 05:48:12,010 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,010 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:48:12 INFO - 2015-11-18 05:48:12,010 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:48:12 INFO - 2015-11-18 05:48:12,010 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,010 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:108.50 stddev:3.87 (3.6%) stddev-sans-first:4.10 05:48:12 INFO - 2015-11-18 05:48:12,011 DEBUG : BROWSER_OUTPUT: Values: 108.0 101.0 108.0 108.0 109.0 117.0 109.0 108.0 110.0 107.0 05:48:12 INFO - 2015-11-18 05:48:12,011 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,011 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.90 Median:151.00 stddev:13.35 (8.8%) stddev-sans-first:13.91 05:48:12 INFO - 2015-11-18 05:48:12,011 DEBUG : BROWSER_OUTPUT: Values: 152.0 133.0 150.0 160.0 129.0 153.0 150.0 127.0 163.0 132.0 05:48:12 INFO - 2015-11-18 05:48:12,011 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,011 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:170.80 Median:172.00 stddev:6.99 (4.1%) stddev-sans-first:7.09 05:48:12 INFO - 2015-11-18 05:48:12,013 DEBUG : BROWSER_OUTPUT: Values: 165.0 163.0 166.0 166.0 165.0 170.0 174.0 177.0 183.0 179.0 05:48:12 INFO - 2015-11-18 05:48:12,013 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,013 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.30 Median:71.50 stddev:17.10 (23.9%) stddev-sans-first:18.07 05:48:12 INFO - 2015-11-18 05:48:12,013 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 77.0 65.0 70.0 70.0 71.0 124.0 67.0 74.0 05:48:12 INFO - 2015-11-18 05:48:12,013 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,014 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:89.50 stddev:19.99 (22.3%) stddev-sans-first:20.69 05:48:12 INFO - 2015-11-18 05:48:12,014 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 129.0 86.0 89.0 91.0 124.0 91.0 96.0 139.0 05:48:12 INFO - 2015-11-18 05:48:12,014 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,014 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:122.00 Median:124.00 stddev:4.35 (3.5%) stddev-sans-first:4.59 05:48:12 INFO - 2015-11-18 05:48:12,014 DEBUG : BROWSER_OUTPUT: Values: 121.0 115.0 117.0 119.0 130.0 125.0 124.0 124.0 124.0 121.0 05:48:12 INFO - 2015-11-18 05:48:12,015 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,015 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:133.60 Median:137.00 stddev:5.15 (3.8%) stddev-sans-first:4.67 05:48:12 INFO - 2015-11-18 05:48:12,015 DEBUG : BROWSER_OUTPUT: Values: 126.0 128.0 126.0 132.0 137.0 138.0 139.0 136.0 137.0 137.0 05:48:12 INFO - 2015-11-18 05:48:12,015 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,015 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.30 Median:106.50 stddev:3.47 (3.3%) stddev-sans-first:2.83 05:48:12 INFO - 2015-11-18 05:48:12,015 DEBUG : BROWSER_OUTPUT: Values: 99.0 106.0 103.0 107.0 104.0 108.0 105.0 106.0 112.0 103.0 05:48:12 INFO - 2015-11-18 05:48:12,016 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,016 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:2.21 (3.5%) stddev-sans-first:2.35 05:48:12 INFO - 2015-11-18 05:48:12,016 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 63.0 63.0 63.0 70.0 63.0 62.0 05:48:12 INFO - 2015-11-18 05:48:12,016 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,016 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:1.55 (2.2%) stddev-sans-first:1.64 05:48:12 INFO - 2015-11-18 05:48:12,016 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 69.0 71.0 71.0 73.0 71.0 72.0 72.0 75.0 05:48:12 INFO - 2015-11-18 05:48:12,017 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,017 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:93.00 stddev:3.71 (4.0%) stddev-sans-first:3.67 05:48:12 INFO - 2015-11-18 05:48:12,017 DEBUG : BROWSER_OUTPUT: Values: 87.0 87.0 87.0 88.0 88.0 93.0 93.0 94.0 96.0 95.0 05:48:12 INFO - 2015-11-18 05:48:12,017 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,017 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:134.50 stddev:5.74 (4.3%) stddev-sans-first:5.96 05:48:12 INFO - 2015-11-18 05:48:12,018 DEBUG : BROWSER_OUTPUT: Values: 132.0 127.0 133.0 132.0 133.0 142.0 147.0 138.0 133.0 136.0 05:48:12 INFO - 2015-11-18 05:48:12,018 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,018 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:169.50 stddev:10.56 (6.2%) stddev-sans-first:8.86 05:48:12 INFO - 2015-11-18 05:48:12,018 DEBUG : BROWSER_OUTPUT: Values: 144.0 158.0 157.0 147.0 163.0 172.0 173.0 169.0 170.0 171.0 05:48:12 INFO - 2015-11-18 05:48:12,018 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,019 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.42 (1.9%) stddev-sans-first:1.50 05:48:12 INFO - 2015-11-18 05:48:12,020 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 70.0 72.0 73.0 74.0 71.0 73.0 73.0 75.0 05:48:12 INFO - 2015-11-18 05:48:12,020 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:48:12 INFO - 2015-11-18 05:48:12,020 DEBUG : BROWSER_OUTPUT: 05:48:12 INFO - 2015-11-18 05:48:12,656 INFO : Browser exited with error code: 0 05:48:12 INFO - 2015-11-18 05:48:12,704 INFO : Completed test kraken (00:00:58) 05:48:12 INFO - 2015-11-18 05:48:12,704 INFO : Starting test v8_7 05:48:12 INFO - 2015-11-18 05:48:12,704 DEBUG : operating with platform_type : mac_ 05:48:12 INFO - 2015-11-18 05:48:12,705 INFO : Initialising browser for v8_7 test... 05:48:12 INFO - 2015-11-18 05:48:12,718 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpCbg4wh/profile http://localhost:49264/getInfo.html 05:48:15 INFO - 2015-11-18 05:48:15,680 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:48:15 INFO - 2015-11-18 05:48:15,680 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:48:15 INFO - 2015-11-18 05:48:15,680 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:48:15 INFO - 2015-11-18 05:48:15,680 DEBUG : BROWSER_OUTPUT: __metrics 05:48:16 INFO - 2015-11-18 05:48:16,448 INFO : Browser initialized. 05:48:16 INFO - 2015-11-18 05:48:16,448 INFO : Running cycle 1/1 for v8_7 test... 05:48:16 INFO - 2015-11-18 05:48:16,449 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpCbg4wh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:48:28 INFO - 2015-11-18 05:48:28,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 241229824 05:48:28 INFO - 2015-11-18 05:48:28,466 DEBUG : BROWSER_OUTPUT: 05:48:49 INFO - 2015-11-18 05:48:49,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 05:48:50 INFO - 2015-11-18 05:48:50,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 261722112 05:48:50 INFO - 2015-11-18 05:48:50,228 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,228 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:48:50 INFO - 2015-11-18 05:48:50,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:48:50 INFO - 2015-11-18 05:48:50,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |0;Richards;168.20857863751053 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.09825673534073 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |2;Encrypt;331.01621979476994 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5837.209302325581 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1170.7602339181287 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |5;Earley;825.0825082508251 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |6;Boyer;13662.162162162162 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |7;RegExp;29911.764705882353 05:48:50 INFO - 2015-11-18 05:48:50,229 DEBUG : BROWSER_OUTPUT: |8;Splay;662.7140974967062 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5911.764705882353 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: __startTimestamp1447854530216__endTimestamp 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,230 DEBUG : BROWSER_OUTPUT: Values: 168.2 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.10 Median:198.10 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: Values: 198.1 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:331.02 Median:331.02 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: Values: 331.0 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5837.21 Median:5837.21 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: Values: 5837.2 05:48:50 INFO - 2015-11-18 05:48:50,231 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1170.76 Median:1170.76 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: Values: 1170.8 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:825.08 Median:825.08 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: Values: 825.1 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13662.16 Median:13662.16 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: Values: 13662.2 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29911.76 Median:29911.76 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: Values: 29911.8 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,232 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:662.71 Median:662.71 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,233 DEBUG : BROWSER_OUTPUT: Values: 662.7 05:48:50 INFO - 2015-11-18 05:48:50,233 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,233 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5911.76 Median:5911.76 stddev:0.00 (0.0%) 05:48:50 INFO - 2015-11-18 05:48:50,233 DEBUG : BROWSER_OUTPUT: Values: 5911.8 05:48:50 INFO - 2015-11-18 05:48:50,233 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:48:50 INFO - 2015-11-18 05:48:50,233 DEBUG : BROWSER_OUTPUT: 05:48:50 INFO - 2015-11-18 05:48:50,893 INFO : Browser exited with error code: 0 05:48:50 INFO - 2015-11-18 05:48:50,914 INFO : Completed test v8_7 (00:00:38) 05:48:51 INFO - 2015-11-18 05:48:51,273 INFO : Completed test suite (00:20:10) 05:48:51 INFO - 2015-11-18 05:48:51,273 DEBUG : Working with test: dromaeo_css 05:48:51 INFO - 2015-11-18 05:48:51,273 DEBUG : Generating results file: dromaeo_css 05:48:51 INFO - 2015-11-18 05:48:51,273 DEBUG : Working with test: kraken 05:48:51 INFO - 2015-11-18 05:48:51,273 DEBUG : Generating results file: kraken 05:48:51 INFO - 2015-11-18 05:48:51,274 INFO : javascript benchmark 05:48:51 INFO - 2015-11-18 05:48:51,274 DEBUG : Working with test: v8_7 05:48:51 INFO - 2015-11-18 05:48:51,274 DEBUG : Generating results file: v8_7 05:48:51 INFO - 2015-11-18 05:48:51,274 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:48:51 INFO - 2015-11-18 05:48:51,321 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:48:51 INFO - 2015-11-18 05:48:51,322 DEBUG : process_Request line: dromaeo_css 6374.83 graph.html#tests=[[72,1,57]] 05:48:51 INFO - 2015-11-18 05:48:51,322 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:48:51 INFO - 2015-11-18 05:48:51,350 DEBUG : process_Request line: kraken 1560.80 graph.html#tests=[[232,1,57]] 05:48:51 INFO - 2015-11-18 05:48:51,350 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:48:51 INFO - 2015-11-18 05:48:51,378 DEBUG : process_Request line: v8_7 19050.44 graph.html#tests=[[230,1,57]] 05:48:51 INFO - 2015-11-18 05:48:51,379 INFO : javascript benchmark 05:48:51 INFO - 2015-11-18 05:48:51,381 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [320.98395080245984, 327.4400774675305, 327.988520401786, 329.37090157798593, 333.9448990916499, 11682.591109311175, 12098.576549820758, 16214.351425942963, 16998.20071971212, 18293.45119646411, 11518.424078796048, 11600.767984640303, 11626.883731162687, 11743.119266055037, 11986.640400787968, 4275.5724427557225, 4347.60871521563, 4356.150550642626, 4402.25161722508, 4407.427034485512, 4308.138372325532, 4411.316245981878, 4588.701734387254, 4613.8154473821005, 4617.976910115444, 4291.141771645668, 4484.23767959446, 4541.114482675879, 4552.499225085238, 4616.469106052813, 4413.271810151337, 4437.1125774844995, 4439.711418757771, 4471.0, 4506.684532082755, 3718.9070273243115, 3793.2982398256413, 3822.751521151144, 3825.7895815730126, 3843.461915331856, 12713.237205767591, 12941.352932353344, 12964.0, 13218.66953326165, 13249.337533123306, 1858.210260639223, 1870.635226130905, 1883.8304552590332, 1999.530110424049, 2011.5474018345901, 9155.542222888895, 9244.537773111317, 9568.473733944631, 9597.712068637951, 9689.806203875953, 1534.3172288331698, 1557.3692654474955, 1597.456864666019, 1601.2474137155518, 1632.2817960097518, 53878.73060634672, 55949.160762589, 56130.43869561293, 56298.43701563014, 56876.43123568753, 6260.40526150015, 6318.273398559225, 6362.9045564316575, 6383.425491705769, 6451.548391612542, 7238.638068096574, 7258.745943891939, 7268.636568171571, 7278.818029549304, 7394.334509894135, 5314.202869569595, 5326.6005049621435, 5364.0, 5380.192971054373, 5381.165919282517, 5761.567882408836, 5792.82621521355, 5795.304563452412, 5800.970995145081, 5825.533957283407, 2854.685984541699, 2873.0088119598704, 2881.697421770684, 2896.5075937090746, 2904.8111872728628, 1005.6681295172575, 1018.4856647393167, 1019.3476175247847, 1031.7626945802358, 1075.4085253110914, 395.7605648582566, 399.0243853777486, 402.9844791126345, 404.33486914026264, 426.14770459081836, 9749.658761943298, 10181.083702466814, 10244.078032976919, 10400.687979360631, 10540.0, 441.4239417560051, 451.99431265434805, 454.8908262017158, 464.4194756554307, 465.1882465098425, 5795.8551036224435, 5965.433283838029, 5990.64056156632, 6026.306974697878, 6059.121427393092, 505099.0, 508186.0, 518735.0, 524257.0, 524496.0, 69908.3009169912, 71703.28296716967, 71729.2827071733, 71804.64097679582, 72941.63529182426, 491.0424671889829, 492.67237287204324, 493.29705170132416, 494.7427337784332, 496.0624419846493, 10163.847542286723, 10303.690889273334, 10322.896771032194, 10364.844527332247, 10421.166306695597, 32094.83952580222, 32235.677643224204, 32279.193020174684, 32311.51532727058, 32625.510617341235, 47508.0, 47841.760791197215, 47954.0, 48209.75895120642, 48518.0, 5954.136650185612, 6100.603460775035, 6133.233345831771, 6134.9079763804475, 6146.477549408351, 10612.363258204532, 11246.718832029264, 11341.886581134413, 11470.483828227583, 11714.414279286171, 9416.670416535388, 9750.60997560118, 9763.365381250196, 9811.80376392454, 9917.206623470249, 9223.49270790113, 9240.676576319796, 9466.668666596635, 9717.80564388694, 9839.311248212844, 9729.85405218908, 9898.752531186778, 9958.302918795614, 9977.151942084714, 10106.545205465625, 5898.852528686817, 5926.318473375617, 5995.520358371407, 5998.190244316961, 6026.819195424145, 9799.461029643153, 9929.304948653526, 10051.798964020825, 10074.798504029732, 10129.746756331151], "dojo.html": [2983.8806447742104, 3047.2077259912444, 3154.936901261975, 3195.9680403195966, 3272.5418441418205, 5089.974550127245, 5105.948940510594, 5136.5633921116705, 5169.276301317814, 5233.816816411427, 4919.991401762639, 5017.698938063719, 5059.06407314647, 5073.112205364056, 5144.408393034802, 4721.740304283272, 4746.121967436018, 4816.83141090062, 4841.757912104398, 4922.286268491067, 4702.952970470285, 4745.928811067837, 4761.47623761386, 4773.06925149596, 4789.353437285957, 4552.4764652065105, 4622.237330840408, 4688.179568575486, 4755.191617425046, 4760.381150450454, 4754.405699287589, 4780.641451891122, 4788.18600837855, 4815.446223684286, 4863.8297659582095, 4676.0, 4736.3369128322065, 4757.833475828364, 4800.927986080212, 4825.986542826011, 4851.27230915362, 4901.950980490221, 5028.698278103326, 5106.157484015133, 5119.052975199563, 5490.149026900836, 5496.725163741797, 5508.118701007819, 5520.254765606632, 5532.336119665626, 5391.892162156735, 5580.832575022756, 5598.328200615912, 5626.268585083953, 5638.182463542763, 5020.221865610873, 5051.520105589963, 5072.797088116434, 5072.923906141411, 5122.871928201825, 5640.182173584807, 5658.91511627326, 5664.745086471119, 5685.090385538294, 5719.7426115824055, 5110.897782044338, 5241.397239317451, 5439.728013599304, 5444.373897001817, 5494.917576236359, 5420.24116623673, 5541.0, 5601.579881508903, 5603.579731520153, 5650.152477128381, 5429.647072940246, 5448.291722076184, 5468.835934921959, 5476.315460567429, 5477.643953143033, 5329.626926115135, 5421.83734487966, 5483.341998960151, 5495.835124946258, 5550.27846379968, 4257.510386305553, 4260.829566817292, 4268.210381079511, 4291.31338985767, 4315.6763242756915, 3869.7484663496784, 3878.825452854628, 3886.9222615548097, 3904.1606054698377, 3921.392184211452, 5011.974940125276, 5097.847064588068, 5165.793368265227, 5167.715775632376, 5296.973515132399, 5627.971860140673, 5635.887282254414, 5637.605367624227, 5638.4925356718095, 5640.605157639008, 5266.052110620049, 5269.077911365495, 5274.472552744694, 5285.31290932184, 5302.496262855023, 4713.2458806590785, 4797.808087676523, 4817.927731084036, 4843.975780121147, 4918.0, 5684.175794509855, 5696.54427645779, 5733.3406658234835, 5743.59794814359, 5773.076307790733, 5427.565794736491, 5585.553155747449, 5601.80393686219, 5601.915971260353, 5649.096144616841, 5646.407127251579, 5689.487946084707, 5698.0, 5702.8289151325525, 5793.449622285876, 5497.0, 5505.256790333254, 5512.035393806148, 5528.06022976103, 5531.917021244604, 5413.539849112712, 5564.054110801093, 5584.357798853021, 5594.664320140804, 5605.355384130877, 5039.773210205476, 5260.500252476008, 5337.0, 5342.9198562022375, 5420.241166236809, 5442.918356224739, 5448.155535891943, 5454.427285135003, 5464.972675136599, 5497.532709719559, 5029.27075574047, 5147.58819294448, 5182.559482444034, 5332.68003919766, 5342.0384330820825, 5344.171653393731, 5351.3043304370185, 5358.732063396893, 5377.784888604569, 5379.892402151857, 5284.524392804666, 5287.841364759063, 5288.074586947346, 5296.867578310573, 5307.920381194363], "mootools.html": [1298.6688394459418, 1337.8193943817594, 1338.0299283019813, 1669.7328427451607, 1724.2327164411843, 6911.274316196802, 7121.0, 7189.0, 7303.963480182599, 7327.596982165979, 6809.863802723955, 6871.312868713127, 6893.069435626189, 6902.17173939128, 6954.895676564843, 2113.6089823382645, 2145.6996020557135, 2151.7202763640703, 2158.6006588781047, 2160.8703477791382, 2140.283005193262, 2173.282816670495, 2207.9448013799624, 2217.966730499044, 2218.5895609312247, 2084.062172022588, 2103.7159983402275, 2120.268507364957, 2123.819475344598, 2127.4362293992103, 2099.653557163066, 2179.6730490426403, 2191.463091542574, 2191.8465707400487, 2195.868247905115, 2162.4485756132085, 2165.1339464214284, 2172.011734660726, 2173.1307477009323, 2175.2277941330917, 7113.964430177816, 7187.532810367362, 7213.603251821148, 7218.494705370626, 7230.60231687257, 4510.21071312519, 4603.148417542765, 4603.171429142753, 4616.0767846430845, 4647.0, 2699.85150816705, 2704.580789977557, 2733.3986522964915, 2758.613794068832, 2778.763805076571, 882.1355072029382, 894.8657701344786, 908.4231512989234, 927.0266220468549, 930.4370855632312, 9329.0, 9457.716268511957, 9469.952650236704, 9526.095020973065, 9537.618495260182, 4120.587941205916, 4184.5187803403, 4253.468316460442, 4269.210196113729, 4285.185814695198, 8396.874046889301, 8399.832003360021, 8427.873581896276, 8435.283000944866, 8473.449225800427, 4582.175208462509, 4602.194615942197, 4628.213203755369, 4630.351750754897, 4631.143238500888, 4220.683448741295, 4246.129543443587, 4257.978710106491, 4274.358846173037, 4275.315949448073, 3359.983200083984, 3448.3620530201993, 3450.068481509978, 3455.395305821471, 3456.70617997468, 1097.7694684116425, 1118.5022664914197, 1120.2998126171144, 1127.4419162514607, 1131.2025022359383, 1032.5714828346302, 1034.3483605328595, 1155.566662501562, 1168.742876567171, 1227.4415141110774, 6783.3555812197765, 6836.316368363124, 6840.281770414035, 6847.383735463733, 6855.143107111611, 1077.6874706335232, 1105.0929508164222, 1110.4225802582612, 1118.1278602689915, 1126.8422420861086, 5386.811461598825, 5409.269748583891, 5435.211894275387, 5439.700816455053, 5482.506574408322, 8041.718539851077, 8146.0632027317615, 8159.836803263902, 8212.630431630472, 8394.286485648667, 8275.668973241123, 8313.750587482386, 8352.12302708219, 8418.621162047722, 8428.578571071545, 6571.178602674666, 6614.636195009224, 6700.6984685688285, 6754.257031726506, 6759.391654750998, 6647.833804154935, 6697.263301036979, 6718.764843230463, 6781.050652908695, 6799.456043516408, 7258.3104605062435, 7403.5928023959195, 7485.625718713934, 7522.6614802335125, 7652.923470765444, 7510.474266801271, 7668.693252269847, 7707.961460192663, 7756.767296981099, 7813.687452501837, 6279.560430769802, 6361.809145725636, 6365.204349456318, 6365.840853978502, 6417.2620148681635, 6633.535652504278, 6754.527183097136, 6807.047013418224, 6812.0122582226295, 6828.419584335387, 6288.465480434214, 6314.747410103544, 6406.775762848278, 6426.646534440463, 6445.097686323825, 5664.716764161858, 6256.249250089836, 6288.11966324724, 6342.619442833445, 6381.8085457436355, 6414.326495718069, 6445.516586255956, 6462.4506916910705, 6471.288158302677, 6502.73989040452, 5861.413858614104, 5866.6186697864505, 5870.972579798604, 5878.500327472213, 5881.117832325014, 5933.2880054393745, 5967.194428752063, 5970.910436343372, 5976.193213916065, 6022.488088512526], "ext.html": [530.157050290039, 530.631211308141, 538.7360193505182, 549.9037668408027, 555.7026990560051, 37497.62502374975, 38511.422328665096, 38667.80666096673, 38698.80650596746, 38731.419028714525, 40924.59075409245, 41040.0, 41048.794756026175, 41080.17839643213, 41247.38128928068, 8677.566121693922, 8904.777380565472, 8911.509866957314, 8959.641614335418, 9002.189802917736, 8709.43388679737, 8775.64897404103, 8838.690645827397, 8848.690295839648, 8864.911350886505, 8736.301095912311, 8811.691590794324, 8856.51289179095, 8877.0, 8927.776805579848, 8748.25639820616, 8852.159044890725, 8862.423942443786, 8885.422447540921, 8906.376553641248, 8662.956685216597, 8802.339824513123, 8810.427322224035, 8854.86717699235, 8861.379703420764, 37106.0, 37175.81412092949, 37200.62799371999, 37325.626743732486, 37647.4352884707, 2516.3709072731817, 2724.428113083117, 2889.653241610999, 3111.1910903165112, 3515.9979405869462, 26053.60919586208, 26594.0, 26608.866955665097, 27208.727912720817, 27685.307867303276, 2329.2895666821614, 2335.497867958397, 2350.5063936573342, 2352.741198468167, 2457.5453541094776, 223693.0, 223802.0, 225790.0, 226751.0, 394845.0, 57866.0, 57994.4200557989, 58398.708006459696, 58420.7078964611, 58616.70691646515, 62411.0, 62491.375086248554, 62621.0, 62665.686671567266, 62772.68613656903, 16161.0, 16372.345106195618, 16379.672406551803, 16389.67220655604, 16393.262303196385, 12284.14011019238, 12525.498980040697, 12584.0, 12584.37078146089, 12594.748105037848, 19452.416427507196, 19774.110165042606, 19778.406647800588, 19785.0, 19818.70271945922, 8484.236418722345, 8686.95656521726, 8706.695265665672, 8722.215000649972, 8790.956045219733, 888.9244414224734, 935.742670765545, 989.2036910287144, 1010.9747256318651, 1095.2606990281529, 27225.183244502696, 30211.546826797614, 30636.54045189324, 30858.845705771328, 30928.226794330323, 954.8090381923643, 970.1753509516996, 1026.4046852825493, 1038.8026275007876, 1127.3517727306667, 13454.596362109152, 13961.964580826547, 14172.433102675983, 14195.148291102567, 14211.92894035544, 368451.0, 381656.0, 382132.0, 382208.0, 386116.0, 52133.218001730005, 52627.73686131545, 52969.73515132477, 53065.2040219397, 53088.0, 1291.438224372401, 1309.0640192262579, 1309.1294289297512, 1324.0202250334683, 1337.9665508362368, 26179.607305890047, 26482.735172648026, 26756.331091722863, 26757.19728408073, 26823.463530729667, 43036.569634303254, 43891.34162987622, 43918.780406097765, 43933.56066439295, 44471.33293000672, 262313.0, 263260.0, 264517.0, 264641.0, 264914.0, 31194.0, 42205.366919496846, 44114.779426102665, 44122.0, 44205.33691994687, 40176.598234017285, 41328.79335603303, 41343.37984930168, 41506.58493415027, 42025.78987105045, 35007.0, 35061.64938350686, 35231.47152792659, 35298.64701352954, 35567.0, 34937.30125397529, 34984.650153498136, 35024.64975350316, 35201.82399087988, 35246.64753352536, 34361.0, 34912.0, 35090.649093508735, 35100.94697159089, 35585.0, 29733.0, 31323.84338078295, 31381.529277060406, 31448.685513144577, 31507.84246078755, 23516.76483235146, 23576.29271121869, 23701.170459033852, 23733.52532949366, 23797.405064873517], "prototype.html": [304.444388990093, 306.7377392329558, 311.05749578776306, 311.5015974440893, 311.995320070199, 6136.969315153429, 6150.231221097363, 6166.753329866806, 6298.779542716006, 6306.6846657667165, 6075.726592303346, 6149.692515374236, 6190.938090619093, 6191.288001879785, 6271.623702577837, 4466.151431228072, 4589.954100458986, 4597.356370108188, 4613.008203236303, 4640.559146881041, 4581.106684196583, 4604.746738929358, 4612.677112602119, 4622.6070783983405, 4649.837255696051, 4538.205813982557, 4553.066621342617, 4553.317002449642, 4565.520620334867, 4587.42657167854, 4521.59305662492, 4529.682922195448, 4542.863714088583, 4554.407926969506, 4618.584327410549, 3813.161104556993, 3886.902827429337, 3890.0858298299877, 3909.159530700913, 3928.8035598219976, 5916.4675179233645, 5930.584859059867, 6012.819615411545, 6093.756249750005, 6099.6950152492645, 5152.665076770036, 5161.7161056141895, 5163.1480805667015, 5177.37871455424, 5234.136367499358, 6432.871342573122, 6446.0, 6500.4799616030605, 6502.674866256668, 6523.0, 4149.564295748964, 4216.114615930658, 4232.32282834745, 4241.088166044285, 4249.553796851317, 6692.397684208445, 6754.9662251688915, 6775.4918381121615, 6791.3208679132185, 6855.794326170173, 4295.82816687329, 4296.3555466680245, 4298.828046878152, 4304.978475107604, 4313.029568347097, 4368.759718215529, 4372.519022907478, 4381.014271788886, 4381.890452738707, 4384.649228061748, 5017.774200161001, 5125.897482050338, 5129.615278854101, 5131.743412829418, 5164.741762911839, 6452.290248072708, 6459.0, 6486.4486518646445, 6493.805185844338, 6523.902141467882, 1524.9161296128598, 1540.7996960395076, 1542.3753379881166, 1551.8525740054677, 1554.7901033360351, 979.485769970771, 988.8516722491684, 998.8901220865699, 1001.2640709078821, 1006.8741407324085, 6160.722767475474, 6188.8762224755255, 6192.195014648067, 6215.098810672427, 6250.281217659936, 6712.127423434922, 6749.156355455568, 6771.762988295484, 6780.457563394916, 6847.383735463832, 6007.729652165663, 6181.227346581677, 6202.751889924352, 6211.9689401553605, 6227.844303892439, 3632.2735452909524, 3675.283319752676, 3678.576963649161, 3681.5950245472977, 3691.9261614768093, 6875.243723190445, 6944.826379340557, 7048.365647091787, 7052.717891284394, 7090.787276381717, 6952.374286314155, 7000.824979375557, 7038.3665470107935, 7055.611941343275, 7066.222715501291, 6829.829254268584, 7028.297170283033, 7035.401990830836, 7095.609741464165, 7117.074780278531, 6798.490113241428, 6799.660016999229, 6810.965945170243, 6851.383375496229, 6885.208201056943, 6607.141071660653, 6617.966910165418, 6626.867462650624, 6690.29751876046, 6694.263631000488, 6826.180858296838, 7016.0, 7079.1505019398, 7094.0, 7112.644367781487, 4282.80727367263, 4337.0, 4338.913221735611, 4364.08354245612, 4369.300911854215, 6722.193336799615, 6728.764493242713, 6734.427573656294, 6747.797566073025, 6800.625965571941, 6383.553151279366, 6477.514186435942, 6519.152510173647, 6523.967380163259, 6568.47452203813, 6482.384173503509, 6510.609363438209, 6520.510961677798, 6565.540412171294, 6565.737370505318, 6321.52588555851, 6331.366863313632, 6355.1420558224045, 6406.391392817675, 6407.775727849503, 6337.9366206337345, 6506.707198176188, 6527.2167339919515, 6595.1096601958125, 6624.768133115318, 6407.231132264158, 6437.839054023687, 6441.516886233645, 6456.903146452713, 6469.5794773339585], "yui.html": [706.5584009993754, 720.3408880874, 725.8983742276082, 743.9070116235469, 767.3707559800964, 12571.685707857308, 12653.240805551673, 12765.489380424784, 12890.613281601556, 12915.547955821548, 12584.370781460937, 12597.370131493435, 12643.051771117158, 12751.426185821638, 12768.233905965648, 675.8850995330781, 677.9796606101825, 811.9594020298991, 826.3348004856089, 852.3011130872687, 784.4430454377399, 812.4800127918107, 822.6421506644599, 823.2467292427422, 825.8678611422174, 900.6622516556291, 905.85053466178, 909.5725009245677, 911.968081117161, 913.1051569461931, 873.7378786364065, 900.9549522523847, 901.3915606965338, 901.8106197698426, 901.9098090190961, 653.9373518033196, 658.1378394303478, 658.720043981306, 660.1088530483856, 670.7082419147687, 13000.479980800757, 13145.802812957812, 13166.210027398387, 13166.539171128965, 13191.208527488285, 11010.724731881686, 11163.265000075033, 11407.942960285229, 11448.484818183202, 11460.14048946324, 9024.954875225647, 9045.231155351803, 9088.363814532986, 9231.0, 9470.431774093577, 3123.9687603123907, 3198.8880389186265, 3251.9349613007607, 3351.0, 3355.429576971896, 46489.53510464886, 46561.767191163824, 46781.06437871223, 46861.76569117167, 46900.06199875983, 8410.621522031523, 8519.488830670056, 8550.572471376407, 8602.397832151815, 9163.358564900527, 11438.256513326607, 11593.304401735923, 11599.536018559163, 11683.941580292045, 18597.16312765929, 5668.0647693130995, 5780.0, 5856.443637854397, 5873.941260587425, 5990.430909063632, 3495.580530336325, 3548.9467657984633, 3571.535700358989, 3577.7853328800356, 3637.927241455209, 2652.1910817200937, 2687.3953360494124, 2690.8250963687296, 2696.703362630109, 2709.0, 355.2787840683417, 363.7599184538245, 363.93994990826747, 368.7234574069448, 368.85614610302, 465.4437946653716, 486.05324762924573, 500.39202369120966, 544.863958646227, 566.8724536979147, 7313.853722925512, 7501.399888008947, 7577.280158384945, 7794.41541884361, 7839.608019598997, 561.9775208991595, 573.3893403525233, 583.7110630238059, 592.8932792097464, 596.2904144068544, 3538.929221415557, 3614.2590768892314, 3647.343478173901, 3743.831527581265, 3780.4707340972286, 56852.71573642105, 56941.14588281179, 57506.0, 58728.41271587315, 59360.40639593635, 47265.5273447268, 47673.76163119232, 48339.27491087637, 49163.01673966572, 50303.0, 45423.31865021961, 45477.77261113739, 45924.770376148575, 46352.07295854064, 46393.7680311603, 7560.8487830244185, 7662.118856331594, 7769.417293702882, 7817.843643126992, 8167.83664326722, 33153.83423082869, 33290.334193316485, 33592.32815343728, 33863.49204761881, 34208.82895585506, 45101.54898450973, 45553.0, 45780.77109614431, 45891.77054114708, 46343.0, 6679.131712877489, 6781.6270105144695, 6808.863822723617, 6943.236244013054, 7007.509474336747, 10526.263161578616, 10661.360318380923, 10902.618408355669, 11089.778204436028, 11606.361650109326, 9667.564959576977, 9751.268654850772, 9983.351082179635, 10072.54673539707, 10424.947875260576, 9512.667056652985, 9616.75958101053, 9628.855567166358, 9677.758056048655, 10487.790244195226, 8168.183181681784, 8346.666133354598, 9637.662681806383, 9832.967538408364, 9850.556724947537, 8070.1122876484715, 8220.095789463274, 8419.0, 8449.197326253996, 8734.868976965477, 8153.22544358285, 8257.339412846837, 8264.917350826414, 8604.268637165911, 8712.520811355436]}, "summary": {"lowerIsBetter": false, "suite": 6374.8247924802, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6384.668788906104, "unit": "ms", "value": 6384.668788906104}, "dojo.html": {"lowerIsBetter": false, "filtered": 5101.9862886078545, "unit": "ms", "value": 5101.9862886078545}, "mootools.html": {"lowerIsBetter": false, "filtered": 4176.588125522498, "unit": "ms", "value": 4176.588125522498}, "ext.html": {"lowerIsBetter": false, "filtered": 18123.552138545816, "unit": "ms", "value": 18123.552138545816}, "prototype.html": {"lowerIsBetter": false, "filtered": 4820.2198026225, "unit": "ms", "value": 4820.2198026225}, "yui.html": {"lowerIsBetter": false, "filtered": 5646.257866091267, "unit": "ms", "value": 5646.257866091267}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0077.e"}, "testrun": {"date": 1447853320, "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": [165.0, 163.0, 166.0, 166.0, 165.0, 170.0, 174.0, 177.0, 183.0, 179.0], "ai-astar": [108.0, 101.0, 108.0, 108.0, 109.0, 117.0, 109.0, 108.0, 110.0, 107.0], "imaging-gaussian-blur": [121.0, 115.0, 117.0, 119.0, 130.0, 125.0, 124.0, 124.0, 124.0, 121.0], "audio-beat-detection": [152.0, 133.0, 150.0, 160.0, 129.0, 153.0, 150.0, 127.0, 163.0, 132.0], "json-stringify-tinderbox": [72.0, 72.0, 69.0, 71.0, 71.0, 73.0, 71.0, 72.0, 72.0, 75.0], "stanford-crypto-pbkdf2": [144.0, 158.0, 157.0, 147.0, 163.0, 172.0, 173.0, 169.0, 170.0, 171.0], "json-parse-financial": [64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 70.0, 63.0, 62.0], "stanford-crypto-sha256-iterative": [73.0, 73.0, 70.0, 72.0, 73.0, 74.0, 71.0, 73.0, 73.0, 75.0], "audio-fft": [72.0, 73.0, 77.0, 65.0, 70.0, 70.0, 71.0, 124.0, 67.0, 74.0], "imaging-darkroom": [126.0, 128.0, 126.0, 132.0, 137.0, 138.0, 139.0, 136.0, 137.0, 137.0], "stanford-crypto-ccm": [132.0, 127.0, 133.0, 132.0, 133.0, 142.0, 147.0, 138.0, 133.0, 136.0], "audio-oscillator": [90.0, 89.0, 129.0, 86.0, 89.0, 91.0, 124.0, 91.0, 96.0, 139.0], "stanford-crypto-aes": [87.0, 87.0, 87.0, 88.0, 88.0, 93.0, 93.0, 94.0, 96.0, 95.0], "imaging-desaturate": [99.0, 106.0, 103.0, 107.0, 104.0, 108.0, 105.0, 106.0, 112.0, 103.0]}, "summary": {"lowerIsBetter": true, "suite": 1560.8000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.3, "unit": "ms", "value": 76.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 162.4, "unit": "ms", "value": 162.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.9, "unit": "ms", "value": 144.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 135.3, "unit": "ms", "value": 135.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 133.6, "unit": "ms", "value": 133.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 64.0, "unit": "ms", "value": 64.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.4, "unit": "ms", "value": 102.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.5, "unit": "ms", "value": 108.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 170.8, "unit": "ms", "value": 170.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.7, "unit": "ms", "value": 72.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 71.8, "unit": "ms", "value": 71.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 122.0, "unit": "ms", "value": 122.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 90.8, "unit": "ms", "value": 90.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 105.3, "unit": "ms", "value": 105.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0077.e"}, "testrun": {"date": 1447853320, "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": [198.09825673534073], "Encrypt": [331.01621979476994], "NavierStokes": [5911.764705882353], "Decrypt": [5837.209302325581], "Splay": [662.7140974967062], "Richards": [168.20857863751053], "RegExp": [29911.764705882353], "Earley": [825.0825082508251], "Boyer": [13662.162162162162], "RayTrace": [1170.7602339181287]}, "summary": {"lowerIsBetter": false, "suite": 19050.44081023477, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 333.76366399999995, "unit": "score", "value": 333.76366399999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 804.1328010000002, "unit": "score", "value": 804.1328010000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 251.02487562189037, "unit": "score", "value": 251.02487562189037}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.600729083665335, "unit": "score", "value": 45.600729083665335}, "Splay": {"lowerIsBetter": false, "filtered": 122.96554473161036, "unit": "score", "value": 122.96554473161036}, "RegExp": {"lowerIsBetter": false, "filtered": 30.45574237954766, "unit": "score", "value": 30.45574237954766}, "Richards": {"lowerIsBetter": false, "filtered": 209.87038999999996, "unit": "score", "value": 209.87038999999996}, "Earley": {"lowerIsBetter": false, "filtered": 807.7531559999996, "unit": "score", "value": 807.7531559999996}, "Boyer": {"lowerIsBetter": false, "filtered": 48.78166369930765, "unit": "score", "value": 48.78166369930765}, "RayTrace": {"lowerIsBetter": false, "filtered": 632.0585364635361, "unit": "score", "value": 632.0585364635361}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0077.e"}, "testrun": {"date": 1447853320, "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:51 INFO - RETURN: dromaeo_css: 6374.83 05:48:51 INFO - RETURN: kraken: 1560.80 05:48:51 INFO - RETURN: v8_7: 19050.44 05:48:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "19050.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1560.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "6374.83"}}} 05:48:51 INFO - Return code: 0 05:48:51 INFO - # TBPL SUCCESS # 05:48:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:51 INFO - 2015-11-18 05:48:51.495 screenresolution[1705:13874] starting screenresolution argv=screenresolution get 05:48:51 INFO - 2015-11-18 05:48:51.498 screenresolution[1705:13874] Display 0: 1600x1200x32@60 05:48:51 INFO - 2015-11-18 05:48:51.504 screenresolution[1706:13877] starting screenresolution argv=screenresolution list 05:48:51 INFO - Available Modes on Display 0 05:48:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:51 INFO - Intel HD Graphics 3000: 05:48:51 INFO - Chipset Model: Intel HD Graphics 3000 05:48:51 INFO - Type: GPU 05:48:51 INFO - Bus: Built-In 05:48:51 INFO - VRAM (Total): 512 MB 05:48:51 INFO - VRAM (Dynamic, Max): 10 05:48:51 INFO - Vendor: Intel (0x8086) 05:48:51 INFO - Device ID: 0x0116 05:48:51 INFO - Revision ID: 0x0009 05:48:51 INFO - Displays: 05:48:51 INFO - Display: 05:48:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:51 INFO - Display Serial Number: 1600x1200 60 05:48:51 INFO - Main Display: Yes 05:48:51 INFO - Mirror: Off 05:48:51 INFO - Online: Yes 05:48:51 INFO - Rotation: Supported 05:48:51 INFO - Return code: 0 05:48:51 INFO - Running post-action listener: _resource_record_post_action 05:48:51 INFO - Running post-run listener: _resource_record_post_run 05:48:52 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 42996736; Write bytes: 694268928; Read time: 6441; Write time: 62486 05:48:52 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 339649024; Write bytes: 335605760; Read time: 33380; Write time: 4582 05:48:52 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 40887296; Write bytes: 347452416; Read time: 5837; Write time: 57152 05:48:52 INFO - Running post-run listener: _upload_blobber_files 05:48:52 INFO - Blob upload gear active. 05:48:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:48:52 INFO - Copying logs to upload dir... 05:48:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1339.072416 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2015-11-18 05:48:52.907628) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 05:48:52.910728) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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.010102 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:52.939799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:48:52.940165) ========= 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.CtvCvJvdkY/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.40HqTcOuaI/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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.005403 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 05:48:52.992429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 05:48:52.992799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 05:48:52.993229) ========= ========= Total master_lag: 0.50 =========