builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0096 starttime: 1447538470.57 results: success (0) buildid: 20151114130830 builduid: 397f39f902b24703960218d2c38d540f revision: bbeaf161feb415b87fca25bd2a25e9d31f3d7c46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.567682) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.568419) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.568868) ========= 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.m4dlSA08Si/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.kZxf9saBEW/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.006265 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.678405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.678740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.731284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.731570) ========= 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.m4dlSA08Si/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.kZxf9saBEW/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.005780 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.786406) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.786847) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.787259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:10.787737) ========= 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.m4dlSA08Si/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.kZxf9saBEW/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-14 14:01:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.6M=0s 2015-11-14 14:01:11 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.394205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.200734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.201119) ========= 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.m4dlSA08Si/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.kZxf9saBEW/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.019997 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.349554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.349877) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bbeaf161feb415b87fca25bd2a25e9d31f3d7c46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bbeaf161feb415b87fca25bd2a25e9d31f3d7c46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m4dlSA08Si/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.kZxf9saBEW/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-14 14:01:11,420 truncating revision to first 12 chars 2015-11-14 14:01:11,420 Setting DEBUG logging. 2015-11-14 14:01:11,420 attempt 1/10 2015-11-14 14:01:11,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bbeaf161feb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 14:01:11,701 unpacking tar archive at: mozilla-central-bbeaf161feb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.897305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.897669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.911002) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.911507) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 14:01:11.912060) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2015-11-14 14:01:11.912437) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m4dlSA08Si/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.kZxf9saBEW/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 14:01:12 INFO - MultiFileLogger online at 20151114 14:01:12 in /builds/slave/test 14:01:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:01:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:12 INFO - {'append_to_log': False, 14:01:12 INFO - 'base_work_dir': '/builds/slave/test', 14:01:12 INFO - 'blob_upload_branch': 'Firefox', 14:01:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:12 INFO - 'branch': 'Firefox', 14:01:12 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:12 INFO - 'config_files': ('talos/mac_config.py',), 14:01:12 INFO - 'default_actions': ('clobber', 14:01:12 INFO - 'read-buildbot-config', 14:01:12 INFO - 'download-and-extract', 14:01:12 INFO - 'populate-webroot', 14:01:12 INFO - 'create-virtualenv', 14:01:12 INFO - 'install', 14:01:12 INFO - 'run-tests'), 14:01:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:12 INFO - 'download_minidump_stackwalk': True, 14:01:12 INFO - 'download_symbols': 'ondemand', 14:01:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:12 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:12 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:12 INFO - 'installer_path': 'installer.exe', 14:01:12 INFO - 'log_level': 'info', 14:01:12 INFO - 'log_name': 'talos', 14:01:12 INFO - 'log_to_console': True, 14:01:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:01:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:01:12 INFO - 'opt_config_files': (), 14:01:12 INFO - 'pip_index': False, 14:01:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:01:12 INFO - 'cmd': ('bash', 14:01:12 INFO - '-c', 14:01:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:01:12 INFO - 'enabled': True, 14:01:12 INFO - 'halt_on_failure': False, 14:01:12 INFO - 'name': 'check_screen_resolution'},), 14:01:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:01:12 INFO - 'cmd': ('bash', 14:01:12 INFO - '-c', 14:01:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:01:12 INFO - 'enabled': True, 14:01:12 INFO - 'halt_on_failure': False, 14:01:12 INFO - 'name': 'check_screen_resolution'},), 14:01:12 INFO - 'run_cmd_checks_enabled': True, 14:01:12 INFO - 'sps_profile': False, 14:01:12 INFO - 'sps_profile_interval': 0, 14:01:12 INFO - 'suite': 'dromaeojs', 14:01:12 INFO - 'system_bits': '64', 14:01:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:12 INFO - 'title': 't-yosemite-r5-0096', 14:01:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:12 INFO - 'use_talos_json': True, 14:01:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:12 INFO - 'work_dir': 'build'} 14:01:12 INFO - ##### 14:01:12 INFO - ##### Running clobber step. 14:01:12 INFO - ##### 14:01:12 INFO - Running pre-action listener: _resource_record_pre_action 14:01:12 INFO - Running main action method: clobber 14:01:12 INFO - rmtree: /builds/slave/test/build 14:01:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:12 INFO - Running post-action listener: _resource_record_post_action 14:01:12 INFO - ##### 14:01:12 INFO - ##### Running read-buildbot-config step. 14:01:12 INFO - ##### 14:01:12 INFO - Running pre-action listener: _resource_record_pre_action 14:01:12 INFO - Running main action method: read_buildbot_config 14:01:12 INFO - Using buildbot properties: 14:01:12 INFO - { 14:01:12 INFO - "properties": { 14:01:12 INFO - "buildnumber": 558, 14:01:12 INFO - "product": "firefox", 14:01:12 INFO - "script_repo_revision": "production", 14:01:12 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 14:01:12 INFO - "repository": "", 14:01:12 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 14:01:12 INFO - "buildid": "20151114130830", 14:01:12 INFO - "slavename": "t-yosemite-r5-0096", 14:01:12 INFO - "pgo_build": "False", 14:01:12 INFO - "basedir": "/builds/slave/test", 14:01:12 INFO - "project": "", 14:01:12 INFO - "platform": "yosemite", 14:01:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:01:12 INFO - "slavebuilddir": "test", 14:01:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:01:12 INFO - "branch": "mozilla-central", 14:01:12 INFO - "repo_path": "mozilla-central", 14:01:12 INFO - "stage_platform": "macosx64", 14:01:12 INFO - "builduid": "397f39f902b24703960218d2c38d540f", 14:01:12 INFO - "revision": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46" 14:01:12 INFO - }, 14:01:12 INFO - "sourcestamp": { 14:01:12 INFO - "repository": "", 14:01:12 INFO - "hasPatch": false, 14:01:12 INFO - "project": "", 14:01:12 INFO - "branch": "mozilla-central-macosx64-talos", 14:01:12 INFO - "changes": [ 14:01:12 INFO - { 14:01:12 INFO - "category": null, 14:01:12 INFO - "files": [ 14:01:12 INFO - { 14:01:12 INFO - "url": null, 14:01:12 INFO - "name": "https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 14:01:12 INFO - } 14:01:12 INFO - ], 14:01:12 INFO - "repository": "", 14:01:12 INFO - "rev": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46", 14:01:12 INFO - "who": "philringnalda@gmail.com", 14:01:12 INFO - "when": 1447538381, 14:01:12 INFO - "number": 6662584, 14:01:12 INFO - "comments": "Back out changeset 202b199b9fcf (bug 1223394) since it didn't actually disable the permaorange tests, a=nnoyance", 14:01:12 INFO - "project": "", 14:01:12 INFO - "at": "Sat 14 Nov 2015 13:59:41", 14:01:12 INFO - "branch": "mozilla-central-macosx64-talos", 14:01:12 INFO - "revlink": "", 14:01:12 INFO - "properties": [ 14:01:12 INFO - [ 14:01:12 INFO - "buildid", 14:01:12 INFO - "20151114130830", 14:01:12 INFO - "Change" 14:01:12 INFO - ], 14:01:12 INFO - [ 14:01:12 INFO - "builduid", 14:01:12 INFO - "397f39f902b24703960218d2c38d540f", 14:01:12 INFO - "Change" 14:01:12 INFO - ], 14:01:12 INFO - [ 14:01:12 INFO - "pgo_build", 14:01:12 INFO - "False", 14:01:12 INFO - "Change" 14:01:12 INFO - ] 14:01:12 INFO - ], 14:01:12 INFO - "revision": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46" 14:01:12 INFO - } 14:01:12 INFO - ], 14:01:12 INFO - "revision": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46" 14:01:12 INFO - } 14:01:12 INFO - } 14:01:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 14:01:12 INFO - Running post-action listener: _resource_record_post_action 14:01:12 INFO - ##### 14:01:12 INFO - ##### Running download-and-extract step. 14:01:12 INFO - ##### 14:01:12 INFO - Running pre-action listener: _resource_record_pre_action 14:01:12 INFO - Running main action method: download_and_extract 14:01:12 INFO - mkdir: /builds/slave/test/build/tests 14:01: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')]} 14:01:12 INFO - https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/test_packages.json 14:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/test_packages.json 14:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:01:14 INFO - Downloaded 1149 bytes. 14:01:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:01:14 INFO - Using the following test package requirements: 14:01:14 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:01:14 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 14:01:14 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'jsshell-mac.zip'], 14:01:14 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 14:01:14 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:01:14 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 14:01:14 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 14:01:14 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 14:01:14 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:01:14 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:01:14 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 14:01:14 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:01:14 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')]} 14:01:14 INFO - https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:01:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:01:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:01:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:20 INFO - Downloaded 17460950 bytes. 14:01:20 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 14:01:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:01:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 14:01:26 INFO - Return code: 0 14:01:26 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 14:01: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')]} 14:01:26 INFO - https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:27 INFO - Downloaded 17460950 bytes. 14:01:27 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 14:01:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:01:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 14:01:33 INFO - Return code: 0 14:01:33 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')]} 14:01:33 INFO - https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:35 INFO - Downloaded 11131693 bytes. 14:01:35 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 14:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:01:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:01:35 INFO - Return code: 0 14:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:35 INFO - https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 14:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xr9qlizDSzKOBAr59hgbYw/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 14:01:38 INFO - Downloaded 108693114 bytes. 14:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:01:38 INFO - mkdir: /builds/slave/test/properties 14:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:38 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:38 INFO - Contents: 14:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:01:38 INFO - Running post-action listener: _resource_record_post_action 14:01:38 INFO - Running post-action listener: set_extra_try_arguments 14:01:38 INFO - ##### 14:01:38 INFO - ##### Running populate-webroot step. 14:01:38 INFO - ##### 14:01:38 INFO - Running pre-action listener: _resource_record_pre_action 14:01:38 INFO - Running main action method: populate_webroot 14:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:01:38 INFO - '../fennec_ids.txt'], 14:01:38 INFO - 'tests': ['tcheck2']}, 14:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:38 INFO - '--tppagecycles', 14:01:38 INFO - '7'], 14:01:38 INFO - 'tests': ['tsvgm']}}, 14:01:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:01:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'tests': ['damp', 'tps']}, 14:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['damp', 'tps']}, 14:01:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:38 INFO - 'other': {'tests': ['a11yr', 14:01:38 INFO - 'ts_paint', 14:01:38 INFO - 'tpaint', 14:01:38 INFO - 'sessionrestore', 14:01:38 INFO - 'sessionrestore_no_auto_restore']}, 14:01:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['a11yr', 14:01:38 INFO - 'ts_paint', 14:01:38 INFO - 'tpaint', 14:01:38 INFO - 'sessionrestore', 14:01:38 INFO - 'sessionrestore_no_auto_restore']}, 14:01:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['a11yr', 14:01:38 INFO - 'ts_paint', 14:01:38 INFO - 'tpaint', 14:01:38 INFO - 'sessionrestore', 14:01:38 INFO - 'sessionrestore_no_auto_restore']}, 14:01:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['a11yr', 14:01:38 INFO - 'ts_paint', 14:01:38 INFO - 'tpaint', 14:01:38 INFO - 'sessionrestore', 14:01:38 INFO - 'sessionrestore_no_auto_restore']}, 14:01:38 INFO - 'other_l64': {'tests': ['a11yr', 14:01:38 INFO - 'ts_paint', 14:01:38 INFO - 'tpaint', 14:01:38 INFO - 'sessionrestore', 14:01:38 INFO - 'sessionrestore_no_auto_restore']}, 14:01:38 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:38 INFO - 'ts_paint', 14:01:38 INFO - 'tpaint', 14:01:38 INFO - 'sessionrestore', 14:01:38 INFO - 'sessionrestore_no_auto_restore']}, 14:01:38 INFO - 'svgr': {'tests': ['tsvgx', 14:01:38 INFO - 'tsvgr_opacity', 14:01:38 INFO - 'tart', 14:01:38 INFO - 'tscrollx', 14:01:38 INFO - 'cart']}, 14:01:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['tsvgx', 14:01:38 INFO - 'tsvgr_opacity', 14:01:38 INFO - 'tart', 14:01:38 INFO - 'tscrollx', 14:01:38 INFO - 'cart']}, 14:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'tests': ['tp5o']}, 14:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'talos_options': ['--e10s'], 14:01:38 INFO - 'tests': ['tp5o']}, 14:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'talos_options': ['--xperf_path', 14:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:38 INFO - 'tests': ['tp5n']}, 14:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:38 INFO - 'talos_options': ['--e10s', 14:01:38 INFO - '--xperf_path', 14:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:38 INFO - 'tests': ['tp5n']}}, 14:01:38 INFO - 'talos.zip': {'path': '', 14:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:38 INFO - Running post-action listener: _resource_record_post_action 14:01:38 INFO - ##### 14:01:38 INFO - ##### Running create-virtualenv step. 14:01:38 INFO - ##### 14:01:38 INFO - Running pre-action listener: _resource_record_pre_action 14:01:38 INFO - Running main action method: create_virtualenv 14:01:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:38 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 14:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:38 INFO - Using real prefix '/tools/python27' 14:01:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:42 INFO - Installing pip.................done. 14:01:42 INFO - Return code: 0 14:01:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:42 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 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:01:42 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 14:01:42 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 14:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:01:42 INFO - 'HOME': '/Users/cltbld', 14:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:01:42 INFO - 'LOGNAME': 'cltbld', 14:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:42 INFO - 'MOZ_NO_REMOTE': '1', 14:01:42 INFO - 'NO_EM_RESTART': '1', 14:01:42 INFO - 'PAGER': '/bin/cat', 14:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:42 INFO - 'PWD': '/builds/slave/test', 14:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:01:42 INFO - 'SHELL': '/bin/bash', 14:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:01:42 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:01:42 INFO - 'USER': 'cltbld', 14:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:42 INFO - 'XPC_FLAGS': '0x0', 14:01:42 INFO - 'XPC_SERVICE_NAME': '0', 14:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:43 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 14:01:43 INFO - Cleaning up... 14:01:43 INFO - Return code: 0 14:01:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:01:43 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')]} 14:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:43 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')]} 14:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:43 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 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:01:43 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 14:01:43 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 14:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:01:43 INFO - 'HOME': '/Users/cltbld', 14:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:01:43 INFO - 'LOGNAME': 'cltbld', 14:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:43 INFO - 'MOZ_NO_REMOTE': '1', 14:01:43 INFO - 'NO_EM_RESTART': '1', 14:01:43 INFO - 'PAGER': '/bin/cat', 14:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:43 INFO - 'PWD': '/builds/slave/test', 14:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:01:43 INFO - 'SHELL': '/bin/bash', 14:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:01:43 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:01:43 INFO - 'USER': 'cltbld', 14:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:43 INFO - 'XPC_FLAGS': '0x0', 14:01:43 INFO - 'XPC_SERVICE_NAME': '0', 14:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:43 INFO - Downloading/unpacking psutil>=0.7.1 14:01:43 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 14:01:43 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 14:01:43 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 14:01:43 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 14:01:43 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 14:01:43 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 14:01:46 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:01:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:46 INFO - Installing collected packages: psutil 14:01:46 INFO - Running setup.py install for psutil 14:01:46 INFO - building 'psutil._psutil_osx' extension 14:01:46 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 14:01:46 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 14:01:46 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 14:01:47 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 14:01:47 INFO - building 'psutil._psutil_posix' extension 14:01:47 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 14:01:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:01:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:01:47 INFO - ^ 14:01:47 INFO - 1 warning generated. 14:01:47 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 14:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:47 INFO - Successfully installed psutil 14:01:47 INFO - Cleaning up... 14:01:47 INFO - Return code: 0 14:01:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:01:47 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')]} 14:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:47 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')]} 14:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:47 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 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:01:47 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 14:01:47 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 14:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:01:47 INFO - 'HOME': '/Users/cltbld', 14:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:01:47 INFO - 'LOGNAME': 'cltbld', 14:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:47 INFO - 'MOZ_NO_REMOTE': '1', 14:01:47 INFO - 'NO_EM_RESTART': '1', 14:01:47 INFO - 'PAGER': '/bin/cat', 14:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:47 INFO - 'PWD': '/builds/slave/test', 14:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:01:47 INFO - 'SHELL': '/bin/bash', 14:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:01:47 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:01:47 INFO - 'USER': 'cltbld', 14:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:47 INFO - 'XPC_FLAGS': '0x0', 14:01:47 INFO - 'XPC_SERVICE_NAME': '0', 14:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:50 INFO - Installing collected packages: mozsystemmonitor 14:01:50 INFO - Running setup.py install for mozsystemmonitor 14:01:50 INFO - Successfully installed mozsystemmonitor 14:01:50 INFO - Cleaning up... 14:01:50 INFO - Return code: 0 14:01:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:01:50 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 14:01:50 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 14:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:01:50 INFO - 'HOME': '/Users/cltbld', 14:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:01:50 INFO - 'LOGNAME': 'cltbld', 14:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:50 INFO - 'MOZ_NO_REMOTE': '1', 14:01:50 INFO - 'NO_EM_RESTART': '1', 14:01:50 INFO - 'PAGER': '/bin/cat', 14:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:50 INFO - 'PWD': '/builds/slave/test', 14:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:01:50 INFO - 'SHELL': '/bin/bash', 14:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:01:50 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:01:50 INFO - 'USER': 'cltbld', 14:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:50 INFO - 'XPC_FLAGS': '0x0', 14:01:50 INFO - 'XPC_SERVICE_NAME': '0', 14:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:01:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 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 14:01:53 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 14:01:54 INFO - Downloading docopt-0.6.1.tar.gz 14:01:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:54 INFO - Running setup.py install for blobuploader 14:01:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:01:54 INFO - Running setup.py install for requests 14:01:55 INFO - Running setup.py install for docopt 14:01:55 INFO - Successfully installed blobuploader requests docopt 14:01:55 INFO - Cleaning up... 14:01:55 INFO - Return code: 0 14:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:55 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 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:01:55 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 14:01:55 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 14:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:01:55 INFO - 'HOME': '/Users/cltbld', 14:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:01:55 INFO - 'LOGNAME': 'cltbld', 14:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:55 INFO - 'MOZ_NO_REMOTE': '1', 14:01:55 INFO - 'NO_EM_RESTART': '1', 14:01:55 INFO - 'PAGER': '/bin/cat', 14:01:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:55 INFO - 'PWD': '/builds/slave/test', 14:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:01:55 INFO - 'SHELL': '/bin/bash', 14:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:01:55 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:01:55 INFO - 'USER': 'cltbld', 14:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:55 INFO - 'XPC_FLAGS': '0x0', 14:01:55 INFO - 'XPC_SERVICE_NAME': '0', 14:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:55 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-MeLSDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:55 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-Qo1mFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:55 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-9FCZFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:55 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-lVe_Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-BNljiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-1r7EAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-iROaAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-yP6FrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-1pGgIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-zY6wMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-FNY_nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:56 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-rS7xtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:57 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-JQAD4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:57 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-0t4kUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:57 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-JcRba3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:57 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-N1LF7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:57 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-w8_J94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:57 INFO - Running setup.py install for manifestparser 14:01:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:01:57 INFO - Running setup.py install for mozcrash 14:01:57 INFO - Running setup.py install for mozdebug 14:01:58 INFO - Running setup.py install for mozdevice 14:01:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Running setup.py install for mozfile 14:01:58 INFO - Running setup.py install for mozhttpd 14:01:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Running setup.py install for mozinfo 14:01:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Running setup.py install for mozInstall 14:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:01:58 INFO - Running setup.py install for mozleak 14:01:59 INFO - Running setup.py install for mozlog 14:01:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Running setup.py install for moznetwork 14:01:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Running setup.py install for mozprocess 14:01:59 INFO - Running setup.py install for mozprofile 14:01:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:01:59 INFO - Running setup.py install for mozrunner 14:02:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Running setup.py install for mozscreenshot 14:02:00 INFO - Running setup.py install for moztest 14:02:00 INFO - Running setup.py install for mozversion 14:02:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:00 INFO - Cleaning up... 14:02:00 INFO - Return code: 0 14:02:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 14:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 14:02:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:02:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:00 INFO - 'HOME': '/Users/cltbld', 14:02:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:00 INFO - 'LOGNAME': 'cltbld', 14:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:00 INFO - 'MOZ_NO_REMOTE': '1', 14:02:00 INFO - 'NO_EM_RESTART': '1', 14:02:00 INFO - 'PAGER': '/bin/cat', 14:02:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:00 INFO - 'PWD': '/builds/slave/test', 14:02:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:00 INFO - 'SHELL': '/bin/bash', 14:02:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:02:00 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:02:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:00 INFO - 'USER': 'cltbld', 14:02:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:00 INFO - 'XPC_FLAGS': '0x0', 14:02:00 INFO - 'XPC_SERVICE_NAME': '0', 14:02:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:00 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-m17jTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-DXl2Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-gdN2vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-bnuTac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-eC6ROZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-lc8LbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-UTWmfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-vHEMHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-FiBuio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:01 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)) 14:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:01 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-b33WVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-7aCYI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-q5ebx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-2JDy8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-hpwHlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-q7Qy_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-Pq_lGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:02 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)) 14:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:02 INFO - Running setup.py (path:/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/pip-0NDbBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:05 INFO - Downloading blessings-1.5.1.tar.gz 14:02:05 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:05 INFO - Installing collected packages: blessings 14:02:05 INFO - Running setup.py install for blessings 14:02:05 INFO - Successfully installed blessings 14:02:05 INFO - Cleaning up... 14:02:05 INFO - Return code: 0 14:02:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:06 INFO - Reading from file tmpfile_stdout 14:02:06 INFO - Current package versions: 14:02:06 INFO - blessings == 1.5.1 14:02:06 INFO - blobuploader == 1.2.4 14:02:06 INFO - docopt == 0.6.1 14:02:06 INFO - manifestparser == 1.1 14:02:06 INFO - mozInstall == 1.12 14:02:06 INFO - mozcrash == 0.16 14:02:06 INFO - mozdebug == 0.1 14:02:06 INFO - mozdevice == 0.47 14:02:06 INFO - mozfile == 1.2 14:02:06 INFO - mozhttpd == 0.7 14:02:06 INFO - mozinfo == 0.9 14:02:06 INFO - mozleak == 0.1 14:02:06 INFO - mozlog == 3.0 14:02:06 INFO - moznetwork == 0.27 14:02:06 INFO - mozprocess == 0.22 14:02:06 INFO - mozprofile == 0.27 14:02:06 INFO - mozrunner == 6.11 14:02:06 INFO - mozscreenshot == 0.1 14:02:06 INFO - mozsystemmonitor == 0.0 14:02:06 INFO - moztest == 0.7 14:02:06 INFO - mozversion == 1.4 14:02:06 INFO - psutil == 3.1.1 14:02:06 INFO - requests == 1.2.3 14:02:06 INFO - wsgiref == 0.1.2 14:02:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab3d4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, '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.m4dlSA08Si/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.kZxf9saBEW/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 14:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:02:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:06 INFO - 'HOME': '/Users/cltbld', 14:02:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:06 INFO - 'LOGNAME': 'cltbld', 14:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:06 INFO - 'MOZ_NO_REMOTE': '1', 14:02:06 INFO - 'NO_EM_RESTART': '1', 14:02:06 INFO - 'PAGER': '/bin/cat', 14:02:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:06 INFO - 'PWD': '/builds/slave/test', 14:02:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:06 INFO - 'SHELL': '/bin/bash', 14:02:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:02:06 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:02:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:06 INFO - 'USER': 'cltbld', 14:02:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:06 INFO - 'XPC_FLAGS': '0x0', 14:02:06 INFO - 'XPC_SERVICE_NAME': '0', 14:02:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:06 INFO - Cleaning up... 14:02:06 INFO - Return code: 0 14:02:06 INFO - Running post-action listener: _resource_record_post_action 14:02:06 INFO - Running post-action listener: _start_resource_monitoring 14:02:06 INFO - Starting resource monitoring. 14:02:06 INFO - ##### 14:02:06 INFO - ##### Running install step. 14:02:06 INFO - ##### 14:02:06 INFO - Running pre-action listener: _resource_record_pre_action 14:02:06 INFO - Running main action method: install 14:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:06 INFO - Reading from file tmpfile_stdout 14:02:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:06 INFO - Reading from file tmpfile_stdout 14:02:06 INFO - Output received: 14:02:06 INFO - Usage: mozinstall [options] installer 14:02:06 INFO - Options: 14:02:06 INFO - -h, --help show this help message and exit 14:02:06 INFO - -d DEST, --destination=DEST 14:02:06 INFO - Directory to install application into. [default: 14:02:06 INFO - "/builds/slave/test"] 14:02:06 INFO - --app=APP Application being installed. [default: firefox] 14:02:06 INFO - mkdir: /builds/slave/test/build/application 14:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:02:44 INFO - Reading from file tmpfile_stdout 14:02:44 INFO - Output received: 14:02:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:02:44 INFO - Running post-action listener: _resource_record_post_action 14:02:44 INFO - ##### 14:02:44 INFO - ##### Running run-tests step. 14:02:44 INFO - ##### 14:02:44 INFO - Running pre-action listener: _resource_record_pre_action 14:02:44 INFO - Running main action method: run_tests 14:02:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:02:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:02:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:02:44 INFO - 2015-11-14 14:02:44.446 screenresolution[6181:118847] starting screenresolution argv=screenresolution get 14:02:44 INFO - 2015-11-14 14:02:44.449 screenresolution[6181:118847] Display 0: 1600x1200x32@60 14:02:44 INFO - 2015-11-14 14:02:44.456 screenresolution[6182:118849] starting screenresolution argv=screenresolution list 14:02:44 INFO - Available Modes on Display 0 14:02:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:02:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:02:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:02:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:02:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:02:44 INFO - Intel HD Graphics 3000: 14:02:44 INFO - Chipset Model: Intel HD Graphics 3000 14:02:44 INFO - Type: GPU 14:02:44 INFO - Bus: Built-In 14:02:44 INFO - VRAM (Total): 512 MB 14:02:44 INFO - VRAM (Dynamic, Max): 10 14:02:44 INFO - Vendor: Intel (0x8086) 14:02:44 INFO - Device ID: 0x0116 14:02:44 INFO - Revision ID: 0x0009 14:02:44 INFO - Displays: 14:02:44 INFO - Display: 14:02:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:02:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:02:44 INFO - Display Serial Number: 1600x1200 60 14:02:44 INFO - Main Display: Yes 14:02:44 INFO - Mirror: Off 14:02:44 INFO - Online: Yes 14:02:44 INFO - Rotation: Supported 14:02:44 INFO - Return code: 0 14:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:02:44 INFO - Python 2.7.3 14:02:44 INFO - Return code: 0 14:02:44 INFO - grabbing minidump binary from tooltool 14:02: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')]} 14:02:44 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 0x10dfce9f0>, '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 0x10dd2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfc28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:02:44 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 14:02:44 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 14:02:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:44 INFO - Return code: 0 14:02:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:02:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:02:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:02:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:02:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0096', '--webServer', 'localhost'] in /builds/slave/test/build 14:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0096 --webServer localhost 14:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4dlSA08Si/Render', 14:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:44 INFO - 'HOME': '/Users/cltbld', 14:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:44 INFO - 'LOGNAME': 'cltbld', 14:02:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:02:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:44 INFO - 'MOZ_NO_REMOTE': '1', 14:02:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:02:44 INFO - 'NO_EM_RESTART': '1', 14:02:44 INFO - 'PAGER': '/bin/cat', 14:02:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:44 INFO - 'PWD': '/builds/slave/test', 14:02:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:44 INFO - 'SHELL': '/bin/bash', 14:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kZxf9saBEW/Listeners', 14:02:44 INFO - 'TMPDIR': '/var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/', 14:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:44 INFO - 'USER': 'cltbld', 14:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:44 INFO - 'XPC_FLAGS': '0x0', 14:02:44 INFO - 'XPC_SERVICE_NAME': '0', 14:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:02:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0096', '--webServer', 'localhost'] with output_timeout 3600 14:02:45 INFO - mozversion INFO | application_buildid: 20151114130830 14:02:45 INFO - mozversion INFO | application_changeset: bbeaf161feb415b87fca25bd2a25e9d31f3d7c46 14:02:45 INFO - mozversion INFO | application_display_name: Nightly 14:02:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:45 INFO - mozversion INFO | application_name: Firefox 14:02:45 INFO - mozversion INFO | application_remotingname: firefox 14:02:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 14:02:45 INFO - mozversion INFO | application_vendor: Mozilla 14:02:45 INFO - mozversion INFO | application_version: 45.0a1 14:02:45 INFO - mozversion INFO | platform_buildid: 20151114130830 14:02:45 INFO - mozversion INFO | platform_changeset: bbeaf161feb415b87fca25bd2a25e9d31f3d7c46 14:02:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 14:02:45 INFO - mozversion INFO | platform_version: 45.0a1 14:02:45 INFO - 2015-11-14 14:02:45,085 DEBUG : using testdate: 1447538565 14:02:45 INFO - 2015-11-14 14:02:45,085 DEBUG : actual date: 1447538565 14:02:45 INFO - 2015-11-14 14:02:45,167 INFO : starting webserver on 'localhost:56180' 14:02:45 INFO - 2015-11-14 14:02:45,168 INFO : Starting test suite t-yosemite-r5-0096 14:02:45 INFO - 2015-11-14 14:02:45,169 INFO : Starting test dromaeo_css 14:02:45 INFO - 2015-11-14 14:02:45,169 DEBUG : operating with platform_type : mac_ 14:02:45 INFO - 2015-11-14 14:02:45,170 INFO : Initialising browser for dromaeo_css test... 14:02:45 INFO - 2015-11-14 14:02:45,200 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmp5IimwX/profile http://localhost:56180/getInfo.html 14:02:48 INFO - 2015-11-14 14:02:48,338 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:02:48 INFO - 2015-11-14 14:02:48,338 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:02:48 INFO - 2015-11-14 14:02:48,338 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:02:48 INFO - 2015-11-14 14:02:48,338 DEBUG : BROWSER_OUTPUT: __metrics 14:02:48 INFO - 2015-11-14 14:02:48,359 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:49 INFO - 2015-11-14 14:02:49,053 INFO : Browser initialized. 14:02:49 INFO - 2015-11-14 14:02:49,054 INFO : Running cycle 1/1 for dromaeo_css test... 14:02:49 INFO - 2015-11-14 14:02:49,054 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmp5IimwX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:01 INFO - 2015-11-14 14:03:01,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 229576704 14:03:01 INFO - 2015-11-14 14:03:01,041 DEBUG : BROWSER_OUTPUT: 14:03:52 INFO - 2015-11-14 14:03:52,884 DEBUG : BROWSER_OUTPUT: 1447538632883 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] 14:06:03 INFO - 2015-11-14 14:06:03,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56180/tests/dromaeo/cssquery-ext.html) 14:06:04 INFO - 2015-11-14 14:06:04,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 340209664 14:06:04 INFO - 2015-11-14 14:06:04,346 DEBUG : BROWSER_OUTPUT: 14:09:06 INFO - 2015-11-14 14:09:06,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-ext.html (next: http://localhost:56180/tests/dromaeo/cssquery-jquery.html) 14:09:07 INFO - 2015-11-14 14:09:07,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 365285376 14:09:07 INFO - 2015-11-14 14:09:07,492 DEBUG : BROWSER_OUTPUT: 14:12:09 INFO - 2015-11-14 14:12:09,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56180/tests/dromaeo/cssquery-mootools.html) 14:12:10 INFO - 2015-11-14 14:12:10,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 331554816 14:12:10 INFO - 2015-11-14 14:12:10,199 DEBUG : BROWSER_OUTPUT: 14:15:12 INFO - 2015-11-14 14:15:12,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56180/tests/dromaeo/cssquery-prototype.html) 14:15:12 INFO - 2015-11-14 14:15:12,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 321531904 14:15:12 INFO - 2015-11-14 14:15:12,713 DEBUG : BROWSER_OUTPUT: 14:18:15 INFO - 2015-11-14 14:18:15,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56180/tests/dromaeo/cssquery-yui.html) 14:18:16 INFO - 2015-11-14 14:18:16,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 323510272 14:18:16 INFO - 2015-11-14 14:18:16,421 DEBUG : BROWSER_OUTPUT: 14:21:18 INFO - 2015-11-14 14:21:18,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-yui.html (next: http://localhost:56180/tests/dromaeo/cssquery-dojo.html) 14:21:19 INFO - 2015-11-14 14:21:19,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 376602624 14:21:19 INFO - 2015-11-14 14:21:19,264 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,264 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:21:19 INFO - 2015-11-14 14:21:19,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:21:19 INFO - 2015-11-14 14:21:19,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:21:19 INFO - 2015-11-14 14:21:19,265 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:21:19 INFO - 2015-11-14 14:21:19,269 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3051.816890986542;3099.333643266698;3166.6516683164864;3228.8062716237027;3247.8863239786606;4843.031393721252;4915.705057696532;5062.848114556565;5126.974365128179;5194.558462530685;4945.554900059003;4991.475895031024;5079.720615366154;5137.460566640505;5155.407128180261;4650.7442090685;4697.459792123898;4723.645726570504;4753.191957367256;4852.781624826874;4742.383490146276;4815.133276010317;4826.0830442215865;4842.665605333211;4853.272009198613;4544.295634176675;4649.721016738973;4666.393368862026;4741.881452963687;4758.547937945924;4569.383133276999;4606.101810147023;4618.030213655136;4628.190066738307;4639.512851150648;4558.612517935946;4650.348951146842;4657.347971284023;4669.533046695337;4675.812967481331;5052.696838189684;5055.9241611375855;5056.014077254937;5069.650605161004;5138.768755406016;5391.703456309901;5414.648047876875;5421.864453388657;5423.376311724162;5447.591430642718;5270.631055826094;5294.68231906083;5318.9202161967605;5401.405845357008;5450.945490545123;5103.132467480537;5110.693358398508;5116;5116.334876466073;5119.283300337956;5518.2826232590305;5611.607187496836;5616.438356164351;5616.887662246732;5628.437156284339;5134.666246693953;5151.5878729701535;5260.026895024433;5271.736413179326;5330.120530112566;5435.782568697208;5444.673319600836;5468.453154684579;5501.312335958005;5527.226188333637;5381.327334083239;5382.91925621116;5390.380106287748;5401.540869026177;5444.782208711607;5155.896882062338;5275.63070585063;5321.175217841241;5327.334083239595;5369.892602148013;4199.265128602482;4223.113146239262;4249.68127390447;4256.616904478612;4260.190563792869;3831.7700937943814;3835.4055121456217;3838.8272527736317;3872.4772155759174;3879.2435475082652;4934.753262336869;5039.042581909425;5041.0422019816115;5059.569936555434;5108.6168537359845;5455.454454554592;5502.202180683778;5523.585731070186;5555.749991250404;5574.108142697149;5162.251473536317;5167.147420675622;5171.3535808024;5180.611454140954;5188.507091826271;4633.096546173531;4825.613950883921;4834.009028149221;4840.6127509799835;4879.414470263591;5612.382637909908;5624.55003599711;5651.886962260732;5693.117566777156;5755.827325180251;5457.590680698884;5479.479449452296;5487.972560137174;5491.972540137273;5558.360788509373;5371.328583927009;5638.069718496402;5659.717014149193;5662.405447427961;5674.347450043298;5301.920471192858;5304.336957880265;5304.840854774363;5326.840194794162;5354.143337066051;5350.785968561214;5354.303940487712;5447.863803404946;5457.154141107976;5461.754221060141;5323.0950738373795;5365.946340536545;5376.274202982704;5391.865203369947;5446.046941785251;5360.490753378423;5366.785328586969;5394.703291319015;5407.351117865724;5489.862753431196;5001.874953126201;5145.871353216199;5179.689218646893;5194.065068287745;5257.8159764408065;5313.707746073848;5313.840584782462;5340.359156901041;5363.302770639948;5384.407715151408;5071.340725705634;5211.869703257449;5215.374155101412;5225.5819534437915;5259.658122222043 14:21:19 INFO - 2015-11-14 14:21:19,269 DEBUG : BROWSER_OUTPUT: |1;ext.html;533.1868899927609;533.274746344971;536.7155407633953;542.4169018305322;557.7350758389763;29350.706492935064;30429.695703042962;34957.30085398294;35134.12164695884;35513.289734205304;39638.40542391859;39951.60048399515;40135;40226.39660405096;40360.59639403605;7814.960925195366;8730.956345218265;8933.77665558363;9047.095290470934;9060.365774395796;8023.4383593148505;10681.145508359352;10860.891391086107;10862.131029517619;10974.615888443906;10491.213159013067;10548;10593.947030264839;10658.573657053708;10665.520051597698;8106.959465202695;8249.917500825035;10293.948530257301;10497.317674351143;10666.200034997406;10148.391096534231;10256.076953074184;10296.07335339823;10324.58701651933;10332.121769649513;34774.1748407675;34845.12887177816;34880.47679284813;34908;35364.823175883954;2628.7239839816925;2690.0181433776725;2716;2789.2050765531726;3142.5286207068893;25694.74305256942;26014.479710405685;26372.8681356592;26573.069942552112;26742.509451444705;2331.8170696998477;2338.228384633067;2348.0607756897207;2349.48311371498;2464.6549483072386;248173;251917;252764;254372;255417;48191.27713084307;48502;49826.512144150285;56649;56870.146947795816;57424;58338.12492812611;58401.70799145977;58561.70719146377;58922;12742.80885786714;12751.298678572583;12779.808302875465;12822.23066616006;12823.294718790556;10540.578376864993;10632.574697012033;10638.840417393745;10639.787204255872;10680.89319106799;18533.166007529693;18623.720644190347;18658.626827463646;18676.53308667267;18679.626407472046;8136.389770767216;8439.915600844035;8442.873356899652;8445.1977062179;8451.619677114422;876.4522173641474;904.3398319227001;942.5146049784366;952.9952350238204;990.9446439541865;26827.32931676724;26996.1901142966;27048.323791904968;27284.454310913672;28210;978.1441238915949;983.3559018842669;1000.429755039635;1081.1458947431597;1112.410422476089;13622.931885340708;13654.453821847213;13664.863351366359;13903.930480347533;13912.51306204278;305683;311499;313437;313803;316946;49731.254031189565;50046;50235.74410639763;50425.49574504281;50557.49442505528;1323.483841301893;1331.4407948661585;1345.8519562848078;1347.791092380663;1352.1751731443812;21977.890110549346;26999.73000269972;27243.72756272491;27666.861665691544;28602.713972860005;46399.76800115978;46530;46736.53263467322;47049.52950470588;47136;246495;247905;247962;248159;250652;24611.507769844862;24742.628860567467;28673.71326286794;29114.70885291205;29472.557911630913;35833.82083089672;36036.8198159018;36588.085297867765;36648;38998.610013899495;31028.22429439282;31319;31657;31695.52456713105;31712.36575268528;31038.22404439817;31047.84476077605;31208.53187202239;31247.687523124478;31394.843025784725;31193.37613247677;31746.52380214345;31781.682183177873;32072.67927320697;32197.51703724399;28923.276918076375;29758;29902.70097299086;30005;30056.849715751283;22425.663615046113;22654.093836246364;22748.4312892179;22983.77016229883;23089.422764431023 14:21:19 INFO - 2015-11-14 14:21:19,273 DEBUG : BROWSER_OUTPUT: |2;jquery.html;308.9042396856973;317.5554224086279;318.97613567772606;322.3166886201252;327.8033180091945;13604.523841665543;13754.105983111116;15750.606234844134;16377.42679006235;16957.915210423947;13773.449062037507;16261.349546018146;18714.251429942786;19011.429657110275;19054.61890762184;5661.207430959658;5982.670953097578;5994.910076348859;6000.129981152731;6002.969985150068;4218.767967761772;4336.739795612258;5869.090291004901;5939.762409503636;6498;6706.731730730789;6767.729290828385;6796.08252885859;6796.7621133260345;6818.727250909958;6589.077529145923;6615.900761488581;6640.402363787258;6655.201375834882;6720.932790672104;6128.050152226412;6334.936650633481;6347;6350.904736428957;6407.583507072025;23203.187888423825;23535.4116147096;23554.646680299807;23588.882055589613;23660.76339236603;1923.4902750771057;1947.376839411389;2041.428400047989;2061.917523299066;2086.2072412483158;13528.120672156278;13533.323333833268;13774.724505509934;14278.64303392413;14344.211068391234;1705.0792572011098;1735.1497766094649;1751.1594434671429;1793.9103044847836;1832.1480511562188;59742;63056.36943630597;63324.36675633277;63666.68166659137;64059;15951.60120996961;16199.757003644954;16342.346306147621;16368.590785230464;16385;23641.527169456516;23686.170984015476;23715.525689486112;23785;23818.40453988664;8772.385932984758;8872.600732967032;8902.154295341932;9055.81888362229;9072.092790721008;7443.925560744323;7461;7467.514611550232;7489.28851759082;7519.736809211651;7582.393408527305;7609.201033891472;7674.347680447225;7678.424118191047;7680.270374314431;2629.684437867468;3051.7711171662213;3086.4444400007765;3120.9245851508945;3176.539401786728;401.08540643320816;434.38751360581426;440.27354864473875;444.22482767570796;451.03028488748794;9948.602055917827;11033;11247.437628118561;11329.320240785579;11533.653990380302;442.9335599660012;443.7803287372771;447.1057884231537;452.6446739309692;469.4413647759156;6023.427774361428;6063.120847477091;6099.237595300588;6136.417040381157;6138.294096178907;441867;450589;483127;487685;488026;64258;68203.65898170478;68242;68652;70273.29726702668;471.51905056842514;481.9349387832598;482.57774447359265;483.03152179879817;483.7073570489873;10413.32313399657;10673.146148308271;10678.8398174029;10720.001590504675;10726.463676815973;33688.831555842065;33813;34229.48655770116;34289.14277143091;34570.82714586411;45441.54558454373;45841.31238031499;46290.53709462862;46314;46315.305270421646;6984.126984126984;7226.313500217471;7365.926340736738;7417.406607471497;7439.739609113655;10678.412687302272;10924.617638382619;11102.167337449562;11118.555257789598;11121.443927803739;9325.114114159143;9345;9567.234621230424;9691.370060946016;9799.951000244953;9242.12199841014;9245.72262832116;9328.300377471582;9350.766230844283;9445;9479.431234125974;9727.756806079622;9782.75543111428;9793.657221997197;9813.705588832347;7160.641967901688;7189.317014883578;7208.315210055036;7250.709971601077;7274.636268186464;9383.483908385104;9442.95278523603;9547.188488978514;9583.808323833624;9613.375130616487 14:21:19 INFO - 2015-11-14 14:21:19,273 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1449.2970909109074;1680.0339804612347;1718.9742153867687;1732.8007279162896;1744.8691348148884;6642.900356494656;7146.106736657918;7438.293362130603;7597.658105385257;7745;7425.814354641123;7616.238376162381;7624.542527448357;7641.426892983035;7665.501742386755;2092.3199960013017;2116.6930795034787;2120.6076875777953;2122.172352782416;2140.2295173737443;2095.172406899274;2097.2974053692033;2098.27609474731;2117.8729276243475;2126.33020598511;2055.722477465538;2064.597403506317;2072.803083707053;2083.7603675577275;2088.1021160900805;2059.9176032958662;2071.906764195615;2077.054940002303;2082.354470114254;2100.9159633614636;2084.8436367272516;2085.9478513037143;2090.3310940499046;2102.453362125843;2111.155537784883;6500.284968653492;7435.1449583297535;7479.925200747977;7539.321461068475;7581.469297149201;3917.5298964124204;4334.45819272591;4418.602325790662;4428.40216570762;4456.331550267453;2793.385455199873;2818.9154325370273;2880.3807181456086;2882.884684612613;2911.30128769096;845.0704225352125;874.9300055995569;880.6741505642954;888.1695614600369;891.4383938119008;10039.447830369327;10099.192064634884;10122.190224782;10230.23273254509;10238.488075596191;3984.7011474138976;4004.5795191505053;4060.7563546187325;4078.4290199372113;4101.835926562904;8854.955725221462;8866.157715017063;8907.777305567282;8945.06076861933;8967;4495.730256184639;4507.2788353863225;4509.413776209138;4556.476005259437;4557.430321209848;4042.6967977401223;4067.918641627151;4076.2255171517318;4089.3661482470266;4110.7328023678965;3316.369889720945;3343.615484219346;3359.5800524934384;3362.277110421271;3374.8312584370683;1011.9898801012043;1024.6311327921942;1030;1044.6813721814767;1044.8746150461993;933.5285680731188;945.6501094594906;952.9999999999861;1002.754325190333;1283.371148137406;7196.208417074117;7227;7245.710171593183;7274.709011639475;7282.271772822675;394.86377199866;406.65231227300825;412.9648979836687;414.19852585247645;421.1765997474929;5123.487651234921;5568.554515638739;5621.353544342453;5676.829695109153;5702.287214098238;7474.588897610575;9158.358914876027;9165.404248723811;9189.540522973824;9192.63229470827;8627.180417860292;8942.418742781698;8950.597223124974;9081.091890810998;9101.180893719464;6899.965500172467;7095.680694368766;7100.366915609438;7167.247439018932;7168.641567921583;6716.529842911144;6897.206821215625;6898.103246577913;6922.203946546211;6996.790096297119;7775.688972441265;7869.606519674108;7930.762077137695;7980.162082981204;8006.439549231498;8117.10711821711;8195;8337.249647531751;8371.037330707046;8424.157584241526;6390.424861762278;6488.383603557654;6493.577917435352;6500.3174666659315;6531.706073226621;7157.534760240567;7173.24680908518;7183.5330703504105;7229.819254518679;7245.7826265210015;6630.867382652416;6788.660566971533;6809.38715515606;6844.349786770249;6968.989496523077;6691.2639609643875;6728.192616886005;6772.153480814898;6845.5550389224545;6865.691043902936;6737.191537015589;6767.966160169168;6903.309669033057;6912.412444942236;6940.41006514452;6039.305479869871;6086.117512960507;6110.7861224856915;6143.969280153749;6173.197484327009;6105.694715264308;6142.600730952474;6174.629522228681;6194.318624951162;6252.687365631609 14:21:19 INFO - 2015-11-14 14:21:19,276 DEBUG : BROWSER_OUTPUT: |4;prototype.html;284.0569309891162;295.23975762411794;297.4586253019504;299.1981489607851;309.6361774914475;5741.19623252745;5862.32583252926;5881.735321910513;5895.233619629447;5976;5780.277465316835;5841.123831425289;5884.882302353961;5923.348431672513;6004.729787159577;4470.150671372445;4472.686911916167;4490.506044335137;4518.1415531049;4524.683272170958;4236.813692166198;4367.890802729941;4440.200763862504;4488.955110448903;4492.348609451627;4425.623821975136;4434.647432533076;4441.378207051015;4455.509893911667;4475.0378668586245;4417.42573465449;4450.287953927356;4463.040446304028;4481.350204220386;4499.820007199708;3786.8863934082024;3794.146317078663;3808.752431091998;3825.5791862895057;3830.119072613287;5679.858003549903;5714.085746280575;5788.565857560658;5799.623024503436;5814.0697488402075;4994.500549945013;5012.8496145115705;5056.039352523009;5071.1632580624155;5072.264521644378;5999.370066143036;6190.628562286277;6197.225346831646;6232.283287421914;6237.189165408513;4035.656969157625;4092.2224777292217;4134.669226461876;4149.315362965137;4156.9792151039355;6435.22777266731;6543.967280163616;6545.37818907203;6565.638889861056;6603.966980165116;4169.854055108057;4180.581941805795;4183.477065366829;4185.6232939035635;4233.894152646147;4123.9175216495505;4243.809028593659;4258.276093064186;4280.743155410685;4284.485861696554;4994.700317980933;5004.4995500450395;5022.146235140035;5064.1897296433135;5069.797208111708;6188.628682279078;6241.095041218998;6279.152314437584;6284.465820405317;6294.590851594632;1489.4265707702396;1512.4101600375861;1513.4248985385484;1525.5270866031565;1526.5649289952532;972.1299437003842;974.3082411487923;989.7723523589615;992.1269283031031;992.6178421307849;5970.283565972111;5988.431099045583;6025.0661147522205;6041.426064523863;6080.787172448943;6497.350264973465;6512.381323774234;6550.672466376662;6565;6581.736730530821;5965.731542080617;5974.551908606872;6011;6031.819045428644;6043.969780151071;3459.2216751231276;3516.384632689269;3517.3668739627115;3558.5729712434672;3563.2873425315042;6729.629870357177;6749.122614060141;6761.256261811295;6851.520393572402;6853.897191542131;6676.098726671934;6689.76585819494;6755.60176137474;6763.188417389944;6769.120014398097;6591.143151390289;6718.260991291052;6738.225104112992;6810.421114205249;6813.931860681528;6362.713677884413;6512.511561632991;6564.409203171737;6598.60408375499;6601.471882249312;6313;6341.619502829661;6371.96814015927;6372.522060845363;6418.839529011812;6354.301026887131;6752.122224110834;6800.455963523005;6857.382835544825;6899.931000689929;4086.1623367210245;4126.814293356746;4155.272827255158;4158.438610787505;4184.539700632867;6470.6441145737435;6476.676166191577;6535.150430444012;6543.247526534319;6559.967200164159;6150.876982460415;6269.373062693694;6297.52768542352;6383.234011918599;6402.263739669811;6300.306966233802;6327.651979141191;6339.524535659936;6342.778002769881;6423.967880160756;6179.589959915546;6182.227221597301;6204.472619827366;6250.687465626791;6279.434850863444;6194.132821405097;6336.493080553637;6367.936320636734;6408.839779005562;6413.647249401328;6197.845053873689;6201.224846894138;6247.437730604267;6269.717862696099;6284.308726040041 14:21:19 INFO - 2015-11-14 14:21:19,277 DEBUG : BROWSER_OUTPUT: |5;yui.html;635.2250254689277;651.3909494622525;718.7807718645811;726.1177669132005;747.174372318588;13032.674183145415;13164.605061848148;14859.925700371483;14874.999999999987;15156.772648410282;13622.863771362283;13656.24890631015;13684.384202710877;13795;13804.102733322326;652.5008368598026;660.1121491593799;816.6774124220944;822.3996482567729;847.7668641123679;809.9919000810005;826.3513142183388;831.1854382704953;834.5451728807784;835.4611275727183;856.1951765340591;863.0592654007162;866.0300463480879;868.700298397052;873.6199753107387;672.6838385958616;683.0028158888005;826.4297634632145;843.8059246373307;844.7719115838689;627.4384425938805;627.7081157261849;628.9716962736687;629.0030301971381;629.8771739510797;12864.228146311158;13082.738345233138;13124.278164700938;13128;13145.21128732279;8932.330075244383;8958.820823583492;9199.494027828467;9335.439873607538;9491.003444638352;8560.443571167854;8583.313334933253;8645.697400590949;8684.652613895436;8800.339974501938;2796.9720302796914;2806.1441260415563;2807.115758536075;2808.789340799428;2849.871755770995;44321;44467;44788.3281750774;44834.551654483366;44913;6301.117843501914;6466.35336466359;6511.479081673455;6661.766838160641;6826.726930922708;11181.44092795357;11203.71990700239;11297.49161287744;11322.830157547478;11327.94336028331;5548.195511650869;5623.184638227434;5721.284839395075;5738.684372359477;5739.942600573941;3287.0176279172156;3366.562346894888;3429.022728522359;3547.8758243461357;3593.8562457501407;2586.1594981631047;2616.3720707030175;2618.9607155892677;2631.8947242110485;2633.11790550164;399.34108720611226;401;401.38387575072124;404.80771633473864;405.19164267286953;409.56586018819553;444.3823085910587;536.6377695055821;553.9556835453154;575.318247876268;6975.4070903972715;7407.629618519052;7524.623768811647;7677.385809135368;7910.090339610903;550.2324257660621;565.2312854517852;578.9565782566324;589.6963064022032;592.8578533770997;3661.7253705971625;3705.6850167735506;3765.6234376562124;3774.8112594370173;3792.1846802937503;50447.74776126169;52882.206766898526;55884.44115558793;56691.71654141703;56730.43269567334;45509.7724511382;45513.77243113829;45705.54294457013;45774.77112614482;45967;44643.553564464586;44759;44954;45097.77451112789;46135;7820.296173344426;7891.68433262686;7945.562994035153;7991.4006449515355;8201.79495512617;33177.50233746544;33260.50109248412;33768.155796104315;34035.14912127217;34170;41878.79060604677;41934.790326048176;44210.77894610506;45388.09223815439;45548.54451455575;7095.645217739196;7253.528520646141;7304.160021597584;7330.780076597711;7449.8882516761205;10718.946405267923;10819.945900270448;11014.779704406028;11058.668239952493;11448.42757862087;10404.375737455777;10543.683689489328;10559.683209503728;10579.682609521727;10918.78162436731;9845.212383009486;10425.165986721197;10567.048965593134;10676.733081673021;10805.675829725122;6808.659567021728;9446.716598502057;9722.416655000723;9809.313348065567;9927.503624818586;7855.253750893656;8115.229053239933;8116.431849770459;8432.409731318749;8634.136586341316;8593.65625374978;8774.956125219333;8988.46069235848;9004.819903602021;9082.682106126254 14:21:19 INFO - 2015-11-14 14:21:19,277 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,931 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: __startTimestamp1447539679263__endTimestamp 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:21:19 INFO - 2015-11-14 14:21:19,278 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:21:19 INFO - 2015-11-14 14:21:19,279 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,279 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5069.02 Median:5194.56 stddev:526.55 (10.1%) stddev-sans-first:503.82 14:21:19 INFO - 2015-11-14 14:21:19,280 DEBUG : BROWSER_OUTPUT: Values: 3051.8 3099.3 3166.7 3228.8 3247.9 4843.0 4915.7 5062.8 5127.0 5194.6 4945.6 4991.5 5079.7 5137.5 5155.4 4650.7 4697.5 4723.6 4753.2 4852.8 4742.4 4815.1 4826.1 4842.7 4853.3 4544.3 4649.7 4666.4 4741.9 4758.5 4569.4 4606.1 4618.0 4628.2 4639.5 4558.6 4650.3 4657.3 4669.5 4675.8 5052.7 5055.9 5056.0 5069.7 5138.8 5391.7 5414.6 5421.9 5423.4 5447.6 5270.6 5294.7 5318.9 5401.4 5450.9 5103.1 5110.7 5116.0 5116.3 5119.3 5518.3 5611.6 5616.4 5616.9 5628.4 5134.7 5151.6 5260.0 5271.7 5330.1 5435.8 5444.7 5468.5 5501.3 5527.2 5381.3 5382.9 5390.4 5401.5 5444.8 5155.9 5275.6 5321.2 5327.3 5369.9 4199.3 4223.1 4249.7 4256.6 4260.2 3831.8 3835.4 3838.8 3872.5 3879.2 4934.8 5039.0 5041.0 5059.6 5108.6 5455.5 5502.2 5523.6 5555.7 5574.1 5162.3 5167.1 5171.4 5180.6 5188.5 4633.1 4825.6 4834.0 4840.6 4879.4 5612.4 5624.6 5651.9 5693.1 5755.8 5457.6 5479.5 5488.0 5492.0 5558.4 5371.3 5638.1 5659.7 5662.4 5674.3 5301.9 5304.3 5304.8 5326.8 5354.1 5350.8 5354.3 5447.9 5457.2 5461.8 5323.1 5365.9 5376.3 5391.9 5446.0 5360.5 5366.8 5394.7 5407.4 5489.9 5001.9 5145.9 5179.7 5194.1 5257.8 5313.7 5313.8 5340.4 5363.3 5384.4 5071.3 5211.9 5215.4 5225.6 5259.7 14:21:19 INFO - 2015-11-14 14:21:19,280 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,280 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42839.41 Median:29615.28 stddev:71230.48 (240.5%) stddev-sans-first:71359.47 14:21:19 INFO - 2015-11-14 14:21:19,282 DEBUG : BROWSER_OUTPUT: Values: 533.2 533.3 536.7 542.4 557.7 29350.7 30429.7 34957.3 35134.1 35513.3 39638.4 39951.6 40135.0 40226.4 40360.6 7815.0 8731.0 8933.8 9047.1 9060.4 8023.4 10681.1 10860.9 10862.1 10974.6 10491.2 10548.0 10593.9 10658.6 10665.5 8107.0 8249.9 10293.9 10497.3 10666.2 10148.4 10256.1 10296.1 10324.6 10332.1 34774.2 34845.1 34880.5 34908.0 35364.8 2628.7 2690.0 2716.0 2789.2 3142.5 25694.7 26014.5 26372.9 26573.1 26742.5 2331.8 2338.2 2348.1 2349.5 2464.7 248173.0 251917.0 252764.0 254372.0 255417.0 48191.3 48502.0 49826.5 56649.0 56870.1 57424.0 58338.1 58401.7 58561.7 58922.0 12742.8 12751.3 12779.8 12822.2 12823.3 10540.6 10632.6 10638.8 10639.8 10680.9 18533.2 18623.7 18658.6 18676.5 18679.6 8136.4 8439.9 8442.9 8445.2 8451.6 876.5 904.3 942.5 953.0 990.9 26827.3 26996.2 27048.3 27284.5 28210.0 978.1 983.4 1000.4 1081.1 1112.4 13622.9 13654.5 13664.9 13903.9 13912.5 305683.0 311499.0 313437.0 313803.0 316946.0 49731.3 50046.0 50235.7 50425.5 50557.5 1323.5 1331.4 1345.9 1347.8 1352.2 21977.9 26999.7 27243.7 27666.9 28602.7 46399.8 46530.0 46736.5 47049.5 47136.0 246495.0 247905.0 247962.0 248159.0 250652.0 24611.5 24742.6 28673.7 29114.7 29472.6 35833.8 36036.8 36588.1 36648.0 38998.6 31028.2 31319.0 31657.0 31695.5 31712.4 31038.2 31047.8 31208.5 31247.7 31394.8 31193.4 31746.5 31781.7 32072.7 32197.5 28923.3 29758.0 29902.7 30005.0 30056.8 22425.7 22654.1 22748.4 22983.8 23089.4 14:21:19 INFO - 2015-11-14 14:21:19,282 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,282 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26279.37 Median:482.80 stddev:76935.54 (15935.1%) stddev-sans-first:77126.65 14:21:19 INFO - 2015-11-14 14:21:19,283 DEBUG : BROWSER_OUTPUT: Values: 308.9 317.6 319.0 322.3 327.8 13604.5 13754.1 15750.6 16377.4 16957.9 13773.4 16261.3 18714.3 19011.4 19054.6 5661.2 5982.7 5994.9 6000.1 6003.0 4218.8 4336.7 5869.1 5939.8 6498.0 6706.7 6767.7 6796.1 6796.8 6818.7 6589.1 6615.9 6640.4 6655.2 6720.9 6128.1 6334.9 6347.0 6350.9 6407.6 23203.2 23535.4 23554.6 23588.9 23660.8 1923.5 1947.4 2041.4 2061.9 2086.2 13528.1 13533.3 13774.7 14278.6 14344.2 1705.1 1735.1 1751.2 1793.9 1832.1 59742.0 63056.4 63324.4 63666.7 64059.0 15951.6 16199.8 16342.3 16368.6 16385.0 23641.5 23686.2 23715.5 23785.0 23818.4 8772.4 8872.6 8902.2 9055.8 9072.1 7443.9 7461.0 7467.5 7489.3 7519.7 7582.4 7609.2 7674.3 7678.4 7680.3 2629.7 3051.8 3086.4 3120.9 3176.5 401.1 434.4 440.3 444.2 451.0 9948.6 11033.0 11247.4 11329.3 11533.7 442.9 443.8 447.1 452.6 469.4 6023.4 6063.1 6099.2 6136.4 6138.3 441867.0 450589.0 483127.0 487685.0 488026.0 64258.0 68203.7 68242.0 68652.0 70273.3 471.5 481.9 482.6 483.0 483.7 10413.3 10673.1 10678.8 10720.0 10726.5 33688.8 33813.0 34229.5 34289.1 34570.8 45441.5 45841.3 46290.5 46314.0 46315.3 6984.1 7226.3 7365.9 7417.4 7439.7 10678.4 10924.6 11102.2 11118.6 11121.4 9325.1 9345.0 9567.2 9691.4 9800.0 9242.1 9245.7 9328.3 9350.8 9445.0 9479.4 9727.8 9782.8 9793.7 9813.7 7160.6 7189.3 7208.3 7250.7 7274.6 9383.5 9443.0 9547.2 9583.8 9613.4 14:21:19 INFO - 2015-11-14 14:21:19,283 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,283 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5195.99 Median:6223.50 stddev:2765.69 (44.4%) stddev-sans-first:2759.11 14:21:19 INFO - 2015-11-14 14:21:19,284 DEBUG : BROWSER_OUTPUT: Values: 1449.3 1680.0 1719.0 1732.8 1744.9 6642.9 7146.1 7438.3 7597.7 7745.0 7425.8 7616.2 7624.5 7641.4 7665.5 2092.3 2116.7 2120.6 2122.2 2140.2 2095.2 2097.3 2098.3 2117.9 2126.3 2055.7 2064.6 2072.8 2083.8 2088.1 2059.9 2071.9 2077.1 2082.4 2100.9 2084.8 2085.9 2090.3 2102.5 2111.2 6500.3 7435.1 7479.9 7539.3 7581.5 3917.5 4334.5 4418.6 4428.4 4456.3 2793.4 2818.9 2880.4 2882.9 2911.3 845.1 874.9 880.7 888.2 891.4 10039.4 10099.2 10122.2 10230.2 10238.5 3984.7 4004.6 4060.8 4078.4 4101.8 8855.0 8866.2 8907.8 8945.1 8967.0 4495.7 4507.3 4509.4 4556.5 4557.4 4042.7 4067.9 4076.2 4089.4 4110.7 3316.4 3343.6 3359.6 3362.3 3374.8 1012.0 1024.6 1030.0 1044.7 1044.9 933.5 945.7 953.0 1002.8 1283.4 7196.2 7227.0 7245.7 7274.7 7282.3 394.9 406.7 413.0 414.2 421.2 5123.5 5568.6 5621.4 5676.8 5702.3 7474.6 9158.4 9165.4 9189.5 9192.6 8627.2 8942.4 8950.6 9081.1 9101.2 6900.0 7095.7 7100.4 7167.2 7168.6 6716.5 6897.2 6898.1 6922.2 6996.8 7775.7 7869.6 7930.8 7980.2 8006.4 8117.1 8195.0 8337.2 8371.0 8424.2 6390.4 6488.4 6493.6 6500.3 6531.7 7157.5 7173.2 7183.5 7229.8 7245.8 6630.9 6788.7 6809.4 6844.3 6969.0 6691.3 6728.2 6772.2 6845.6 6865.7 6737.2 6768.0 6903.3 6912.4 6940.4 6039.3 6086.1 6110.8 6144.0 6173.2 6105.7 6142.6 6174.6 6194.3 6252.7 14:21:19 INFO - 2015-11-14 14:21:19,284 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,284 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5210.93 Median:6018.03 stddev:1632.47 (27.1%) stddev-sans-first:1594.61 14:21:19 INFO - 2015-11-14 14:21:19,285 DEBUG : BROWSER_OUTPUT: Values: 284.1 295.2 297.5 299.2 309.6 5741.2 5862.3 5881.7 5895.2 5976.0 5780.3 5841.1 5884.9 5923.3 6004.7 4470.2 4472.7 4490.5 4518.1 4524.7 4236.8 4367.9 4440.2 4489.0 4492.3 4425.6 4434.6 4441.4 4455.5 4475.0 4417.4 4450.3 4463.0 4481.4 4499.8 3786.9 3794.1 3808.8 3825.6 3830.1 5679.9 5714.1 5788.6 5799.6 5814.1 4994.5 5012.8 5056.0 5071.2 5072.3 5999.4 6190.6 6197.2 6232.3 6237.2 4035.7 4092.2 4134.7 4149.3 4157.0 6435.2 6544.0 6545.4 6565.6 6604.0 4169.9 4180.6 4183.5 4185.6 4233.9 4123.9 4243.8 4258.3 4280.7 4284.5 4994.7 5004.5 5022.1 5064.2 5069.8 6188.6 6241.1 6279.2 6284.5 6294.6 1489.4 1512.4 1513.4 1525.5 1526.6 972.1 974.3 989.8 992.1 992.6 5970.3 5988.4 6025.1 6041.4 6080.8 6497.4 6512.4 6550.7 6565.0 6581.7 5965.7 5974.6 6011.0 6031.8 6044.0 3459.2 3516.4 3517.4 3558.6 3563.3 6729.6 6749.1 6761.3 6851.5 6853.9 6676.1 6689.8 6755.6 6763.2 6769.1 6591.1 6718.3 6738.2 6810.4 6813.9 6362.7 6512.5 6564.4 6598.6 6601.5 6313.0 6341.6 6372.0 6372.5 6418.8 6354.3 6752.1 6800.5 6857.4 6899.9 4086.2 4126.8 4155.3 4158.4 4184.5 6470.6 6476.7 6535.2 6543.2 6560.0 6150.9 6269.4 6297.5 6383.2 6402.3 6300.3 6327.7 6339.5 6342.8 6424.0 6179.6 6182.2 6204.5 6250.7 6279.4 6194.1 6336.5 6367.9 6408.8 6413.6 6197.8 6201.2 6247.4 6269.7 6284.3 14:21:19 INFO - 2015-11-14 14:21:19,285 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,286 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12487.65 Median:3051.08 stddev:15185.72 (497.7%) stddev-sans-first:15202.24 14:21:19 INFO - 2015-11-14 14:21:19,287 DEBUG : BROWSER_OUTPUT: Values: 635.2 651.4 718.8 726.1 747.2 13032.7 13164.6 14859.9 14875.0 15156.8 13622.9 13656.2 13684.4 13795.0 13804.1 652.5 660.1 816.7 822.4 847.8 810.0 826.4 831.2 834.5 835.5 856.2 863.1 866.0 868.7 873.6 672.7 683.0 826.4 843.8 844.8 627.4 627.7 629.0 629.0 629.9 12864.2 13082.7 13124.3 13128.0 13145.2 8932.3 8958.8 9199.5 9335.4 9491.0 8560.4 8583.3 8645.7 8684.7 8800.3 2797.0 2806.1 2807.1 2808.8 2849.9 44321.0 44467.0 44788.3 44834.6 44913.0 6301.1 6466.4 6511.5 6661.8 6826.7 11181.4 11203.7 11297.5 11322.8 11327.9 5548.2 5623.2 5721.3 5738.7 5739.9 3287.0 3366.6 3429.0 3547.9 3593.9 2586.2 2616.4 2619.0 2631.9 2633.1 399.3 401.0 401.4 404.8 405.2 409.6 444.4 536.6 554.0 575.3 6975.4 7407.6 7524.6 7677.4 7910.1 550.2 565.2 579.0 589.7 592.9 3661.7 3705.7 3765.6 3774.8 3792.2 50447.7 52882.2 55884.4 56691.7 56730.4 45509.8 45513.8 45705.5 45774.8 45967.0 44643.6 44759.0 44954.0 45097.8 46135.0 7820.3 7891.7 7945.6 7991.4 8201.8 33177.5 33260.5 33768.2 34035.1 34170.0 41878.8 41934.8 44210.8 45388.1 45548.5 7095.6 7253.5 7304.2 7330.8 7449.9 10718.9 10819.9 11014.8 11058.7 11448.4 10404.4 10543.7 10559.7 10579.7 10918.8 9845.2 10425.2 10567.0 10676.7 10805.7 6808.7 9446.7 9722.4 9809.3 9927.5 7855.3 8115.2 8116.4 8432.4 8634.1 8593.7 8775.0 8988.5 9004.8 9082.7 14:21:19 INFO - 2015-11-14 14:21:19,287 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:21:19 INFO - 2015-11-14 14:21:19,287 DEBUG : BROWSER_OUTPUT: 14:21:19 INFO - 2015-11-14 14:21:19,938 INFO : Browser exited with error code: 0 14:21:19 INFO - 2015-11-14 14:21:19,965 INFO : Completed test dromaeo_css (00:18:34) 14:21:19 INFO - 2015-11-14 14:21:19,965 INFO : Starting test kraken 14:21:19 INFO - 2015-11-14 14:21:19,965 DEBUG : operating with platform_type : mac_ 14:21:19 INFO - 2015-11-14 14:21:19,966 INFO : Initialising browser for kraken test... 14:21:19 INFO - 2015-11-14 14:21:19,978 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmp6edG5n/profile http://localhost:56180/getInfo.html 14:21:22 INFO - 2015-11-14 14:21:22,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:21:22 INFO - 2015-11-14 14:21:22,292 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:21:22 INFO - 2015-11-14 14:21:22,292 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:21:22 INFO - 2015-11-14 14:21:22,293 DEBUG : BROWSER_OUTPUT: __metrics 14:21:22 INFO - 2015-11-14 14:21:22,313 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:22 INFO - 2015-11-14 14:21:22,994 INFO : Browser initialized. 14:21:22 INFO - 2015-11-14 14:21:22,995 INFO : Running cycle 1/1 for kraken test... 14:21:22 INFO - 2015-11-14 14:21:22,995 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmp6edG5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:21:34 INFO - 2015-11-14 14:21:34,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 229167104 14:21:34 INFO - 2015-11-14 14:21:34,931 DEBUG : BROWSER_OUTPUT: 14:21:37 INFO - 2015-11-14 14:21:37,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:38 INFO - 2015-11-14 14:21:38,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 285216768 14:21:38 INFO - 2015-11-14 14:21:38,112 DEBUG : BROWSER_OUTPUT: 14:21:40 INFO - 2015-11-14 14:21:40,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-dft) 14:21:41 INFO - 2015-11-14 14:21:41,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 298115072 14:21:41 INFO - 2015-11-14 14:21:41,355 DEBUG : BROWSER_OUTPUT: 14:21:44 INFO - 2015-11-14 14:21:44,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-fft) 14:21:44 INFO - 2015-11-14 14:21:44,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 280973312 14:21:44 INFO - 2015-11-14 14:21:44,919 DEBUG : BROWSER_OUTPUT: 14:21:46 INFO - 2015-11-14 14:21:46,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-oscillator) 14:21:47 INFO - 2015-11-14 14:21:47,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 280928256 14:21:47 INFO - 2015-11-14 14:21:47,533 DEBUG : BROWSER_OUTPUT: 14:21:49 INFO - 2015-11-14 14:21:49,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:21:50 INFO - 2015-11-14 14:21:50,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 283111424 14:21:50 INFO - 2015-11-14 14:21:50,285 DEBUG : BROWSER_OUTPUT: 14:21:53 INFO - 2015-11-14 14:21:53,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56180/tests/kraken/driver.html?testName=imaging-darkroom) 14:21:53 INFO - 2015-11-14 14:21:53,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 283791360 14:21:53 INFO - 2015-11-14 14:21:53,928 DEBUG : BROWSER_OUTPUT: 14:21:57 INFO - 2015-11-14 14:21:57,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56180/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:57 INFO - 2015-11-14 14:21:57,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 284266496 14:21:57 INFO - 2015-11-14 14:21:57,706 DEBUG : BROWSER_OUTPUT: 14:22:00 INFO - 2015-11-14 14:22:00,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56180/tests/kraken/driver.html?testName=json-parse-financial) 14:22:01 INFO - 2015-11-14 14:22:01,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 284065792 14:22:01 INFO - 2015-11-14 14:22:01,164 DEBUG : BROWSER_OUTPUT: 14:22:02 INFO - 2015-11-14 14:22:02,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:03 INFO - 2015-11-14 14:22:03,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 317767680 14:22:03 INFO - 2015-11-14 14:22:03,313 DEBUG : BROWSER_OUTPUT: 14:22:05 INFO - 2015-11-14 14:22:05,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:05 INFO - 2015-11-14 14:22:05,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 317329408 14:22:05 INFO - 2015-11-14 14:22:05,762 DEBUG : BROWSER_OUTPUT: 14:22:07 INFO - 2015-11-14 14:22:07,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:08 INFO - 2015-11-14 14:22:08,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 327520256 14:22:08 INFO - 2015-11-14 14:22:08,457 DEBUG : BROWSER_OUTPUT: 14:22:11 INFO - 2015-11-14 14:22:11,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:11 INFO - 2015-11-14 14:22:11,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 328376320 14:22:11 INFO - 2015-11-14 14:22:11,735 DEBUG : BROWSER_OUTPUT: 14:22:14 INFO - 2015-11-14 14:22:14,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:15 INFO - 2015-11-14 14:22:15,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 328224768 14:22:15 INFO - 2015-11-14 14:22:15,029 DEBUG : BROWSER_OUTPUT: 14:22:16 INFO - 2015-11-14 14:22:16,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56180/tests/kraken/driver.html?testName=ai-astar) 14:22:17 INFO - 2015-11-14 14:22:17,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 386637824 14:22:17 INFO - 2015-11-14 14:22:17,008 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,009 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:22:17 INFO - 2015-11-14 14:22:17,010 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:22:17 INFO - 2015-11-14 14:22:17,010 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:22:17 INFO - 2015-11-14 14:22:17,010 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:22:17 INFO - 2015-11-14 14:22:17,010 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;106;104;108;109;107;96;107;106;109 14:22:17 INFO - 2015-11-14 14:22:17,010 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;131;155;164;130;151;148;126;166;126 14:22:17 INFO - 2015-11-14 14:22:17,011 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;162;162;161;163;163;162;161;161 14:22:17 INFO - 2015-11-14 14:22:17,011 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;82;89;85;68;69;71;79;83;68 14:22:17 INFO - 2015-11-14 14:22:17,011 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;100;137;88;89;93;125;88;88;126 14:22:17 INFO - 2015-11-14 14:22:17,011 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;121;115;120;120;117;122;119;115;122 14:22:17 INFO - 2015-11-14 14:22:17,011 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;126;126;127;125;131;126;135;133;132 14:22:17 INFO - 2015-11-14 14:22:17,011 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;93;100;96;93;97;109;110;102;98 14:22:17 INFO - 2015-11-14 14:22:17,012 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;61;60;58;58;60;66;57;58 14:22:17 INFO - 2015-11-14 14:22:17,012 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;67;68;68;68;69;69;68;70 14:22:17 INFO - 2015-11-14 14:22:17,012 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;85;85;86;87;85;89;93 14:22:17 INFO - 2015-11-14 14:22:17,012 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;124;132;127;142;137;139;142;146;146 14:22:17 INFO - 2015-11-14 14:22:17,013 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;146;157;159;157;150;170;168;168;161 14:22:17 INFO - 2015-11-14 14:22:17,013 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;71;71;72;71;71;72;72;72 14:22:17 INFO - 2015-11-14 14:22:17,013 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:22:17 INFO - 2015-11-14 14:22:17,013 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:22:17 INFO - 2015-11-14 14:22:17,014 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 14:22:17 INFO - 2015-11-14 14:22:17,014 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:22:17 INFO - 2015-11-14 14:22:17,015 DEBUG : BROWSER_OUTPUT: __startTimestamp1447539737009__endTimestamp 14:22:17 INFO - 2015-11-14 14:22:17,015 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,015 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:22:17 INFO - 2015-11-14 14:22:17,015 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:22:17 INFO - 2015-11-14 14:22:17,015 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,015 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.80 Median:107.50 stddev:3.77 (3.5%) stddev-sans-first:3.99 14:22:17 INFO - 2015-11-14 14:22:17,016 DEBUG : BROWSER_OUTPUT: Values: 106.0 106.0 104.0 108.0 109.0 107.0 96.0 107.0 106.0 109.0 14:22:17 INFO - 2015-11-14 14:22:17,016 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,016 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.80 Median:153.00 stddev:16.12 (10.5%) stddev-sans-first:16.14 14:22:17 INFO - 2015-11-14 14:22:17,017 DEBUG : BROWSER_OUTPUT: Values: 161.0 131.0 155.0 164.0 130.0 151.0 148.0 126.0 166.0 126.0 14:22:17 INFO - 2015-11-14 14:22:17,017 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,017 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 14:22:17 INFO - 2015-11-14 14:22:17,017 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 162.0 162.0 161.0 163.0 163.0 162.0 161.0 161.0 14:22:17 INFO - 2015-11-14 14:22:17,018 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,018 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.80 Median:80.50 stddev:7.77 (9.7%) stddev-sans-first:8.18 14:22:17 INFO - 2015-11-14 14:22:17,018 DEBUG : BROWSER_OUTPUT: Values: 74.0 82.0 89.0 85.0 68.0 69.0 71.0 79.0 83.0 68.0 14:22:17 INFO - 2015-11-14 14:22:17,018 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,018 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:88.00 stddev:18.81 (21.4%) stddev-sans-first:19.82 14:22:17 INFO - 2015-11-14 14:22:17,018 DEBUG : BROWSER_OUTPUT: Values: 97.0 100.0 137.0 88.0 89.0 93.0 125.0 88.0 88.0 126.0 14:22:17 INFO - 2015-11-14 14:22:17,019 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,019 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:120.00 stddev:2.60 (2.2%) stddev-sans-first:2.74 14:22:17 INFO - 2015-11-14 14:22:17,019 DEBUG : BROWSER_OUTPUT: Values: 120.0 121.0 115.0 120.0 120.0 117.0 122.0 119.0 115.0 122.0 14:22:17 INFO - 2015-11-14 14:22:17,019 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,019 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:128.60 Median:129.00 stddev:3.75 (2.9%) stddev-sans-first:3.74 14:22:17 INFO - 2015-11-14 14:22:17,019 DEBUG : BROWSER_OUTPUT: Values: 125.0 126.0 126.0 127.0 125.0 131.0 126.0 135.0 133.0 132.0 14:22:17 INFO - 2015-11-14 14:22:17,020 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,020 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:99.30 Median:94.00 stddev:6.07 (6.5%) stddev-sans-first:6.24 14:22:17 INFO - 2015-11-14 14:22:17,020 DEBUG : BROWSER_OUTPUT: Values: 95.0 93.0 100.0 96.0 93.0 97.0 109.0 110.0 102.0 98.0 14:22:17 INFO - 2015-11-14 14:22:17,020 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,020 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:2.55 (4.3%) stddev-sans-first:2.69 14:22:17 INFO - 2015-11-14 14:22:17,020 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 61.0 60.0 58.0 58.0 60.0 66.0 57.0 58.0 14:22:17 INFO - 2015-11-14 14:22:17,021 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,021 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 14:22:17 INFO - 2015-11-14 14:22:17,021 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 68.0 68.0 68.0 69.0 69.0 68.0 70.0 14:22:17 INFO - 2015-11-14 14:22:17,021 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,021 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:2.59 (3.0%) stddev-sans-first:2.68 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 85.0 85.0 86.0 87.0 85.0 89.0 93.0 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:140.50 stddev:7.52 (5.4%) stddev-sans-first:7.98 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: Values: 137.0 124.0 132.0 127.0 142.0 137.0 139.0 142.0 146.0 146.0 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:160.00 stddev:8.45 (5.3%) stddev-sans-first:8.23 14:22:17 INFO - 2015-11-14 14:22:17,022 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 157.0 159.0 157.0 150.0 170.0 168.0 168.0 161.0 14:22:17 INFO - 2015-11-14 14:22:17,024 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,024 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 14:22:17 INFO - 2015-11-14 14:22:17,024 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 71.0 72.0 71.0 71.0 72.0 72.0 72.0 14:22:17 INFO - 2015-11-14 14:22:17,024 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:22:17 INFO - 2015-11-14 14:22:17,024 DEBUG : BROWSER_OUTPUT: 14:22:17 INFO - 2015-11-14 14:22:17,674 INFO : Browser exited with error code: 0 14:22:17 INFO - 2015-11-14 14:22:17,724 INFO : Completed test kraken (00:00:57) 14:22:17 INFO - 2015-11-14 14:22:17,724 INFO : Starting test v8_7 14:22:17 INFO - 2015-11-14 14:22:17,724 DEBUG : operating with platform_type : mac_ 14:22:17 INFO - 2015-11-14 14:22:17,724 INFO : Initialising browser for v8_7 test... 14:22:17 INFO - 2015-11-14 14:22:17,737 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpt6fFqc/profile http://localhost:56180/getInfo.html 14:22:19 INFO - 2015-11-14 14:22:19,982 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:22:19 INFO - 2015-11-14 14:22:19,982 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:22:19 INFO - 2015-11-14 14:22:19,982 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:22:19 INFO - 2015-11-14 14:22:19,983 DEBUG : BROWSER_OUTPUT: __metrics 14:22:20 INFO - 2015-11-14 14:22:20,000 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:20 INFO - 2015-11-14 14:22:20,703 INFO : Browser initialized. 14:22:20 INFO - 2015-11-14 14:22:20,703 INFO : Running cycle 1/1 for v8_7 test... 14:22:20 INFO - 2015-11-14 14:22:20,703 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3q/2wmh7r853tj6xgp3km8ynt6h00000w/T/tmpt6fFqc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:22:32 INFO - 2015-11-14 14:22:32,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 228290560 14:22:32 INFO - 2015-11-14 14:22:32,675 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56180/tests/v8_7/run.html (next: http://localhost:56180/tests/v8_7/run.html) 14:22:54 INFO - 2015-11-14 14:22:54,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 674328576 14:22:54 INFO - 2015-11-14 14:22:54,399 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,399 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: |0;Richards;168.54879487611663 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.7281399046105 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: |2;Encrypt;328.94736842105266 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5888.235294117647 14:22:54 INFO - 2015-11-14 14:22:54,400 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: |5;Earley;1013.1578947368421 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: |6;Boyer;13621.621621621622 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: |7;RegExp;30909.090909090908 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: |8;Splay;650.6180871828237 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5946.745562130178 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: __startTimestamp1447539774397__endTimestamp 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,401 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.55 Median:168.55 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: Values: 168.5 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.73 Median:198.73 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: Values: 198.7 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,402 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:328.95 Median:328.95 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: Values: 328.9 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5888.24 Median:5888.24 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: Values: 5888.2 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: Values: 1972.4 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,403 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1013.16 Median:1013.16 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: Values: 1013.2 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13621.62 Median:13621.62 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: Values: 13621.6 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30909.09 Median:30909.09 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: Values: 30909.1 14:22:54 INFO - 2015-11-14 14:22:54,404 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:650.62 Median:650.62 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: Values: 650.6 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5946.75 Median:5946.75 stddev:0.00 (0.0%) 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: Values: 5946.7 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:22:54 INFO - 2015-11-14 14:22:54,405 DEBUG : BROWSER_OUTPUT: 14:22:55 INFO - 2015-11-14 14:22:55,137 INFO : Browser exited with error code: 0 14:22:55 INFO - 2015-11-14 14:22:55,157 INFO : Completed test v8_7 (00:00:37) 14:22:55 INFO - 2015-11-14 14:22:55,521 INFO : Completed test suite (00:20:10) 14:22:55 INFO - 2015-11-14 14:22:55,521 DEBUG : Working with test: dromaeo_css 14:22:55 INFO - 2015-11-14 14:22:55,521 DEBUG : Generating results file: dromaeo_css 14:22:55 INFO - 2015-11-14 14:22:55,522 DEBUG : Working with test: kraken 14:22:55 INFO - 2015-11-14 14:22:55,522 DEBUG : Generating results file: kraken 14:22:55 INFO - 2015-11-14 14:22:55,522 INFO : javascript benchmark 14:22:55 INFO - 2015-11-14 14:22:55,522 DEBUG : Working with test: v8_7 14:22:55 INFO - 2015-11-14 14:22:55,522 DEBUG : Generating results file: v8_7 14:22:55 INFO - 2015-11-14 14:22:55,522 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:22:55 INFO - 2015-11-14 14:22:55,578 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 14:22:55 INFO - 2015-11-14 14:22:55,578 DEBUG : process_Request line: dromaeo_css 6492.16 graph.html#tests=[[72,1,55]] 14:22:55 INFO - 2015-11-14 14:22:55,578 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:22:55 INFO - 2015-11-14 14:22:55,698 DEBUG : process_Request line: kraken 1522.20 graph.html#tests=[[232,1,55]] 14:22:55 INFO - 2015-11-14 14:22:55,698 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:22:55 INFO - 2015-11-14 14:22:55,729 DEBUG : process_Request line: v8_7 17667.71 graph.html#tests=[[230,1,55]] 14:22:55 INFO - 2015-11-14 14:22:55,730 INFO : javascript benchmark 14:22:55 INFO - 2015-11-14 14:22:55,732 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [308.9042396856973, 317.5554224086279, 318.97613567772606, 322.3166886201252, 327.8033180091945, 13604.523841665543, 13754.105983111116, 15750.606234844134, 16377.42679006235, 16957.915210423947, 13773.449062037507, 16261.349546018146, 18714.251429942786, 19011.429657110275, 19054.61890762184, 5661.207430959658, 5982.670953097578, 5994.910076348859, 6000.129981152731, 6002.969985150068, 4218.767967761772, 4336.739795612258, 5869.090291004901, 5939.762409503636, 6498.0, 6706.731730730789, 6767.729290828385, 6796.08252885859, 6796.7621133260345, 6818.727250909958, 6589.077529145923, 6615.900761488581, 6640.402363787258, 6655.201375834882, 6720.932790672104, 6128.050152226412, 6334.936650633481, 6347.0, 6350.904736428957, 6407.583507072025, 23203.187888423825, 23535.4116147096, 23554.646680299807, 23588.882055589613, 23660.76339236603, 1923.4902750771057, 1947.376839411389, 2041.428400047989, 2061.917523299066, 2086.2072412483158, 13528.120672156278, 13533.323333833268, 13774.724505509934, 14278.64303392413, 14344.211068391234, 1705.0792572011098, 1735.1497766094649, 1751.1594434671429, 1793.9103044847836, 1832.1480511562188, 59742.0, 63056.36943630597, 63324.36675633277, 63666.68166659137, 64059.0, 15951.60120996961, 16199.757003644954, 16342.346306147621, 16368.590785230464, 16385.0, 23641.527169456516, 23686.170984015476, 23715.525689486112, 23785.0, 23818.40453988664, 8772.385932984758, 8872.600732967032, 8902.154295341932, 9055.81888362229, 9072.092790721008, 7443.925560744323, 7461.0, 7467.514611550232, 7489.28851759082, 7519.736809211651, 7582.393408527305, 7609.201033891472, 7674.347680447225, 7678.424118191047, 7680.270374314431, 2629.684437867468, 3051.7711171662213, 3086.4444400007765, 3120.9245851508945, 3176.539401786728, 401.08540643320816, 434.38751360581426, 440.27354864473875, 444.22482767570796, 451.03028488748794, 9948.602055917827, 11033.0, 11247.437628118561, 11329.320240785579, 11533.653990380302, 442.9335599660012, 443.7803287372771, 447.1057884231537, 452.6446739309692, 469.4413647759156, 6023.427774361428, 6063.120847477091, 6099.237595300588, 6136.417040381157, 6138.294096178907, 441867.0, 450589.0, 483127.0, 487685.0, 488026.0, 64258.0, 68203.65898170478, 68242.0, 68652.0, 70273.29726702668, 471.51905056842514, 481.9349387832598, 482.57774447359265, 483.03152179879817, 483.7073570489873, 10413.32313399657, 10673.146148308271, 10678.8398174029, 10720.001590504675, 10726.463676815973, 33688.831555842065, 33813.0, 34229.48655770116, 34289.14277143091, 34570.82714586411, 45441.54558454373, 45841.31238031499, 46290.53709462862, 46314.0, 46315.305270421646, 6984.126984126984, 7226.313500217471, 7365.926340736738, 7417.406607471497, 7439.739609113655, 10678.412687302272, 10924.617638382619, 11102.167337449562, 11118.555257789598, 11121.443927803739, 9325.114114159143, 9345.0, 9567.234621230424, 9691.370060946016, 9799.951000244953, 9242.12199841014, 9245.72262832116, 9328.300377471582, 9350.766230844283, 9445.0, 9479.431234125974, 9727.756806079622, 9782.75543111428, 9793.657221997197, 9813.705588832347, 7160.641967901688, 7189.317014883578, 7208.315210055036, 7250.709971601077, 7274.636268186464, 9383.483908385104, 9442.95278523603, 9547.188488978514, 9583.808323833624, 9613.375130616487], "dojo.html": [3051.816890986542, 3099.333643266698, 3166.6516683164864, 3228.8062716237027, 3247.8863239786606, 4843.031393721252, 4915.705057696532, 5062.848114556565, 5126.974365128179, 5194.558462530685, 4945.554900059003, 4991.475895031024, 5079.720615366154, 5137.460566640505, 5155.407128180261, 4650.7442090685, 4697.459792123898, 4723.645726570504, 4753.191957367256, 4852.781624826874, 4742.383490146276, 4815.133276010317, 4826.0830442215865, 4842.665605333211, 4853.272009198613, 4544.295634176675, 4649.721016738973, 4666.393368862026, 4741.881452963687, 4758.547937945924, 4569.383133276999, 4606.101810147023, 4618.030213655136, 4628.190066738307, 4639.512851150648, 4558.612517935946, 4650.348951146842, 4657.347971284023, 4669.533046695337, 4675.812967481331, 5052.696838189684, 5055.9241611375855, 5056.014077254937, 5069.650605161004, 5138.768755406016, 5391.703456309901, 5414.648047876875, 5421.864453388657, 5423.376311724162, 5447.591430642718, 5270.631055826094, 5294.68231906083, 5318.9202161967605, 5401.405845357008, 5450.945490545123, 5103.132467480537, 5110.693358398508, 5116.0, 5116.334876466073, 5119.283300337956, 5518.2826232590305, 5611.607187496836, 5616.438356164351, 5616.887662246732, 5628.437156284339, 5134.666246693953, 5151.5878729701535, 5260.026895024433, 5271.736413179326, 5330.120530112566, 5435.782568697208, 5444.673319600836, 5468.453154684579, 5501.312335958005, 5527.226188333637, 5381.327334083239, 5382.91925621116, 5390.380106287748, 5401.540869026177, 5444.782208711607, 5155.896882062338, 5275.63070585063, 5321.175217841241, 5327.334083239595, 5369.892602148013, 4199.265128602482, 4223.113146239262, 4249.68127390447, 4256.616904478612, 4260.190563792869, 3831.7700937943814, 3835.4055121456217, 3838.8272527736317, 3872.4772155759174, 3879.2435475082652, 4934.753262336869, 5039.042581909425, 5041.0422019816115, 5059.569936555434, 5108.6168537359845, 5455.454454554592, 5502.202180683778, 5523.585731070186, 5555.749991250404, 5574.108142697149, 5162.251473536317, 5167.147420675622, 5171.3535808024, 5180.611454140954, 5188.507091826271, 4633.096546173531, 4825.613950883921, 4834.009028149221, 4840.6127509799835, 4879.414470263591, 5612.382637909908, 5624.55003599711, 5651.886962260732, 5693.117566777156, 5755.827325180251, 5457.590680698884, 5479.479449452296, 5487.972560137174, 5491.972540137273, 5558.360788509373, 5371.328583927009, 5638.069718496402, 5659.717014149193, 5662.405447427961, 5674.347450043298, 5301.920471192858, 5304.336957880265, 5304.840854774363, 5326.840194794162, 5354.143337066051, 5350.785968561214, 5354.303940487712, 5447.863803404946, 5457.154141107976, 5461.754221060141, 5323.0950738373795, 5365.946340536545, 5376.274202982704, 5391.865203369947, 5446.046941785251, 5360.490753378423, 5366.785328586969, 5394.703291319015, 5407.351117865724, 5489.862753431196, 5001.874953126201, 5145.871353216199, 5179.689218646893, 5194.065068287745, 5257.8159764408065, 5313.707746073848, 5313.840584782462, 5340.359156901041, 5363.302770639948, 5384.407715151408, 5071.340725705634, 5211.869703257449, 5215.374155101412, 5225.5819534437915, 5259.658122222043], "mootools.html": [1449.2970909109074, 1680.0339804612347, 1718.9742153867687, 1732.8007279162896, 1744.8691348148884, 6642.900356494656, 7146.106736657918, 7438.293362130603, 7597.658105385257, 7745.0, 7425.814354641123, 7616.238376162381, 7624.542527448357, 7641.426892983035, 7665.501742386755, 2092.3199960013017, 2116.6930795034787, 2120.6076875777953, 2122.172352782416, 2140.2295173737443, 2095.172406899274, 2097.2974053692033, 2098.27609474731, 2117.8729276243475, 2126.33020598511, 2055.722477465538, 2064.597403506317, 2072.803083707053, 2083.7603675577275, 2088.1021160900805, 2059.9176032958662, 2071.906764195615, 2077.054940002303, 2082.354470114254, 2100.9159633614636, 2084.8436367272516, 2085.9478513037143, 2090.3310940499046, 2102.453362125843, 2111.155537784883, 6500.284968653492, 7435.1449583297535, 7479.925200747977, 7539.321461068475, 7581.469297149201, 3917.5298964124204, 4334.45819272591, 4418.602325790662, 4428.40216570762, 4456.331550267453, 2793.385455199873, 2818.9154325370273, 2880.3807181456086, 2882.884684612613, 2911.30128769096, 845.0704225352125, 874.9300055995569, 880.6741505642954, 888.1695614600369, 891.4383938119008, 10039.447830369327, 10099.192064634884, 10122.190224782, 10230.23273254509, 10238.488075596191, 3984.7011474138976, 4004.5795191505053, 4060.7563546187325, 4078.4290199372113, 4101.835926562904, 8854.955725221462, 8866.157715017063, 8907.777305567282, 8945.06076861933, 8967.0, 4495.730256184639, 4507.2788353863225, 4509.413776209138, 4556.476005259437, 4557.430321209848, 4042.6967977401223, 4067.918641627151, 4076.2255171517318, 4089.3661482470266, 4110.7328023678965, 3316.369889720945, 3343.615484219346, 3359.5800524934384, 3362.277110421271, 3374.8312584370683, 1011.9898801012043, 1024.6311327921942, 1030.0, 1044.6813721814767, 1044.8746150461993, 933.5285680731188, 945.6501094594906, 952.9999999999861, 1002.754325190333, 1283.371148137406, 7196.208417074117, 7227.0, 7245.710171593183, 7274.709011639475, 7282.271772822675, 394.86377199866, 406.65231227300825, 412.9648979836687, 414.19852585247645, 421.1765997474929, 5123.487651234921, 5568.554515638739, 5621.353544342453, 5676.829695109153, 5702.287214098238, 7474.588897610575, 9158.358914876027, 9165.404248723811, 9189.540522973824, 9192.63229470827, 8627.180417860292, 8942.418742781698, 8950.597223124974, 9081.091890810998, 9101.180893719464, 6899.965500172467, 7095.680694368766, 7100.366915609438, 7167.247439018932, 7168.641567921583, 6716.529842911144, 6897.206821215625, 6898.103246577913, 6922.203946546211, 6996.790096297119, 7775.688972441265, 7869.606519674108, 7930.762077137695, 7980.162082981204, 8006.439549231498, 8117.10711821711, 8195.0, 8337.249647531751, 8371.037330707046, 8424.157584241526, 6390.424861762278, 6488.383603557654, 6493.577917435352, 6500.3174666659315, 6531.706073226621, 7157.534760240567, 7173.24680908518, 7183.5330703504105, 7229.819254518679, 7245.7826265210015, 6630.867382652416, 6788.660566971533, 6809.38715515606, 6844.349786770249, 6968.989496523077, 6691.2639609643875, 6728.192616886005, 6772.153480814898, 6845.5550389224545, 6865.691043902936, 6737.191537015589, 6767.966160169168, 6903.309669033057, 6912.412444942236, 6940.41006514452, 6039.305479869871, 6086.117512960507, 6110.7861224856915, 6143.969280153749, 6173.197484327009, 6105.694715264308, 6142.600730952474, 6174.629522228681, 6194.318624951162, 6252.687365631609], "ext.html": [533.1868899927609, 533.274746344971, 536.7155407633953, 542.4169018305322, 557.7350758389763, 29350.706492935064, 30429.695703042962, 34957.30085398294, 35134.12164695884, 35513.289734205304, 39638.40542391859, 39951.60048399515, 40135.0, 40226.39660405096, 40360.59639403605, 7814.960925195366, 8730.956345218265, 8933.77665558363, 9047.095290470934, 9060.365774395796, 8023.4383593148505, 10681.145508359352, 10860.891391086107, 10862.131029517619, 10974.615888443906, 10491.213159013067, 10548.0, 10593.947030264839, 10658.573657053708, 10665.520051597698, 8106.959465202695, 8249.917500825035, 10293.948530257301, 10497.317674351143, 10666.200034997406, 10148.391096534231, 10256.076953074184, 10296.07335339823, 10324.58701651933, 10332.121769649513, 34774.1748407675, 34845.12887177816, 34880.47679284813, 34908.0, 35364.823175883954, 2628.7239839816925, 2690.0181433776725, 2716.0, 2789.2050765531726, 3142.5286207068893, 25694.74305256942, 26014.479710405685, 26372.8681356592, 26573.069942552112, 26742.509451444705, 2331.8170696998477, 2338.228384633067, 2348.0607756897207, 2349.48311371498, 2464.6549483072386, 248173.0, 251917.0, 252764.0, 254372.0, 255417.0, 48191.27713084307, 48502.0, 49826.512144150285, 56649.0, 56870.146947795816, 57424.0, 58338.12492812611, 58401.70799145977, 58561.70719146377, 58922.0, 12742.80885786714, 12751.298678572583, 12779.808302875465, 12822.23066616006, 12823.294718790556, 10540.578376864993, 10632.574697012033, 10638.840417393745, 10639.787204255872, 10680.89319106799, 18533.166007529693, 18623.720644190347, 18658.626827463646, 18676.53308667267, 18679.626407472046, 8136.389770767216, 8439.915600844035, 8442.873356899652, 8445.1977062179, 8451.619677114422, 876.4522173641474, 904.3398319227001, 942.5146049784366, 952.9952350238204, 990.9446439541865, 26827.32931676724, 26996.1901142966, 27048.323791904968, 27284.454310913672, 28210.0, 978.1441238915949, 983.3559018842669, 1000.429755039635, 1081.1458947431597, 1112.410422476089, 13622.931885340708, 13654.453821847213, 13664.863351366359, 13903.930480347533, 13912.51306204278, 305683.0, 311499.0, 313437.0, 313803.0, 316946.0, 49731.254031189565, 50046.0, 50235.74410639763, 50425.49574504281, 50557.49442505528, 1323.483841301893, 1331.4407948661585, 1345.8519562848078, 1347.791092380663, 1352.1751731443812, 21977.890110549346, 26999.73000269972, 27243.72756272491, 27666.861665691544, 28602.713972860005, 46399.76800115978, 46530.0, 46736.53263467322, 47049.52950470588, 47136.0, 246495.0, 247905.0, 247962.0, 248159.0, 250652.0, 24611.507769844862, 24742.628860567467, 28673.71326286794, 29114.70885291205, 29472.557911630913, 35833.82083089672, 36036.8198159018, 36588.085297867765, 36648.0, 38998.610013899495, 31028.22429439282, 31319.0, 31657.0, 31695.52456713105, 31712.36575268528, 31038.22404439817, 31047.84476077605, 31208.53187202239, 31247.687523124478, 31394.843025784725, 31193.37613247677, 31746.52380214345, 31781.682183177873, 32072.67927320697, 32197.51703724399, 28923.276918076375, 29758.0, 29902.70097299086, 30005.0, 30056.849715751283, 22425.663615046113, 22654.093836246364, 22748.4312892179, 22983.77016229883, 23089.422764431023], "prototype.html": [284.0569309891162, 295.23975762411794, 297.4586253019504, 299.1981489607851, 309.6361774914475, 5741.19623252745, 5862.32583252926, 5881.735321910513, 5895.233619629447, 5976.0, 5780.277465316835, 5841.123831425289, 5884.882302353961, 5923.348431672513, 6004.729787159577, 4470.150671372445, 4472.686911916167, 4490.506044335137, 4518.1415531049, 4524.683272170958, 4236.813692166198, 4367.890802729941, 4440.200763862504, 4488.955110448903, 4492.348609451627, 4425.623821975136, 4434.647432533076, 4441.378207051015, 4455.509893911667, 4475.0378668586245, 4417.42573465449, 4450.287953927356, 4463.040446304028, 4481.350204220386, 4499.820007199708, 3786.8863934082024, 3794.146317078663, 3808.752431091998, 3825.5791862895057, 3830.119072613287, 5679.858003549903, 5714.085746280575, 5788.565857560658, 5799.623024503436, 5814.0697488402075, 4994.500549945013, 5012.8496145115705, 5056.039352523009, 5071.1632580624155, 5072.264521644378, 5999.370066143036, 6190.628562286277, 6197.225346831646, 6232.283287421914, 6237.189165408513, 4035.656969157625, 4092.2224777292217, 4134.669226461876, 4149.315362965137, 4156.9792151039355, 6435.22777266731, 6543.967280163616, 6545.37818907203, 6565.638889861056, 6603.966980165116, 4169.854055108057, 4180.581941805795, 4183.477065366829, 4185.6232939035635, 4233.894152646147, 4123.9175216495505, 4243.809028593659, 4258.276093064186, 4280.743155410685, 4284.485861696554, 4994.700317980933, 5004.4995500450395, 5022.146235140035, 5064.1897296433135, 5069.797208111708, 6188.628682279078, 6241.095041218998, 6279.152314437584, 6284.465820405317, 6294.590851594632, 1489.4265707702396, 1512.4101600375861, 1513.4248985385484, 1525.5270866031565, 1526.5649289952532, 972.1299437003842, 974.3082411487923, 989.7723523589615, 992.1269283031031, 992.6178421307849, 5970.283565972111, 5988.431099045583, 6025.0661147522205, 6041.426064523863, 6080.787172448943, 6497.350264973465, 6512.381323774234, 6550.672466376662, 6565.0, 6581.736730530821, 5965.731542080617, 5974.551908606872, 6011.0, 6031.819045428644, 6043.969780151071, 3459.2216751231276, 3516.384632689269, 3517.3668739627115, 3558.5729712434672, 3563.2873425315042, 6729.629870357177, 6749.122614060141, 6761.256261811295, 6851.520393572402, 6853.897191542131, 6676.098726671934, 6689.76585819494, 6755.60176137474, 6763.188417389944, 6769.120014398097, 6591.143151390289, 6718.260991291052, 6738.225104112992, 6810.421114205249, 6813.931860681528, 6362.713677884413, 6512.511561632991, 6564.409203171737, 6598.60408375499, 6601.471882249312, 6313.0, 6341.619502829661, 6371.96814015927, 6372.522060845363, 6418.839529011812, 6354.301026887131, 6752.122224110834, 6800.455963523005, 6857.382835544825, 6899.931000689929, 4086.1623367210245, 4126.814293356746, 4155.272827255158, 4158.438610787505, 4184.539700632867, 6470.6441145737435, 6476.676166191577, 6535.150430444012, 6543.247526534319, 6559.967200164159, 6150.876982460415, 6269.373062693694, 6297.52768542352, 6383.234011918599, 6402.263739669811, 6300.306966233802, 6327.651979141191, 6339.524535659936, 6342.778002769881, 6423.967880160756, 6179.589959915546, 6182.227221597301, 6204.472619827366, 6250.687465626791, 6279.434850863444, 6194.132821405097, 6336.493080553637, 6367.936320636734, 6408.839779005562, 6413.647249401328, 6197.845053873689, 6201.224846894138, 6247.437730604267, 6269.717862696099, 6284.308726040041], "yui.html": [635.2250254689277, 651.3909494622525, 718.7807718645811, 726.1177669132005, 747.174372318588, 13032.674183145415, 13164.605061848148, 14859.925700371483, 14874.999999999987, 15156.772648410282, 13622.863771362283, 13656.24890631015, 13684.384202710877, 13795.0, 13804.102733322326, 652.5008368598026, 660.1121491593799, 816.6774124220944, 822.3996482567729, 847.7668641123679, 809.9919000810005, 826.3513142183388, 831.1854382704953, 834.5451728807784, 835.4611275727183, 856.1951765340591, 863.0592654007162, 866.0300463480879, 868.700298397052, 873.6199753107387, 672.6838385958616, 683.0028158888005, 826.4297634632145, 843.8059246373307, 844.7719115838689, 627.4384425938805, 627.7081157261849, 628.9716962736687, 629.0030301971381, 629.8771739510797, 12864.228146311158, 13082.738345233138, 13124.278164700938, 13128.0, 13145.21128732279, 8932.330075244383, 8958.820823583492, 9199.494027828467, 9335.439873607538, 9491.003444638352, 8560.443571167854, 8583.313334933253, 8645.697400590949, 8684.652613895436, 8800.339974501938, 2796.9720302796914, 2806.1441260415563, 2807.115758536075, 2808.789340799428, 2849.871755770995, 44321.0, 44467.0, 44788.3281750774, 44834.551654483366, 44913.0, 6301.117843501914, 6466.35336466359, 6511.479081673455, 6661.766838160641, 6826.726930922708, 11181.44092795357, 11203.71990700239, 11297.49161287744, 11322.830157547478, 11327.94336028331, 5548.195511650869, 5623.184638227434, 5721.284839395075, 5738.684372359477, 5739.942600573941, 3287.0176279172156, 3366.562346894888, 3429.022728522359, 3547.8758243461357, 3593.8562457501407, 2586.1594981631047, 2616.3720707030175, 2618.9607155892677, 2631.8947242110485, 2633.11790550164, 399.34108720611226, 401.0, 401.38387575072124, 404.80771633473864, 405.19164267286953, 409.56586018819553, 444.3823085910587, 536.6377695055821, 553.9556835453154, 575.318247876268, 6975.4070903972715, 7407.629618519052, 7524.623768811647, 7677.385809135368, 7910.090339610903, 550.2324257660621, 565.2312854517852, 578.9565782566324, 589.6963064022032, 592.8578533770997, 3661.7253705971625, 3705.6850167735506, 3765.6234376562124, 3774.8112594370173, 3792.1846802937503, 50447.74776126169, 52882.206766898526, 55884.44115558793, 56691.71654141703, 56730.43269567334, 45509.7724511382, 45513.77243113829, 45705.54294457013, 45774.77112614482, 45967.0, 44643.553564464586, 44759.0, 44954.0, 45097.77451112789, 46135.0, 7820.296173344426, 7891.68433262686, 7945.562994035153, 7991.4006449515355, 8201.79495512617, 33177.50233746544, 33260.50109248412, 33768.155796104315, 34035.14912127217, 34170.0, 41878.79060604677, 41934.790326048176, 44210.77894610506, 45388.09223815439, 45548.54451455575, 7095.645217739196, 7253.528520646141, 7304.160021597584, 7330.780076597711, 7449.8882516761205, 10718.946405267923, 10819.945900270448, 11014.779704406028, 11058.668239952493, 11448.42757862087, 10404.375737455777, 10543.683689489328, 10559.683209503728, 10579.682609521727, 10918.78162436731, 9845.212383009486, 10425.165986721197, 10567.048965593134, 10676.733081673021, 10805.675829725122, 6808.659567021728, 9446.716598502057, 9722.416655000723, 9809.313348065567, 9927.503624818586, 7855.253750893656, 8115.229053239933, 8116.431849770459, 8432.409731318749, 8634.136586341316, 8593.65625374978, 8774.956125219333, 8988.46069235848, 9004.819903602021, 9082.682106126254]}, "summary": {"lowerIsBetter": false, "suite": 6492.158338039255, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8112.3915424505885, "unit": "ms", "value": 8112.3915424505885}, "dojo.html": {"lowerIsBetter": false, "filtered": 5037.5460492635475, "unit": "ms", "value": 5037.5460492635475}, "mootools.html": {"lowerIsBetter": false, "filtered": 4140.130035250133, "unit": "ms", "value": 4140.130035250133}, "ext.html": {"lowerIsBetter": false, "filtered": 17241.785434435587, "unit": "ms", "value": 17241.785434435587}, "prototype.html": {"lowerIsBetter": false, "filtered": 4663.011790351538, "unit": "ms", "value": 4663.011790351538}, "yui.html": {"lowerIsBetter": false, "filtered": 5503.810356850971, "unit": "ms", "value": 5503.810356850971}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0096"}, "testrun": {"date": 1447538565, "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": "20151114130830", "branch": "Firefox", "revision": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 164.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0, 161.0, 161.0], "ai-astar": [106.0, 106.0, 104.0, 108.0, 109.0, 107.0, 96.0, 107.0, 106.0, 109.0], "imaging-gaussian-blur": [120.0, 121.0, 115.0, 120.0, 120.0, 117.0, 122.0, 119.0, 115.0, 122.0], "audio-beat-detection": [161.0, 131.0, 155.0, 164.0, 130.0, 151.0, 148.0, 126.0, 166.0, 126.0], "json-stringify-tinderbox": [68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 70.0], "stanford-crypto-pbkdf2": [149.0, 146.0, 157.0, 159.0, 157.0, 150.0, 170.0, 168.0, 168.0, 161.0], "json-parse-financial": [59.0, 59.0, 61.0, 60.0, 58.0, 58.0, 60.0, 66.0, 57.0, 58.0], "stanford-crypto-sha256-iterative": [71.0, 72.0, 71.0, 71.0, 72.0, 71.0, 71.0, 72.0, 72.0, 72.0], "audio-fft": [74.0, 82.0, 89.0, 85.0, 68.0, 69.0, 71.0, 79.0, 83.0, 68.0], "imaging-darkroom": [125.0, 126.0, 126.0, 127.0, 125.0, 131.0, 126.0, 135.0, 133.0, 132.0], "stanford-crypto-ccm": [137.0, 124.0, 132.0, 127.0, 142.0, 137.0, 139.0, 142.0, 146.0, 146.0], "audio-oscillator": [97.0, 100.0, 137.0, 88.0, 89.0, 93.0, 125.0, 88.0, 88.0, 126.0], "stanford-crypto-aes": [85.0, 86.0, 85.0, 85.0, 85.0, 86.0, 87.0, 85.0, 89.0, 93.0], "imaging-desaturate": [95.0, 93.0, 100.0, 96.0, 93.0, 97.0, 109.0, 110.0, 102.0, 98.0]}, "summary": {"lowerIsBetter": true, "suite": 1522.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.8, "unit": "ms", "value": 76.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 158.5, "unit": "ms", "value": 158.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 137.2, "unit": "ms", "value": 137.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 128.6, "unit": "ms", "value": 128.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.6, "unit": "ms", "value": 59.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.1, "unit": "ms", "value": 103.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 105.8, "unit": "ms", "value": 105.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.1, "unit": "ms", "value": 162.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.5, "unit": "ms", "value": 71.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.2, "unit": "ms", "value": 68.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 119.1, "unit": "ms", "value": 119.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.6, "unit": "ms", "value": 86.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 99.3, "unit": "ms", "value": 99.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0096"}, "testrun": {"date": 1447538565, "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": "20151114130830", "branch": "Firefox", "revision": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46"}}, {"talos_counters": {}, "results": {"DeltaBlue": [198.7281399046105], "Encrypt": [328.94736842105266], "NavierStokes": [5946.745562130178], "Decrypt": [5888.235294117647], "Splay": [650.6180871828237], "Richards": [168.54879487611663], "RegExp": [30909.090909090908], "Earley": [1013.1578947368421], "Boyer": [13621.621621621622], "RayTrace": [1972.3865877712033]}, "summary": {"lowerIsBetter": false, "suite": 17667.70621925602, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 332.70577599999984, "unit": "score", "value": 332.70577599999984}, "Encrypt": {"lowerIsBetter": false, "filtered": 809.1902399999998, "unit": "score", "value": 809.1902399999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 249.54825870646746, "unit": "score", "value": 249.54825870646746}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.20556443556443, "unit": "score", "value": 45.20556443556443}, "Splay": {"lowerIsBetter": false, "filtered": 125.25166700000001, "unit": "score", "value": 125.25166700000001}, "RegExp": {"lowerIsBetter": false, "filtered": 29.47304411764707, "unit": "score", "value": 29.47304411764707}, "Richards": {"lowerIsBetter": false, "filtered": 209.44676600000008, "unit": "score", "value": 209.44676600000008}, "Earley": {"lowerIsBetter": false, "filtered": 657.8076363636364, "unit": "score", "value": 657.8076363636364}, "Boyer": {"lowerIsBetter": false, "filtered": 48.92684722222226, "unit": "score", "value": 48.92684722222226}, "RayTrace": {"lowerIsBetter": false, "filtered": 375.1744229999998, "unit": "score", "value": 375.1744229999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0096"}, "testrun": {"date": 1447538565, "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": "20151114130830", "branch": "Firefox", "revision": "bbeaf161feb415b87fca25bd2a25e9d31f3d7c46"}}] 14:22:55 INFO - RETURN: dromaeo_css: 6492.16 14:22:55 INFO - RETURN: kraken: 1522.20 14:22:55 INFO - RETURN: v8_7: 17667.71 14:22:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "17667.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1522.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6492.16"}}} 14:22:55 INFO - Return code: 0 14:22:55 INFO - # TBPL SUCCESS # 14:22:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:55 INFO - 2015-11-14 14:22:55.840 screenresolution[6206:120942] starting screenresolution argv=screenresolution get 14:22:55 INFO - 2015-11-14 14:22:55.843 screenresolution[6206:120942] Display 0: 1600x1200x32@60 14:22:55 INFO - 2015-11-14 14:22:55.850 screenresolution[6207:120945] starting screenresolution argv=screenresolution list 14:22:55 INFO - Available Modes on Display 0 14:22:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:56 INFO - Intel HD Graphics 3000: 14:22:56 INFO - Chipset Model: Intel HD Graphics 3000 14:22:56 INFO - Type: GPU 14:22:56 INFO - Bus: Built-In 14:22:56 INFO - VRAM (Total): 512 MB 14:22:56 INFO - VRAM (Dynamic, Max): 10 14:22:56 INFO - Vendor: Intel (0x8086) 14:22:56 INFO - Device ID: 0x0116 14:22:56 INFO - Revision ID: 0x0009 14:22:56 INFO - Displays: 14:22:56 INFO - Display: 14:22:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:56 INFO - Display Serial Number: 1600x1200 60 14:22:56 INFO - Main Display: Yes 14:22:56 INFO - Mirror: Off 14:22:56 INFO - Online: Yes 14:22:56 INFO - Rotation: Supported 14:22:56 INFO - Return code: 0 14:22:56 INFO - Running post-action listener: _resource_record_post_action 14:22:56 INFO - Running post-run listener: _resource_record_post_run 14:22:57 INFO - Total resource usage - Wall time: 1249s; CPU: 30.0%; Read bytes: 3470336; Write bytes: 683965440; Read time: 1147; Write time: 62409 14:22:57 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 333328896; Write bytes: 334501888; Read time: 32537; Write time: 6284 14:22:57 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 3470336; Write bytes: 339043328; Read time: 1147; Write time: 54799 14:22:57 INFO - Running post-run listener: _upload_blobber_files 14:22:57 INFO - Blob upload gear active. 14:22:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:22:57 INFO - Copying logs to upload dir... 14:22:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1305.323062 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2015-11-14 14:22:57.272488) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 14:22:57.276167) ========= 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.m4dlSA08Si/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.kZxf9saBEW/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/xr9qlizDSzKOBAr59hgbYw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010222 build_url: 'https://queue.taskcluster.net/v1/task/xr9qlizDSzKOBAr59hgbYw/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-14 14:22:57.304860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:22:57.305460) ========= 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.m4dlSA08Si/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.kZxf9saBEW/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.005334 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 14:22:57.356339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 14:22:57.356717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 14:22:57.357394) ========= ========= Total master_lag: 0.42 =========