builder: ash_yosemite_test-dromaeojs slave: t-yosemite-r5-0096 starttime: 1447791324.67 results: success (0) buildid: 20151117102307 builduid: 10c1b776219540d0a9063b7cbf45f7cb revision: 2185368ac9231548d3b0f9379812dd0a0ae50484 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.669854) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.670269) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.670569) ========= 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.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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.005988 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.752349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.752829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.778820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.779199) ========= 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.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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.024761 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.828434) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.828776) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.829123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:24.829410) ========= 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.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 12:15:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, :: Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2015-11-17 12:15:25 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.013595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.013952) ========= 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.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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.086834 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.115854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.116282) ========= bash -c 'python archiver_client.py mozharness --repo projects/ash --rev 2185368ac9231548d3b0f9379812dd0a0ae50484 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev 2185368ac9231548d3b0f9379812dd0a0ae50484 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 12:15:25,201 truncating revision to first 12 chars 2015-11-17 12:15:25,201 Setting DEBUG logging. 2015-11-17 12:15:25,201 attempt 1/10 2015-11-17 12:15:25,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/2185368ac923?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 12:15:25,453 unpacking tar archive at: ash-2185368ac923/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.638444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.638832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.657087) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.657507) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 12:15:25.658019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-17 12:15:25.658378) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Ash', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Ash'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:15:25 INFO - MultiFileLogger online at 20151117 12:15:25 in /builds/slave/test 12:15:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash 12:15:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:25 INFO - {'append_to_log': False, 12:15:25 INFO - 'base_work_dir': '/builds/slave/test', 12:15:25 INFO - 'blob_upload_branch': 'Ash', 12:15:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:25 INFO - 'branch': 'Ash', 12:15:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:25 INFO - 'config_files': ('talos/mac_config.py',), 12:15:25 INFO - 'default_actions': ('clobber', 12:15:25 INFO - 'read-buildbot-config', 12:15:25 INFO - 'download-and-extract', 12:15:25 INFO - 'populate-webroot', 12:15:25 INFO - 'create-virtualenv', 12:15:25 INFO - 'install', 12:15:25 INFO - 'run-tests'), 12:15:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:25 INFO - 'download_minidump_stackwalk': True, 12:15:25 INFO - 'download_symbols': 'ondemand', 12:15:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:25 INFO - 'installer_path': 'installer.exe', 12:15:25 INFO - 'log_level': 'info', 12:15:25 INFO - 'log_name': 'talos', 12:15:25 INFO - 'log_to_console': True, 12:15:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:15:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:15:25 INFO - 'opt_config_files': (), 12:15:25 INFO - 'pip_index': False, 12:15:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:25 INFO - 'cmd': ('bash', 12:15:25 INFO - '-c', 12:15:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:25 INFO - 'enabled': True, 12:15:25 INFO - 'halt_on_failure': False, 12:15:25 INFO - 'name': 'check_screen_resolution'},), 12:15:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:25 INFO - 'cmd': ('bash', 12:15:25 INFO - '-c', 12:15:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:25 INFO - 'enabled': True, 12:15:25 INFO - 'halt_on_failure': False, 12:15:25 INFO - 'name': 'check_screen_resolution'},), 12:15:25 INFO - 'run_cmd_checks_enabled': True, 12:15:25 INFO - 'sps_profile': False, 12:15:25 INFO - 'sps_profile_interval': 0, 12:15:25 INFO - 'suite': 'dromaeojs', 12:15:25 INFO - 'system_bits': '64', 12:15:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:25 INFO - 'title': 't-yosemite-r5-0096', 12:15:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:25 INFO - 'use_talos_json': True, 12:15:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:25 INFO - 'work_dir': 'build'} 12:15:25 INFO - ##### 12:15:25 INFO - ##### Running clobber step. 12:15:25 INFO - ##### 12:15:25 INFO - Running pre-action listener: _resource_record_pre_action 12:15:25 INFO - Running main action method: clobber 12:15:25 INFO - rmtree: /builds/slave/test/build 12:15:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:29 INFO - Running post-action listener: _resource_record_post_action 12:15:29 INFO - ##### 12:15:29 INFO - ##### Running read-buildbot-config step. 12:15:29 INFO - ##### 12:15:29 INFO - Running pre-action listener: _resource_record_pre_action 12:15:29 INFO - Running main action method: read_buildbot_config 12:15:29 INFO - Using buildbot properties: 12:15:29 INFO - { 12:15:29 INFO - "properties": { 12:15:29 INFO - "buildnumber": 13, 12:15:29 INFO - "product": "firefox", 12:15:29 INFO - "script_repo_revision": "production", 12:15:29 INFO - "builddir": "ash_yosemite_test-dromaeojs", 12:15:29 INFO - "repository": "", 12:15:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 ash talos dromaeojs", 12:15:29 INFO - "buildid": "20151117102307", 12:15:29 INFO - "slavename": "t-yosemite-r5-0096", 12:15:29 INFO - "pgo_build": "False", 12:15:29 INFO - "basedir": "/builds/slave/test", 12:15:29 INFO - "project": "", 12:15:29 INFO - "platform": "yosemite", 12:15:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:15:29 INFO - "slavebuilddir": "test", 12:15:29 INFO - "scheduler": "tests-ash-macosx64-talos", 12:15:29 INFO - "branch": "ash", 12:15:29 INFO - "repo_path": "projects/ash", 12:15:29 INFO - "stage_platform": "macosx64", 12:15:29 INFO - "builduid": "10c1b776219540d0a9063b7cbf45f7cb", 12:15:29 INFO - "revision": "2185368ac9231548d3b0f9379812dd0a0ae50484" 12:15:29 INFO - }, 12:15:29 INFO - "sourcestamp": { 12:15:29 INFO - "repository": "", 12:15:29 INFO - "hasPatch": false, 12:15:29 INFO - "project": "", 12:15:29 INFO - "branch": "ash-macosx64-talos", 12:15:29 INFO - "changes": [ 12:15:29 INFO - { 12:15:29 INFO - "category": null, 12:15:29 INFO - "files": [ 12:15:29 INFO - { 12:15:29 INFO - "url": null, 12:15:29 INFO - "name": "https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:15:29 INFO - } 12:15:29 INFO - ], 12:15:29 INFO - "repository": "", 12:15:29 INFO - "rev": "2185368ac9231548d3b0f9379812dd0a0ae50484", 12:15:29 INFO - "who": "catlee@mozilla.com", 12:15:29 INFO - "when": 1447791302, 12:15:29 INFO - "number": 6673409, 12:15:29 INFO - "comments": "merged from central", 12:15:29 INFO - "project": "", 12:15:29 INFO - "at": "Tue 17 Nov 2015 12:15:02", 12:15:29 INFO - "branch": "ash-macosx64-talos", 12:15:29 INFO - "revlink": "", 12:15:29 INFO - "properties": [ 12:15:29 INFO - [ 12:15:29 INFO - "buildid", 12:15:29 INFO - "20151117102307", 12:15:29 INFO - "Change" 12:15:29 INFO - ], 12:15:29 INFO - [ 12:15:29 INFO - "builduid", 12:15:29 INFO - "10c1b776219540d0a9063b7cbf45f7cb", 12:15:29 INFO - "Change" 12:15:29 INFO - ], 12:15:29 INFO - [ 12:15:29 INFO - "pgo_build", 12:15:29 INFO - "False", 12:15:29 INFO - "Change" 12:15:29 INFO - ] 12:15:29 INFO - ], 12:15:29 INFO - "revision": "2185368ac9231548d3b0f9379812dd0a0ae50484" 12:15:29 INFO - } 12:15:29 INFO - ], 12:15:29 INFO - "revision": "2185368ac9231548d3b0f9379812dd0a0ae50484" 12:15:29 INFO - } 12:15:29 INFO - } 12:15:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:15:29 INFO - Running post-action listener: _resource_record_post_action 12:15:29 INFO - ##### 12:15:29 INFO - ##### Running download-and-extract step. 12:15:29 INFO - ##### 12:15:29 INFO - Running pre-action listener: _resource_record_pre_action 12:15:29 INFO - Running main action method: download_and_extract 12:15:29 INFO - mkdir: /builds/slave/test/build/tests 12:15:29 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')]} 12:15:29 INFO - https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/test_packages.json 12:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/test_packages.json 12:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:15:37 INFO - Downloaded 1149 bytes. 12:15:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:15:37 INFO - Using the following test package requirements: 12:15:37 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:15:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:15:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'jsshell-mac.zip'], 12:15:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:15:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:15:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:15:37 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:15:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:15:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:15:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:15:37 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:15:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:37 INFO - https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:15:38 INFO - Downloaded 17461053 bytes. 12:15:38 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 12:15:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:15:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:15:44 INFO - Return code: 0 12:15:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:15: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')]} 12:15:44 INFO - https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:15:52 INFO - Downloaded 17461053 bytes. 12:15:52 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 12:15:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:15:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:15:57 INFO - Return code: 0 12:15:57 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')]} 12:15:57 INFO - https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:15:58 INFO - Downloaded 11131693 bytes. 12:15:58 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 12:15:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:15:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:15:59 INFO - Return code: 0 12:15:59 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')]} 12:15:59 INFO - https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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 12:16:02 INFO - Downloaded 105053985 bytes. 12:16:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:16:02 INFO - mkdir: /builds/slave/test/properties 12:16:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:02 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:02 INFO - Contents: 12:16:02 INFO - build_url:https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:16:02 INFO - Running post-action listener: _resource_record_post_action 12:16:02 INFO - Running post-action listener: set_extra_try_arguments 12:16:02 INFO - ##### 12:16:02 INFO - ##### Running populate-webroot step. 12:16:02 INFO - ##### 12:16:02 INFO - Running pre-action listener: _resource_record_pre_action 12:16:02 INFO - Running main action method: populate_webroot 12:16:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:02 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:16:02 INFO - '../fennec_ids.txt'], 12:16:02 INFO - 'tests': ['tcheck2']}, 12:16:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:02 INFO - '--tppagecycles', 12:16:02 INFO - '7'], 12:16:02 INFO - 'tests': ['tsvgm']}}, 12:16:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'tests': ['damp', 'tps']}, 12:16:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['damp', 'tps']}, 12:16:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:02 INFO - 'other': {'tests': ['a11yr', 12:16:02 INFO - 'ts_paint', 12:16:02 INFO - 'tpaint', 12:16:02 INFO - 'sessionrestore', 12:16:02 INFO - 'sessionrestore_no_auto_restore']}, 12:16:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['a11yr', 12:16:02 INFO - 'ts_paint', 12:16:02 INFO - 'tpaint', 12:16:02 INFO - 'sessionrestore', 12:16:02 INFO - 'sessionrestore_no_auto_restore']}, 12:16:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['a11yr', 12:16:02 INFO - 'ts_paint', 12:16:02 INFO - 'tpaint', 12:16:02 INFO - 'sessionrestore', 12:16:02 INFO - 'sessionrestore_no_auto_restore']}, 12:16:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['a11yr', 12:16:02 INFO - 'ts_paint', 12:16:02 INFO - 'tpaint', 12:16:02 INFO - 'sessionrestore', 12:16:02 INFO - 'sessionrestore_no_auto_restore']}, 12:16:02 INFO - 'other_l64': {'tests': ['a11yr', 12:16:02 INFO - 'ts_paint', 12:16:02 INFO - 'tpaint', 12:16:02 INFO - 'sessionrestore', 12:16:02 INFO - 'sessionrestore_no_auto_restore']}, 12:16:02 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:02 INFO - 'ts_paint', 12:16:02 INFO - 'tpaint', 12:16:02 INFO - 'sessionrestore', 12:16:02 INFO - 'sessionrestore_no_auto_restore']}, 12:16:02 INFO - 'svgr': {'tests': ['tsvgx', 12:16:02 INFO - 'tsvgr_opacity', 12:16:02 INFO - 'tart', 12:16:02 INFO - 'tscrollx', 12:16:02 INFO - 'cart']}, 12:16:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['tsvgx', 12:16:02 INFO - 'tsvgr_opacity', 12:16:02 INFO - 'tart', 12:16:02 INFO - 'tscrollx', 12:16:02 INFO - 'cart']}, 12:16:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'tests': ['tp5o']}, 12:16:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'talos_options': ['--e10s'], 12:16:02 INFO - 'tests': ['tp5o']}, 12:16:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'talos_options': ['--xperf_path', 12:16:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:02 INFO - 'tests': ['tp5n']}, 12:16:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:02 INFO - 'talos_options': ['--e10s', 12:16:02 INFO - '--xperf_path', 12:16:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:02 INFO - 'tests': ['tp5n']}}, 12:16:02 INFO - 'talos.zip': {'path': '', 12:16:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:02 INFO - Running post-action listener: _resource_record_post_action 12:16:02 INFO - ##### 12:16:02 INFO - ##### Running create-virtualenv step. 12:16:02 INFO - ##### 12:16:02 INFO - Running pre-action listener: _resource_record_pre_action 12:16:02 INFO - Running main action method: create_virtualenv 12:16:02 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:02 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 12:16:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:02 INFO - Using real prefix '/tools/python27' 12:16:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:06 INFO - Installing pip.................done. 12:16:06 INFO - Return code: 0 12:16:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:06 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 12:16:06 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 12:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:06 INFO - 'HOME': '/Users/cltbld', 12:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:06 INFO - 'LOGNAME': 'cltbld', 12:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:06 INFO - 'MOZ_NO_REMOTE': '1', 12:16:06 INFO - 'NO_EM_RESTART': '1', 12:16:06 INFO - 'PAGER': '/bin/cat', 12:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:06 INFO - 'PWD': '/builds/slave/test', 12:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:06 INFO - 'SHELL': '/bin/bash', 12:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:06 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:06 INFO - 'USER': 'cltbld', 12:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:06 INFO - 'XPC_FLAGS': '0x0', 12:16:06 INFO - 'XPC_SERVICE_NAME': '0', 12:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:07 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 12:16:07 INFO - Cleaning up... 12:16:07 INFO - Return code: 0 12:16:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:07 INFO - 'HOME': '/Users/cltbld', 12:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:07 INFO - 'LOGNAME': 'cltbld', 12:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:07 INFO - 'MOZ_NO_REMOTE': '1', 12:16:07 INFO - 'NO_EM_RESTART': '1', 12:16:07 INFO - 'PAGER': '/bin/cat', 12:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:07 INFO - 'PWD': '/builds/slave/test', 12:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:07 INFO - 'SHELL': '/bin/bash', 12:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:07 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:07 INFO - 'USER': 'cltbld', 12:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:07 INFO - 'XPC_FLAGS': '0x0', 12:16:07 INFO - 'XPC_SERVICE_NAME': '0', 12:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:07 INFO - Downloading/unpacking psutil>=0.7.1 12:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:10 INFO - Installing collected packages: psutil 12:16:10 INFO - Running setup.py install for psutil 12:16:10 INFO - building 'psutil._psutil_osx' extension 12:16:10 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 12:16:12 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 12:16:12 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 12:16:12 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 12:16:12 INFO - building 'psutil._psutil_posix' extension 12:16:12 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 12:16:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:16:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:16:12 INFO - ^ 12:16:12 INFO - 1 warning generated. 12:16:12 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 12:16:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:12 INFO - Successfully installed psutil 12:16:12 INFO - Cleaning up... 12:16:12 INFO - Return code: 0 12:16:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:12 INFO - 'HOME': '/Users/cltbld', 12:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:12 INFO - 'LOGNAME': 'cltbld', 12:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:12 INFO - 'MOZ_NO_REMOTE': '1', 12:16:12 INFO - 'NO_EM_RESTART': '1', 12:16:12 INFO - 'PAGER': '/bin/cat', 12:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:12 INFO - 'PWD': '/builds/slave/test', 12:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:12 INFO - 'SHELL': '/bin/bash', 12:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:12 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:12 INFO - 'USER': 'cltbld', 12:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:12 INFO - 'XPC_FLAGS': '0x0', 12:16:12 INFO - 'XPC_SERVICE_NAME': '0', 12:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:15 INFO - Installing collected packages: mozsystemmonitor 12:16:15 INFO - Running setup.py install for mozsystemmonitor 12:16:15 INFO - Successfully installed mozsystemmonitor 12:16:15 INFO - Cleaning up... 12:16:15 INFO - Return code: 0 12:16:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:15 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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:15 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 12:16:15 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 12:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:15 INFO - 'HOME': '/Users/cltbld', 12:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:15 INFO - 'LOGNAME': 'cltbld', 12:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:15 INFO - 'MOZ_NO_REMOTE': '1', 12:16:15 INFO - 'NO_EM_RESTART': '1', 12:16:15 INFO - 'PAGER': '/bin/cat', 12:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:15 INFO - 'PWD': '/builds/slave/test', 12:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:15 INFO - 'SHELL': '/bin/bash', 12:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:15 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:15 INFO - 'USER': 'cltbld', 12:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:15 INFO - 'XPC_FLAGS': '0x0', 12:16:15 INFO - 'XPC_SERVICE_NAME': '0', 12:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:16 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:18 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:19 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 12:16:19 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 12:16:19 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 12:16:19 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 12:16:19 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 12:16:19 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 12:16:19 INFO - Downloading docopt-0.6.1.tar.gz 12:16:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:19 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:19 INFO - Running setup.py install for blobuploader 12:16:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:20 INFO - Running setup.py install for requests 12:16:20 INFO - Running setup.py install for docopt 12:16:20 INFO - Successfully installed blobuploader requests docopt 12:16:20 INFO - Cleaning up... 12:16:20 INFO - Return code: 0 12:16:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:20 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')]} 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 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')]} 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:20 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 12:16:20 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 12:16:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:20 INFO - 'HOME': '/Users/cltbld', 12:16:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:20 INFO - 'LOGNAME': 'cltbld', 12:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:20 INFO - 'MOZ_NO_REMOTE': '1', 12:16:20 INFO - 'NO_EM_RESTART': '1', 12:16:20 INFO - 'PAGER': '/bin/cat', 12:16:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:20 INFO - 'PWD': '/builds/slave/test', 12:16:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:20 INFO - 'SHELL': '/bin/bash', 12:16:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:20 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:20 INFO - 'USER': 'cltbld', 12:16:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:20 INFO - 'XPC_FLAGS': '0x0', 12:16:20 INFO - 'XPC_SERVICE_NAME': '0', 12:16:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-6_OH97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-I1F_Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-r80VVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-yeLXFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-pFaajX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-H12OQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:21 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-DgSh2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-skUNeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-FfHh9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-64akiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-G1md5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-bm1LNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-FqskMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-i3PZll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:22 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-FusGCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:23 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-0q0b_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:23 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-_LPbvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:23 INFO - Running setup.py install for manifestparser 12:16:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:23 INFO - Running setup.py install for mozcrash 12:16:23 INFO - Running setup.py install for mozdebug 12:16:23 INFO - Running setup.py install for mozdevice 12:16:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozfile 12:16:24 INFO - Running setup.py install for mozhttpd 12:16:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozinfo 12:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozInstall 12:16:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozleak 12:16:24 INFO - Running setup.py install for mozlog 12:16:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Running setup.py install for moznetwork 12:16:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Running setup.py install for mozprocess 12:16:25 INFO - Running setup.py install for mozprofile 12:16:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Running setup.py install for mozrunner 12:16:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Running setup.py install for mozscreenshot 12:16:25 INFO - Running setup.py install for moztest 12:16:26 INFO - Running setup.py install for mozversion 12:16:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:26 INFO - Cleaning up... 12:16:26 INFO - Return code: 0 12:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:26 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')]} 12:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:26 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')]} 12:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:26 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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:26 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 12:16:26 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 12:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:26 INFO - 'HOME': '/Users/cltbld', 12:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:26 INFO - 'LOGNAME': 'cltbld', 12:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:26 INFO - 'MOZ_NO_REMOTE': '1', 12:16:26 INFO - 'NO_EM_RESTART': '1', 12:16:26 INFO - 'PAGER': '/bin/cat', 12:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:26 INFO - 'PWD': '/builds/slave/test', 12:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:26 INFO - 'SHELL': '/bin/bash', 12:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:26 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:26 INFO - 'USER': 'cltbld', 12:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:26 INFO - 'XPC_FLAGS': '0x0', 12:16:26 INFO - 'XPC_SERVICE_NAME': '0', 12:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:26 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-cWUWcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:26 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-ukyXrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:26 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-ANfDe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-4JHWAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-J4YjRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-vCrWhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-9_JLAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-zZ58iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-7gJFvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-4BcYgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:27 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)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:27 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-3DX43T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:28 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)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:28 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-gGH5e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:28 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)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:28 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-B5pWNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:28 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)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:28 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-rMpfuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:28 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)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:28 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-EWwxNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:28 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)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:28 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-PlkoWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:28 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)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:28 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-rC6mjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:28 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)) 12:16:28 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)) 12:16:28 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)) 12:16:28 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)) 12:16:28 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)) 12:16:28 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)) 12:16:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:31 INFO - Downloading blessings-1.5.1.tar.gz 12:16:31 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 12:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:31 INFO - Installing collected packages: blessings 12:16:31 INFO - Running setup.py install for blessings 12:16:31 INFO - Successfully installed blessings 12:16:31 INFO - Cleaning up... 12:16:31 INFO - Return code: 0 12:16:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:32 INFO - Reading from file tmpfile_stdout 12:16:32 INFO - Current package versions: 12:16:32 INFO - blessings == 1.5.1 12:16:32 INFO - blobuploader == 1.2.4 12:16:32 INFO - docopt == 0.6.1 12:16:32 INFO - manifestparser == 1.1 12:16:32 INFO - mozInstall == 1.12 12:16:32 INFO - mozcrash == 0.16 12:16:32 INFO - mozdebug == 0.1 12:16:32 INFO - mozdevice == 0.47 12:16:32 INFO - mozfile == 1.2 12:16:32 INFO - mozhttpd == 0.7 12:16:32 INFO - mozinfo == 0.9 12:16:32 INFO - mozleak == 0.1 12:16:32 INFO - mozlog == 3.0 12:16:32 INFO - moznetwork == 0.27 12:16:32 INFO - mozprocess == 0.22 12:16:32 INFO - mozprofile == 0.27 12:16:32 INFO - mozrunner == 6.11 12:16:32 INFO - mozscreenshot == 0.1 12:16:32 INFO - mozsystemmonitor == 0.0 12:16:32 INFO - moztest == 0.7 12:16:32 INFO - mozversion == 1.4 12:16:32 INFO - psutil == 3.1.1 12:16:32 INFO - requests == 1.2.3 12:16:32 INFO - wsgiref == 0.1.2 12:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:32 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')]} 12:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:32 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')]} 12:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:32 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 0x10bc1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbfc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8153702e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, '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.tHlwcZP9na/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.39ZuwQoy0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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 12:16:32 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 12:16:32 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 12:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:32 INFO - 'HOME': '/Users/cltbld', 12:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:32 INFO - 'LOGNAME': 'cltbld', 12:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:32 INFO - 'MOZ_NO_REMOTE': '1', 12:16:32 INFO - 'NO_EM_RESTART': '1', 12:16:32 INFO - 'PAGER': '/bin/cat', 12:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:32 INFO - 'PWD': '/builds/slave/test', 12:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:32 INFO - 'SHELL': '/bin/bash', 12:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:16:32 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:32 INFO - 'USER': 'cltbld', 12:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:32 INFO - 'XPC_FLAGS': '0x0', 12:16:32 INFO - 'XPC_SERVICE_NAME': '0', 12:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 INFO - Cleaning up... 12:16:32 INFO - Return code: 0 12:16:32 INFO - Running post-action listener: _resource_record_post_action 12:16:32 INFO - Running post-action listener: _start_resource_monitoring 12:16:32 INFO - Starting resource monitoring. 12:16:32 INFO - ##### 12:16:32 INFO - ##### Running install step. 12:16:32 INFO - ##### 12:16:32 INFO - Running pre-action listener: _resource_record_pre_action 12:16:32 INFO - Running main action method: install 12:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:32 INFO - Reading from file tmpfile_stdout 12:16:32 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:32 INFO - Reading from file tmpfile_stdout 12:16:32 INFO - Output received: 12:16:32 INFO - Usage: mozinstall [options] installer 12:16:32 INFO - Options: 12:16:32 INFO - -h, --help show this help message and exit 12:16:32 INFO - -d DEST, --destination=DEST 12:16:32 INFO - Directory to install application into. [default: 12:16:32 INFO - "/builds/slave/test"] 12:16:32 INFO - --app=APP Application being installed. [default: firefox] 12:16:32 INFO - mkdir: /builds/slave/test/build/application 12:16:32 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'] 12:16:32 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 12:17:13 INFO - Reading from file tmpfile_stdout 12:17:13 INFO - Output received: 12:17:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:17:13 INFO - Running post-action listener: _resource_record_post_action 12:17:13 INFO - ##### 12:17:13 INFO - ##### Running run-tests step. 12:17:13 INFO - ##### 12:17:13 INFO - Running pre-action listener: _resource_record_pre_action 12:17:13 INFO - Running main action method: run_tests 12:17:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:17:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:17:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:17:13 INFO - 2015-11-17 12:17:13.278 screenresolution[1628:7802] starting screenresolution argv=screenresolution get 12:17:13 INFO - 2015-11-17 12:17:13.282 screenresolution[1628:7802] Display 0: 1600x1200x32@60 12:17:13 INFO - 2015-11-17 12:17:13.288 screenresolution[1629:7804] starting screenresolution argv=screenresolution list 12:17:13 INFO - Available Modes on Display 0 12:17:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:17:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:17:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:17:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:17:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:17:13 INFO - Intel HD Graphics 3000: 12:17:13 INFO - Chipset Model: Intel HD Graphics 3000 12:17:13 INFO - Type: GPU 12:17:13 INFO - Bus: Built-In 12:17:13 INFO - VRAM (Total): 512 MB 12:17:13 INFO - VRAM (Dynamic, Max): 10 12:17:13 INFO - Vendor: Intel (0x8086) 12:17:13 INFO - Device ID: 0x0116 12:17:13 INFO - Revision ID: 0x0009 12:17:13 INFO - Displays: 12:17:13 INFO - Display: 12:17:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:17:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:17:13 INFO - Display Serial Number: 1600x1200 60 12:17:13 INFO - Main Display: Yes 12:17:13 INFO - Mirror: Off 12:17:13 INFO - Online: Yes 12:17:13 INFO - Rotation: Supported 12:17:13 INFO - Return code: 0 12:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:13 INFO - Python 2.7.3 12:17:13 INFO - Return code: 0 12:17:13 INFO - grabbing minidump binary from tooltool 12:17: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')]} 12:17:13 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 0x10bb429f0>, '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 0x10b8a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb368c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:13 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 12:17:13 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 12:17:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:13 INFO - Return code: 0 12:17:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:17:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:17:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0096', '--webServer', 'localhost'] in /builds/slave/test/build 12:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Ash --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0096 --webServer localhost 12:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHlwcZP9na/Render', 12:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:13 INFO - 'HOME': '/Users/cltbld', 12:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:13 INFO - 'LOGNAME': 'cltbld', 12:17:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:13 INFO - 'MOZ_NO_REMOTE': '1', 12:17:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:13 INFO - 'NO_EM_RESTART': '1', 12:17:13 INFO - 'PAGER': '/bin/cat', 12:17:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:13 INFO - 'PWD': '/builds/slave/test', 12:17:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:13 INFO - 'SHELL': '/bin/bash', 12:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.39ZuwQoy0B/Listeners', 12:17:13 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 12:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:13 INFO - 'USER': 'cltbld', 12:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:13 INFO - 'XPC_FLAGS': '0x0', 12:17:13 INFO - 'XPC_SERVICE_NAME': '0', 12:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:17:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0096', '--webServer', 'localhost'] with output_timeout 3600 12:17:14 INFO - mozversion INFO | application_buildid: 20151117102307 12:17:14 INFO - mozversion INFO | application_changeset: 2185368ac9231548d3b0f9379812dd0a0ae50484 12:17:14 INFO - mozversion INFO | application_display_name: Nightly 12:17:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:14 INFO - mozversion INFO | application_name: Firefox 12:17:14 INFO - mozversion INFO | application_remotingname: firefox 12:17:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/ash 12:17:14 INFO - mozversion INFO | application_vendor: Mozilla 12:17:14 INFO - mozversion INFO | application_version: 45.0a1 12:17:14 INFO - mozversion INFO | platform_buildid: 20151117102307 12:17:14 INFO - mozversion INFO | platform_changeset: 2185368ac9231548d3b0f9379812dd0a0ae50484 12:17:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/ash 12:17:14 INFO - mozversion INFO | platform_version: 45.0a1 12:17:14 INFO - 2015-11-17 12:17:14,004 DEBUG : using testdate: 1447791434 12:17:14 INFO - 2015-11-17 12:17:14,005 DEBUG : actual date: 1447791434 12:17:14 INFO - 2015-11-17 12:17:14,018 INFO : starting webserver on 'localhost:49263' 12:17:14 INFO - 2015-11-17 12:17:14,019 INFO : Starting test suite t-yosemite-r5-0096 12:17:14 INFO - 2015-11-17 12:17:14,019 INFO : Starting test dromaeo_css 12:17:14 INFO - 2015-11-17 12:17:14,019 DEBUG : operating with platform_type : mac_ 12:17:14 INFO - 2015-11-17 12:17:14,020 INFO : Initialising browser for dromaeo_css test... 12:17:14 INFO - 2015-11-17 12:17:14,053 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpvHzmnY/profile http://localhost:49263/getInfo.html 12:17:17 INFO - 2015-11-17 12:17:17,620 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:17:17 INFO - 2015-11-17 12:17:17,620 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:17:17 INFO - 2015-11-17 12:17:17,620 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:17:17 INFO - 2015-11-17 12:17:17,620 DEBUG : BROWSER_OUTPUT: __metrics 12:17:17 INFO - 2015-11-17 12:17:17,656 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:18 INFO - 2015-11-17 12:17:18,402 INFO : Browser initialized. 12:17:18 INFO - 2015-11-17 12:17:18,402 INFO : Running cycle 1/1 for dromaeo_css test... 12:17:18 INFO - 2015-11-17 12:17:18,402 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpvHzmnY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:30 INFO - 2015-11-17 12:17:30,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 235057152 12:17:30 INFO - 2015-11-17 12:17:30,389 DEBUG : BROWSER_OUTPUT: 12:18:22 INFO - 2015-11-17 12:18:22,236 DEBUG : BROWSER_OUTPUT: 1447791502234 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] 12:20:32 INFO - 2015-11-17 12:20:32,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 12:20:33 INFO - 2015-11-17 12:20:33,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 365654016 12:20:33 INFO - 2015-11-17 12:20:33,823 DEBUG : BROWSER_OUTPUT: 12:23:36 INFO - 2015-11-17 12:23:36,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 12:23:37 INFO - 2015-11-17 12:23:37,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 380252160 12:23:37 INFO - 2015-11-17 12:23:37,187 DEBUG : BROWSER_OUTPUT: 12:26:39 INFO - 2015-11-17 12:26:39,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 12:26:39 INFO - 2015-11-17 12:26:39,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 348569600 12:26:39 INFO - 2015-11-17 12:26:39,959 DEBUG : BROWSER_OUTPUT: 12:29:42 INFO - 2015-11-17 12:29:42,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 12:29:42 INFO - 2015-11-17 12:29:42,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 332427264 12:29:42 INFO - 2015-11-17 12:29:42,612 DEBUG : BROWSER_OUTPUT: 12:32:45 INFO - 2015-11-17 12:32:45,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 12:32:46 INFO - 2015-11-17 12:32:46,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 339251200 12:32:46 INFO - 2015-11-17 12:32:46,347 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 12:35:49 INFO - 2015-11-17 12:35:49,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 379658240 12:35:49 INFO - 2015-11-17 12:35:49,320 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,321 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:49 INFO - 2015-11-17 12:35:49,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:49 INFO - 2015-11-17 12:35:49,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:49 INFO - 2015-11-17 12:35:49,321 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:49 INFO - 2015-11-17 12:35:49,323 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3026.1678038539385;3052.160655819648;3105.3168302973345;3173.2384227785337;3220.339830334781;4856.757162141887;4933.457319694835;4963.329950456688;5007.273945277937;5031.220160875066;4896.290037944496;5007.37407824022;5018.849434516961;5118.385793704751;5166.457521960197;4695.3426520287185;4697.953020469803;4711.7879695413785;4733.526647335256;4833.854984350475;4754.168020596399;4873.585745211643;4873.902521949559;4876.244182151772;4931.802727890898;4554.7039442436135;4656.4645065817185;4666.9766651166865;4809.807607695688;4821.517848215186;4699.224627936386;4709.293605959134;4728.314394412825;4730.148573256813;4731.526847315241;4560.179167749804;4644.419447569054;4705.223638099709;4717.433907931036;4739.170645137122;4907;4922.852314430537;4923.458419573844;4939.061578300111;5008.449070602231;5253.133233016586;5263.421023687391;5281.128613778722;5289.127293996486;5304.257403963448;5260.447652996457;5337.279467271907;5359.464053594609;5381.919271210896;5409.459054094559;4882.633802464794;4922.655414121049;4938.1358262304675;4959.181735013683;4993.1262029144755;5429.239906413105;5449.591280653967;5497.47773961473;5511.917321240185;5550.056490396642;5103.413107492686;5212.374515058142;5229.189475631283;5232.73836308183;5240.633155679142;5313.920291195635;5380.757865896044;5398.946010539923;5416.322959630046;5459.836204913859;5275.235090911796;5311.097113490716;5314.123169677037;5377.851153928685;5394.91907621386;5246.921296180561;5343.732813359316;5352.437994010651;5357.4106848246665;5422.810201642924;4064.7357921734992;4101.200265948111;4106.979465102655;4140.751554906716;4148.087420767426;3737.2151848111657;3743.21392507571;3763.7553559018575;3768.679662228741;3805.238952209569;4951.851444456672;4976.402831660224;5009.89980200394;5058.772355244023;5076.771545280471;5348.411674715778;5412.377576578744;5425.6202065855805;5440.401555828935;5505.587080968943;5060.240963855451;5089.134847076006;5099.158638824627;5124.948750512447;5135.409427915837;4542.795574199169;4653.813847446064;4664.580187783048;4782.808687652455;4838.322634831126;5416.322959630046;5417.3770016447825;5504.80733174337;5536.197251398444;5536.861578460571;5423.62034657586;5425.674459532441;5446.700431476307;5453.863653408696;5469.453054694658;5231;5540.612157148961;5542;5559.63862348946;5605.159226115952;5193.766280517461;5277.630565860353;5303.549198318186;5353.919691204557;5385.030694475032;5359.651622644516;5378.865528361822;5379.408265090915;5380.0584897641975;5386.245925570502;4777.522247775334;5255.63210575256;5267.473252674702;5296.894062118659;5304.893902122013;5134.743262836769;5148.279240906351;5174.741262936914;5222.738863056908;5247.317848679647;5104.489551044866;5108.948910510847;5110.233464980282;5130.204818253177;5184.066867963803;5193.818216362409;5264.657797243167;5267.631265811357;5285.312909321918;5287.867803304948;5147.897042059213;5149;5167.22491626259;5167.92248116271;5180.067587834226 12:35:49 INFO - 2015-11-17 12:35:49,326 DEBUG : BROWSER_OUTPUT: |1;ext.html;521.8304051183367;524.3026774390062;533.6291277562093;542.0541155683334;554.1078863030523;28525.14424567261;30825.22936926575;36748.44877326839;38689.61310386896;38900.610993890055;40141.799291003575;40301.798491007576;40464.595354046454;40574.79712601433;40671.59328406715;7746.961265193666;8281.83436331273;8367.121452247533;8542.786430339229;8554.61504232311;7823.882641760378;10473.005064518897;10574.629887953923;10655;10667.253292269545;10355.89644103557;10371.170306375472;10415.895841041569;10493.895061049368;10510.316829406102;7975.162607926142;8077.555734434603;10178.236632252574;10254.384736915772;10473.895261047444;10100.444475553842;10206;10254.384736915734;10294.7426314342;10299.53652085658;36544.26911461756;36676.44985325222;36763.448548271794;36871;36949.261014779826;2844.7013063628433;2929.9267518312;3159.494480883048;3275.1157187559465;3324.1191084362663;25554.105606303878;25556.23331300064;25756.734240488597;25848.224553263244;25970.610440843404;2100.2544096845554;2102.737157855268;2111.915523379063;2117.2907076129513;2208.2712704807377;246062;247405;247584;248441;248885.7555712228;48448.5155148444;49421.752891235315;56199.438005620235;56481.15278270829;56576;60391.69804150951;60639;61204.38795612076;61309.69345153335;61358;12124.39378031095;12280.140390172603;12280.692982675504;12292.446839892227;12292.938535307445;9034.32242581809;9044.326799541974;9051.59267832949;9052.773680657905;9054.728358149267;17998.460046198634;18089.7286540702;18116.547086322946;18465.81534184668;18485.81514184841;7180.599783042257;7310.4517161213125;7398.260173982559;7436.442266830009;7488.438367122379;883.4743327720125;913.4199783137623;948.1750876737145;989.9208063355059;1027.768752030802;26473.205803825917;26813.731862681514;26855;27178.320541986213;27465;999.8550210219623;1009.4195837393381;1033.705393962717;1050.9894901051046;1118.1446193661855;14066.507672231422;14077.929610352088;14079.859201407855;14121.293935303194;14121.43514259418;420844;433125;434284;434481;434630;49664.25503617449;49884.750576246886;50007.74996124996;50123.49876501261;50244.49755502398;1273.2487832178874;1279.9232046077266;1283.4352884730688;1285.119693010291;1285.3573213393304;23797.64303535483;25947.740522595286;26332.605010925236;27446.451070978866;27517.587236191073;46328.30507542457;47699.52300476951;47737;47743.28385074157;47755.76122119367;173435;239138;240695;242284;244749;26174.86912565425;29313;29408.11775646734;29414.41171176607;29444.527773611662;37245.25509489849;37550.624493754716;37701.24597508089;37955.62044379521;38096.23807523779;31614;33600.3279934395;34461;34764.82617586896;34777.82611086928;34017.37844333491;34139.65860341464;34429;34456.31087378289;34475.82762086173;33665.49501757426;34462.65537344695;34665.306693866485;34807.82596087003;34979;29088.41823163567;30182.396352073276;30321.99465005775;30378;30504.84747576248;21789.564208716052;21838.56322873502;21986.670199947333;22036.449088772908;22085 12:35:49 INFO - 2015-11-17 12:35:49,326 DEBUG : BROWSER_OUTPUT: |2;jquery.html;312.19609505523283;317.4888429628298;322.5951430954152;323.12272181028504;325.84848045658765;16448.424305149307;16811.15944202788;17026.31894724211;17257.223424945878;17278.740818887694;17484.65030699385;17598.38405655802;17918.462446126603;18221.544461388472;18226.63546729068;5073.847784566469;5213.175388613992;5218.765155568009;5234.528892399702;5265.420803711589;4451.443569553806;4578;4579.084183163381;4583.335416364625;4591.219492686251;3196.584444022274;3282.6553211912765;4470.7094038887535;4528.637708983273;4535.886602834922;4522.773861306921;4559.931601025987;4579.839705610288;4582.977085114553;4589.2886602576655;3730.2725968436166;3871.993281746738;3875.1280961783655;3877.0113621026458;3883.3010058189516;9999.800003999879;10500.737481563023;10510.316829406063;21444.785552144593;21496.24763133283;1855.1466325490292;1893.4414347767304;1934.477691023416;2023.251396983111;2065.987666043643;12788.87211127886;12854.935725321408;13048.217106973612;13151.671208219776;13486;1685.384834535398;1712.0754792412083;1719.1662043908693;1723.5691077230692;1738.9217485213069;63684.36315636831;64189;64738;65219.67390163066;65357.673211633635;15888.602784930237;16046;16059.919700401424;16084.195790210442;16124.984376952882;23579.41051473727;23625.881870590536;23635.88182059079;23789.64315535268;23811.547325637686;7648.311651951351;7653.693852245848;7929.762107136795;8001.1198768135455;8038.115807261197;6198.349173336825;6199.5660303779205;6211.534134939807;6500.317466666026;6553.836154096186;7455.4408419368765;7560.130584982688;7561.9243807562325;7573.2048134946135;7596.050493688289;2980.226765074777;2981.254686328418;2989.6412430508044;2994.293252845857;3051.725344718986;383.4880434619758;386.98645547405704;387.5098001028701;390.93940439231966;392.0414586336437;10970.506327215295;11114.777704445865;11252.774944501229;11322.716932076764;11347.489362978686;412.7007919258514;418.82618713233666;422.6301985762458;425.21972181048125;430.6081465866047;5391.757370918318;5488.4785945335125;6027.7287522061615;6099.268087829489;6156.907646385308;522890;547763;550981;553245;554204;67932;68155.3184468149;68596;70245;70410.64794675994;489.50559934465736;493.86418734848206;494;494.69081823860085;494.8020791683355;10658;10671.46642667848;10735.89264107349;10737.892621074001;10771.299865508718;34683.82658086693;34757.826210868785;34952.12619684528;35071.64928350786;35132.297354053284;43315.78342108395;45525.31712024388;46999.295010574184;47329.76335118302;47548.2867756977;5797.971010144923;5993.550483713651;6001.609895356788;6019.969900150471;6032.245969253843;10697.411642359433;11151.163662725166;11375;11415.029722473682;11417.486213120595;7915.722949696733;9614;9644.469554174588;9700.951495242478;9706.369086009387;7704.460687751804;8995.145461181177;9395.389299695498;9485.336026478357;9611.807763844823;9551.665691700757;9747.707568772948;9931.503424828585;9975.750606234902;9981.251406144713;5832;5863.2670916135485;5874.383189765013;5898.174255604305;5906.557008224487;9491.66779162726;9772.462514561767;9791.922888482404;9813.85279220798;9851.605935762489 12:35:49 INFO - 2015-11-17 12:35:49,330 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1245.7010317523798;1654.2886558779724;1710.8631309495242;1718.6476772261683;1737.0359450504964;6608.933910660892;6760.492963027768;6900.206476255232;6955.234924158339;6979.6510174491195;7069.18704349;7140.357367836894;7150.427965762739;7151.463640226978;7169.39060179884;1799.3702204228546;1822.8177182281731;2065.194574116092;2096.3186964236606;2099.958000839982;2066.152877320299;2083.364573804989;2096.2453516733963;2098.129276350313;2104.4949212189117;1995.8203761661448;2030.5329774151953;2037.500812300981;2041.173324803457;2052.107333310015;2089.696993935871;2093.3824521766114;2115.217369573252;2118.152738904435;2130.0095455613136;2108.578284343122;2138.379869837745;2141.539568992674;2143.0998980428258;2144.710464087344;7164.319389657974;7180.066591343144;7194.604296763676;7202.747903823341;7231.819204519929;4493.191225579394;4582.954170458286;4586.541345865387;4605.700629459075;4621.722696638179;2612.137994461823;2692.0846912049997;2700.1089640418613;2712.6337944377456;2723.496153211642;703;841.4110122913924;878.7671267114156;880.55972013993;887.2990337633262;9171.945226298927;9247.861282080774;9272.675456359062;9276.443413395218;9299.953500232456;4078.6744308099987;4202.537720850704;4223.535411104776;4239.894002649959;4249.128928569636;8305.46014509055;8323.916760832435;8349.791255218546;8357.414980951397;8359.749207523784;4605.4933957264675;4616.076784643018;4616.146012987608;4637.814487420533;4641.234196357564;4220.092680073799;4234.618884300427;4247.3628955656895;4258.169656916872;4259;3401.608814986259;3437.3125374925116;3452.6374730653424;3463.1169051891607;3484.0244731475227;1105.3202280597375;1109.5506319940437;1112.927659702133;1114.2144787924494;1116.1461481966303;1224.871388504212;1239.2007155384727;1248.219862585884;1254.7239607286383;1259.1878238536092;6784.321567843176;6799.558028728117;6872.62200578963;6928.678892570944;6929.237783843773;456.76248350857367;468.75624675168723;468.78435919476743;470.7716757372672;471.27423767398506;5306.946930530722;5373.194020896896;5378.058839703036;5385.488378604026;5387.892242155135;8295.917040829636;8355.832883342298;8417.368697347723;8429.747107586782;8488.575571221414;8325.542095184703;8354.874676879852;8372.832543349099;8382.455140415854;8392.916070839214;6549.967250163814;6679.098321726505;6686.264510903797;6697.162854643169;6779.796606101726;6419.35806419373;6439.7424103035355;6450.612963222222;6451.645159516272;6451.838704032437;7249;7416.035915330973;7441.3674837637245;7471.327580517779;7510.023696919366;7578.1285152206;7584.165741768511;7678.961605192162;7722.961385193038;7789.143194248515;6311.400416960381;6354.809355719336;6366.586171898812;6375.6493392861985;6376.904346434714;6713.56361836479;6870.244273130052;6872.518923675295;6878.484113691593;6892.724291028503;6281.905771413524;6292.779752708633;6368.044793280859;6412;6415.775447859302;6202.472789812917;6336.366363363627;6385.680715964276;6398.648074355955;6400.967995159995;6036.8188954331445;6188.659623720559;6195.876082478235;6203.038529028008;6203.906941395973;5888.17565540816;5910.408959104056;5930.28836539618;5932.228810254639;5934.970325148347;5264.578833693219;5670.489655930986;5832.912506312324;5981.043033114681;6009.609375390585 12:35:49 INFO - 2015-11-17 12:35:49,331 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.47288988261596;291.51462814414;297.32655535212746;305.42884805413877;306.18096591617416;5769.82690519284;5850.2979642442915;5878.823635290948;5886.234789477373;5905.61613495123;5717.799877004306;5845.473907348349;5857.765689372431;5877.471027607525;5877.794277200299;4552.271636538155;4575.26795712686;4584.220682483986;4586.059857729158;4600.355950166962;4356.869293921188;4592.609628181609;4601.217792975202;4617.907641847161;4646.279826626861;4405.80173892174;4456.509783923766;4536.5236650151755;4552.203364411214;4554.089182163564;4469.709468884528;4517.706349087299;4538.319252112193;4562.634989200856;4567.5889169974525;3891.9416208756893;3892.6885849132286;3906.746061505993;3910.3743401055694;3924.529056513208;5531.612787104904;5614.719264036782;5688.658680479184;5706.28671416073;5715.571332150105;5009.774560144766;5030.170021946375;5039.21892106724;5040.218766091261;5046.873828154289;6148.323684394713;6156.322804491502;6170.475509581691;6180.814575562696;6200.255969283669;4116.464859568267;4122.752634841919;4129.690273229489;4131.132462182945;4138.503379594438;6303.2751233607805;6474.223093228796;6486.513511486657;6504.577202481871;6519.315471875432;4233.11104668017;4233.745975241495;4234.830606775695;4244.8514301999285;4251.17102165081;4280.935785963213;4311.827526898889;4317.287647538184;4327.653787696977;4345.565443455693;5015.22264049073;5020.799168033311;5024;5046.066477701637;5049.318342023853;5969.343372229051;6184.134221209034;6184.443400094013;6184.783532576338;6212.658303793244;1515.8408367121515;1532.8926975111635;1534.3248970452964;1535.3167840311178;1539.8229203641724;999.8400255959011;1012.3217444312328;1016.2885979814012;1017.049059129716;1029.2229366827996;5871.970640146772;5892.646441213541;5894.498967587803;5903.645781253139;5905.675187864708;6416.037594360883;6419.679016049272;6431.389018043278;6440.67796610177;6441.355864413615;5725.713714314267;5841.06542953134;5853.004989151855;5863.355030946593;5902.6458412495385;3322;3426.2804810989473;3458.1181798641687;3467.965320346764;3475.079104037432;6655.267920528738;6675.365840245169;6683.2648408675;6698.956818170504;6717.294684058202;6673.866522669519;6676.86646267072;6678.165229346332;6680.532362734659;6689.966550167315;6455.580387274812;6660.333966603301;6660.600363978177;6685.298043705438;6730.798076057726;6534;6544.476441884733;6571.901421478778;6578.736850525926;6592.307807680317;6406.903896441464;6414.871702566016;6418.903716444351;6443.935560644333;6453.1610890583925;6523.347665233438;6687.465002799667;6693.062971184136;6699.497537684791;6733.023711561894;4196.937045944374;4233.872983810491;4236.872893813191;4254.361845723166;4262.232798096373;6476.31998640136;6488.708008139551;6495.350464953467;6507.349265073455;6508.73965041412;6108.57239993214;6278.623282603058;6282.654454005074;6347.71435285404;6353.618782873043;6305.747770089145;6306.337834527492;6330.778422755181;6330.8100756977365;6346.333634968262;6027.668478233564;6147.262328520606;6158.599691020069;6159.476444502088;6165.106059621419;6149.877002460015;6311.96844015777;6315.08431277453;6325.936740632535;6327.620342779448;6159;6163.876722465615;6167.599106058092;6168.35232300602;6172.444479996821 12:35:49 INFO - 2015-11-17 12:35:49,334 DEBUG : BROWSER_OUTPUT: |5;yui.html;638.2755572425295;647.355880898506;662.1425254295686;662.3972185311367;664.1565212180533;12572.937135314321;13033;13039.543615973444;13041;13107.34463276836;11940.522379104847;11951.043916486682;12028.158028937978;12034.81947770784;12355.505779768799;854.7350321400386;875.8379699755534;876.750126214026;876.8772371867943;880.2034159086037;841.9727931923044;854.372036553133;856.195176534056;860.8235311761074;862.2972277593773;896.2202883491371;907.4101833808045;911.3119594705988;911.8677791720197;912.9726108216764;868.3096937934357;884.9734507964771;889.5730049576175;893.5353616119614;895.8208358328295;664.40203816565;664.7407511070686;669.3206395508563;669.5012215899137;669.7957123077459;11271.211015228937;11531.365774882379;11549.307041577533;11602.883971160349;11660.59187928427;9376.249900007982;9491.66779162726;9657.806843863083;9769.120779129842;10045.748856278578;7488.513246639006;7629.471170588506;7735.922640773577;7797.142314345418;7866.960665196694;2814.8733307001235;2854.6003559501687;2985.2686091907403;3007.593974813416;3030.196997795586;38289.23421531582;41543.7922810387;42766.35850462214;44330.77834610806;44547;7946.602669866484;7949.364050875916;8168.019837619524;8554.401191916631;8616.569171541398;18756.812431875507;18763.81236187648;18777.906110469634;18790;19008.239670413306;6577.86844263112;6727.9327206728285;6849.4177994871;6902.758403455855;6945.062416573698;3495.7727747696317;3625.220577575781;3626.601073881871;3643.690286325639;3745.438184272381;2855.386091990232;2871.3970066285897;2876.6548014238424;2883.524218503965;2903.8548072596286;407.21407683171765;408.8793805827288;432.54366643191736;452.954704529551;453.75497231495285;440.33509400804377;456.0832726220321;456.559420159541;463.25416080110995;581.0499832773446;6942.7222911084;7160.677769500385;7377.22539133394;7400.481966262418;7446.813829654302;482.4018217410456;512.7666911555233;517.3455578692956;564.0777329067005;576.1962062922283;3138.3409484008157;3389.1527118220447;3440.673136052071;3447.7069449096607;3465.9306813864087;55840.720796395755;57485.13772293419;57662.42337576654;58053.419465805644;58351.708241458524;41008.589914101074;47787.28319075217;48332;48408;48762.756186218845;42728.57271427308;42935.35596966048;43035.56964430378;43140.35289470661;43727.56272437298;7515.323620874147;7525.661345239368;7552.169261381354;7638.236176382317;7656.349210317186;31946.840265799452;32983.8350808254;33063.66936330606;33095.50356744699;33228.83385583057;41164.176716464906;44376;45047.774761125984;45477.54522454865;45783;5966.791162309299;6906.240313565604;6931.4108300795;6996.965015174892;7051.964740176266;10467.790644187226;10524.94737526338;10695.839562406414;10812.5134368952;11322.207445478738;9605.18355939753;9887.30788844774;9980.401175929468;10069;10279.537420815932;10147.263572351705;10219.335743176669;10222.335548189343;10302.742431438974;10407.271490995558;9534.427934323963;9717.80564388694;9726.902730972599;10080.546375412978;10109.03964123407;7981.880271796043;8137.226963438464;8252.793680158044;8423.578821059045;8545.82908341842;7811.648475818715;8165.836683266182;8379.70671026511;8431.113876789048;8444.493330400195 12:35:49 INFO - 2015-11-17 12:35:49,334 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:49 INFO - 2015-11-17 12:35:49,335 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:49 INFO - 2015-11-17 12:35:49,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1132 12:35:49 INFO - 2015-11-17 12:35:49,335 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:49 INFO - 2015-11-17 12:35:49,335 DEBUG : BROWSER_OUTPUT: __startTimestamp1447792549320__endTimestamp 12:35:49 INFO - 2015-11-17 12:35:49,335 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5006.40 Median:5148.28 stddev:512.69 (10.0%) stddev-sans-first:490.16 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: Values: 3026.2 3052.2 3105.3 3173.2 3220.3 4856.8 4933.5 4963.3 5007.3 5031.2 4896.3 5007.4 5018.8 5118.4 5166.5 4695.3 4698.0 4711.8 4733.5 4833.9 4754.2 4873.6 4873.9 4876.2 4931.8 4554.7 4656.5 4667.0 4809.8 4821.5 4699.2 4709.3 4728.3 4730.1 4731.5 4560.2 4644.4 4705.2 4717.4 4739.2 4907.0 4922.9 4923.5 4939.1 5008.4 5253.1 5263.4 5281.1 5289.1 5304.3 5260.4 5337.3 5359.5 5381.9 5409.5 4882.6 4922.7 4938.1 4959.2 4993.1 5429.2 5449.6 5497.5 5511.9 5550.1 5103.4 5212.4 5229.2 5232.7 5240.6 5313.9 5380.8 5398.9 5416.3 5459.8 5275.2 5311.1 5314.1 5377.9 5394.9 5246.9 5343.7 5352.4 5357.4 5422.8 4064.7 4101.2 4107.0 4140.8 4148.1 3737.2 3743.2 3763.8 3768.7 3805.2 4951.9 4976.4 5009.9 5058.8 5076.8 5348.4 5412.4 5425.6 5440.4 5505.6 5060.2 5089.1 5099.2 5124.9 5135.4 4542.8 4653.8 4664.6 4782.8 4838.3 5416.3 5417.4 5504.8 5536.2 5536.9 5423.6 5425.7 5446.7 5453.9 5469.5 5231.0 5540.6 5542.0 5559.6 5605.2 5193.8 5277.6 5303.5 5353.9 5385.0 5359.7 5378.9 5379.4 5380.1 5386.2 4777.5 5255.6 5267.5 5296.9 5304.9 5134.7 5148.3 5174.7 5222.7 5247.3 5104.5 5108.9 5110.2 5130.2 5184.1 5193.8 5264.7 5267.6 5285.3 5287.9 5147.9 5149.0 5167.2 5167.9 5180.1 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,336 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45818.78 Median:16992.36 stddev:83701.72 (492.6%) stddev-sans-first:83867.43 12:35:49 INFO - 2015-11-17 12:35:49,338 DEBUG : BROWSER_OUTPUT: Values: 521.8 524.3 533.6 542.1 554.1 28525.1 30825.2 36748.4 38689.6 38900.6 40141.8 40301.8 40464.6 40574.8 40671.6 7747.0 8281.8 8367.1 8542.8 8554.6 7823.9 10473.0 10574.6 10655.0 10667.3 10355.9 10371.2 10415.9 10493.9 10510.3 7975.2 8077.6 10178.2 10254.4 10473.9 10100.4 10206.0 10254.4 10294.7 10299.5 36544.3 36676.4 36763.4 36871.0 36949.3 2844.7 2929.9 3159.5 3275.1 3324.1 25554.1 25556.2 25756.7 25848.2 25970.6 2100.3 2102.7 2111.9 2117.3 2208.3 246062.0 247405.0 247584.0 248441.0 248885.8 48448.5 49421.8 56199.4 56481.2 56576.0 60391.7 60639.0 61204.4 61309.7 61358.0 12124.4 12280.1 12280.7 12292.4 12292.9 9034.3 9044.3 9051.6 9052.8 9054.7 17998.5 18089.7 18116.5 18465.8 18485.8 7180.6 7310.5 7398.3 7436.4 7488.4 883.5 913.4 948.2 989.9 1027.8 26473.2 26813.7 26855.0 27178.3 27465.0 999.9 1009.4 1033.7 1051.0 1118.1 14066.5 14077.9 14079.9 14121.3 14121.4 420844.0 433125.0 434284.0 434481.0 434630.0 49664.3 49884.8 50007.7 50123.5 50244.5 1273.2 1279.9 1283.4 1285.1 1285.4 23797.6 25947.7 26332.6 27446.5 27517.6 46328.3 47699.5 47737.0 47743.3 47755.8 173435.0 239138.0 240695.0 242284.0 244749.0 26174.9 29313.0 29408.1 29414.4 29444.5 37245.3 37550.6 37701.2 37955.6 38096.2 31614.0 33600.3 34461.0 34764.8 34777.8 34017.4 34139.7 34429.0 34456.3 34475.8 33665.5 34462.7 34665.3 34807.8 34979.0 29088.4 30182.4 30322.0 30378.0 30504.8 21789.6 21838.6 21986.7 22036.4 22085.0 12:35:49 INFO - 2015-11-17 12:35:49,338 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,338 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27888.09 Median:4532.26 stddev:89271.86 (1969.7%) stddev-sans-first:89498.28 12:35:49 INFO - 2015-11-17 12:35:49,338 DEBUG : BROWSER_OUTPUT: Values: 312.2 317.5 322.6 323.1 325.8 16448.4 16811.2 17026.3 17257.2 17278.7 17484.7 17598.4 17918.5 18221.5 18226.6 5073.8 5213.2 5218.8 5234.5 5265.4 4451.4 4578.0 4579.1 4583.3 4591.2 3196.6 3282.7 4470.7 4528.6 4535.9 4522.8 4559.9 4579.8 4583.0 4589.3 3730.3 3872.0 3875.1 3877.0 3883.3 9999.8 10500.7 10510.3 21444.8 21496.2 1855.1 1893.4 1934.5 2023.3 2066.0 12788.9 12854.9 13048.2 13151.7 13486.0 1685.4 1712.1 1719.2 1723.6 1738.9 63684.4 64189.0 64738.0 65219.7 65357.7 15888.6 16046.0 16059.9 16084.2 16125.0 23579.4 23625.9 23635.9 23789.6 23811.5 7648.3 7653.7 7929.8 8001.1 8038.1 6198.3 6199.6 6211.5 6500.3 6553.8 7455.4 7560.1 7561.9 7573.2 7596.1 2980.2 2981.3 2989.6 2994.3 3051.7 383.5 387.0 387.5 390.9 392.0 10970.5 11114.8 11252.8 11322.7 11347.5 412.7 418.8 422.6 425.2 430.6 5391.8 5488.5 6027.7 6099.3 6156.9 522890.0 547763.0 550981.0 553245.0 554204.0 67932.0 68155.3 68596.0 70245.0 70410.6 489.5 493.9 494.0 494.7 494.8 10658.0 10671.5 10735.9 10737.9 10771.3 34683.8 34757.8 34952.1 35071.6 35132.3 43315.8 45525.3 46999.3 47329.8 47548.3 5798.0 5993.6 6001.6 6020.0 6032.2 10697.4 11151.2 11375.0 11415.0 11417.5 7915.7 9614.0 9644.5 9701.0 9706.4 7704.5 8995.1 9395.4 9485.3 9611.8 9551.7 9747.7 9931.5 9975.8 9981.3 5832.0 5863.3 5874.4 5898.2 5906.6 9491.7 9772.5 9791.9 9813.9 9851.6 12:35:49 INFO - 2015-11-17 12:35:49,338 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,338 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4975.07 Median:6112.74 stddev:2529.39 (41.4%) stddev-sans-first:2520.95 12:35:49 INFO - 2015-11-17 12:35:49,340 DEBUG : BROWSER_OUTPUT: Values: 1245.7 1654.3 1710.9 1718.6 1737.0 6608.9 6760.5 6900.2 6955.2 6979.7 7069.2 7140.4 7150.4 7151.5 7169.4 1799.4 1822.8 2065.2 2096.3 2100.0 2066.2 2083.4 2096.2 2098.1 2104.5 1995.8 2030.5 2037.5 2041.2 2052.1 2089.7 2093.4 2115.2 2118.2 2130.0 2108.6 2138.4 2141.5 2143.1 2144.7 7164.3 7180.1 7194.6 7202.7 7231.8 4493.2 4583.0 4586.5 4605.7 4621.7 2612.1 2692.1 2700.1 2712.6 2723.5 703.0 841.4 878.8 880.6 887.3 9171.9 9247.9 9272.7 9276.4 9300.0 4078.7 4202.5 4223.5 4239.9 4249.1 8305.5 8323.9 8349.8 8357.4 8359.7 4605.5 4616.1 4616.1 4637.8 4641.2 4220.1 4234.6 4247.4 4258.2 4259.0 3401.6 3437.3 3452.6 3463.1 3484.0 1105.3 1109.6 1112.9 1114.2 1116.1 1224.9 1239.2 1248.2 1254.7 1259.2 6784.3 6799.6 6872.6 6928.7 6929.2 456.8 468.8 468.8 470.8 471.3 5306.9 5373.2 5378.1 5385.5 5387.9 8295.9 8355.8 8417.4 8429.7 8488.6 8325.5 8354.9 8372.8 8382.5 8392.9 6550.0 6679.1 6686.3 6697.2 6779.8 6419.4 6439.7 6450.6 6451.6 6451.8 7249.0 7416.0 7441.4 7471.3 7510.0 7578.1 7584.2 7679.0 7723.0 7789.1 6311.4 6354.8 6366.6 6375.6 6376.9 6713.6 6870.2 6872.5 6878.5 6892.7 6281.9 6292.8 6368.0 6412.0 6415.8 6202.5 6336.4 6385.7 6398.6 6401.0 6036.8 6188.7 6195.9 6203.0 6203.9 5888.2 5910.4 5930.3 5932.2 5935.0 5264.6 5670.5 5832.9 5981.0 6009.6 12:35:49 INFO - 2015-11-17 12:35:49,340 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,340 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5193.37 Median:5878.31 stddev:1597.72 (27.2%) stddev-sans-first:1559.17 12:35:49 INFO - 2015-11-17 12:35:49,341 DEBUG : BROWSER_OUTPUT: Values: 286.5 291.5 297.3 305.4 306.2 5769.8 5850.3 5878.8 5886.2 5905.6 5717.8 5845.5 5857.8 5877.5 5877.8 4552.3 4575.3 4584.2 4586.1 4600.4 4356.9 4592.6 4601.2 4617.9 4646.3 4405.8 4456.5 4536.5 4552.2 4554.1 4469.7 4517.7 4538.3 4562.6 4567.6 3891.9 3892.7 3906.7 3910.4 3924.5 5531.6 5614.7 5688.7 5706.3 5715.6 5009.8 5030.2 5039.2 5040.2 5046.9 6148.3 6156.3 6170.5 6180.8 6200.3 4116.5 4122.8 4129.7 4131.1 4138.5 6303.3 6474.2 6486.5 6504.6 6519.3 4233.1 4233.7 4234.8 4244.9 4251.2 4280.9 4311.8 4317.3 4327.7 4345.6 5015.2 5020.8 5024.0 5046.1 5049.3 5969.3 6184.1 6184.4 6184.8 6212.7 1515.8 1532.9 1534.3 1535.3 1539.8 999.8 1012.3 1016.3 1017.0 1029.2 5872.0 5892.6 5894.5 5903.6 5905.7 6416.0 6419.7 6431.4 6440.7 6441.4 5725.7 5841.1 5853.0 5863.4 5902.6 3322.0 3426.3 3458.1 3468.0 3475.1 6655.3 6675.4 6683.3 6699.0 6717.3 6673.9 6676.9 6678.2 6680.5 6690.0 6455.6 6660.3 6660.6 6685.3 6730.8 6534.0 6544.5 6571.9 6578.7 6592.3 6406.9 6414.9 6418.9 6443.9 6453.2 6523.3 6687.5 6693.1 6699.5 6733.0 4196.9 4233.9 4236.9 4254.4 4262.2 6476.3 6488.7 6495.4 6507.3 6508.7 6108.6 6278.6 6282.7 6347.7 6353.6 6305.7 6306.3 6330.8 6330.8 6346.3 6027.7 6147.3 6158.6 6159.5 6165.1 6149.9 6312.0 6315.1 6325.9 6327.6 6159.0 6163.9 6167.6 6168.4 6172.4 12:35:49 INFO - 2015-11-17 12:35:49,341 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,342 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12578.35 Median:515.06 stddev:15264.85 (2963.7%) stddev-sans-first:15281.34 12:35:49 INFO - 2015-11-17 12:35:49,343 DEBUG : BROWSER_OUTPUT: Values: 638.3 647.4 662.1 662.4 664.2 12572.9 13033.0 13039.5 13041.0 13107.3 11940.5 11951.0 12028.2 12034.8 12355.5 854.7 875.8 876.8 876.9 880.2 842.0 854.4 856.2 860.8 862.3 896.2 907.4 911.3 911.9 913.0 868.3 885.0 889.6 893.5 895.8 664.4 664.7 669.3 669.5 669.8 11271.2 11531.4 11549.3 11602.9 11660.6 9376.2 9491.7 9657.8 9769.1 10045.7 7488.5 7629.5 7735.9 7797.1 7867.0 2814.9 2854.6 2985.3 3007.6 3030.2 38289.2 41543.8 42766.4 44330.8 44547.0 7946.6 7949.4 8168.0 8554.4 8616.6 18756.8 18763.8 18777.9 18790.0 19008.2 6577.9 6727.9 6849.4 6902.8 6945.1 3495.8 3625.2 3626.6 3643.7 3745.4 2855.4 2871.4 2876.7 2883.5 2903.9 407.2 408.9 432.5 453.0 453.8 440.3 456.1 456.6 463.3 581.0 6942.7 7160.7 7377.2 7400.5 7446.8 482.4 512.8 517.3 564.1 576.2 3138.3 3389.2 3440.7 3447.7 3465.9 55840.7 57485.1 57662.4 58053.4 58351.7 41008.6 47787.3 48332.0 48408.0 48762.8 42728.6 42935.4 43035.6 43140.4 43727.6 7515.3 7525.7 7552.2 7638.2 7656.3 31946.8 32983.8 33063.7 33095.5 33228.8 41164.2 44376.0 45047.8 45477.5 45783.0 5966.8 6906.2 6931.4 6997.0 7052.0 10467.8 10524.9 10695.8 10812.5 11322.2 9605.2 9887.3 9980.4 10069.0 10279.5 10147.3 10219.3 10222.3 10302.7 10407.3 9534.4 9717.8 9726.9 10080.5 10109.0 7981.9 8137.2 8252.8 8423.6 8545.8 7811.6 8165.8 8379.7 8431.1 8444.5 12:35:49 INFO - 2015-11-17 12:35:49,343 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:49 INFO - 2015-11-17 12:35:49,343 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-17 12:35:49,997 INFO : Browser exited with error code: 0 12:35:50 INFO - 2015-11-17 12:35:50,023 INFO : Completed test dromaeo_css (00:18:36) 12:35:50 INFO - 2015-11-17 12:35:50,023 INFO : Starting test kraken 12:35:50 INFO - 2015-11-17 12:35:50,023 DEBUG : operating with platform_type : mac_ 12:35:50 INFO - 2015-11-17 12:35:50,024 INFO : Initialising browser for kraken test... 12:35:50 INFO - 2015-11-17 12:35:50,037 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpCOTuAl/profile http://localhost:49263/getInfo.html 12:35:52 INFO - 2015-11-17 12:35:52,299 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:35:52 INFO - 2015-11-17 12:35:52,299 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:35:52 INFO - 2015-11-17 12:35:52,299 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:35:52 INFO - 2015-11-17 12:35:52,299 DEBUG : BROWSER_OUTPUT: __metrics 12:35:52 INFO - 2015-11-17 12:35:52,317 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:53 INFO - 2015-11-17 12:35:53,039 INFO : Browser initialized. 12:35:53 INFO - 2015-11-17 12:35:53,040 INFO : Running cycle 1/1 for kraken test... 12:35:53 INFO - 2015-11-17 12:35:53,040 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpCOTuAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:04 INFO - 2015-11-17 12:36:04,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 236085248 12:36:04 INFO - 2015-11-17 12:36:04,978 DEBUG : BROWSER_OUTPUT: 12:36:07 INFO - 2015-11-17 12:36:07,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:08 INFO - 2015-11-17 12:36:08,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 293363712 12:36:08 INFO - 2015-11-17 12:36:08,128 DEBUG : BROWSER_OUTPUT: 12:36:10 INFO - 2015-11-17 12:36:10,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 12:36:11 INFO - 2015-11-17 12:36:11,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 305143808 12:36:11 INFO - 2015-11-17 12:36:11,357 DEBUG : BROWSER_OUTPUT: 12:36:14 INFO - 2015-11-17 12:36:14,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 12:36:14 INFO - 2015-11-17 12:36:14,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 287907840 12:36:14 INFO - 2015-11-17 12:36:14,906 DEBUG : BROWSER_OUTPUT: 12:36:17 INFO - 2015-11-17 12:36:17,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 12:36:17 INFO - 2015-11-17 12:36:17,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 291307520 12:36:17 INFO - 2015-11-17 12:36:17,589 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-17 12:36:19,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:36:20 INFO - 2015-11-17 12:36:20,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 292458496 12:36:20 INFO - 2015-11-17 12:36:20,391 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-17 12:36:23,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:24 INFO - 2015-11-17 12:36:24,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 292376576 12:36:24 INFO - 2015-11-17 12:36:24,092 DEBUG : BROWSER_OUTPUT: 12:36:27 INFO - 2015-11-17 12:36:27,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:27 INFO - 2015-11-17 12:36:27,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 291450880 12:36:27 INFO - 2015-11-17 12:36:27,940 DEBUG : BROWSER_OUTPUT: 12:36:30 INFO - 2015-11-17 12:36:30,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 12:36:31 INFO - 2015-11-17 12:36:31,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 292814848 12:36:31 INFO - 2015-11-17 12:36:31,469 DEBUG : BROWSER_OUTPUT: 12:36:33 INFO - 2015-11-17 12:36:33,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:33 INFO - 2015-11-17 12:36:33,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 327467008 12:36:33 INFO - 2015-11-17 12:36:33,630 DEBUG : BROWSER_OUTPUT: 12:36:35 INFO - 2015-11-17 12:36:35,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:36 INFO - 2015-11-17 12:36:36,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 326995968 12:36:36 INFO - 2015-11-17 12:36:36,108 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-11-17 12:36:38,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:38 INFO - 2015-11-17 12:36:38,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 334626816 12:36:38 INFO - 2015-11-17 12:36:38,835 DEBUG : BROWSER_OUTPUT: 12:36:41 INFO - 2015-11-17 12:36:41,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:42 INFO - 2015-11-17 12:36:42,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 335839232 12:36:42 INFO - 2015-11-17 12:36:42,086 DEBUG : BROWSER_OUTPUT: 12:36:44 INFO - 2015-11-17 12:36:44,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:45 INFO - 2015-11-17 12:36:45,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 335532032 12:36:45 INFO - 2015-11-17 12:36:45,387 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 12:36:47 INFO - 2015-11-17 12:36:47,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 394780672 12:36:47 INFO - 2015-11-17 12:36:47,394 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,395 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:47 INFO - 2015-11-17 12:36:47,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:47 INFO - 2015-11-17 12:36:47,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:47 INFO - 2015-11-17 12:36:47,395 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:47 INFO - 2015-11-17 12:36:47,395 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;108;100;109;109;107;97;107;110;107 12:36:47 INFO - 2015-11-17 12:36:47,395 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;128;151;163;125;153;149;127;168;125 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;162;163;163;161;163;162;161 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;82;89;85;69;69;71;82;90;72 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;99;135;89;91;92;131;91;96;144 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;124;122;125;127;117;124;129;123;125 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;125;128;128;165;142;136;130;135;135 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;105;101;100;101;109;110;113;109 12:36:47 INFO - 2015-11-17 12:36:47,396 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;61;59;59;60;60;68;59;60 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;68;71;70;69;69;72;75 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;87;88;92;92;93;95;95;95 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;123;131;132;134;131;144;143;141;134 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;141;156;165;168;160;168;166;163;158 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;71;71;71;71;73;76;75;77 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,919 12:36:47 INFO - 2015-11-17 12:36:47,397 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:47 INFO - 2015-11-17 12:36:47,398 DEBUG : BROWSER_OUTPUT: __startTimestamp1447792607393__endTimestamp 12:36:47 INFO - 2015-11-17 12:36:47,398 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,399 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:47 INFO - 2015-11-17 12:36:47,399 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:36:47 INFO - 2015-11-17 12:36:47,399 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,400 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.00 Median:108.50 stddev:4.19 (3.9%) stddev-sans-first:4.44 12:36:47 INFO - 2015-11-17 12:36:47,400 DEBUG : BROWSER_OUTPUT: Values: 106.0 108.0 100.0 109.0 109.0 107.0 97.0 107.0 110.0 107.0 12:36:47 INFO - 2015-11-17 12:36:47,400 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,400 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:152.00 stddev:16.83 (11.1%) stddev-sans-first:17.15 12:36:47 INFO - 2015-11-17 12:36:47,400 DEBUG : BROWSER_OUTPUT: Values: 158.0 128.0 151.0 163.0 125.0 153.0 149.0 127.0 168.0 125.0 12:36:47 INFO - 2015-11-17 12:36:47,400 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,401 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 12:36:47 INFO - 2015-11-17 12:36:47,401 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 162.0 163.0 163.0 161.0 163.0 162.0 161.0 12:36:47 INFO - 2015-11-17 12:36:47,401 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,401 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.50 Median:82.00 stddev:8.13 (9.9%) stddev-sans-first:8.57 12:36:47 INFO - 2015-11-17 12:36:47,401 DEBUG : BROWSER_OUTPUT: Values: 76.0 82.0 89.0 85.0 69.0 69.0 71.0 82.0 90.0 72.0 12:36:47 INFO - 2015-11-17 12:36:47,401 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,402 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:91.50 stddev:21.22 (23.2%) stddev-sans-first:22.28 12:36:47 INFO - 2015-11-17 12:36:47,402 DEBUG : BROWSER_OUTPUT: Values: 98.0 99.0 135.0 89.0 91.0 92.0 131.0 91.0 96.0 144.0 12:36:47 INFO - 2015-11-17 12:36:47,402 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,402 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:123.60 Median:124.50 stddev:3.41 (2.7%) stddev-sans-first:3.35 12:36:47 INFO - 2015-11-17 12:36:47,402 DEBUG : BROWSER_OUTPUT: Values: 120.0 124.0 122.0 125.0 127.0 117.0 124.0 129.0 123.0 125.0 12:36:47 INFO - 2015-11-17 12:36:47,403 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,403 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:135.10 Median:135.00 stddev:11.72 (8.7%) stddev-sans-first:12.06 12:36:47 INFO - 2015-11-17 12:36:47,404 DEBUG : BROWSER_OUTPUT: Values: 127.0 125.0 128.0 128.0 165.0 142.0 136.0 130.0 135.0 135.0 12:36:47 INFO - 2015-11-17 12:36:47,404 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,404 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.00 Median:109.50 stddev:6.06 (5.5%) stddev-sans-first:5.69 12:36:47 INFO - 2015-11-17 12:36:47,404 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 105.0 101.0 100.0 101.0 109.0 110.0 113.0 109.0 12:36:47 INFO - 2015-11-17 12:36:47,405 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,405 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:2.67 (4.5%) stddev-sans-first:2.83 12:36:47 INFO - 2015-11-17 12:36:47,405 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 61.0 59.0 59.0 60.0 60.0 68.0 59.0 60.0 12:36:47 INFO - 2015-11-17 12:36:47,405 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,405 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:2.50 (3.6%) stddev-sans-first:2.47 12:36:47 INFO - 2015-11-17 12:36:47,405 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 71.0 70.0 69.0 69.0 72.0 75.0 12:36:47 INFO - 2015-11-17 12:36:47,406 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,406 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:92.50 stddev:3.65 (3.9%) stddev-sans-first:3.40 12:36:47 INFO - 2015-11-17 12:36:47,406 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 87.0 88.0 92.0 92.0 93.0 95.0 95.0 95.0 12:36:47 INFO - 2015-11-17 12:36:47,406 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,406 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:134.00 stddev:7.56 (5.6%) stddev-sans-first:6.78 12:36:47 INFO - 2015-11-17 12:36:47,406 DEBUG : BROWSER_OUTPUT: Values: 122.0 123.0 131.0 132.0 134.0 131.0 144.0 143.0 141.0 134.0 12:36:47 INFO - 2015-11-17 12:36:47,407 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,407 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:164.00 stddev:8.35 (5.1%) stddev-sans-first:8.49 12:36:47 INFO - 2015-11-17 12:36:47,407 DEBUG : BROWSER_OUTPUT: Values: 153.0 141.0 156.0 165.0 168.0 160.0 168.0 166.0 163.0 158.0 12:36:47 INFO - 2015-11-17 12:36:47,407 DEBUG : BROWSER_OUTPUT: 12:36:47 INFO - 2015-11-17 12:36:47,407 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:72.00 stddev:2.41 (3.3%) stddev-sans-first:2.47 12:36:47 INFO - 2015-11-17 12:36:47,407 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 71.0 71.0 73.0 76.0 75.0 77.0 12:36:47 INFO - 2015-11-17 12:36:47,409 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:47 INFO - 2015-11-17 12:36:47,409 DEBUG : BROWSER_OUTPUT: 12:36:48 INFO - 2015-11-17 12:36:48,084 INFO : Browser exited with error code: 0 12:36:48 INFO - 2015-11-17 12:36:48,135 INFO : Completed test kraken (00:00:58) 12:36:48 INFO - 2015-11-17 12:36:48,135 INFO : Starting test v8_7 12:36:48 INFO - 2015-11-17 12:36:48,135 DEBUG : operating with platform_type : mac_ 12:36:48 INFO - 2015-11-17 12:36:48,135 INFO : Initialising browser for v8_7 test... 12:36:48 INFO - 2015-11-17 12:36:48,149 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpNFEz4E/profile http://localhost:49263/getInfo.html 12:36:50 INFO - 2015-11-17 12:36:50,405 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:50 INFO - 2015-11-17 12:36:50,405 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:50 INFO - 2015-11-17 12:36:50,405 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:36:50 INFO - 2015-11-17 12:36:50,405 DEBUG : BROWSER_OUTPUT: __metrics 12:36:50 INFO - 2015-11-17 12:36:50,415 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:51 INFO - 2015-11-17 12:36:51,165 INFO : Browser initialized. 12:36:51 INFO - 2015-11-17 12:36:51,165 INFO : Running cycle 1/1 for v8_7 test... 12:36:51 INFO - 2015-11-17 12:36:51,165 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpNFEz4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:03 INFO - 2015-11-17 12:37:03,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 236482560 12:37:03 INFO - 2015-11-17 12:37:03,073 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html) 12:37:24 INFO - 2015-11-17 12:37:24,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 709451776 12:37:24 INFO - 2015-11-17 12:37:24,797 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |0;Richards;168.40687100033682 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;199.12385503783352 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |2;Encrypt;332.33632436025255 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6103.658536585366 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |5;Earley;1016.243654822335 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |6;Boyer;13712.328767123288 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |7;RegExp;31406.25 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |8;Splay;634.9206349206349 12:37:24 INFO - 2015-11-17 12:37:24,798 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6036.144578313253 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: __startTimestamp1447792644795__endTimestamp 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.41 Median:168.41 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: Values: 168.4 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:199.12 Median:199.12 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: Values: 199.1 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:332.34 Median:332.34 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: Values: 332.3 12:37:24 INFO - 2015-11-17 12:37:24,799 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6103.66 Median:6103.66 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: Values: 6103.7 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: Values: 1988.1 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1016.24 Median:1016.24 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: Values: 1016.2 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13712.33 Median:13712.33 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: Values: 13712.3 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31406.25 Median:31406.25 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,800 DEBUG : BROWSER_OUTPUT: Values: 31406.3 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:634.92 Median:634.92 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: Values: 634.9 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6036.14 Median:6036.14 stddev:0.00 (0.0%) 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: Values: 6036.1 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:24 INFO - 2015-11-17 12:37:24,801 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-17 12:37:25,503 INFO : Browser exited with error code: 0 12:37:25 INFO - 2015-11-17 12:37:25,523 INFO : Completed test v8_7 (00:00:37) 12:37:25 INFO - 2015-11-17 12:37:25,932 INFO : Completed test suite (00:20:11) 12:37:25 INFO - 2015-11-17 12:37:25,933 DEBUG : Working with test: dromaeo_css 12:37:25 INFO - 2015-11-17 12:37:25,933 DEBUG : Generating results file: dromaeo_css 12:37:25 INFO - 2015-11-17 12:37:25,933 DEBUG : Working with test: kraken 12:37:25 INFO - 2015-11-17 12:37:25,933 DEBUG : Generating results file: kraken 12:37:25 INFO - 2015-11-17 12:37:25,934 INFO : javascript benchmark 12:37:25 INFO - 2015-11-17 12:37:25,934 DEBUG : Working with test: v8_7 12:37:25 INFO - 2015-11-17 12:37:25,934 DEBUG : Generating results file: v8_7 12:37:25 INFO - 2015-11-17 12:37:25,934 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:25 INFO - 2015-11-17 12:37:25,994 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,140,55]] 12:37:25 INFO - 2015-11-17 12:37:25,994 DEBUG : process_Request line: dromaeo_css 6394.09 graph.html#tests=[[72,140,55]] 12:37:25 INFO - 2015-11-17 12:37:25,994 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:26 INFO - 2015-11-17 12:37:26,028 DEBUG : process_Request line: kraken 1547.50 graph.html#tests=[[232,140,55]] 12:37:26 INFO - 2015-11-17 12:37:26,028 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:26 INFO - 2015-11-17 12:37:26,065 DEBUG : process_Request line: v8_7 17543.73 graph.html#tests=[[230,140,55]] 12:37:26 INFO - 2015-11-17 12:37:26,066 INFO : javascript benchmark 12:37:26 INFO - 2015-11-17 12:37:26,068 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [312.19609505523283, 317.4888429628298, 322.5951430954152, 323.12272181028504, 325.84848045658765, 16448.424305149307, 16811.15944202788, 17026.31894724211, 17257.223424945878, 17278.740818887694, 17484.65030699385, 17598.38405655802, 17918.462446126603, 18221.544461388472, 18226.63546729068, 5073.847784566469, 5213.175388613992, 5218.765155568009, 5234.528892399702, 5265.420803711589, 4451.443569553806, 4578.0, 4579.084183163381, 4583.335416364625, 4591.219492686251, 3196.584444022274, 3282.6553211912765, 4470.7094038887535, 4528.637708983273, 4535.886602834922, 4522.773861306921, 4559.931601025987, 4579.839705610288, 4582.977085114553, 4589.2886602576655, 3730.2725968436166, 3871.993281746738, 3875.1280961783655, 3877.0113621026458, 3883.3010058189516, 9999.800003999879, 10500.737481563023, 10510.316829406063, 21444.785552144593, 21496.24763133283, 1855.1466325490292, 1893.4414347767304, 1934.477691023416, 2023.251396983111, 2065.987666043643, 12788.87211127886, 12854.935725321408, 13048.217106973612, 13151.671208219776, 13486.0, 1685.384834535398, 1712.0754792412083, 1719.1662043908693, 1723.5691077230692, 1738.9217485213069, 63684.36315636831, 64189.0, 64738.0, 65219.67390163066, 65357.673211633635, 15888.602784930237, 16046.0, 16059.919700401424, 16084.195790210442, 16124.984376952882, 23579.41051473727, 23625.881870590536, 23635.88182059079, 23789.64315535268, 23811.547325637686, 7648.311651951351, 7653.693852245848, 7929.762107136795, 8001.1198768135455, 8038.115807261197, 6198.349173336825, 6199.5660303779205, 6211.534134939807, 6500.317466666026, 6553.836154096186, 7455.4408419368765, 7560.130584982688, 7561.9243807562325, 7573.2048134946135, 7596.050493688289, 2980.226765074777, 2981.254686328418, 2989.6412430508044, 2994.293252845857, 3051.725344718986, 383.4880434619758, 386.98645547405704, 387.5098001028701, 390.93940439231966, 392.0414586336437, 10970.506327215295, 11114.777704445865, 11252.774944501229, 11322.716932076764, 11347.489362978686, 412.7007919258514, 418.82618713233666, 422.6301985762458, 425.21972181048125, 430.6081465866047, 5391.757370918318, 5488.4785945335125, 6027.7287522061615, 6099.268087829489, 6156.907646385308, 522890.0, 547763.0, 550981.0, 553245.0, 554204.0, 67932.0, 68155.3184468149, 68596.0, 70245.0, 70410.64794675994, 489.50559934465736, 493.86418734848206, 494.0, 494.69081823860085, 494.8020791683355, 10658.0, 10671.46642667848, 10735.89264107349, 10737.892621074001, 10771.299865508718, 34683.82658086693, 34757.826210868785, 34952.12619684528, 35071.64928350786, 35132.297354053284, 43315.78342108395, 45525.31712024388, 46999.295010574184, 47329.76335118302, 47548.2867756977, 5797.971010144923, 5993.550483713651, 6001.609895356788, 6019.969900150471, 6032.245969253843, 10697.411642359433, 11151.163662725166, 11375.0, 11415.029722473682, 11417.486213120595, 7915.722949696733, 9614.0, 9644.469554174588, 9700.951495242478, 9706.369086009387, 7704.460687751804, 8995.145461181177, 9395.389299695498, 9485.336026478357, 9611.807763844823, 9551.665691700757, 9747.707568772948, 9931.503424828585, 9975.750606234902, 9981.251406144713, 5832.0, 5863.2670916135485, 5874.383189765013, 5898.174255604305, 5906.557008224487, 9491.66779162726, 9772.462514561767, 9791.922888482404, 9813.85279220798, 9851.605935762489], "dojo.html": [3026.1678038539385, 3052.160655819648, 3105.3168302973345, 3173.2384227785337, 3220.339830334781, 4856.757162141887, 4933.457319694835, 4963.329950456688, 5007.273945277937, 5031.220160875066, 4896.290037944496, 5007.37407824022, 5018.849434516961, 5118.385793704751, 5166.457521960197, 4695.3426520287185, 4697.953020469803, 4711.7879695413785, 4733.526647335256, 4833.854984350475, 4754.168020596399, 4873.585745211643, 4873.902521949559, 4876.244182151772, 4931.802727890898, 4554.7039442436135, 4656.4645065817185, 4666.9766651166865, 4809.807607695688, 4821.517848215186, 4699.224627936386, 4709.293605959134, 4728.314394412825, 4730.148573256813, 4731.526847315241, 4560.179167749804, 4644.419447569054, 4705.223638099709, 4717.433907931036, 4739.170645137122, 4907.0, 4922.852314430537, 4923.458419573844, 4939.061578300111, 5008.449070602231, 5253.133233016586, 5263.421023687391, 5281.128613778722, 5289.127293996486, 5304.257403963448, 5260.447652996457, 5337.279467271907, 5359.464053594609, 5381.919271210896, 5409.459054094559, 4882.633802464794, 4922.655414121049, 4938.1358262304675, 4959.181735013683, 4993.1262029144755, 5429.239906413105, 5449.591280653967, 5497.47773961473, 5511.917321240185, 5550.056490396642, 5103.413107492686, 5212.374515058142, 5229.189475631283, 5232.73836308183, 5240.633155679142, 5313.920291195635, 5380.757865896044, 5398.946010539923, 5416.322959630046, 5459.836204913859, 5275.235090911796, 5311.097113490716, 5314.123169677037, 5377.851153928685, 5394.91907621386, 5246.921296180561, 5343.732813359316, 5352.437994010651, 5357.4106848246665, 5422.810201642924, 4064.7357921734992, 4101.200265948111, 4106.979465102655, 4140.751554906716, 4148.087420767426, 3737.2151848111657, 3743.21392507571, 3763.7553559018575, 3768.679662228741, 3805.238952209569, 4951.851444456672, 4976.402831660224, 5009.89980200394, 5058.772355244023, 5076.771545280471, 5348.411674715778, 5412.377576578744, 5425.6202065855805, 5440.401555828935, 5505.587080968943, 5060.240963855451, 5089.134847076006, 5099.158638824627, 5124.948750512447, 5135.409427915837, 4542.795574199169, 4653.813847446064, 4664.580187783048, 4782.808687652455, 4838.322634831126, 5416.322959630046, 5417.3770016447825, 5504.80733174337, 5536.197251398444, 5536.861578460571, 5423.62034657586, 5425.674459532441, 5446.700431476307, 5453.863653408696, 5469.453054694658, 5231.0, 5540.612157148961, 5542.0, 5559.63862348946, 5605.159226115952, 5193.766280517461, 5277.630565860353, 5303.549198318186, 5353.919691204557, 5385.030694475032, 5359.651622644516, 5378.865528361822, 5379.408265090915, 5380.0584897641975, 5386.245925570502, 4777.522247775334, 5255.63210575256, 5267.473252674702, 5296.894062118659, 5304.893902122013, 5134.743262836769, 5148.279240906351, 5174.741262936914, 5222.738863056908, 5247.317848679647, 5104.489551044866, 5108.948910510847, 5110.233464980282, 5130.204818253177, 5184.066867963803, 5193.818216362409, 5264.657797243167, 5267.631265811357, 5285.312909321918, 5287.867803304948, 5147.897042059213, 5149.0, 5167.22491626259, 5167.92248116271, 5180.067587834226], "mootools.html": [1245.7010317523798, 1654.2886558779724, 1710.8631309495242, 1718.6476772261683, 1737.0359450504964, 6608.933910660892, 6760.492963027768, 6900.206476255232, 6955.234924158339, 6979.6510174491195, 7069.18704349, 7140.357367836894, 7150.427965762739, 7151.463640226978, 7169.39060179884, 1799.3702204228546, 1822.8177182281731, 2065.194574116092, 2096.3186964236606, 2099.958000839982, 2066.152877320299, 2083.364573804989, 2096.2453516733963, 2098.129276350313, 2104.4949212189117, 1995.8203761661448, 2030.5329774151953, 2037.500812300981, 2041.173324803457, 2052.107333310015, 2089.696993935871, 2093.3824521766114, 2115.217369573252, 2118.152738904435, 2130.0095455613136, 2108.578284343122, 2138.379869837745, 2141.539568992674, 2143.0998980428258, 2144.710464087344, 7164.319389657974, 7180.066591343144, 7194.604296763676, 7202.747903823341, 7231.819204519929, 4493.191225579394, 4582.954170458286, 4586.541345865387, 4605.700629459075, 4621.722696638179, 2612.137994461823, 2692.0846912049997, 2700.1089640418613, 2712.6337944377456, 2723.496153211642, 703.0, 841.4110122913924, 878.7671267114156, 880.55972013993, 887.2990337633262, 9171.945226298927, 9247.861282080774, 9272.675456359062, 9276.443413395218, 9299.953500232456, 4078.6744308099987, 4202.537720850704, 4223.535411104776, 4239.894002649959, 4249.128928569636, 8305.46014509055, 8323.916760832435, 8349.791255218546, 8357.414980951397, 8359.749207523784, 4605.4933957264675, 4616.076784643018, 4616.146012987608, 4637.814487420533, 4641.234196357564, 4220.092680073799, 4234.618884300427, 4247.3628955656895, 4258.169656916872, 4259.0, 3401.608814986259, 3437.3125374925116, 3452.6374730653424, 3463.1169051891607, 3484.0244731475227, 1105.3202280597375, 1109.5506319940437, 1112.927659702133, 1114.2144787924494, 1116.1461481966303, 1224.871388504212, 1239.2007155384727, 1248.219862585884, 1254.7239607286383, 1259.1878238536092, 6784.321567843176, 6799.558028728117, 6872.62200578963, 6928.678892570944, 6929.237783843773, 456.76248350857367, 468.75624675168723, 468.78435919476743, 470.7716757372672, 471.27423767398506, 5306.946930530722, 5373.194020896896, 5378.058839703036, 5385.488378604026, 5387.892242155135, 8295.917040829636, 8355.832883342298, 8417.368697347723, 8429.747107586782, 8488.575571221414, 8325.542095184703, 8354.874676879852, 8372.832543349099, 8382.455140415854, 8392.916070839214, 6549.967250163814, 6679.098321726505, 6686.264510903797, 6697.162854643169, 6779.796606101726, 6419.35806419373, 6439.7424103035355, 6450.612963222222, 6451.645159516272, 6451.838704032437, 7249.0, 7416.035915330973, 7441.3674837637245, 7471.327580517779, 7510.023696919366, 7578.1285152206, 7584.165741768511, 7678.961605192162, 7722.961385193038, 7789.143194248515, 6311.400416960381, 6354.809355719336, 6366.586171898812, 6375.6493392861985, 6376.904346434714, 6713.56361836479, 6870.244273130052, 6872.518923675295, 6878.484113691593, 6892.724291028503, 6281.905771413524, 6292.779752708633, 6368.044793280859, 6412.0, 6415.775447859302, 6202.472789812917, 6336.366363363627, 6385.680715964276, 6398.648074355955, 6400.967995159995, 6036.8188954331445, 6188.659623720559, 6195.876082478235, 6203.038529028008, 6203.906941395973, 5888.17565540816, 5910.408959104056, 5930.28836539618, 5932.228810254639, 5934.970325148347, 5264.578833693219, 5670.489655930986, 5832.912506312324, 5981.043033114681, 6009.609375390585], "ext.html": [521.8304051183367, 524.3026774390062, 533.6291277562093, 542.0541155683334, 554.1078863030523, 28525.14424567261, 30825.22936926575, 36748.44877326839, 38689.61310386896, 38900.610993890055, 40141.799291003575, 40301.798491007576, 40464.595354046454, 40574.79712601433, 40671.59328406715, 7746.961265193666, 8281.83436331273, 8367.121452247533, 8542.786430339229, 8554.61504232311, 7823.882641760378, 10473.005064518897, 10574.629887953923, 10655.0, 10667.253292269545, 10355.89644103557, 10371.170306375472, 10415.895841041569, 10493.895061049368, 10510.316829406102, 7975.162607926142, 8077.555734434603, 10178.236632252574, 10254.384736915772, 10473.895261047444, 10100.444475553842, 10206.0, 10254.384736915734, 10294.7426314342, 10299.53652085658, 36544.26911461756, 36676.44985325222, 36763.448548271794, 36871.0, 36949.261014779826, 2844.7013063628433, 2929.9267518312, 3159.494480883048, 3275.1157187559465, 3324.1191084362663, 25554.105606303878, 25556.23331300064, 25756.734240488597, 25848.224553263244, 25970.610440843404, 2100.2544096845554, 2102.737157855268, 2111.915523379063, 2117.2907076129513, 2208.2712704807377, 246062.0, 247405.0, 247584.0, 248441.0, 248885.7555712228, 48448.5155148444, 49421.752891235315, 56199.438005620235, 56481.15278270829, 56576.0, 60391.69804150951, 60639.0, 61204.38795612076, 61309.69345153335, 61358.0, 12124.39378031095, 12280.140390172603, 12280.692982675504, 12292.446839892227, 12292.938535307445, 9034.32242581809, 9044.326799541974, 9051.59267832949, 9052.773680657905, 9054.728358149267, 17998.460046198634, 18089.7286540702, 18116.547086322946, 18465.81534184668, 18485.81514184841, 7180.599783042257, 7310.4517161213125, 7398.260173982559, 7436.442266830009, 7488.438367122379, 883.4743327720125, 913.4199783137623, 948.1750876737145, 989.9208063355059, 1027.768752030802, 26473.205803825917, 26813.731862681514, 26855.0, 27178.320541986213, 27465.0, 999.8550210219623, 1009.4195837393381, 1033.705393962717, 1050.9894901051046, 1118.1446193661855, 14066.507672231422, 14077.929610352088, 14079.859201407855, 14121.293935303194, 14121.43514259418, 420844.0, 433125.0, 434284.0, 434481.0, 434630.0, 49664.25503617449, 49884.750576246886, 50007.74996124996, 50123.49876501261, 50244.49755502398, 1273.2487832178874, 1279.9232046077266, 1283.4352884730688, 1285.119693010291, 1285.3573213393304, 23797.64303535483, 25947.740522595286, 26332.605010925236, 27446.451070978866, 27517.587236191073, 46328.30507542457, 47699.52300476951, 47737.0, 47743.28385074157, 47755.76122119367, 173435.0, 239138.0, 240695.0, 242284.0, 244749.0, 26174.86912565425, 29313.0, 29408.11775646734, 29414.41171176607, 29444.527773611662, 37245.25509489849, 37550.624493754716, 37701.24597508089, 37955.62044379521, 38096.23807523779, 31614.0, 33600.3279934395, 34461.0, 34764.82617586896, 34777.82611086928, 34017.37844333491, 34139.65860341464, 34429.0, 34456.31087378289, 34475.82762086173, 33665.49501757426, 34462.65537344695, 34665.306693866485, 34807.82596087003, 34979.0, 29088.41823163567, 30182.396352073276, 30321.99465005775, 30378.0, 30504.84747576248, 21789.564208716052, 21838.56322873502, 21986.670199947333, 22036.449088772908, 22085.0], "prototype.html": [286.47288988261596, 291.51462814414, 297.32655535212746, 305.42884805413877, 306.18096591617416, 5769.82690519284, 5850.2979642442915, 5878.823635290948, 5886.234789477373, 5905.61613495123, 5717.799877004306, 5845.473907348349, 5857.765689372431, 5877.471027607525, 5877.794277200299, 4552.271636538155, 4575.26795712686, 4584.220682483986, 4586.059857729158, 4600.355950166962, 4356.869293921188, 4592.609628181609, 4601.217792975202, 4617.907641847161, 4646.279826626861, 4405.80173892174, 4456.509783923766, 4536.5236650151755, 4552.203364411214, 4554.089182163564, 4469.709468884528, 4517.706349087299, 4538.319252112193, 4562.634989200856, 4567.5889169974525, 3891.9416208756893, 3892.6885849132286, 3906.746061505993, 3910.3743401055694, 3924.529056513208, 5531.612787104904, 5614.719264036782, 5688.658680479184, 5706.28671416073, 5715.571332150105, 5009.774560144766, 5030.170021946375, 5039.21892106724, 5040.218766091261, 5046.873828154289, 6148.323684394713, 6156.322804491502, 6170.475509581691, 6180.814575562696, 6200.255969283669, 4116.464859568267, 4122.752634841919, 4129.690273229489, 4131.132462182945, 4138.503379594438, 6303.2751233607805, 6474.223093228796, 6486.513511486657, 6504.577202481871, 6519.315471875432, 4233.11104668017, 4233.745975241495, 4234.830606775695, 4244.8514301999285, 4251.17102165081, 4280.935785963213, 4311.827526898889, 4317.287647538184, 4327.653787696977, 4345.565443455693, 5015.22264049073, 5020.799168033311, 5024.0, 5046.066477701637, 5049.318342023853, 5969.343372229051, 6184.134221209034, 6184.443400094013, 6184.783532576338, 6212.658303793244, 1515.8408367121515, 1532.8926975111635, 1534.3248970452964, 1535.3167840311178, 1539.8229203641724, 999.8400255959011, 1012.3217444312328, 1016.2885979814012, 1017.049059129716, 1029.2229366827996, 5871.970640146772, 5892.646441213541, 5894.498967587803, 5903.645781253139, 5905.675187864708, 6416.037594360883, 6419.679016049272, 6431.389018043278, 6440.67796610177, 6441.355864413615, 5725.713714314267, 5841.06542953134, 5853.004989151855, 5863.355030946593, 5902.6458412495385, 3322.0, 3426.2804810989473, 3458.1181798641687, 3467.965320346764, 3475.079104037432, 6655.267920528738, 6675.365840245169, 6683.2648408675, 6698.956818170504, 6717.294684058202, 6673.866522669519, 6676.86646267072, 6678.165229346332, 6680.532362734659, 6689.966550167315, 6455.580387274812, 6660.333966603301, 6660.600363978177, 6685.298043705438, 6730.798076057726, 6534.0, 6544.476441884733, 6571.901421478778, 6578.736850525926, 6592.307807680317, 6406.903896441464, 6414.871702566016, 6418.903716444351, 6443.935560644333, 6453.1610890583925, 6523.347665233438, 6687.465002799667, 6693.062971184136, 6699.497537684791, 6733.023711561894, 4196.937045944374, 4233.872983810491, 4236.872893813191, 4254.361845723166, 4262.232798096373, 6476.31998640136, 6488.708008139551, 6495.350464953467, 6507.349265073455, 6508.73965041412, 6108.57239993214, 6278.623282603058, 6282.654454005074, 6347.71435285404, 6353.618782873043, 6305.747770089145, 6306.337834527492, 6330.778422755181, 6330.8100756977365, 6346.333634968262, 6027.668478233564, 6147.262328520606, 6158.599691020069, 6159.476444502088, 6165.106059621419, 6149.877002460015, 6311.96844015777, 6315.08431277453, 6325.936740632535, 6327.620342779448, 6159.0, 6163.876722465615, 6167.599106058092, 6168.35232300602, 6172.444479996821], "yui.html": [638.2755572425295, 647.355880898506, 662.1425254295686, 662.3972185311367, 664.1565212180533, 12572.937135314321, 13033.0, 13039.543615973444, 13041.0, 13107.34463276836, 11940.522379104847, 11951.043916486682, 12028.158028937978, 12034.81947770784, 12355.505779768799, 854.7350321400386, 875.8379699755534, 876.750126214026, 876.8772371867943, 880.2034159086037, 841.9727931923044, 854.372036553133, 856.195176534056, 860.8235311761074, 862.2972277593773, 896.2202883491371, 907.4101833808045, 911.3119594705988, 911.8677791720197, 912.9726108216764, 868.3096937934357, 884.9734507964771, 889.5730049576175, 893.5353616119614, 895.8208358328295, 664.40203816565, 664.7407511070686, 669.3206395508563, 669.5012215899137, 669.7957123077459, 11271.211015228937, 11531.365774882379, 11549.307041577533, 11602.883971160349, 11660.59187928427, 9376.249900007982, 9491.66779162726, 9657.806843863083, 9769.120779129842, 10045.748856278578, 7488.513246639006, 7629.471170588506, 7735.922640773577, 7797.142314345418, 7866.960665196694, 2814.8733307001235, 2854.6003559501687, 2985.2686091907403, 3007.593974813416, 3030.196997795586, 38289.23421531582, 41543.7922810387, 42766.35850462214, 44330.77834610806, 44547.0, 7946.602669866484, 7949.364050875916, 8168.019837619524, 8554.401191916631, 8616.569171541398, 18756.812431875507, 18763.81236187648, 18777.906110469634, 18790.0, 19008.239670413306, 6577.86844263112, 6727.9327206728285, 6849.4177994871, 6902.758403455855, 6945.062416573698, 3495.7727747696317, 3625.220577575781, 3626.601073881871, 3643.690286325639, 3745.438184272381, 2855.386091990232, 2871.3970066285897, 2876.6548014238424, 2883.524218503965, 2903.8548072596286, 407.21407683171765, 408.8793805827288, 432.54366643191736, 452.954704529551, 453.75497231495285, 440.33509400804377, 456.0832726220321, 456.559420159541, 463.25416080110995, 581.0499832773446, 6942.7222911084, 7160.677769500385, 7377.22539133394, 7400.481966262418, 7446.813829654302, 482.4018217410456, 512.7666911555233, 517.3455578692956, 564.0777329067005, 576.1962062922283, 3138.3409484008157, 3389.1527118220447, 3440.673136052071, 3447.7069449096607, 3465.9306813864087, 55840.720796395755, 57485.13772293419, 57662.42337576654, 58053.419465805644, 58351.708241458524, 41008.589914101074, 47787.28319075217, 48332.0, 48408.0, 48762.756186218845, 42728.57271427308, 42935.35596966048, 43035.56964430378, 43140.35289470661, 43727.56272437298, 7515.323620874147, 7525.661345239368, 7552.169261381354, 7638.236176382317, 7656.349210317186, 31946.840265799452, 32983.8350808254, 33063.66936330606, 33095.50356744699, 33228.83385583057, 41164.176716464906, 44376.0, 45047.774761125984, 45477.54522454865, 45783.0, 5966.791162309299, 6906.240313565604, 6931.4108300795, 6996.965015174892, 7051.964740176266, 10467.790644187226, 10524.94737526338, 10695.839562406414, 10812.5134368952, 11322.207445478738, 9605.18355939753, 9887.30788844774, 9980.401175929468, 10069.0, 10279.537420815932, 10147.263572351705, 10219.335743176669, 10222.335548189343, 10302.742431438974, 10407.271490995558, 9534.427934323963, 9717.80564388694, 9726.902730972599, 10080.546375412978, 10109.03964123407, 7981.880271796043, 8137.226963438464, 8252.793680158044, 8423.578821059045, 8545.82908341842, 7811.648475818715, 8165.836683266182, 8379.70671026511, 8431.113876789048, 8444.493330400195]}, "summary": {"lowerIsBetter": false, "suite": 6394.086331351427, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7501.3866721936865, "unit": "ms", "value": 7501.3866721936865}, "dojo.html": {"lowerIsBetter": false, "filtered": 4975.96807982952, "unit": "ms", "value": 4975.96807982952}, "mootools.html": {"lowerIsBetter": false, "filtered": 4049.1865927760077, "unit": "ms", "value": 4049.1865927760077}, "ext.html": {"lowerIsBetter": false, "filtered": 17338.210592195297, "unit": "ms", "value": 17338.210592195297}, "prototype.html": {"lowerIsBetter": false, "filtered": 4659.390612017251, "unit": "ms", "value": 4659.390612017251}, "yui.html": {"lowerIsBetter": false, "filtered": 5596.414893512316, "unit": "ms", "value": 5596.414893512316}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0096"}, "testrun": {"date": 1447791434, "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": "20151117102307", "branch": "Ash", "revision": "2185368ac9231548d3b0f9379812dd0a0ae50484"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 162.0, 163.0, 163.0, 161.0, 163.0, 162.0, 161.0], "ai-astar": [106.0, 108.0, 100.0, 109.0, 109.0, 107.0, 97.0, 107.0, 110.0, 107.0], "imaging-gaussian-blur": [120.0, 124.0, 122.0, 125.0, 127.0, 117.0, 124.0, 129.0, 123.0, 125.0], "audio-beat-detection": [158.0, 128.0, 151.0, 163.0, 125.0, 153.0, 149.0, 127.0, 168.0, 125.0], "json-stringify-tinderbox": [67.0, 67.0, 68.0, 68.0, 71.0, 70.0, 69.0, 69.0, 72.0, 75.0], "stanford-crypto-pbkdf2": [153.0, 141.0, 156.0, 165.0, 168.0, 160.0, 168.0, 166.0, 163.0, 158.0], "json-parse-financial": [60.0, 60.0, 61.0, 59.0, 59.0, 60.0, 60.0, 68.0, 59.0, 60.0], "stanford-crypto-sha256-iterative": [71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 73.0, 76.0, 75.0, 77.0], "audio-fft": [76.0, 82.0, 89.0, 85.0, 69.0, 69.0, 71.0, 82.0, 90.0, 72.0], "imaging-darkroom": [127.0, 125.0, 128.0, 128.0, 165.0, 142.0, 136.0, 130.0, 135.0, 135.0], "stanford-crypto-ccm": [122.0, 123.0, 131.0, 132.0, 134.0, 131.0, 144.0, 143.0, 141.0, 134.0], "audio-oscillator": [98.0, 99.0, 135.0, 89.0, 91.0, 92.0, 131.0, 91.0, 96.0, 144.0], "stanford-crypto-aes": [86.0, 87.0, 87.0, 88.0, 92.0, 92.0, 93.0, 95.0, 95.0, 95.0], "imaging-desaturate": [96.0, 96.0, 105.0, 101.0, 100.0, 101.0, 109.0, 110.0, 113.0, 109.0]}, "summary": {"lowerIsBetter": true, "suite": 1547.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.5, "unit": "ms", "value": 78.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 159.8, "unit": "ms", "value": 159.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.7, "unit": "ms", "value": 144.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 133.5, "unit": "ms", "value": 133.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 135.1, "unit": "ms", "value": 135.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.6, "unit": "ms", "value": 60.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 106.6, "unit": "ms", "value": 106.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 106.0, "unit": "ms", "value": 106.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.8, "unit": "ms", "value": 161.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.7, "unit": "ms", "value": 72.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 123.6, "unit": "ms", "value": 123.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 91.0, "unit": "ms", "value": 91.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 104.0, "unit": "ms", "value": 104.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0096"}, "testrun": {"date": 1447791434, "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": "20151117102307", "branch": "Ash", "revision": "2185368ac9231548d3b0f9379812dd0a0ae50484"}}, {"talos_counters": {}, "results": {"DeltaBlue": [199.12385503783352], "Encrypt": [332.33632436025255], "NavierStokes": [6036.144578313253], "Decrypt": [6103.658536585366], "Splay": [634.9206349206349], "Richards": [168.40687100033682], "RegExp": [31406.25], "Earley": [1016.243654822335], "Boyer": [13712.328767123288], "RayTrace": [1988.0715705765408]}, "summary": {"lowerIsBetter": false, "suite": 17543.729943763054, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 332.044596, "unit": "score", "value": 332.044596}, "Encrypt": {"lowerIsBetter": false, "filtered": 800.9386290000003, "unit": "score", "value": 800.9386290000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 245.85229540918172, "unit": "score", "value": 245.85229540918172}, "Decrypt": {"lowerIsBetter": false, "filtered": 43.61007392607391, "unit": "score", "value": 43.61007392607391}, "Splay": {"lowerIsBetter": false, "filtered": 128.34832499999996, "unit": "score", "value": 128.34832499999996}, "RegExp": {"lowerIsBetter": false, "filtered": 29.006487562189033, "unit": "score", "value": 29.006487562189033}, "Richards": {"lowerIsBetter": false, "filtered": 209.62327599999995, "unit": "score", "value": 209.62327599999995}, "Earley": {"lowerIsBetter": false, "filtered": 655.8102447552449, "unit": "score", "value": 655.8102447552449}, "Boyer": {"lowerIsBetter": false, "filtered": 48.60319580419578, "unit": "score", "value": 48.60319580419578}, "RayTrace": {"lowerIsBetter": false, "filtered": 372.21446699999984, "unit": "score", "value": 372.21446699999984}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0096"}, "testrun": {"date": 1447791434, "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": "20151117102307", "branch": "Ash", "revision": "2185368ac9231548d3b0f9379812dd0a0ae50484"}}] 12:37:26 INFO - RETURN: dromaeo_css: 6394.09 12:37:26 INFO - RETURN: kraken: 1547.50 12:37:26 INFO - RETURN: v8_7: 17543.73 12:37:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,140,55]]", "result": "17543.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,140,55]]", "result": "1547.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,140,55]]", "result": "6394.09"}}} 12:37:26 INFO - Return code: 0 12:37:26 INFO - # TBPL SUCCESS # 12:37:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:37:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:37:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:37:26 INFO - 2015-11-17 12:37:26.178 screenresolution[1657:9986] starting screenresolution argv=screenresolution get 12:37:26 INFO - 2015-11-17 12:37:26.181 screenresolution[1657:9986] Display 0: 1600x1200x32@60 12:37:26 INFO - 2015-11-17 12:37:26.187 screenresolution[1658:9989] starting screenresolution argv=screenresolution list 12:37:26 INFO - Available Modes on Display 0 12:37:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:37:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:37:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:37:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:37:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:37:26 INFO - Intel HD Graphics 3000: 12:37:26 INFO - Chipset Model: Intel HD Graphics 3000 12:37:26 INFO - Type: GPU 12:37:26 INFO - Bus: Built-In 12:37:26 INFO - VRAM (Total): 512 MB 12:37:26 INFO - VRAM (Dynamic, Max): 10 12:37:26 INFO - Vendor: Intel (0x8086) 12:37:26 INFO - Device ID: 0x0116 12:37:26 INFO - Revision ID: 0x0009 12:37:26 INFO - Displays: 12:37:26 INFO - Display: 12:37:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:37:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:37:26 INFO - Display Serial Number: 1600x1200 60 12:37:26 INFO - Main Display: Yes 12:37:26 INFO - Mirror: Off 12:37:26 INFO - Online: Yes 12:37:26 INFO - Rotation: Supported 12:37:26 INFO - Return code: 0 12:37:26 INFO - Running post-action listener: _resource_record_post_action 12:37:26 INFO - Running post-run listener: _resource_record_post_run 12:37:27 INFO - Total resource usage - Wall time: 1254s; CPU: 30.0%; Read bytes: 39588864; Write bytes: 728962048; Read time: 5578; Write time: 59409 12:37:27 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 370358784; Write bytes: 365164544; Read time: 35329; Write time: 7164 12:37:27 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 38470656; Write bytes: 342248448; Read time: 5227; Write time: 51415 12:37:27 INFO - Running post-run listener: _upload_blobber_files 12:37:27 INFO - Blob upload gear active. 12:37:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:27 INFO - Copying logs to upload dir... 12:37:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1321.895798 ========= master_lag: 1.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-17 12:37:28.708904) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 12:37:28.712854) ========= 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.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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/mDVmGWAhQF2hVl4hXHUMgw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010127 build_url: 'https://queue.taskcluster.net/v1/task/mDVmGWAhQF2hVl4hXHUMgw/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-17 12:37:28.739080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:37:28.739800) ========= 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.tHlwcZP9na/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.39ZuwQoy0B/Listeners TMPDIR=/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/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.005524 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:37:28.789297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 12:37:28.789614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 12:37:28.790011) ========= ========= Total master_lag: 1.36 =========