builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0069 starttime: 1446234115.47 results: success (0) buildid: 20151030115030 builduid: 259efd1e8ba74e7ca2c95899175227ff revision: 375a22f7bc4ee360e90849d33061c86b1b56fe8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:55.466604) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:55.467048) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:55.467359) ========= 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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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.005680 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:55.863780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:55.864118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.064598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.064863) ========= 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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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.026097 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.125073) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.125343) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.125694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.125968) ========= 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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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-10-30 12:41:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-10-30 12:41:56 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197577 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.353743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.354023) ========= 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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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.080452 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.450103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:56.453509) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 375a22f7bc4ee360e90849d33061c86b1b56fe8b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 375a22f7bc4ee360e90849d33061c86b1b56fe8b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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-10-30 12:41:56,538 truncating revision to first 12 chars 2015-10-30 12:41:56,538 Setting DEBUG logging. 2015-10-30 12:41:56,538 attempt 1/10 2015-10-30 12:41:56,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/375a22f7bc4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 12:41:56,816 unpacking tar archive at: fx-team-375a22f7bc4e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534046 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:57.003698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:57.004000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:57.017000) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:57.017255) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 12:41:57.017642) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2015-10-30 12:41:57.017926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 12:41:57 INFO - MultiFileLogger online at 20151030 12:41:57 in /builds/slave/test 12:41:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:41:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:41:57 INFO - {'append_to_log': False, 12:41:57 INFO - 'base_work_dir': '/builds/slave/test', 12:41:57 INFO - 'blob_upload_branch': 'Fx-Team', 12:41:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:41:57 INFO - 'branch': 'Fx-Team', 12:41:57 INFO - 'buildbot_json_path': 'buildprops.json', 12:41:57 INFO - 'config_files': ('talos/mac_config.py',), 12:41:57 INFO - 'default_actions': ('clobber', 12:41:57 INFO - 'read-buildbot-config', 12:41:57 INFO - 'download-and-extract', 12:41:57 INFO - 'populate-webroot', 12:41:57 INFO - 'create-virtualenv', 12:41:57 INFO - 'install', 12:41:57 INFO - 'run-tests'), 12:41:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:41:57 INFO - 'download_minidump_stackwalk': True, 12:41:57 INFO - 'download_symbols': 'ondemand', 12:41:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:41:57 INFO - 'tooltool.py': '/tools/tooltool.py', 12:41:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:41:57 INFO - '/tools/misc-python/virtualenv.py')}, 12:41:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:41:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:41:57 INFO - 'installer_path': 'installer.exe', 12:41:57 INFO - 'log_level': 'info', 12:41:57 INFO - 'log_name': 'talos', 12:41:57 INFO - 'log_to_console': True, 12:41:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:41:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:41:57 INFO - 'opt_config_files': (), 12:41:57 INFO - 'pip_index': False, 12:41:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:41:57 INFO - 'cmd': ('bash', 12:41:57 INFO - '-c', 12:41:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:41:57 INFO - 'enabled': True, 12:41:57 INFO - 'halt_on_failure': False, 12:41:57 INFO - 'name': 'check_screen_resolution'},), 12:41:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:41:57 INFO - 'cmd': ('bash', 12:41:57 INFO - '-c', 12:41:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:41:57 INFO - 'enabled': True, 12:41:57 INFO - 'halt_on_failure': False, 12:41:57 INFO - 'name': 'check_screen_resolution'},), 12:41:57 INFO - 'run_cmd_checks_enabled': True, 12:41:57 INFO - 'sps_profile': False, 12:41:57 INFO - 'sps_profile_interval': 0, 12:41:57 INFO - 'suite': 'dromaeojs', 12:41:57 INFO - 'system_bits': '64', 12:41:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:41:57 INFO - 'title': 't-yosemite-r5-0069', 12:41:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:41:57 INFO - 'use_talos_json': True, 12:41:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:41:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:41:57 INFO - 'work_dir': 'build'} 12:41:57 INFO - ##### 12:41:57 INFO - ##### Running clobber step. 12:41:57 INFO - ##### 12:41:57 INFO - Running pre-action listener: _resource_record_pre_action 12:41:57 INFO - Running main action method: clobber 12:41:57 INFO - rmtree: /builds/slave/test/build 12:41:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:01 INFO - Running post-action listener: _resource_record_post_action 12:42:01 INFO - ##### 12:42:01 INFO - ##### Running read-buildbot-config step. 12:42:01 INFO - ##### 12:42:01 INFO - Running pre-action listener: _resource_record_pre_action 12:42:01 INFO - Running main action method: read_buildbot_config 12:42:01 INFO - Using buildbot properties: 12:42:01 INFO - { 12:42:01 INFO - "properties": { 12:42:01 INFO - "buildnumber": 1174, 12:42:01 INFO - "product": "firefox", 12:42:01 INFO - "script_repo_revision": "production", 12:42:01 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 12:42:01 INFO - "repository": "", 12:42:01 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 12:42:01 INFO - "buildid": "20151030115030", 12:42:01 INFO - "slavename": "t-yosemite-r5-0069", 12:42:01 INFO - "pgo_build": "False", 12:42:01 INFO - "basedir": "/builds/slave/test", 12:42:01 INFO - "project": "", 12:42:01 INFO - "platform": "yosemite", 12:42:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:42:01 INFO - "slavebuilddir": "test", 12:42:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:42:01 INFO - "branch": "fx-team", 12:42:01 INFO - "repo_path": "integration/fx-team", 12:42:01 INFO - "stage_platform": "macosx64", 12:42:01 INFO - "builduid": "259efd1e8ba74e7ca2c95899175227ff", 12:42:01 INFO - "revision": "375a22f7bc4ee360e90849d33061c86b1b56fe8b" 12:42:01 INFO - }, 12:42:01 INFO - "sourcestamp": { 12:42:01 INFO - "repository": "", 12:42:01 INFO - "hasPatch": false, 12:42:01 INFO - "project": "", 12:42:01 INFO - "branch": "fx-team-macosx64-talos", 12:42:01 INFO - "changes": [ 12:42:01 INFO - { 12:42:01 INFO - "category": null, 12:42:01 INFO - "files": [ 12:42:01 INFO - { 12:42:01 INFO - "url": null, 12:42:01 INFO - "name": "https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:42:01 INFO - } 12:42:01 INFO - ], 12:42:01 INFO - "repository": "", 12:42:01 INFO - "rev": "375a22f7bc4ee360e90849d33061c86b1b56fe8b", 12:42:01 INFO - "who": "dmosedale@mozilla.com", 12:42:01 INFO - "when": 1446234079, 12:42:01 INFO - "number": 6601827, 12:42:01 INFO - "comments": "Bug 1214590 - Remove Loop default Room name, r=dmose", 12:42:01 INFO - "project": "", 12:42:01 INFO - "at": "Fri 30 Oct 2015 12:41:19", 12:42:01 INFO - "branch": "fx-team-macosx64-talos", 12:42:01 INFO - "revlink": "", 12:42:01 INFO - "properties": [ 12:42:01 INFO - [ 12:42:01 INFO - "buildid", 12:42:01 INFO - "20151030115030", 12:42:01 INFO - "Change" 12:42:01 INFO - ], 12:42:01 INFO - [ 12:42:01 INFO - "builduid", 12:42:01 INFO - "259efd1e8ba74e7ca2c95899175227ff", 12:42:01 INFO - "Change" 12:42:01 INFO - ], 12:42:01 INFO - [ 12:42:01 INFO - "pgo_build", 12:42:01 INFO - "False", 12:42:01 INFO - "Change" 12:42:01 INFO - ] 12:42:01 INFO - ], 12:42:01 INFO - "revision": "375a22f7bc4ee360e90849d33061c86b1b56fe8b" 12:42:01 INFO - } 12:42:01 INFO - ], 12:42:01 INFO - "revision": "375a22f7bc4ee360e90849d33061c86b1b56fe8b" 12:42:01 INFO - } 12:42:01 INFO - } 12:42:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:42:01 INFO - Running post-action listener: _resource_record_post_action 12:42:01 INFO - ##### 12:42:01 INFO - ##### Running download-and-extract step. 12:42:01 INFO - ##### 12:42:01 INFO - Running pre-action listener: _resource_record_pre_action 12:42:01 INFO - Running main action method: download_and_extract 12:42:01 INFO - mkdir: /builds/slave/test/build/tests 12:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:01 INFO - https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/test_packages.json 12:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/test_packages.json 12:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:42:02 INFO - Downloaded 1149 bytes. 12:42:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:42:02 INFO - Using the following test package requirements: 12:42:02 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:42:02 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:42:02 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'jsshell-mac.zip'], 12:42:02 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:42:02 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:42:02 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:42:02 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:42:02 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:42:02 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:42:02 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:42:02 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:42:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:02 INFO - https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:42:04 INFO - Downloaded 17447179 bytes. 12:42:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:42:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:42:09 INFO - Return code: 0 12:42:09 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:09 INFO - https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:42:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:42:16 INFO - Downloaded 17447179 bytes. 12:42:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:42:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:42:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:42:22 INFO - Return code: 0 12:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:22 INFO - https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:42:23 INFO - Downloaded 11131307 bytes. 12:42:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 12:42:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:42:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:42:23 INFO - Return code: 0 12:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:23 INFO - https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 12:42:26 INFO - retry: attempt #1 caught exception: '' 12:42:26 INFO - retry: Failed, sleeping 30 seconds before retrying 12:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #2 12:43:00 INFO - Downloaded 108532449 bytes. 12:43:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:43:00 INFO - mkdir: /builds/slave/test/properties 12:43:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:43:00 INFO - Writing to file /builds/slave/test/properties/build_url 12:43:00 INFO - Contents: 12:43:00 INFO - build_url:https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:43:00 INFO - Running post-action listener: _resource_record_post_action 12:43:00 INFO - Running post-action listener: set_extra_try_arguments 12:43:00 INFO - ##### 12:43:00 INFO - ##### Running populate-webroot step. 12:43:00 INFO - ##### 12:43:00 INFO - Running pre-action listener: _resource_record_pre_action 12:43:00 INFO - Running main action method: populate_webroot 12:43:00 INFO - Guessing talos json url... 12:43: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')]} 12:43:00 INFO - https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 12:43:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:43:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:43:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 12:43:00 INFO - Downloaded 103 bytes. 12:43:00 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:43:00 INFO - Contents: 12:43:00 INFO - 20151030115030 12:43:00 INFO - https://hg.mozilla.org/integration/fx-team/rev/375a22f7bc4ee360e90849d33061c86b1b56fe8b 12:43: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')]} 12:43:00 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/375a22f7bc/testing/talos/talos.json 12:43:00 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/375a22f7bc/testing/talos/talos.json to /builds/slave/test/build/talos.json 12:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/375a22f7bc/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 12:43:01 INFO - Downloaded 4264 bytes. 12:43:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:43:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:43:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:43:01 INFO - '../fennec_ids.txt'], 12:43:01 INFO - 'tests': ['tcheck2']}, 12:43:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:43:01 INFO - '--tppagecycles', 12:43:01 INFO - '7'], 12:43:01 INFO - 'tests': ['tsvgm']}}, 12:43:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:43:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:43:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:43:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:43:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'tests': ['damp', 'tps']}, 12:43:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['damp', 'tps']}, 12:43:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:43:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:43:01 INFO - 'other': {'tests': ['a11yr', 12:43:01 INFO - 'ts_paint', 12:43:01 INFO - 'tpaint', 12:43:01 INFO - 'sessionrestore', 12:43:01 INFO - 'sessionrestore_no_auto_restore']}, 12:43:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['a11yr', 12:43:01 INFO - 'ts_paint', 12:43:01 INFO - 'tpaint', 12:43:01 INFO - 'sessionrestore', 12:43:01 INFO - 'sessionrestore_no_auto_restore']}, 12:43:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['a11yr', 12:43:01 INFO - 'ts_paint', 12:43:01 INFO - 'tpaint', 12:43:01 INFO - 'sessionrestore', 12:43:01 INFO - 'sessionrestore_no_auto_restore']}, 12:43:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['a11yr', 12:43:01 INFO - 'ts_paint', 12:43:01 INFO - 'tpaint', 12:43:01 INFO - 'sessionrestore', 12:43:01 INFO - 'sessionrestore_no_auto_restore']}, 12:43:01 INFO - 'other_l64': {'tests': ['a11yr', 12:43:01 INFO - 'ts_paint', 12:43:01 INFO - 'tpaint', 12:43:01 INFO - 'sessionrestore', 12:43:01 INFO - 'sessionrestore_no_auto_restore']}, 12:43:01 INFO - 'other_nol64': {'tests': ['a11yr', 12:43:01 INFO - 'ts_paint', 12:43:01 INFO - 'tpaint', 12:43:01 INFO - 'sessionrestore', 12:43:01 INFO - 'sessionrestore_no_auto_restore']}, 12:43:01 INFO - 'svgr': {'tests': ['tsvgx', 12:43:01 INFO - 'tsvgr_opacity', 12:43:01 INFO - 'tart', 12:43:01 INFO - 'tscrollx', 12:43:01 INFO - 'cart']}, 12:43:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['tsvgx', 12:43:01 INFO - 'tsvgr_opacity', 12:43:01 INFO - 'tart', 12:43:01 INFO - 'tscrollx', 12:43:01 INFO - 'cart']}, 12:43:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'tests': ['tp5o']}, 12:43:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'talos_options': ['--e10s'], 12:43:01 INFO - 'tests': ['tp5o']}, 12:43:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'talos_options': ['--xperf_path', 12:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:01 INFO - 'tests': ['tp5n']}, 12:43:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:01 INFO - 'talos_options': ['--e10s', 12:43:01 INFO - '--xperf_path', 12:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:43:01 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:43:01 INFO - 'tests': ['tp5n']}}, 12:43:01 INFO - 'talos.zip': {'path': '', 12:43:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:43:01 INFO - Running post-action listener: _resource_record_post_action 12:43:01 INFO - ##### 12:43:01 INFO - ##### Running create-virtualenv step. 12:43:01 INFO - ##### 12:43:01 INFO - Running pre-action listener: _resource_record_pre_action 12:43:01 INFO - Running main action method: create_virtualenv 12:43:01 INFO - Creating virtualenv /builds/slave/test/build/venv 12:43:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:43:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:43:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:43:01 INFO - Using real prefix '/tools/python27' 12:43:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:43:02 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:05 INFO - Installing pip.................done. 12:43:05 INFO - Return code: 0 12:43:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:05 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 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:05 INFO - 'HOME': '/Users/cltbld', 12:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:05 INFO - 'LOGNAME': 'cltbld', 12:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:05 INFO - 'MOZ_NO_REMOTE': '1', 12:43:05 INFO - 'NO_EM_RESTART': '1', 12:43:05 INFO - 'PAGER': '/bin/cat', 12:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:05 INFO - 'PWD': '/builds/slave/test', 12:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:05 INFO - 'SHELL': '/bin/bash', 12:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:05 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:05 INFO - 'USER': 'cltbld', 12:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:05 INFO - 'XPC_FLAGS': '0x0', 12:43:05 INFO - 'XPC_SERVICE_NAME': '0', 12:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:43:06 INFO - Cleaning up... 12:43:06 INFO - Return code: 0 12:43:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:06 INFO - 'HOME': '/Users/cltbld', 12:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:06 INFO - 'LOGNAME': 'cltbld', 12:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:06 INFO - 'MOZ_NO_REMOTE': '1', 12:43:06 INFO - 'NO_EM_RESTART': '1', 12:43:06 INFO - 'PAGER': '/bin/cat', 12:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:06 INFO - 'PWD': '/builds/slave/test', 12:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:06 INFO - 'SHELL': '/bin/bash', 12:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:06 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:06 INFO - 'USER': 'cltbld', 12:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:06 INFO - 'XPC_FLAGS': '0x0', 12:43:06 INFO - 'XPC_SERVICE_NAME': '0', 12:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:06 INFO - Downloading/unpacking psutil>=0.7.1 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:43:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:09 INFO - Installing collected packages: psutil 12:43:09 INFO - Running setup.py install for psutil 12:43:09 INFO - building 'psutil._psutil_osx' extension 12:43:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:43:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:43:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:43:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:43:11 INFO - building 'psutil._psutil_posix' extension 12:43:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:43:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:43:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:43:12 INFO - ^ 12:43:12 INFO - 1 warning generated. 12:43:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:12 INFO - Successfully installed psutil 12:43:12 INFO - Cleaning up... 12:43:12 INFO - Return code: 0 12:43:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:12 INFO - 'HOME': '/Users/cltbld', 12:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:12 INFO - 'LOGNAME': 'cltbld', 12:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:12 INFO - 'MOZ_NO_REMOTE': '1', 12:43:12 INFO - 'NO_EM_RESTART': '1', 12:43:12 INFO - 'PAGER': '/bin/cat', 12:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:12 INFO - 'PWD': '/builds/slave/test', 12:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:12 INFO - 'SHELL': '/bin/bash', 12:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:12 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:12 INFO - 'USER': 'cltbld', 12:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:12 INFO - 'XPC_FLAGS': '0x0', 12:43:12 INFO - 'XPC_SERVICE_NAME': '0', 12:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:43:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:43:15 INFO - Installing collected packages: mozsystemmonitor 12:43:15 INFO - Running setup.py install for mozsystemmonitor 12:43:15 INFO - Successfully installed mozsystemmonitor 12:43:15 INFO - Cleaning up... 12:43:15 INFO - Return code: 0 12:43:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:43:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:15 INFO - 'HOME': '/Users/cltbld', 12:43:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:15 INFO - 'LOGNAME': 'cltbld', 12:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:15 INFO - 'MOZ_NO_REMOTE': '1', 12:43:15 INFO - 'NO_EM_RESTART': '1', 12:43:15 INFO - 'PAGER': '/bin/cat', 12:43:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:15 INFO - 'PWD': '/builds/slave/test', 12:43:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:15 INFO - 'SHELL': '/bin/bash', 12:43:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:15 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:15 INFO - 'USER': 'cltbld', 12:43:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:15 INFO - 'XPC_FLAGS': '0x0', 12:43:15 INFO - 'XPC_SERVICE_NAME': '0', 12:43:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:18 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:19 INFO - Downloading docopt-0.6.1.tar.gz 12:43:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:19 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:19 INFO - Running setup.py install for blobuploader 12:43:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:19 INFO - Running setup.py install for requests 12:43:20 INFO - Running setup.py install for docopt 12:43:20 INFO - Successfully installed blobuploader requests docopt 12:43:20 INFO - Cleaning up... 12:43:20 INFO - Return code: 0 12:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:20 INFO - 'HOME': '/Users/cltbld', 12:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:20 INFO - 'LOGNAME': 'cltbld', 12:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:20 INFO - 'MOZ_NO_REMOTE': '1', 12:43:20 INFO - 'NO_EM_RESTART': '1', 12:43:20 INFO - 'PAGER': '/bin/cat', 12:43:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:20 INFO - 'PWD': '/builds/slave/test', 12:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:20 INFO - 'SHELL': '/bin/bash', 12:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:20 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:20 INFO - 'USER': 'cltbld', 12:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:20 INFO - 'XPC_FLAGS': '0x0', 12:43:20 INFO - 'XPC_SERVICE_NAME': '0', 12:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:20 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-dRJl_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:20 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-0m7gWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-RbCdx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-uRbucy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-LgxxLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-oZ3Cfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-uA_WtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-MHJD_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:21 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-gmA0MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-CULj2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-dRMwsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-oTbtqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-u74rZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-JVMrJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-x_YZ3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-FR7NW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:22 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-TbXCrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:23 INFO - Running setup.py install for manifestparser 12:43:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:23 INFO - Running setup.py install for mozcrash 12:43:23 INFO - Running setup.py install for mozdebug 12:43:23 INFO - Running setup.py install for mozdevice 12:43:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:23 INFO - Running setup.py install for mozfile 12:43:23 INFO - Running setup.py install for mozhttpd 12:43:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Running setup.py install for mozinfo 12:43:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Running setup.py install for mozInstall 12:43:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Running setup.py install for mozleak 12:43:24 INFO - Running setup.py install for mozlog 12:43:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:24 INFO - Running setup.py install for moznetwork 12:43:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:25 INFO - Running setup.py install for mozprocess 12:43:25 INFO - Running setup.py install for mozprofile 12:43:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:25 INFO - Running setup.py install for mozrunner 12:43:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:25 INFO - Running setup.py install for mozscreenshot 12:43:25 INFO - Running setup.py install for moztest 12:43:25 INFO - Running setup.py install for mozversion 12:43:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:26 INFO - Cleaning up... 12:43:26 INFO - Return code: 0 12:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:26 INFO - 'HOME': '/Users/cltbld', 12:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:26 INFO - 'LOGNAME': 'cltbld', 12:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:26 INFO - 'MOZ_NO_REMOTE': '1', 12:43:26 INFO - 'NO_EM_RESTART': '1', 12:43:26 INFO - 'PAGER': '/bin/cat', 12:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:26 INFO - 'PWD': '/builds/slave/test', 12:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:26 INFO - 'SHELL': '/bin/bash', 12:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:26 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:26 INFO - 'USER': 'cltbld', 12:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:26 INFO - 'XPC_FLAGS': '0x0', 12:43:26 INFO - 'XPC_SERVICE_NAME': '0', 12:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:26 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-zMewt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:26 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-lHex0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:26 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-CRyyRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:26 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-HJk5RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:26 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-p9Lczo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-McgEIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-6ZBpaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-0ilT9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-CXeNAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-z42Zba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-jloEYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:27 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-hWwBBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:28 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-QOx_8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:28 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-jVIYun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:28 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-DzCwW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:28 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-ZZ_Ztc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:28 INFO - Running setup.py (path:/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/pip-DZ8hmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:31 INFO - Downloading blessings-1.5.1.tar.gz 12:43:31 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:31 INFO - Installing collected packages: blessings 12:43:31 INFO - Running setup.py install for blessings 12:43:31 INFO - Successfully installed blessings 12:43:31 INFO - Cleaning up... 12:43:31 INFO - Return code: 0 12:43:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:31 INFO - Reading from file tmpfile_stdout 12:43:31 INFO - Current package versions: 12:43:31 INFO - blessings == 1.5.1 12:43:31 INFO - blobuploader == 1.2.4 12:43:31 INFO - docopt == 0.6.1 12:43:31 INFO - manifestparser == 1.1 12:43:31 INFO - mozInstall == 1.12 12:43:31 INFO - mozcrash == 0.16 12:43:31 INFO - mozdebug == 0.1 12:43:31 INFO - mozdevice == 0.46 12:43:31 INFO - mozfile == 1.2 12:43:31 INFO - mozhttpd == 0.7 12:43:31 INFO - mozinfo == 0.8 12:43:31 INFO - mozleak == 0.1 12:43:31 INFO - mozlog == 3.0 12:43:31 INFO - moznetwork == 0.27 12:43:31 INFO - mozprocess == 0.22 12:43:31 INFO - mozprofile == 0.27 12:43:31 INFO - mozrunner == 6.11 12:43:31 INFO - mozscreenshot == 0.1 12:43:31 INFO - mozsystemmonitor == 0.0 12:43:31 INFO - moztest == 0.7 12:43:31 INFO - mozversion == 1.4 12:43:31 INFO - psutil == 3.1.1 12:43:31 INFO - requests == 1.2.3 12:43:31 INFO - wsgiref == 0.1.2 12:43:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10672ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106799228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff693f019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, '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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:31 INFO - 'HOME': '/Users/cltbld', 12:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:31 INFO - 'LOGNAME': 'cltbld', 12:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:31 INFO - 'MOZ_NO_REMOTE': '1', 12:43:31 INFO - 'NO_EM_RESTART': '1', 12:43:31 INFO - 'PAGER': '/bin/cat', 12:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:31 INFO - 'PWD': '/builds/slave/test', 12:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:31 INFO - 'SHELL': '/bin/bash', 12:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:43:31 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:31 INFO - 'USER': 'cltbld', 12:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:31 INFO - 'XPC_FLAGS': '0x0', 12:43:31 INFO - 'XPC_SERVICE_NAME': '0', 12:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:32 INFO - Cleaning up... 12:43:32 INFO - Return code: 0 12:43:32 INFO - Running post-action listener: _resource_record_post_action 12:43:32 INFO - Running post-action listener: _start_resource_monitoring 12:43:32 INFO - Starting resource monitoring. 12:43:32 INFO - ##### 12:43:32 INFO - ##### Running install step. 12:43:32 INFO - ##### 12:43:32 INFO - Running pre-action listener: _resource_record_pre_action 12:43:32 INFO - Running main action method: install 12:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:32 INFO - Reading from file tmpfile_stdout 12:43:32 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:32 INFO - Reading from file tmpfile_stdout 12:43:32 INFO - Output received: 12:43:32 INFO - Usage: mozinstall [options] installer 12:43:32 INFO - Options: 12:43:32 INFO - -h, --help show this help message and exit 12:43:32 INFO - -d DEST, --destination=DEST 12:43:32 INFO - Directory to install application into. [default: 12:43:32 INFO - "/builds/slave/test"] 12:43:32 INFO - --app=APP Application being installed. [default: firefox] 12:43:32 INFO - mkdir: /builds/slave/test/build/application 12:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:44:12 INFO - Reading from file tmpfile_stdout 12:44:12 INFO - Output received: 12:44:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:44:12 INFO - Running post-action listener: _resource_record_post_action 12:44:12 INFO - ##### 12:44:12 INFO - ##### Running run-tests step. 12:44:12 INFO - ##### 12:44:12 INFO - Running pre-action listener: _resource_record_pre_action 12:44:12 INFO - Running main action method: run_tests 12:44:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:44:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:44:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:44:12 INFO - 2015-10-30 12:44:12.408 screenresolution[1630:7695] starting screenresolution argv=screenresolution get 12:44:12 INFO - 2015-10-30 12:44:12.412 screenresolution[1630:7695] Display 0: 1600x1200x32@60 12:44:12 INFO - 2015-10-30 12:44:12.418 screenresolution[1631:7697] starting screenresolution argv=screenresolution list 12:44:12 INFO - Available Modes on Display 0 12:44:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:44:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:44:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:44:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:44:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:44:12 INFO - Intel HD Graphics 3000: 12:44:12 INFO - Chipset Model: Intel HD Graphics 3000 12:44:12 INFO - Type: GPU 12:44:12 INFO - Bus: Built-In 12:44:12 INFO - VRAM (Total): 512 MB 12:44:12 INFO - VRAM (Dynamic, Max): 10 12:44:12 INFO - Vendor: Intel (0x8086) 12:44:12 INFO - Device ID: 0x0116 12:44:12 INFO - Revision ID: 0x0009 12:44:12 INFO - Displays: 12:44:12 INFO - Display: 12:44:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:44:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:44:12 INFO - Display Serial Number: 1600x1200 60 12:44:12 INFO - Main Display: Yes 12:44:12 INFO - Mirror: Off 12:44:12 INFO - Online: Yes 12:44:12 INFO - Rotation: Supported 12:44:12 INFO - Return code: 0 12:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:44:12 INFO - Python 2.7.3 12:44:12 INFO - Return code: 0 12:44:12 INFO - grabbing minidump binary from tooltool 12:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:12 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 0x1066e19f0>, '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 0x106440cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066ab990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:44:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:44:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:44:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:12 INFO - Return code: 0 12:44:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:44:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:44:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:44:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:44:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0069', '--webServer', 'localhost'] in /builds/slave/test/build 12:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0069 --webServer localhost 12:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y1CUdwDp1r/Render', 12:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:44:12 INFO - 'HOME': '/Users/cltbld', 12:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:44:12 INFO - 'LOGNAME': 'cltbld', 12:44:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:44:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:12 INFO - 'MOZ_NO_REMOTE': '1', 12:44:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:44:12 INFO - 'NO_EM_RESTART': '1', 12:44:12 INFO - 'PAGER': '/bin/cat', 12:44:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:12 INFO - 'PWD': '/builds/slave/test', 12:44:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:44:12 INFO - 'SHELL': '/bin/bash', 12:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q49Tw0HMDa/Listeners', 12:44:12 INFO - 'TMPDIR': '/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/', 12:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:44:12 INFO - 'USER': 'cltbld', 12:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:12 INFO - 'XPC_FLAGS': '0x0', 12:44:12 INFO - 'XPC_SERVICE_NAME': '0', 12:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:44:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0069', '--webServer', 'localhost'] with output_timeout 3600 12:44:13 INFO - mozversion INFO | application_buildid: 20151030115030 12:44:13 INFO - mozversion INFO | application_changeset: 375a22f7bc4ee360e90849d33061c86b1b56fe8b 12:44:13 INFO - mozversion INFO | application_display_name: Nightly 12:44:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:13 INFO - mozversion INFO | application_name: Firefox 12:44:13 INFO - mozversion INFO | application_remotingname: firefox 12:44:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:44:13 INFO - mozversion INFO | application_vendor: Mozilla 12:44:13 INFO - mozversion INFO | application_version: 45.0a1 12:44:13 INFO - mozversion INFO | platform_buildid: 20151030115030 12:44:13 INFO - mozversion INFO | platform_changeset: 375a22f7bc4ee360e90849d33061c86b1b56fe8b 12:44:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:44:13 INFO - mozversion INFO | platform_version: 45.0a1 12:44:13 INFO - 2015-10-30 12:44:13,166 DEBUG : using testdate: 1446234253 12:44:13 INFO - 2015-10-30 12:44:13,166 DEBUG : actual date: 1446234253 12:44:13 INFO - 2015-10-30 12:44:13,176 INFO : starting webserver on 'localhost:49269' 12:44:13 INFO - 2015-10-30 12:44:13,177 INFO : Starting test suite t-yosemite-r5-0069 12:44:13 INFO - 2015-10-30 12:44:13,177 INFO : Starting test dromaeo_css 12:44:13 INFO - 2015-10-30 12:44:13,177 DEBUG : operating with platform_type : mac_ 12:44:13 INFO - 2015-10-30 12:44:13,178 INFO : Initialising browser for dromaeo_css test... 12:44:13 INFO - 2015-10-30 12:44:13,207 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/tmpBPpEbL/profile http://localhost:49269/getInfo.html 12:44:16 INFO - 2015-10-30 12:44:16,219 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:44:16 INFO - 2015-10-30 12:44:16,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:44:16 INFO - 2015-10-30 12:44:16,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:44:16 INFO - 2015-10-30 12:44:16,221 DEBUG : BROWSER_OUTPUT: __metrics 12:44:16 INFO - 2015-10-30 12:44:16,237 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:44:16 INFO - 2015-10-30 12:44:16,997 INFO : Browser initialized. 12:44:16 INFO - 2015-10-30 12:44:16,997 INFO : Running cycle 1/1 for dromaeo_css test... 12:44:16 INFO - 2015-10-30 12:44:16,997 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/tmpBPpEbL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:44:29 INFO - 2015-10-30 12:44:29,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 222633984 12:44:29 INFO - 2015-10-30 12:44:29,062 DEBUG : BROWSER_OUTPUT: 12:45:20 INFO - 2015-10-30 12:45:20,061 DEBUG : BROWSER_OUTPUT: 1446234320057 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:47:31 INFO - 2015-10-30 12:47:31,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 12:47:32 INFO - 2015-10-30 12:47:32,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 334454784 12:47:32 INFO - 2015-10-30 12:47:32,511 DEBUG : BROWSER_OUTPUT: 12:50:35 INFO - 2015-10-30 12:50:35,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 12:50:36 INFO - 2015-10-30 12:50:36,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 355278848 12:50:36 INFO - 2015-10-30 12:50:36,041 DEBUG : BROWSER_OUTPUT: 12:53:38 INFO - 2015-10-30 12:53:38,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 12:53:38 INFO - 2015-10-30 12:53:38,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 314470400 12:53:38 INFO - 2015-10-30 12:53:38,863 DEBUG : BROWSER_OUTPUT: 12:56:40 INFO - 2015-10-30 12:56:40,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 12:56:41 INFO - 2015-10-30 12:56:41,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 314400768 12:56:41 INFO - 2015-10-30 12:56:41,533 DEBUG : BROWSER_OUTPUT: 12:59:44 INFO - 2015-10-30 12:59:44,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 12:59:45 INFO - 2015-10-30 12:59:45,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 314724352 12:59:45 INFO - 2015-10-30 12:59:45,389 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 13:02:48 INFO - 2015-10-30 13:02:48,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 374272000 13:02:48 INFO - 2015-10-30 13:02:48,333 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,333 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:02:48 INFO - 2015-10-30 13:02:48,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:02:48 INFO - 2015-10-30 13:02:48,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:02:48 INFO - 2015-10-30 13:02:48,333 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:02:48 INFO - 2015-10-30 13:02:48,334 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2805.4809860175865;2848.230977636037;2859.2708859240893;2888.5378339465688;2903.274181454636;4678.298255261712;4708.199606066968;4849.054434385292;4862.659613827033;4892.070506603747;4700.85897423077;4735.834245801398;4853.805847766085;4879.121758083544;4900.362952816138;4324.589164029428;4331.155424692186;4368.650507959355;4441.75570343631;4498.617617502517;4365.738055716652;4460.710053846506;4462.866114016585;4478.507364189936;4480.372747815309;4262.360645903108;4361.454818147731;4366.8908277293;4433.179861725575;4444.266695995189;4338.370936214263;4343.67422443318;4372.23485889968;4388;4417.580329868657;4265.680073994463;4289.249381358281;4292.399064131024;4350.8912277193;4362.825486980549;4524.8190072397065;4646.512116227781;4657.534246575349;4673.88315292117;4702.8118875244945;4786.617070634341;4888.388951381077;4918;4933.01339732055;4934.481879402647;4989.301497790312;5003.974980125113;5039.571636410909;5127.897442051175;5191.221316802472;4561.635069194523;4667.229907065364;4673.696209746356;4693.507181745936;4715.104130215213;5050.141475949097;5056.64603477753;5059.848204553869;5099.77051032697;5114.41184263807;4794.472608013116;4885.755712214375;4902.240152776325;4911.18965370717;4914.262860570871;4768.451628062748;4931.0630980113665;4994.475580064113;5006.374203224597;5029.27075574047;4887.853364399074;4896.559309662148;4911.631627627942;4927.926081108786;4958.231474121517;4906.288588154697;4951.8266860659705;4970.602351811846;4992.550670439678;4998.825041123616;3796.5064541609413;3884.7280690351968;3892.649661530476;3903.10228647407;3975.5229372475487;3367.1413789483527;3443.2596991646415;3508.1755787389943;3510.8946731598094;3518.7712798668003;4657.0685862826895;4668.346431499593;4692.577668009895;4719.85840424781;4729.337892695025;4858.125537403302;4940.308356830046;4991.775370108354;5040.647154699136;5143.485651434827;4647.6281897448125;4653.232216684277;4654.999175177353;4673.626109911199;4694.694844835075;4516.187086324493;4520.909581808345;4521.1409832131785;4532.410786597788;4632.884177895512;4889.633277504273;5113.872153196051;5175.560077393388;5187.118189907649;5203.765830537635;4814;4951.232558953368;4984.00319936007;5095.898082038264;5104.617153713561;5105.2342148678;5121.487851214849;5157.0975079361715;5168.612354073384;5169.457206993362;4773.260144677581;4949.678270912379;4956.355673762388;5021.6735912165595;5030.798768049237;4894.339264199288;4989.301497790385;5010.9749451253965;5072.416672082758;5118.488151184852;4735.786889589908;4965.702057876539;4973.502649734997;4974.353334066548;5012.749362531786;4764.380630518011;4895.877603059952;4958.776855041604;4966.6771659842;5028.974855125701;4535.886602834956;4818.494058123846;4818.831340903052;4835.29888166221;4841.419029716457;4881.951180488291;4905.975470122627;4910.263460480956;4953.356063711839;5076.010178015252;4642.2340313847835;4860.73265970375;4864;4900.828471003498;4918.581920536794 13:02:48 INFO - 2015-10-30 13:02:48,334 DEBUG : BROWSER_OUTPUT: |1;ext.html;480.19327529750007;484.68011112665647;494.19446302526876;507.8628770232037;519.9834323896782;27136.592951105726;28403.57394639082;34182.31635367291;34713.65286347136;34880;37231.627683723156;37232.813835930785;37816.05459863505;37906.8104659477;37934.4309835352;7177.3899218566485;7985.241402066809;8199.71301004462;8354.749357519284;8368.748937531853;7470.252974702514;9681.806363872718;9929.801403971916;9982.9500852496;9997.750056248578;9518.238540916711;9630.566624501915;9661.661841835537;9758.804823903552;9884.505774711271;7520.924790752078;7695.345895598881;9704.12662860339;9796;9941.652042178524;9327.953360233156;9422.152006319464;9606.711798646053;9705.369151005232;9755.951220243924;35526.289474210374;35533.82233088818;35625.46561801575;35896;36079.81960090209;2598.800247125175;2610.5953577195373;2666.0668765931964;2692.1923422973227;3070.140360699008;23394;23739.76260237393;24095.397615059588;24434.14480493174;24624.384390390205;1946.8929208893505;2008.2469074097214;2028.2292728763123;2057.9279725209694;2133.381319417367;238537;238940;239214.99999999825;240496;242901;51743.741281293354;52050;52124;52130;52390.738046309525;49591;49918.500814991385;50513.242301365506;52990;53064.73467632637;14557.27213639335;14708.926455367655;14893.70212595742;14919.254037298091;15098.320575573905;10497;10895.455227238765;10992.615258465916;11063.778724425467;11064.778704426028;14147.434102635985;14895.627609309853;15867.444639437796;15969;16861.409850655167;7447.3669738071785;7806.3364614007305;7835.960820195976;7854.646540905673;7921.683132674743;793.2662287384146;811.3387589114852;902.3953950852945;930.7300882744064;946.0823001688351;24511.632325515133;25100.74899250984;25251;25957.480850382886;26104.34739131537;924.3575714878095;929.1962452478692;951.129716309569;955;1038.2524582300732;11777.352245626402;12043.638690839289;12080;12151;12201.572944946884;272935;274641;277353;279813;279881;45949.77025114853;45968.770156149;46290;46540;46657;1225.026104247108;1231.2673958994385;1245.5391505142975;1250.2560976219136;1250.843644544432;23643.881780590986;24690.876545617157;25711.742882570936;26186.86906565455;26305.342366440993;44329.77835110933;44429.555704442544;44931.55068449274;44941.77529112464;44973;222817;223999;225373;225813;226808;25551;26737.732622674303;26971.190864274104;27050.458990820465;27416.725832741417;31507.431422444075;31651.52522712207;37454.250914981;40590.79704601458;40628.1874362517;30264.394712105193;31117;31378.431078446443;31582.526262105628;31621.20946976344;30187.396252074395;30531.389372212874;31083.222919427197;31145;31147;26885.596716048884;27613.72386276192;31201.219969500944;32478.83760581182;32489.187770305933;24629.630555541324;27472.313192170357;27830.582541261494;27863.721362786924;27932.16203513898;20799.480012999797;20859.269925552533;20908.1636734535;29182.708172918;29814.552781708724 13:02:48 INFO - 2015-10-30 13:02:48,334 DEBUG : BROWSER_OUTPUT: |2;jquery.html;289.13116086161085;291.9313961219112;301.08019998903353;301.2393705892621;304.3972933591489;14764.6308842279;15242;15914.283857226425;16121.758173627404;16122.435714749956;14945.17801520916;15235.542933712006;15407.614809629766;15413.922930385332;15563.066216027046;3752.512173417452;3905.531336239655;3909.3354129798004;3912.9021774455723;3981.542122655903;3822.388417853144;3852.7303088783797;3861.0540417597726;3875.670568001723;3900.31744444721;3879.495665563473;3921.764694118362;3929.44987701722;3939.231849789292;3995.4805875236325;3918.45141680165;3920.9803950980063;3935.193285376505;3954.1498577805623;3954.9209015819665;3197.1527545200543;3396.6433524480067;3401.642827503101;3410.4823353607653;3420.2817408344276;11511.539538418454;11638.59264925732;11770.88229117715;11821.468033938494;11884;1509.9698006039928;1539.3150048228542;1733.1334332833583;1739.1391261325598;1758.2285996537482;8112.067112282045;8241.629126689313;8428.8314233715;8472.78818029548;8492.065872753992;1357.518081081212;1362.1146254934272;1364.7202323523654;1369.732902084094;1382.6059573021641;39375;50811.49188508104;51667.48332516664;53776.731116344556;54364.18453723197;5433.26650902131;5442.346918369742;5609.102543593006;5671.51792097668;5709.200711900337;6487.448566871774;6493.090967264587;6497.317781632955;6537.771178008747;6650.168728908887;4793.065352256346;4829.758512074382;4866.343043689128;4868.123737727243;4898.53463920927;5110.105731496973;5211.739413029409;5213.713245771519;5274.340707411574;5274.894502109936;2535.961960570593;2596.143272719998;2609.960850587243;2617.1101825379465;2656.800739944512;916.4409710076848;925.648253663617;932.5197523275518;937.161240689579;977.3354119199013;369.49748342254514;402.81873157079434;403.1775178635609;406.8209987605444;423.0755798580112;10086.142677872316;10485.108765754843;10513.632022879163;10587.788244235073;10615.946920265504;355.70654210276626;406.1410117601252;412.58535172151795;426.5563813633786;426.9893252668646;5400.91898621521;5482.451754824486;5723.713814309268;5756.510696590837;5919.881602368015;429388;435110;452086;452410;457538;48836.51163488391;59057;60812;64226;64499;395.800120938924;404.93318602430855;405.84780707234785;408.29568993486;408.895731588449;8577.356698247531;8589.14108589136;8695.347848911231;8811.867821982803;8856.291496680122;26203.4759304809;29779.10662680123;30153.698463015087;30696.84651576728;30970.53544196794;42873.785631071645;43009.354859677755;43181.784091079346;43269.350959735;43814.34278485762;6778.2205046420295;6866.244713081657;6945.617991010341;6959.095317608679;7019.859602808017;10336.573154769927;10554.261201716114;10595.417252050904;10595.47022648849;10643.201759867887;8948.328875334246;9122.5438728062;9170.128837760401;9221;9230;8191.877121843297;8549.27331176832;8748.60631271607;8783.824323513621;8794.648214071365;8866.556672166495;8906.910930890608;9104.544772761203;9143.679971200976;9288.907110929074;6588.275289718223;6760.1549806274215;6761.797146085625;6770.187577490733;6771.966140169465;7911.406644501801;8383.622736976973;8403.453775504573;8446.915530844859;8951.462912225288 13:02:48 INFO - 2015-10-30 13:02:48,334 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1387.2439520461348;1459.0953608762568;1516.916569588673;1543.9845601543989;1584.3900098462088;6235.781747638834;6562.73749050038;6919.550229235102;7030.543014704041;7146;6812.55718378305;6902.551334163276;6964.338387853159;6977.651117444133;7077.964610176955;1943.5529828139536;1950.4441234248243;1960.5000724815152;1980.8316293115101;1980.9405717828488;1966.8721533100374;1992.7409436773198;2019.2125071222235;2027.7870823563535;2029.7361343025386;1875.268645228362;1937.8643494955359;1950.7366505521786;1951.8926459044746;1955.501347156473;1937.4575118966711;1945.5038965063889;1945.5136215946013;1965.164804957887;1965.6560101982095;1956.5108722819296;1973.4375702924597;1988.4134180416668;2005;2005.9498512537157;6117;6845.589264644137;6882.69027893746;6896.586204827727;7019.82450438738;3859.9807000964815;4115.477273408858;4218.915621687549;4286.7856607169515;4311.094670119279;2413.6017557103055;2433.1848830641757;2464.039024780337;2471.3821544613847;2486.4405508760383;692.2904023376029;712.6579241963886;724.6159535446222;726.8400951790597;728.6866647341641;8921.15249051339;9043.41217820846;9064.68273610427;9131.497767622777;9177.770555736093;3679.2089700714473;3745.85016599333;3758.586555478895;3764.7364684471822;3820.751651142667;7382.852342953111;7415.480916335805;7420.443466739908;7485;7514.361279291212;4198.5591512891315;4215.97892010538;4260.4248426462655;4274.871753847389;4282.721623094489;3903.921921561553;3920.7059470539825;3934.2328245991757;3952.7430717003303;3953.8616148434667;2834.631497905259;2908.171171216193;2931.1939216715145;2944.6319210098736;2986.148947549938;916.8028873792033;917.2386918857333;930.283681565191;935.4854829843558;937.1284705224207;890.7639475538988;941.1905761045496;941.8540126280437;971.0920289529313;971.0920289529313;6595.142631457879;6680.766173184013;6692.163479565054;6699.02864084705;6718.0930574372815;413.48108124303803;414.7283529288321;418.4330232534932;422.39597375752356;425.59568410010615;5212.765425555859;5275.472452754694;5282.392524859613;5355.571554275649;5362.839114826562;7537.020187375716;7665.3101220890385;7892.723754668559;7971.521708697497;8065.072516660659;7974.242446967529;8022.358211343078;8041.597920104088;8116.310113640407;8141.470804397695;6241.687915604201;6446.194225721785;6481.773137940149;6539.444147247537;6593.406593406617;6354.26925903527;6428;6459.515536334699;6476.676166191577;6554.246261679968;7018.684159212949;7253.310935461122;7255.891161632474;7340.632968351454;7357.889631655423;7288.599127047851;7446.553206807609;7483.251674832473;7522.285382888617;7606.8098297543;6028.819135425769;6053.606515576474;6187.938120618916;6190.969045154746;6191.783287584913;6504.577202481823;6608.43828274602;6658.800235992928;6663.067170596218;6669.866602667822;6128.448439640276;6138.570300078952;6216.285127210429;6246.219222597176;6323.051542268697;5853.473187413153;5895.793647222326;6102.328743838086;6107.931112055461;6210.3168651449205;6065.969670151621;6098.29869564988;6111.724972376165;6131.356207598138;6199.287081985449;5600.439956004367;5608.046632072639;5635.549156067586;5641.153826925994;5716.228309178374;5671.688057156896;5698;5702.173184888251;5771.422857714195;5796.710164491843 13:02:48 INFO - 2015-10-30 13:02:48,338 DEBUG : BROWSER_OUTPUT: |4;prototype.html;265.6029236291744;268.4617342228831;273.0797213390873;273.30989252138363;278.9888404463822;5334.279872217249;5398.595105367099;5412.512873841353;5414.187871819224;5494.258275132851;5243.9213411798855;5366.677999320043;5395.865103372417;5405.864853378667;5405.891882162355;4085.0808568072243;4104.712670113093;4116.5060192776755;4117.608827161415;4118.135191609766;3938.684905207591;3985;4023.034471726779;4070;4074.775887326196;3936.6850651947775;4010.8596199133035;4021.4973128358956;4073.429719839225;4078.632923036926;3888.8833334999995;3990.102226998931;3997.060690737674;4076.8165432555606;4079.3065178919655;3430.879919202841;3440.17435815405;3454.913627159316;3484.843182056788;3505.5968563615;5147.356580427447;5179.7410129493755;5191.117510023305;5192.870178245574;5203.1414816555225;4496.662750293741;4566;4566.954330456686;4620.5841474267145;4623.30650402439;5516.227728118067;5538.9169162462595;5550.27846379972;5567.832965011056;5576.052071147874;3768.7550309229814;3773.13217959868;3791.165943492455;3824.0248736572275;3832.1952389998132;5736.906937932134;5757.453041961007;5764.33710123337;5790.305163380379;5855.238818953509;3834.9233015339537;3842.366009608383;3843.5003449551937;3864;3879.4956655634587;3680.392735198662;3894.7857867816974;3896.922061558753;3912.765234085964;3978.980105099456;4442.400275962768;4448.35498852671;4448.733076015449;4462.509123996358;4465.486469056035;5415.296011518478;5432.076546987022;5435.592330575144;5443.265159203536;5559.638623489541;1320.4982106799355;1363.5841068474012;1388.8472268050507;1397.357215680778;1402.0045767504982;858.8969323681073;882.1266945723816;885.4864178776294;885.9069797671281;887.1394747095308;5214.270002199695;5244.685318880803;5266.1574148136115;5295.391030031596;5302.3637163540625;5655.179998900218;5676.971615141981;5717.942820571824;5730.799422020209;5738.024535828836;5219.243209734643;5324.787008519694;5342.706151161723;5389.218563308298;5393.973030134903;3188.2348236423554;3193.5050067239613;3204.951925721116;3215.903522894317;3217.2117831131523;5825.009748342792;5846.795362162304;5866.208061911672;5880.911786323209;5910.852228694231;5652.943470565324;5913.970430147821;5924.14099955504;5934.050551911673;5944.554158438134;5844.094165404369;5866.823995280149;5928.762849486058;5973.133895585116;5978.432048955342;5842;5843.977303971703;5882.058870580687;5892.823215303548;5918.112283157388;5504.779808807763;5669.4047125051275;5774.2782152230975;5789.131630255495;5821.534277257894;5822.82531524055;5838.824835254949;5840.2991641003355;5955.255593050869;5969.641821490724;3840.4047372657283;3866.168773713665;3918.2359439908946;3932.8820135395986;3934.9409758854213;5702.287214098238;5790.449907258803;5800.477956983892;5828.0966450200285;5829.94170058294;5481.972590137024;5544.61187716856;5576.33084029919;5658.179563963285;5743.10981797822;5569.610127291051;5616.297962754656;5618.85952851182;5639.605227634026;5663.773449062156;5458.372287187024;5511.834644960658;5535.225068490495;5536.031194541019;5540.639858409352;5508.807191748269;5654.236678048411;5661.0659241226385;5663.32040155184;5674.971625141848;5437.700926449083;5505.091659876076;5510;5541.667499950016;5566.137248726453 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: |5;yui.html;556.7967691792497;565.7001789051801;572.5248044123379;590.7902694543437;667.9666016699165;13485;13635.386407611657;13821.516246931373;14089.295535223224;14089.731924126827;12555.372231388417;12596.307203103826;12635.62093137205;12652.43064062117;12725.681857953556;630.5208041888152;647.4981889035988;770.5761830992959;777.378097521983;793.464411522223;795.932345750612;799.8480288745149;804.7585724282721;805.6012273924416;805.8468890910738;809.5062012172571;810.1007881251805;812.4150611559697;819.8319344534386;820.8235229425673;612.8375980365207;653.9444147247466;793.3296364571928;800.8358286551243;807.1565214350959;587.7825204674255;590.6515156057947;592.7806711516723;598.3388355866748;601.482724856623;11777.352245626487;11958.581449649308;12004.399780011052;12028.63914082579;12035.217710848854;8031.759047228593;8107.756767296991;8204.83590328196;8425.70510032146;8523.360747943867;7841.411894107908;8001.679932802681;8026.357891368676;8033.477823941425;8101.5544145072;2509.7992160627105;2514.157757151338;2555.8083143764293;2576.471823276224;2615.1500762252153;40746.38880416796;41307.7934610328;41642.58357416417;41892.79053604743;42581.36127958083;5548.361938377057;5577.135543990688;5580.218769372291;5660.716964151776;5776.913346299809;9689.854652180224;9707.126358627758;9708.757281067888;9817.852732209023;9824.754381140387;5287.973560132252;5296.92054619181;5329.18807605416;5412.83761487156;5469.863253418617;3127.4526957782296;3201.4717571600427;3239.3294578076534;3258.332041931398;3413.300273443938;2325.976740232576;2358.316088334398;2361.504084142315;2362.267697013897;2363.763623637657;349.8023616656581;349.81809459081137;351.6278885488181;354.1924412339869;354.6028448138102;492.88663607370506;503.75819606589044;512.451676705921;513.958883289336;516.3622925686774;6645.568038077509;6781.62701051437;6874.862502749917;7077.186123595749;7147.714091436388;344.1538476796876;447.95296493867676;453.17748286859245;519.9168133098686;541.2746919128308;3205.8557364918634;3385.306012267479;3391.6777906098882;3475.2354482013916;3504.404251277289;53123.73438132785;53245.733771331674;53343;53521.73239133857;53852.46147538553;42167.36748948768;42872.356914646305;42926.35610465846;43015.35476967848;45360;40505.59494405018;40798.38802417966;41084.79457602693;41220.38169427461;41637;7296.233895441114;7352.742654007084;7396.408287337108;7448.776536703907;7520.586367749826;29224.707752922197;29401.264968375963;30418.239544011576;30651;30715.539266911463;39494.80252598719;40277;40807.59192408038;41329.52022878637;41659;6516.446102081376;6531.771388001397;6587;6700.061991321317;6777.762778302736;9718.562664680248;9767.316287860065;9769.462679552693;9869.506524673594;10489.580416783243;8918.420302680304;8980.910190898006;9025.3231007676;9169.587368568296;9493.715188544355;9119.452832830051;9141.77145571366;9415.116991546169;9613.134817866425;9722.854157187789;8767.824643506967;9010.189082982562;9043.366964312698;9158.67944621935;9165.220956218529;7959.204079592226;8004.439689221698;8158.184181581794;8322.250997410261;8340.87488687658;7378;7873.685052598061;7974.441789074709;8037.316828069445;8281.627326770189 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: __startTimestamp1446235368325__endTimestamp 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,340 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:02:48 INFO - 2015-10-30 13:02:48,341 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:02:48 INFO - 2015-10-30 13:02:48,341 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,341 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4675.80 Median:4849.05 stddev:483.98 (10.0%) stddev-sans-first:462.69 13:02:48 INFO - 2015-10-30 13:02:48,341 DEBUG : BROWSER_OUTPUT: Values: 2805.5 2848.2 2859.3 2888.5 2903.3 4678.3 4708.2 4849.1 4862.7 4892.1 4700.9 4735.8 4853.8 4879.1 4900.4 4324.6 4331.2 4368.7 4441.8 4498.6 4365.7 4460.7 4462.9 4478.5 4480.4 4262.4 4361.5 4366.9 4433.2 4444.3 4338.4 4343.7 4372.2 4388.0 4417.6 4265.7 4289.2 4292.4 4350.9 4362.8 4524.8 4646.5 4657.5 4673.9 4702.8 4786.6 4888.4 4918.0 4933.0 4934.5 4989.3 5004.0 5039.6 5127.9 5191.2 4561.6 4667.2 4673.7 4693.5 4715.1 5050.1 5056.6 5059.8 5099.8 5114.4 4794.5 4885.8 4902.2 4911.2 4914.3 4768.5 4931.1 4994.5 5006.4 5029.3 4887.9 4896.6 4911.6 4927.9 4958.2 4906.3 4951.8 4970.6 4992.6 4998.8 3796.5 3884.7 3892.6 3903.1 3975.5 3367.1 3443.3 3508.2 3510.9 3518.8 4657.1 4668.3 4692.6 4719.9 4729.3 4858.1 4940.3 4991.8 5040.6 5143.5 4647.6 4653.2 4655.0 4673.6 4694.7 4516.2 4520.9 4521.1 4532.4 4632.9 4889.6 5113.9 5175.6 5187.1 5203.8 4814.0 4951.2 4984.0 5095.9 5104.6 5105.2 5121.5 5157.1 5168.6 5169.5 4773.3 4949.7 4956.4 5021.7 5030.8 4894.3 4989.3 5011.0 5072.4 5118.5 4735.8 4965.7 4973.5 4974.4 5012.7 4764.4 4895.9 4958.8 4966.7 5029.0 4535.9 4818.5 4818.8 4835.3 4841.4 4882.0 4906.0 4910.3 4953.4 5076.0 4642.2 4860.7 4864.0 4900.8 4918.6 13:02:48 INFO - 2015-10-30 13:02:48,341 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,341 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39943.29 Median:31146.00 stddev:64731.14 (207.8%) stddev-sans-first:64844.91 13:02:48 INFO - 2015-10-30 13:02:48,345 DEBUG : BROWSER_OUTPUT: Values: 480.2 484.7 494.2 507.9 520.0 27136.6 28403.6 34182.3 34713.7 34880.0 37231.6 37232.8 37816.1 37906.8 37934.4 7177.4 7985.2 8199.7 8354.7 8368.7 7470.3 9681.8 9929.8 9983.0 9997.8 9518.2 9630.6 9661.7 9758.8 9884.5 7520.9 7695.3 9704.1 9796.0 9941.7 9328.0 9422.2 9606.7 9705.4 9756.0 35526.3 35533.8 35625.5 35896.0 36079.8 2598.8 2610.6 2666.1 2692.2 3070.1 23394.0 23739.8 24095.4 24434.1 24624.4 1946.9 2008.2 2028.2 2057.9 2133.4 238537.0 238940.0 239215.0 240496.0 242901.0 51743.7 52050.0 52124.0 52130.0 52390.7 49591.0 49918.5 50513.2 52990.0 53064.7 14557.3 14708.9 14893.7 14919.3 15098.3 10497.0 10895.5 10992.6 11063.8 11064.8 14147.4 14895.6 15867.4 15969.0 16861.4 7447.4 7806.3 7836.0 7854.6 7921.7 793.3 811.3 902.4 930.7 946.1 24511.6 25100.7 25251.0 25957.5 26104.3 924.4 929.2 951.1 955.0 1038.3 11777.4 12043.6 12080.0 12151.0 12201.6 272935.0 274641.0 277353.0 279813.0 279881.0 45949.8 45968.8 46290.0 46540.0 46657.0 1225.0 1231.3 1245.5 1250.3 1250.8 23643.9 24690.9 25711.7 26186.9 26305.3 44329.8 44429.6 44931.6 44941.8 44973.0 222817.0 223999.0 225373.0 225813.0 226808.0 25551.0 26737.7 26971.2 27050.5 27416.7 31507.4 31651.5 37454.3 40590.8 40628.2 30264.4 31117.0 31378.4 31582.5 31621.2 30187.4 30531.4 31083.2 31145.0 31147.0 26885.6 27613.7 31201.2 32478.8 32489.2 24629.6 27472.3 27830.6 27863.7 27932.2 20799.5 20859.3 20908.2 29182.7 29814.6 13:02:48 INFO - 2015-10-30 13:02:48,345 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,345 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22557.88 Median:21650.39 stddev:72961.12 (337.0%) stddev-sans-first:73146.63 13:02:48 INFO - 2015-10-30 13:02:48,345 DEBUG : BROWSER_OUTPUT: Values: 289.1 291.9 301.1 301.2 304.4 14764.6 15242.0 15914.3 16121.8 16122.4 14945.2 15235.5 15407.6 15413.9 15563.1 3752.5 3905.5 3909.3 3912.9 3981.5 3822.4 3852.7 3861.1 3875.7 3900.3 3879.5 3921.8 3929.4 3939.2 3995.5 3918.5 3921.0 3935.2 3954.1 3954.9 3197.2 3396.6 3401.6 3410.5 3420.3 11511.5 11638.6 11770.9 11821.5 11884.0 1510.0 1539.3 1733.1 1739.1 1758.2 8112.1 8241.6 8428.8 8472.8 8492.1 1357.5 1362.1 1364.7 1369.7 1382.6 39375.0 50811.5 51667.5 53776.7 54364.2 5433.3 5442.3 5609.1 5671.5 5709.2 6487.4 6493.1 6497.3 6537.8 6650.2 4793.1 4829.8 4866.3 4868.1 4898.5 5110.1 5211.7 5213.7 5274.3 5274.9 2536.0 2596.1 2610.0 2617.1 2656.8 916.4 925.6 932.5 937.2 977.3 369.5 402.8 403.2 406.8 423.1 10086.1 10485.1 10513.6 10587.8 10615.9 355.7 406.1 412.6 426.6 427.0 5400.9 5482.5 5723.7 5756.5 5919.9 429388.0 435110.0 452086.0 452410.0 457538.0 48836.5 59057.0 60812.0 64226.0 64499.0 395.8 404.9 405.8 408.3 408.9 8577.4 8589.1 8695.3 8811.9 8856.3 26203.5 29779.1 30153.7 30696.8 30970.5 42873.8 43009.4 43181.8 43269.4 43814.3 6778.2 6866.2 6945.6 6959.1 7019.9 10336.6 10554.3 10595.4 10595.5 10643.2 8948.3 9122.5 9170.1 9221.0 9230.0 8191.9 8549.3 8748.6 8783.8 8794.6 8866.6 8906.9 9104.5 9143.7 9288.9 6588.3 6760.2 6761.8 6770.2 6772.0 7911.4 8383.6 8403.5 8446.9 8951.5 13:02:48 INFO - 2015-10-30 13:02:48,345 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,346 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4743.87 Median:6129.90 stddev:2480.22 (40.5%) stddev-sans-first:2474.35 13:02:48 INFO - 2015-10-30 13:02:48,347 DEBUG : BROWSER_OUTPUT: Values: 1387.2 1459.1 1516.9 1544.0 1584.4 6235.8 6562.7 6919.6 7030.5 7146.0 6812.6 6902.6 6964.3 6977.7 7078.0 1943.6 1950.4 1960.5 1980.8 1980.9 1966.9 1992.7 2019.2 2027.8 2029.7 1875.3 1937.9 1950.7 1951.9 1955.5 1937.5 1945.5 1945.5 1965.2 1965.7 1956.5 1973.4 1988.4 2005.0 2005.9 6117.0 6845.6 6882.7 6896.6 7019.8 3860.0 4115.5 4218.9 4286.8 4311.1 2413.6 2433.2 2464.0 2471.4 2486.4 692.3 712.7 724.6 726.8 728.7 8921.2 9043.4 9064.7 9131.5 9177.8 3679.2 3745.9 3758.6 3764.7 3820.8 7382.9 7415.5 7420.4 7485.0 7514.4 4198.6 4216.0 4260.4 4274.9 4282.7 3903.9 3920.7 3934.2 3952.7 3953.9 2834.6 2908.2 2931.2 2944.6 2986.1 916.8 917.2 930.3 935.5 937.1 890.8 941.2 941.9 971.1 971.1 6595.1 6680.8 6692.2 6699.0 6718.1 413.5 414.7 418.4 422.4 425.6 5212.8 5275.5 5282.4 5355.6 5362.8 7537.0 7665.3 7892.7 7971.5 8065.1 7974.2 8022.4 8041.6 8116.3 8141.5 6241.7 6446.2 6481.8 6539.4 6593.4 6354.3 6428.0 6459.5 6476.7 6554.2 7018.7 7253.3 7255.9 7340.6 7357.9 7288.6 7446.6 7483.3 7522.3 7606.8 6028.8 6053.6 6187.9 6191.0 6191.8 6504.6 6608.4 6658.8 6663.1 6669.9 6128.4 6138.6 6216.3 6246.2 6323.1 5853.5 5895.8 6102.3 6107.9 6210.3 6066.0 6098.3 6111.7 6131.4 6199.3 5600.4 5608.0 5635.5 5641.2 5716.2 5671.7 5698.0 5702.2 5771.4 5796.7 13:02:48 INFO - 2015-10-30 13:02:48,347 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,347 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4657.04 Median:5405.88 stddev:1420.08 (26.3%) stddev-sans-first:1385.28 13:02:48 INFO - 2015-10-30 13:02:48,348 DEBUG : BROWSER_OUTPUT: Values: 265.6 268.5 273.1 273.3 279.0 5334.3 5398.6 5412.5 5414.2 5494.3 5243.9 5366.7 5395.9 5405.9 5405.9 4085.1 4104.7 4116.5 4117.6 4118.1 3938.7 3985.0 4023.0 4070.0 4074.8 3936.7 4010.9 4021.5 4073.4 4078.6 3888.9 3990.1 3997.1 4076.8 4079.3 3430.9 3440.2 3454.9 3484.8 3505.6 5147.4 5179.7 5191.1 5192.9 5203.1 4496.7 4566.0 4567.0 4620.6 4623.3 5516.2 5538.9 5550.3 5567.8 5576.1 3768.8 3773.1 3791.2 3824.0 3832.2 5736.9 5757.5 5764.3 5790.3 5855.2 3834.9 3842.4 3843.5 3864.0 3879.5 3680.4 3894.8 3896.9 3912.8 3979.0 4442.4 4448.4 4448.7 4462.5 4465.5 5415.3 5432.1 5435.6 5443.3 5559.6 1320.5 1363.6 1388.8 1397.4 1402.0 858.9 882.1 885.5 885.9 887.1 5214.3 5244.7 5266.2 5295.4 5302.4 5655.2 5677.0 5717.9 5730.8 5738.0 5219.2 5324.8 5342.7 5389.2 5394.0 3188.2 3193.5 3205.0 3215.9 3217.2 5825.0 5846.8 5866.2 5880.9 5910.9 5652.9 5914.0 5924.1 5934.1 5944.6 5844.1 5866.8 5928.8 5973.1 5978.4 5842.0 5844.0 5882.1 5892.8 5918.1 5504.8 5669.4 5774.3 5789.1 5821.5 5822.8 5838.8 5840.3 5955.3 5969.6 3840.4 3866.2 3918.2 3932.9 3934.9 5702.3 5790.4 5800.5 5828.1 5829.9 5482.0 5544.6 5576.3 5658.2 5743.1 5569.6 5616.3 5618.9 5639.6 5663.8 5458.4 5511.8 5535.2 5536.0 5540.6 5508.8 5654.2 5661.1 5663.3 5675.0 5437.7 5505.1 5510.0 5541.7 5566.1 13:02:48 INFO - 2015-10-30 13:02:48,348 DEBUG : BROWSER_OUTPUT: 13:02:48 INFO - 2015-10-30 13:02:48,348 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11588.30 Median:3113.21 stddev:14300.88 (459.4%) stddev-sans-first:14317.00 13:02:48 INFO - 2015-10-30 13:02:48,349 DEBUG : BROWSER_OUTPUT: Values: 556.8 565.7 572.5 590.8 668.0 13485.0 13635.4 13821.5 14089.3 14089.7 12555.4 12596.3 12635.6 12652.4 12725.7 630.5 647.5 770.6 777.4 793.5 795.9 799.8 804.8 805.6 805.8 809.5 810.1 812.4 819.8 820.8 612.8 653.9 793.3 800.8 807.2 587.8 590.7 592.8 598.3 601.5 11777.4 11958.6 12004.4 12028.6 12035.2 8031.8 8107.8 8204.8 8425.7 8523.4 7841.4 8001.7 8026.4 8033.5 8101.6 2509.8 2514.2 2555.8 2576.5 2615.2 40746.4 41307.8 41642.6 41892.8 42581.4 5548.4 5577.1 5580.2 5660.7 5776.9 9689.9 9707.1 9708.8 9817.9 9824.8 5288.0 5296.9 5329.2 5412.8 5469.9 3127.5 3201.5 3239.3 3258.3 3413.3 2326.0 2358.3 2361.5 2362.3 2363.8 349.8 349.8 351.6 354.2 354.6 492.9 503.8 512.5 514.0 516.4 6645.6 6781.6 6874.9 7077.2 7147.7 344.2 448.0 453.2 519.9 541.3 3205.9 3385.3 3391.7 3475.2 3504.4 53123.7 53245.7 53343.0 53521.7 53852.5 42167.4 42872.4 42926.4 43015.4 45360.0 40505.6 40798.4 41084.8 41220.4 41637.0 7296.2 7352.7 7396.4 7448.8 7520.6 29224.7 29401.3 30418.2 30651.0 30715.5 39494.8 40277.0 40807.6 41329.5 41659.0 6516.4 6531.8 6587.0 6700.1 6777.8 9718.6 9767.3 9769.5 9869.5 10489.6 8918.4 8980.9 9025.3 9169.6 9493.7 9119.5 9141.8 9415.1 9613.1 9722.9 8767.8 9010.2 9043.4 9158.7 9165.2 7959.2 8004.4 8158.2 8322.3 8340.9 7378.0 7873.7 7974.4 8037.3 8281.6 13:02:48 INFO - 2015-10-30 13:02:48,349 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:02:48 INFO - 2015-10-30 13:02:48,349 DEBUG : BROWSER_OUTPUT: 13:02:49 INFO - 2015-10-30 13:02:49,051 INFO : Browser exited with error code: 0 13:02:49 INFO - 2015-10-30 13:02:49,082 INFO : Completed test dromaeo_css (00:18:35) 13:02:49 INFO - 2015-10-30 13:02:49,082 INFO : Starting test kraken 13:02:49 INFO - 2015-10-30 13:02:49,083 DEBUG : operating with platform_type : mac_ 13:02:49 INFO - 2015-10-30 13:02:49,083 INFO : Initialising browser for kraken test... 13:02:49 INFO - 2015-10-30 13:02:49,100 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/tmpBNlWj0/profile http://localhost:49269/getInfo.html 13:02:51 INFO - 2015-10-30 13:02:51,558 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:02:51 INFO - 2015-10-30 13:02:51,558 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:02:51 INFO - 2015-10-30 13:02:51,558 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:02:51 INFO - 2015-10-30 13:02:51,558 DEBUG : BROWSER_OUTPUT: __metrics 13:02:51 INFO - 2015-10-30 13:02:51,576 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:02:52 INFO - 2015-10-30 13:02:52,334 INFO : Browser initialized. 13:02:52 INFO - 2015-10-30 13:02:52,334 INFO : Running cycle 1/1 for kraken test... 13:02:52 INFO - 2015-10-30 13:02:52,334 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/tmpBNlWj0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:03:04 INFO - 2015-10-30 13:03:04,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 222941184 13:03:04 INFO - 2015-10-30 13:03:04,375 DEBUG : BROWSER_OUTPUT: 13:03:07 INFO - 2015-10-30 13:03:07,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 13:03:07 INFO - 2015-10-30 13:03:07,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 277385216 13:03:07 INFO - 2015-10-30 13:03:07,717 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2015-10-30 13:03:10,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 13:03:11 INFO - 2015-10-30 13:03:11,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 279724032 13:03:11 INFO - 2015-10-30 13:03:11,298 DEBUG : BROWSER_OUTPUT: 13:03:14 INFO - 2015-10-30 13:03:14,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 13:03:15 INFO - 2015-10-30 13:03:15,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 264953856 13:03:15 INFO - 2015-10-30 13:03:15,130 DEBUG : BROWSER_OUTPUT: 13:03:17 INFO - 2015-10-30 13:03:17,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 13:03:17 INFO - 2015-10-30 13:03:17,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 272543744 13:03:17 INFO - 2015-10-30 13:03:17,950 DEBUG : BROWSER_OUTPUT: 13:03:20 INFO - 2015-10-30 13:03:20,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:21 INFO - 2015-10-30 13:03:21,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 264720384 13:03:21 INFO - 2015-10-30 13:03:21,044 DEBUG : BROWSER_OUTPUT: 13:03:24 INFO - 2015-10-30 13:03:24,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:25 INFO - 2015-10-30 13:03:25,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 271937536 13:03:25 INFO - 2015-10-30 13:03:25,017 DEBUG : BROWSER_OUTPUT: 13:03:28 INFO - 2015-10-30 13:03:28,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:29 INFO - 2015-10-30 13:03:29,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 269213696 13:03:29 INFO - 2015-10-30 13:03:29,097 DEBUG : BROWSER_OUTPUT: 13:03:32 INFO - 2015-10-30 13:03:32,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 13:03:32 INFO - 2015-10-30 13:03:32,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 268771328 13:03:32 INFO - 2015-10-30 13:03:32,885 DEBUG : BROWSER_OUTPUT: 13:03:34 INFO - 2015-10-30 13:03:34,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:35 INFO - 2015-10-30 13:03:35,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 300699648 13:03:35 INFO - 2015-10-30 13:03:35,128 DEBUG : BROWSER_OUTPUT: 13:03:37 INFO - 2015-10-30 13:03:37,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:37 INFO - 2015-10-30 13:03:37,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 299192320 13:03:37 INFO - 2015-10-30 13:03:37,652 DEBUG : BROWSER_OUTPUT: 13:03:39 INFO - 2015-10-30 13:03:39,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:40 INFO - 2015-10-30 13:03:40,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 315834368 13:03:40 INFO - 2015-10-30 13:03:40,512 DEBUG : BROWSER_OUTPUT: 13:03:43 INFO - 2015-10-30 13:03:43,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:43 INFO - 2015-10-30 13:03:43,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 317259776 13:03:43 INFO - 2015-10-30 13:03:43,964 DEBUG : BROWSER_OUTPUT: 13:03:46 INFO - 2015-10-30 13:03:46,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:47 INFO - 2015-10-30 13:03:47,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 313933824 13:03:47 INFO - 2015-10-30 13:03:47,428 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 13:03:49 INFO - 2015-10-30 13:03:49,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 368267264 13:03:49 INFO - 2015-10-30 13:03:49,587 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,587 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:03:49 INFO - 2015-10-30 13:03:49,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:03:49 INFO - 2015-10-30 13:03:49,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:03:49 INFO - 2015-10-30 13:03:49,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;107;125;109;128;122;125;127;126;123 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;155;179;190;166;163;165;163;181;188 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;186;185;186;180;181;186;186;184;178 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;91;95;111;93;94;95;94;101;93 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;116;117;153;119;122;122;157;116;120;165 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;143;136;135;136;142;142;139;130;136;142 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;145;142;148;148;147;142;147;148 13:03:49 INFO - 2015-10-30 13:03:49,588 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;119;118;119;119;119;117;118;119;117 13:03:49 INFO - 2015-10-30 13:03:49,589 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;64;65;65;66;68;69;77;66;67 13:03:49 INFO - 2015-10-30 13:03:49,589 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;72;73;73;75;76;74;76;80;72 13:03:49 INFO - 2015-10-30 13:03:49,589 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;96;100;100;98;98;100;100;101;100 13:03:49 INFO - 2015-10-30 13:03:49,589 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;140;148;149;149;161;147;153;144;154;152 13:03:49 INFO - 2015-10-30 13:03:49,589 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;159;177;177;178;178;159;172;175;180;167 13:03:49 INFO - 2015-10-30 13:03:49,589 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;83;82;86;85;84;84;85;86;86 13:03:49 INFO - 2015-10-30 13:03:49,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:03:49 INFO - 2015-10-30 13:03:49,590 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:03:49 INFO - 2015-10-30 13:03:49,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 13:03:49 INFO - 2015-10-30 13:03:49,590 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:03:49 INFO - 2015-10-30 13:03:49,590 DEBUG : BROWSER_OUTPUT: __startTimestamp1446235429585__endTimestamp 13:03:49 INFO - 2015-10-30 13:03:49,591 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,591 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:03:49 INFO - 2015-10-30 13:03:49,591 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:03:49 INFO - 2015-10-30 13:03:49,591 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,591 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.90 Median:125.00 stddev:7.48 (6.0%) stddev-sans-first:7.79 13:03:49 INFO - 2015-10-30 13:03:49,591 DEBUG : BROWSER_OUTPUT: Values: 117.0 107.0 125.0 109.0 128.0 122.0 125.0 127.0 126.0 123.0 13:03:49 INFO - 2015-10-30 13:03:49,592 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,593 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:170.10 Median:172.50 stddev:13.54 (7.9%) stddev-sans-first:12.48 13:03:49 INFO - 2015-10-30 13:03:49,593 DEBUG : BROWSER_OUTPUT: Values: 151.0 155.0 179.0 190.0 166.0 163.0 165.0 163.0 181.0 188.0 13:03:49 INFO - 2015-10-30 13:03:49,593 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,594 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.20 Median:185.50 stddev:3.12 (1.7%) stddev-sans-first:3.09 13:03:49 INFO - 2015-10-30 13:03:49,594 DEBUG : BROWSER_OUTPUT: Values: 180.0 186.0 185.0 186.0 180.0 181.0 186.0 186.0 184.0 178.0 13:03:49 INFO - 2015-10-30 13:03:49,594 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,594 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.50 Median:93.50 stddev:6.36 (6.8%) stddev-sans-first:6.14 13:03:49 INFO - 2015-10-30 13:03:49,594 DEBUG : BROWSER_OUTPUT: Values: 88.0 91.0 95.0 111.0 93.0 94.0 95.0 94.0 101.0 93.0 13:03:49 INFO - 2015-10-30 13:03:49,595 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,595 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:130.70 Median:122.00 stddev:19.40 (15.9%) stddev-sans-first:19.84 13:03:49 INFO - 2015-10-30 13:03:49,595 DEBUG : BROWSER_OUTPUT: Values: 116.0 117.0 153.0 119.0 122.0 122.0 157.0 116.0 120.0 165.0 13:03:49 INFO - 2015-10-30 13:03:49,595 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,595 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:138.10 Median:140.50 stddev:4.20 (3.0%) stddev-sans-first:4.07 13:03:49 INFO - 2015-10-30 13:03:49,595 DEBUG : BROWSER_OUTPUT: Values: 143.0 136.0 135.0 136.0 142.0 142.0 139.0 130.0 136.0 142.0 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:147.50 stddev:2.39 (1.6%) stddev-sans-first:2.52 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 145.0 142.0 148.0 148.0 147.0 142.0 147.0 148.0 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.90 Median:119.00 stddev:1.60 (1.3%) stddev-sans-first:0.87 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: Values: 114.0 119.0 118.0 119.0 119.0 119.0 117.0 118.0 119.0 117.0 13:03:49 INFO - 2015-10-30 13:03:49,596 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.50 stddev:4.37 (6.6%) stddev-sans-first:3.91 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: Values: 60.0 64.0 65.0 65.0 66.0 68.0 69.0 77.0 66.0 67.0 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:74.50 stddev:2.98 (4.0%) stddev-sans-first:2.55 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 73.0 73.0 75.0 76.0 74.0 76.0 80.0 72.0 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,597 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.40 Median:96.00 stddev:2.99 (3.1%) stddev-sans-first:1.56 13:03:49 INFO - 2015-10-30 13:03:49,598 DEBUG : BROWSER_OUTPUT: Values: 91.0 96.0 100.0 100.0 98.0 98.0 100.0 100.0 101.0 100.0 13:03:49 INFO - 2015-10-30 13:03:49,598 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,599 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:150.50 stddev:5.77 (3.8%) stddev-sans-first:4.94 13:03:49 INFO - 2015-10-30 13:03:49,599 DEBUG : BROWSER_OUTPUT: Values: 140.0 148.0 149.0 149.0 161.0 147.0 153.0 144.0 154.0 152.0 13:03:49 INFO - 2015-10-30 13:03:49,599 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,599 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:177.00 stddev:7.87 (4.4%) stddev-sans-first:6.75 13:03:49 INFO - 2015-10-30 13:03:49,599 DEBUG : BROWSER_OUTPUT: Values: 159.0 177.0 177.0 178.0 178.0 159.0 172.0 175.0 180.0 167.0 13:03:49 INFO - 2015-10-30 13:03:49,600 DEBUG : BROWSER_OUTPUT: 13:03:49 INFO - 2015-10-30 13:03:49,600 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.10 Median:85.00 stddev:1.97 (2.3%) stddev-sans-first:1.42 13:03:49 INFO - 2015-10-30 13:03:49,600 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 82.0 86.0 85.0 84.0 84.0 85.0 86.0 86.0 13:03:49 INFO - 2015-10-30 13:03:49,600 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:03:49 INFO - 2015-10-30 13:03:49,600 DEBUG : BROWSER_OUTPUT: 13:03:50 INFO - 2015-10-30 13:03:50,321 INFO : Browser exited with error code: 0 13:03:50 INFO - 2015-10-30 13:03:50,374 INFO : Completed test kraken (00:01:01) 13:03:50 INFO - 2015-10-30 13:03:50,374 INFO : Starting test v8_7 13:03:50 INFO - 2015-10-30 13:03:50,374 DEBUG : operating with platform_type : mac_ 13:03:50 INFO - 2015-10-30 13:03:50,374 INFO : Initialising browser for v8_7 test... 13:03:50 INFO - 2015-10-30 13:03:50,389 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/tmpJQ6jfI/profile http://localhost:49269/getInfo.html 13:03:52 INFO - 2015-10-30 13:03:52,929 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:03:52 INFO - 2015-10-30 13:03:52,930 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:03:52 INFO - 2015-10-30 13:03:52,930 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:03:52 INFO - 2015-10-30 13:03:52,930 DEBUG : BROWSER_OUTPUT: __metrics 13:03:52 INFO - 2015-10-30 13:03:52,950 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:53 INFO - 2015-10-30 13:03:53,256 DEBUG : BROWSER_OUTPUT: console.error: 13:03:53 INFO - 2015-10-30 13:03:53,257 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: Stack: 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 13:03:53 INFO - 2015-10-30 13:03:53,258 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 13:03:53 INFO - 2015-10-30 13:03:53,259 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:03:53 INFO - 2015-10-30 13:03:53,259 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 13:03:53 INFO - 2015-10-30 13:03:53,259 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:03:53 INFO - 2015-10-30 13:03:53,259 DEBUG : BROWSER_OUTPUT: 13:03:53 INFO - 2015-10-30 13:03:53,735 INFO : Browser initialized. 13:03:53 INFO - 2015-10-30 13:03:53,735 INFO : Running cycle 1/1 for v8_7 test... 13:03:53 INFO - 2015-10-30 13:03:53,735 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/T/tmpJQ6jfI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:04:05 INFO - 2015-10-30 13:04:05,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 222998528 13:04:05 INFO - 2015-10-30 13:04:05,763 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 13:04:28 INFO - 2015-10-30 13:04:28,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 734814208 13:04:28 INFO - 2015-10-30 13:04:28,614 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: |0;Richards;180.8972503617945 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.27272727272728 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: |2;Encrypt;355.6187766714082 13:04:28 INFO - 2015-10-30 13:04:28,615 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6731.543624161074 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2333.3333333333335 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: |5;Earley;1035.1966873706003 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: |6;Boyer;14069.444444444445 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: |7;RegExp;32967.74193548387 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: |8;Splay;754.7169811320755 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6535.9477124183 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: __startTimestamp1446235468605__endTimestamp 13:04:28 INFO - 2015-10-30 13:04:28,616 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:180.90 Median:180.90 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: Values: 180.9 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,617 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.27 Median:227.27 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: Values: 227.3 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:355.62 Median:355.62 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: Values: 355.6 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6731.54 Median:6731.54 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,618 DEBUG : BROWSER_OUTPUT: Values: 6731.5 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2333.33 Median:2333.33 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: Values: 2333.3 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1035.20 Median:1035.20 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: Values: 1035.2 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,619 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14069.44 Median:14069.44 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: Values: 14069.4 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32967.74 Median:32967.74 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: Values: 32967.7 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:754.72 Median:754.72 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: Values: 754.7 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: 13:04:28 INFO - 2015-10-30 13:04:28,620 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6535.95 Median:6535.95 stddev:0.00 (0.0%) 13:04:28 INFO - 2015-10-30 13:04:28,621 DEBUG : BROWSER_OUTPUT: Values: 6535.9 13:04:28 INFO - 2015-10-30 13:04:28,621 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:04:28 INFO - 2015-10-30 13:04:28,621 DEBUG : BROWSER_OUTPUT: 13:04:29 INFO - 2015-10-30 13:04:29,361 INFO : Browser exited with error code: 0 13:04:29 INFO - 2015-10-30 13:04:29,384 INFO : Completed test v8_7 (00:00:39) 13:04:29 INFO - 2015-10-30 13:04:29,612 INFO : Completed test suite (00:20:16) 13:04:29 INFO - 2015-10-30 13:04:29,612 DEBUG : Working with test: dromaeo_css 13:04:29 INFO - 2015-10-30 13:04:29,612 DEBUG : Generating results file: dromaeo_css 13:04:29 INFO - 2015-10-30 13:04:29,613 DEBUG : Working with test: kraken 13:04:29 INFO - 2015-10-30 13:04:29,613 DEBUG : Generating results file: kraken 13:04:29 INFO - 2015-10-30 13:04:29,614 INFO : javascript benchmark 13:04:29 INFO - 2015-10-30 13:04:29,614 DEBUG : Working with test: v8_7 13:04:29 INFO - 2015-10-30 13:04:29,614 DEBUG : Generating results file: v8_7 13:04:29 INFO - 2015-10-30 13:04:29,614 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:29 INFO - 2015-10-30 13:04:29,670 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 13:04:29 INFO - 2015-10-30 13:04:29,670 DEBUG : process_Request line: dromaeo_css 5738.27 graph.html#tests=[[72,64,55]] 13:04:29 INFO - 2015-10-30 13:04:29,670 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:29 INFO - 2015-10-30 13:04:29,702 DEBUG : process_Request line: kraken 1747.70 graph.html#tests=[[232,64,55]] 13:04:29 INFO - 2015-10-30 13:04:29,702 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:29 INFO - 2015-10-30 13:04:29,741 DEBUG : process_Request line: v8_7 16078.45 graph.html#tests=[[230,64,55]] 13:04:29 INFO - 2015-10-30 13:04:29,742 INFO : javascript benchmark 13:04:29 INFO - 2015-10-30 13:04:29,744 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [289.13116086161085, 291.9313961219112, 301.08019998903353, 301.2393705892621, 304.3972933591489, 14764.6308842279, 15242.0, 15914.283857226425, 16121.758173627404, 16122.435714749956, 14945.17801520916, 15235.542933712006, 15407.614809629766, 15413.922930385332, 15563.066216027046, 3752.512173417452, 3905.531336239655, 3909.3354129798004, 3912.9021774455723, 3981.542122655903, 3822.388417853144, 3852.7303088783797, 3861.0540417597726, 3875.670568001723, 3900.31744444721, 3879.495665563473, 3921.764694118362, 3929.44987701722, 3939.231849789292, 3995.4805875236325, 3918.45141680165, 3920.9803950980063, 3935.193285376505, 3954.1498577805623, 3954.9209015819665, 3197.1527545200543, 3396.6433524480067, 3401.642827503101, 3410.4823353607653, 3420.2817408344276, 11511.539538418454, 11638.59264925732, 11770.88229117715, 11821.468033938494, 11884.0, 1509.9698006039928, 1539.3150048228542, 1733.1334332833583, 1739.1391261325598, 1758.2285996537482, 8112.067112282045, 8241.629126689313, 8428.8314233715, 8472.78818029548, 8492.065872753992, 1357.518081081212, 1362.1146254934272, 1364.7202323523654, 1369.732902084094, 1382.6059573021641, 39375.0, 50811.49188508104, 51667.48332516664, 53776.731116344556, 54364.18453723197, 5433.26650902131, 5442.346918369742, 5609.102543593006, 5671.51792097668, 5709.200711900337, 6487.448566871774, 6493.090967264587, 6497.317781632955, 6537.771178008747, 6650.168728908887, 4793.065352256346, 4829.758512074382, 4866.343043689128, 4868.123737727243, 4898.53463920927, 5110.105731496973, 5211.739413029409, 5213.713245771519, 5274.340707411574, 5274.894502109936, 2535.961960570593, 2596.143272719998, 2609.960850587243, 2617.1101825379465, 2656.800739944512, 916.4409710076848, 925.648253663617, 932.5197523275518, 937.161240689579, 977.3354119199013, 369.49748342254514, 402.81873157079434, 403.1775178635609, 406.8209987605444, 423.0755798580112, 10086.142677872316, 10485.108765754843, 10513.632022879163, 10587.788244235073, 10615.946920265504, 355.70654210276626, 406.1410117601252, 412.58535172151795, 426.5563813633786, 426.9893252668646, 5400.91898621521, 5482.451754824486, 5723.713814309268, 5756.510696590837, 5919.881602368015, 429388.0, 435110.0, 452086.0, 452410.0, 457538.0, 48836.51163488391, 59057.0, 60812.0, 64226.0, 64499.0, 395.800120938924, 404.93318602430855, 405.84780707234785, 408.29568993486, 408.895731588449, 8577.356698247531, 8589.14108589136, 8695.347848911231, 8811.867821982803, 8856.291496680122, 26203.4759304809, 29779.10662680123, 30153.698463015087, 30696.84651576728, 30970.53544196794, 42873.785631071645, 43009.354859677755, 43181.784091079346, 43269.350959735, 43814.34278485762, 6778.2205046420295, 6866.244713081657, 6945.617991010341, 6959.095317608679, 7019.859602808017, 10336.573154769927, 10554.261201716114, 10595.417252050904, 10595.47022648849, 10643.201759867887, 8948.328875334246, 9122.5438728062, 9170.128837760401, 9221.0, 9230.0, 8191.877121843297, 8549.27331176832, 8748.60631271607, 8783.824323513621, 8794.648214071365, 8866.556672166495, 8906.910930890608, 9104.544772761203, 9143.679971200976, 9288.907110929074, 6588.275289718223, 6760.1549806274215, 6761.797146085625, 6770.187577490733, 6771.966140169465, 7911.406644501801, 8383.622736976973, 8403.453775504573, 8446.915530844859, 8951.462912225288], "dojo.html": [2805.4809860175865, 2848.230977636037, 2859.2708859240893, 2888.5378339465688, 2903.274181454636, 4678.298255261712, 4708.199606066968, 4849.054434385292, 4862.659613827033, 4892.070506603747, 4700.85897423077, 4735.834245801398, 4853.805847766085, 4879.121758083544, 4900.362952816138, 4324.589164029428, 4331.155424692186, 4368.650507959355, 4441.75570343631, 4498.617617502517, 4365.738055716652, 4460.710053846506, 4462.866114016585, 4478.507364189936, 4480.372747815309, 4262.360645903108, 4361.454818147731, 4366.8908277293, 4433.179861725575, 4444.266695995189, 4338.370936214263, 4343.67422443318, 4372.23485889968, 4388.0, 4417.580329868657, 4265.680073994463, 4289.249381358281, 4292.399064131024, 4350.8912277193, 4362.825486980549, 4524.8190072397065, 4646.512116227781, 4657.534246575349, 4673.88315292117, 4702.8118875244945, 4786.617070634341, 4888.388951381077, 4918.0, 4933.01339732055, 4934.481879402647, 4989.301497790312, 5003.974980125113, 5039.571636410909, 5127.897442051175, 5191.221316802472, 4561.635069194523, 4667.229907065364, 4673.696209746356, 4693.507181745936, 4715.104130215213, 5050.141475949097, 5056.64603477753, 5059.848204553869, 5099.77051032697, 5114.41184263807, 4794.472608013116, 4885.755712214375, 4902.240152776325, 4911.18965370717, 4914.262860570871, 4768.451628062748, 4931.0630980113665, 4994.475580064113, 5006.374203224597, 5029.27075574047, 4887.853364399074, 4896.559309662148, 4911.631627627942, 4927.926081108786, 4958.231474121517, 4906.288588154697, 4951.8266860659705, 4970.602351811846, 4992.550670439678, 4998.825041123616, 3796.5064541609413, 3884.7280690351968, 3892.649661530476, 3903.10228647407, 3975.5229372475487, 3367.1413789483527, 3443.2596991646415, 3508.1755787389943, 3510.8946731598094, 3518.7712798668003, 4657.0685862826895, 4668.346431499593, 4692.577668009895, 4719.85840424781, 4729.337892695025, 4858.125537403302, 4940.308356830046, 4991.775370108354, 5040.647154699136, 5143.485651434827, 4647.6281897448125, 4653.232216684277, 4654.999175177353, 4673.626109911199, 4694.694844835075, 4516.187086324493, 4520.909581808345, 4521.1409832131785, 4532.410786597788, 4632.884177895512, 4889.633277504273, 5113.872153196051, 5175.560077393388, 5187.118189907649, 5203.765830537635, 4814.0, 4951.232558953368, 4984.00319936007, 5095.898082038264, 5104.617153713561, 5105.2342148678, 5121.487851214849, 5157.0975079361715, 5168.612354073384, 5169.457206993362, 4773.260144677581, 4949.678270912379, 4956.355673762388, 5021.6735912165595, 5030.798768049237, 4894.339264199288, 4989.301497790385, 5010.9749451253965, 5072.416672082758, 5118.488151184852, 4735.786889589908, 4965.702057876539, 4973.502649734997, 4974.353334066548, 5012.749362531786, 4764.380630518011, 4895.877603059952, 4958.776855041604, 4966.6771659842, 5028.974855125701, 4535.886602834956, 4818.494058123846, 4818.831340903052, 4835.29888166221, 4841.419029716457, 4881.951180488291, 4905.975470122627, 4910.263460480956, 4953.356063711839, 5076.010178015252, 4642.2340313847835, 4860.73265970375, 4864.0, 4900.828471003498, 4918.581920536794], "mootools.html": [1387.2439520461348, 1459.0953608762568, 1516.916569588673, 1543.9845601543989, 1584.3900098462088, 6235.781747638834, 6562.73749050038, 6919.550229235102, 7030.543014704041, 7146.0, 6812.55718378305, 6902.551334163276, 6964.338387853159, 6977.651117444133, 7077.964610176955, 1943.5529828139536, 1950.4441234248243, 1960.5000724815152, 1980.8316293115101, 1980.9405717828488, 1966.8721533100374, 1992.7409436773198, 2019.2125071222235, 2027.7870823563535, 2029.7361343025386, 1875.268645228362, 1937.8643494955359, 1950.7366505521786, 1951.8926459044746, 1955.501347156473, 1937.4575118966711, 1945.5038965063889, 1945.5136215946013, 1965.164804957887, 1965.6560101982095, 1956.5108722819296, 1973.4375702924597, 1988.4134180416668, 2005.0, 2005.9498512537157, 6117.0, 6845.589264644137, 6882.69027893746, 6896.586204827727, 7019.82450438738, 3859.9807000964815, 4115.477273408858, 4218.915621687549, 4286.7856607169515, 4311.094670119279, 2413.6017557103055, 2433.1848830641757, 2464.039024780337, 2471.3821544613847, 2486.4405508760383, 692.2904023376029, 712.6579241963886, 724.6159535446222, 726.8400951790597, 728.6866647341641, 8921.15249051339, 9043.41217820846, 9064.68273610427, 9131.497767622777, 9177.770555736093, 3679.2089700714473, 3745.85016599333, 3758.586555478895, 3764.7364684471822, 3820.751651142667, 7382.852342953111, 7415.480916335805, 7420.443466739908, 7485.0, 7514.361279291212, 4198.5591512891315, 4215.97892010538, 4260.4248426462655, 4274.871753847389, 4282.721623094489, 3903.921921561553, 3920.7059470539825, 3934.2328245991757, 3952.7430717003303, 3953.8616148434667, 2834.631497905259, 2908.171171216193, 2931.1939216715145, 2944.6319210098736, 2986.148947549938, 916.8028873792033, 917.2386918857333, 930.283681565191, 935.4854829843558, 937.1284705224207, 890.7639475538988, 941.1905761045496, 941.8540126280437, 971.0920289529313, 971.0920289529313, 6595.142631457879, 6680.766173184013, 6692.163479565054, 6699.02864084705, 6718.0930574372815, 413.48108124303803, 414.7283529288321, 418.4330232534932, 422.39597375752356, 425.59568410010615, 5212.765425555859, 5275.472452754694, 5282.392524859613, 5355.571554275649, 5362.839114826562, 7537.020187375716, 7665.3101220890385, 7892.723754668559, 7971.521708697497, 8065.072516660659, 7974.242446967529, 8022.358211343078, 8041.597920104088, 8116.310113640407, 8141.470804397695, 6241.687915604201, 6446.194225721785, 6481.773137940149, 6539.444147247537, 6593.406593406617, 6354.26925903527, 6428.0, 6459.515536334699, 6476.676166191577, 6554.246261679968, 7018.684159212949, 7253.310935461122, 7255.891161632474, 7340.632968351454, 7357.889631655423, 7288.599127047851, 7446.553206807609, 7483.251674832473, 7522.285382888617, 7606.8098297543, 6028.819135425769, 6053.606515576474, 6187.938120618916, 6190.969045154746, 6191.783287584913, 6504.577202481823, 6608.43828274602, 6658.800235992928, 6663.067170596218, 6669.866602667822, 6128.448439640276, 6138.570300078952, 6216.285127210429, 6246.219222597176, 6323.051542268697, 5853.473187413153, 5895.793647222326, 6102.328743838086, 6107.931112055461, 6210.3168651449205, 6065.969670151621, 6098.29869564988, 6111.724972376165, 6131.356207598138, 6199.287081985449, 5600.439956004367, 5608.046632072639, 5635.549156067586, 5641.153826925994, 5716.228309178374, 5671.688057156896, 5698.0, 5702.173184888251, 5771.422857714195, 5796.710164491843], "ext.html": [480.19327529750007, 484.68011112665647, 494.19446302526876, 507.8628770232037, 519.9834323896782, 27136.592951105726, 28403.57394639082, 34182.31635367291, 34713.65286347136, 34880.0, 37231.627683723156, 37232.813835930785, 37816.05459863505, 37906.8104659477, 37934.4309835352, 7177.3899218566485, 7985.241402066809, 8199.71301004462, 8354.749357519284, 8368.748937531853, 7470.252974702514, 9681.806363872718, 9929.801403971916, 9982.9500852496, 9997.750056248578, 9518.238540916711, 9630.566624501915, 9661.661841835537, 9758.804823903552, 9884.505774711271, 7520.924790752078, 7695.345895598881, 9704.12662860339, 9796.0, 9941.652042178524, 9327.953360233156, 9422.152006319464, 9606.711798646053, 9705.369151005232, 9755.951220243924, 35526.289474210374, 35533.82233088818, 35625.46561801575, 35896.0, 36079.81960090209, 2598.800247125175, 2610.5953577195373, 2666.0668765931964, 2692.1923422973227, 3070.140360699008, 23394.0, 23739.76260237393, 24095.397615059588, 24434.14480493174, 24624.384390390205, 1946.8929208893505, 2008.2469074097214, 2028.2292728763123, 2057.9279725209694, 2133.381319417367, 238537.0, 238940.0, 239214.99999999825, 240496.0, 242901.0, 51743.741281293354, 52050.0, 52124.0, 52130.0, 52390.738046309525, 49591.0, 49918.500814991385, 50513.242301365506, 52990.0, 53064.73467632637, 14557.27213639335, 14708.926455367655, 14893.70212595742, 14919.254037298091, 15098.320575573905, 10497.0, 10895.455227238765, 10992.615258465916, 11063.778724425467, 11064.778704426028, 14147.434102635985, 14895.627609309853, 15867.444639437796, 15969.0, 16861.409850655167, 7447.3669738071785, 7806.3364614007305, 7835.960820195976, 7854.646540905673, 7921.683132674743, 793.2662287384146, 811.3387589114852, 902.3953950852945, 930.7300882744064, 946.0823001688351, 24511.632325515133, 25100.74899250984, 25251.0, 25957.480850382886, 26104.34739131537, 924.3575714878095, 929.1962452478692, 951.129716309569, 955.0, 1038.2524582300732, 11777.352245626402, 12043.638690839289, 12080.0, 12151.0, 12201.572944946884, 272935.0, 274641.0, 277353.0, 279813.0, 279881.0, 45949.77025114853, 45968.770156149, 46290.0, 46540.0, 46657.0, 1225.026104247108, 1231.2673958994385, 1245.5391505142975, 1250.2560976219136, 1250.843644544432, 23643.881780590986, 24690.876545617157, 25711.742882570936, 26186.86906565455, 26305.342366440993, 44329.77835110933, 44429.555704442544, 44931.55068449274, 44941.77529112464, 44973.0, 222817.0, 223999.0, 225373.0, 225813.0, 226808.0, 25551.0, 26737.732622674303, 26971.190864274104, 27050.458990820465, 27416.725832741417, 31507.431422444075, 31651.52522712207, 37454.250914981, 40590.79704601458, 40628.1874362517, 30264.394712105193, 31117.0, 31378.431078446443, 31582.526262105628, 31621.20946976344, 30187.396252074395, 30531.389372212874, 31083.222919427197, 31145.0, 31147.0, 26885.596716048884, 27613.72386276192, 31201.219969500944, 32478.83760581182, 32489.187770305933, 24629.630555541324, 27472.313192170357, 27830.582541261494, 27863.721362786924, 27932.16203513898, 20799.480012999797, 20859.269925552533, 20908.1636734535, 29182.708172918, 29814.552781708724], "prototype.html": [265.6029236291744, 268.4617342228831, 273.0797213390873, 273.30989252138363, 278.9888404463822, 5334.279872217249, 5398.595105367099, 5412.512873841353, 5414.187871819224, 5494.258275132851, 5243.9213411798855, 5366.677999320043, 5395.865103372417, 5405.864853378667, 5405.891882162355, 4085.0808568072243, 4104.712670113093, 4116.5060192776755, 4117.608827161415, 4118.135191609766, 3938.684905207591, 3985.0, 4023.034471726779, 4070.0, 4074.775887326196, 3936.6850651947775, 4010.8596199133035, 4021.4973128358956, 4073.429719839225, 4078.632923036926, 3888.8833334999995, 3990.102226998931, 3997.060690737674, 4076.8165432555606, 4079.3065178919655, 3430.879919202841, 3440.17435815405, 3454.913627159316, 3484.843182056788, 3505.5968563615, 5147.356580427447, 5179.7410129493755, 5191.117510023305, 5192.870178245574, 5203.1414816555225, 4496.662750293741, 4566.0, 4566.954330456686, 4620.5841474267145, 4623.30650402439, 5516.227728118067, 5538.9169162462595, 5550.27846379972, 5567.832965011056, 5576.052071147874, 3768.7550309229814, 3773.13217959868, 3791.165943492455, 3824.0248736572275, 3832.1952389998132, 5736.906937932134, 5757.453041961007, 5764.33710123337, 5790.305163380379, 5855.238818953509, 3834.9233015339537, 3842.366009608383, 3843.5003449551937, 3864.0, 3879.4956655634587, 3680.392735198662, 3894.7857867816974, 3896.922061558753, 3912.765234085964, 3978.980105099456, 4442.400275962768, 4448.35498852671, 4448.733076015449, 4462.509123996358, 4465.486469056035, 5415.296011518478, 5432.076546987022, 5435.592330575144, 5443.265159203536, 5559.638623489541, 1320.4982106799355, 1363.5841068474012, 1388.8472268050507, 1397.357215680778, 1402.0045767504982, 858.8969323681073, 882.1266945723816, 885.4864178776294, 885.9069797671281, 887.1394747095308, 5214.270002199695, 5244.685318880803, 5266.1574148136115, 5295.391030031596, 5302.3637163540625, 5655.179998900218, 5676.971615141981, 5717.942820571824, 5730.799422020209, 5738.024535828836, 5219.243209734643, 5324.787008519694, 5342.706151161723, 5389.218563308298, 5393.973030134903, 3188.2348236423554, 3193.5050067239613, 3204.951925721116, 3215.903522894317, 3217.2117831131523, 5825.009748342792, 5846.795362162304, 5866.208061911672, 5880.911786323209, 5910.852228694231, 5652.943470565324, 5913.970430147821, 5924.14099955504, 5934.050551911673, 5944.554158438134, 5844.094165404369, 5866.823995280149, 5928.762849486058, 5973.133895585116, 5978.432048955342, 5842.0, 5843.977303971703, 5882.058870580687, 5892.823215303548, 5918.112283157388, 5504.779808807763, 5669.4047125051275, 5774.2782152230975, 5789.131630255495, 5821.534277257894, 5822.82531524055, 5838.824835254949, 5840.2991641003355, 5955.255593050869, 5969.641821490724, 3840.4047372657283, 3866.168773713665, 3918.2359439908946, 3932.8820135395986, 3934.9409758854213, 5702.287214098238, 5790.449907258803, 5800.477956983892, 5828.0966450200285, 5829.94170058294, 5481.972590137024, 5544.61187716856, 5576.33084029919, 5658.179563963285, 5743.10981797822, 5569.610127291051, 5616.297962754656, 5618.85952851182, 5639.605227634026, 5663.773449062156, 5458.372287187024, 5511.834644960658, 5535.225068490495, 5536.031194541019, 5540.639858409352, 5508.807191748269, 5654.236678048411, 5661.0659241226385, 5663.32040155184, 5674.971625141848, 5437.700926449083, 5505.091659876076, 5510.0, 5541.667499950016, 5566.137248726453], "yui.html": [556.7967691792497, 565.7001789051801, 572.5248044123379, 590.7902694543437, 667.9666016699165, 13485.0, 13635.386407611657, 13821.516246931373, 14089.295535223224, 14089.731924126827, 12555.372231388417, 12596.307203103826, 12635.62093137205, 12652.43064062117, 12725.681857953556, 630.5208041888152, 647.4981889035988, 770.5761830992959, 777.378097521983, 793.464411522223, 795.932345750612, 799.8480288745149, 804.7585724282721, 805.6012273924416, 805.8468890910738, 809.5062012172571, 810.1007881251805, 812.4150611559697, 819.8319344534386, 820.8235229425673, 612.8375980365207, 653.9444147247466, 793.3296364571928, 800.8358286551243, 807.1565214350959, 587.7825204674255, 590.6515156057947, 592.7806711516723, 598.3388355866748, 601.482724856623, 11777.352245626487, 11958.581449649308, 12004.399780011052, 12028.63914082579, 12035.217710848854, 8031.759047228593, 8107.756767296991, 8204.83590328196, 8425.70510032146, 8523.360747943867, 7841.411894107908, 8001.679932802681, 8026.357891368676, 8033.477823941425, 8101.5544145072, 2509.7992160627105, 2514.157757151338, 2555.8083143764293, 2576.471823276224, 2615.1500762252153, 40746.38880416796, 41307.7934610328, 41642.58357416417, 41892.79053604743, 42581.36127958083, 5548.361938377057, 5577.135543990688, 5580.218769372291, 5660.716964151776, 5776.913346299809, 9689.854652180224, 9707.126358627758, 9708.757281067888, 9817.852732209023, 9824.754381140387, 5287.973560132252, 5296.92054619181, 5329.18807605416, 5412.83761487156, 5469.863253418617, 3127.4526957782296, 3201.4717571600427, 3239.3294578076534, 3258.332041931398, 3413.300273443938, 2325.976740232576, 2358.316088334398, 2361.504084142315, 2362.267697013897, 2363.763623637657, 349.8023616656581, 349.81809459081137, 351.6278885488181, 354.1924412339869, 354.6028448138102, 492.88663607370506, 503.75819606589044, 512.451676705921, 513.958883289336, 516.3622925686774, 6645.568038077509, 6781.62701051437, 6874.862502749917, 7077.186123595749, 7147.714091436388, 344.1538476796876, 447.95296493867676, 453.17748286859245, 519.9168133098686, 541.2746919128308, 3205.8557364918634, 3385.306012267479, 3391.6777906098882, 3475.2354482013916, 3504.404251277289, 53123.73438132785, 53245.733771331674, 53343.0, 53521.73239133857, 53852.46147538553, 42167.36748948768, 42872.356914646305, 42926.35610465846, 43015.35476967848, 45360.0, 40505.59494405018, 40798.38802417966, 41084.79457602693, 41220.38169427461, 41637.0, 7296.233895441114, 7352.742654007084, 7396.408287337108, 7448.776536703907, 7520.586367749826, 29224.707752922197, 29401.264968375963, 30418.239544011576, 30651.0, 30715.539266911463, 39494.80252598719, 40277.0, 40807.59192408038, 41329.52022878637, 41659.0, 6516.446102081376, 6531.771388001397, 6587.0, 6700.061991321317, 6777.762778302736, 9718.562664680248, 9767.316287860065, 9769.462679552693, 9869.506524673594, 10489.580416783243, 8918.420302680304, 8980.910190898006, 9025.3231007676, 9169.587368568296, 9493.715188544355, 9119.452832830051, 9141.77145571366, 9415.116991546169, 9613.134817866425, 9722.854157187789, 8767.824643506967, 9010.189082982562, 9043.366964312698, 9158.67944621935, 9165.220956218529, 7959.204079592226, 8004.439689221698, 8158.184181581794, 8322.250997410261, 8340.87488687658, 7378.0, 7873.685052598061, 7974.441789074709, 8037.316828069445, 8281.627326770189]}, "summary": {"suite": 5738.273246986111, "subtests": {"jquery.html": {"filtered": 5872.463552100979, "value": 5872.463552100979}, "dojo.html": {"filtered": 4646.507031272319, "value": 4646.507031272319}, "mootools.html": {"filtered": 3794.866326146412, "value": 3794.866326146412}, "ext.html": {"filtered": 16297.857506115783, "value": 16297.857506115783}, "prototype.html": {"filtered": 4181.2168475172475, "value": 4181.2168475172475}, "yui.html": {"filtered": 5059.022620579806, "value": 5059.022620579806}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0069"}, "testrun": {"date": 1446234253, "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": "20151030115030", "branch": "Fx-Team", "revision": "375a22f7bc4ee360e90849d33061c86b1b56fe8b"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 186.0, 185.0, 186.0, 180.0, 181.0, 186.0, 186.0, 184.0, 178.0], "ai-astar": [117.0, 107.0, 125.0, 109.0, 128.0, 122.0, 125.0, 127.0, 126.0, 123.0], "imaging-gaussian-blur": [143.0, 136.0, 135.0, 136.0, 142.0, 142.0, 139.0, 130.0, 136.0, 142.0], "audio-beat-detection": [151.0, 155.0, 179.0, 190.0, 166.0, 163.0, 165.0, 163.0, 181.0, 188.0], "json-stringify-tinderbox": [69.0, 72.0, 73.0, 73.0, 75.0, 76.0, 74.0, 76.0, 80.0, 72.0], "stanford-crypto-pbkdf2": [159.0, 177.0, 177.0, 178.0, 178.0, 159.0, 172.0, 175.0, 180.0, 167.0], "json-parse-financial": [60.0, 64.0, 65.0, 65.0, 66.0, 68.0, 69.0, 77.0, 66.0, 67.0], "stanford-crypto-sha256-iterative": [80.0, 83.0, 82.0, 86.0, 85.0, 84.0, 84.0, 85.0, 86.0, 86.0], "audio-fft": [88.0, 91.0, 95.0, 111.0, 93.0, 94.0, 95.0, 94.0, 101.0, 93.0], "imaging-darkroom": [147.0, 148.0, 145.0, 142.0, 148.0, 148.0, 147.0, 142.0, 147.0, 148.0], "stanford-crypto-ccm": [140.0, 148.0, 149.0, 149.0, 161.0, 147.0, 153.0, 144.0, 154.0, 152.0], "audio-oscillator": [116.0, 117.0, 153.0, 119.0, 122.0, 122.0, 157.0, 116.0, 120.0, 165.0], "stanford-crypto-aes": [91.0, 96.0, 100.0, 100.0, 98.0, 98.0, 100.0, 100.0, 101.0, 100.0], "imaging-desaturate": [114.0, 119.0, 118.0, 119.0, 119.0, 119.0, 117.0, 118.0, 119.0, 117.0]}, "summary": {"suite": 1747.7000000000003, "subtests": {"audio-fft": {"filtered": 95.5, "value": 95.5}, "stanford-crypto-pbkdf2": {"filtered": 172.2, "value": 172.2}, "audio-beat-detection": {"filtered": 170.1, "value": 170.1}, "stanford-crypto-ccm": {"filtered": 149.7, "value": 149.7}, "imaging-darkroom": {"filtered": 146.2, "value": 146.2}, "json-parse-financial": {"filtered": 66.7, "value": 66.7}, "audio-oscillator": {"filtered": 130.7, "value": 130.7}, "ai-astar": {"filtered": 120.9, "value": 120.9}, "audio-dft": {"filtered": 183.2, "value": 183.2}, "stanford-crypto-sha256-iterative": {"filtered": 84.1, "value": 84.1}, "json-stringify-tinderbox": {"filtered": 74.0, "value": 74.0}, "imaging-gaussian-blur": {"filtered": 138.1, "value": 138.1}, "stanford-crypto-aes": {"filtered": 98.4, "value": 98.4}, "imaging-desaturate": {"filtered": 117.9, "value": 117.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0069"}, "testrun": {"date": 1446234253, "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": "20151030115030", "branch": "Fx-Team", "revision": "375a22f7bc4ee360e90849d33061c86b1b56fe8b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.27272727272728], "Encrypt": [355.6187766714082], "NavierStokes": [6535.9477124183], "Decrypt": [6731.543624161074], "Splay": [754.7169811320755], "Richards": [180.8972503617945], "RegExp": [32967.74193548387], "Earley": [1035.1966873706003], "Boyer": [14069.444444444445], "RayTrace": [2333.3333333333335]}, "summary": {"suite": 16078.452407859882, "subtests": {"DeltaBlue": {"filtered": 290.91919999999993, "value": 290.91919999999993}, "Encrypt": {"filtered": 748.500972, "value": 748.500972}, "NavierStokes": {"filtered": 227.05199999999994, "value": 227.05199999999994}, "Decrypt": {"filtered": 39.542341974077786, "value": 39.542341974077786}, "Splay": {"filtered": 107.97557500000003, "value": 107.97557500000003}, "RegExp": {"filtered": 27.632617416829735, "value": 27.632617416829735}, "Richards": {"filtered": 195.14945600000001, "value": 195.14945600000001}, "Earley": {"filtered": 643.8032579999998, "value": 643.8032579999998}, "Boyer": {"filtered": 47.36953208292197, "value": 47.36953208292197}, "RayTrace": {"filtered": 317.1381428571427, "value": 317.1381428571427}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0069"}, "testrun": {"date": 1446234253, "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": "20151030115030", "branch": "Fx-Team", "revision": "375a22f7bc4ee360e90849d33061c86b1b56fe8b"}}] 13:04:29 INFO - RETURN: dromaeo_css: 5738.27 13:04:29 INFO - RETURN: kraken: 1747.70 13:04:29 INFO - RETURN: v8_7: 16078.45 13:04:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16078.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1747.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5738.27"}}} 13:04:29 INFO - Return code: 0 13:04:29 INFO - # TBPL SUCCESS # 13:04:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:04:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:04:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:04:29 INFO - 2015-10-30 13:04:29.830 screenresolution[1658:9992] starting screenresolution argv=screenresolution get 13:04:29 INFO - 2015-10-30 13:04:29.834 screenresolution[1658:9992] Display 0: 1600x1200x32@60 13:04:29 INFO - 2015-10-30 13:04:29.840 screenresolution[1659:9996] starting screenresolution argv=screenresolution list 13:04:29 INFO - Available Modes on Display 0 13:04:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:04:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:04:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:04:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:04:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:04:30 INFO - Intel HD Graphics 3000: 13:04:30 INFO - Chipset Model: Intel HD Graphics 3000 13:04:30 INFO - Type: GPU 13:04:30 INFO - Bus: Built-In 13:04:30 INFO - VRAM (Total): 512 MB 13:04:30 INFO - VRAM (Dynamic, Max): 10 13:04:30 INFO - Vendor: Intel (0x8086) 13:04:30 INFO - Device ID: 0x0116 13:04:30 INFO - Revision ID: 0x0009 13:04:30 INFO - Displays: 13:04:30 INFO - Display: 13:04:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:04:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:04:30 INFO - Display Serial Number: 1600x1200 60 13:04:30 INFO - Main Display: Yes 13:04:30 INFO - Mirror: Off 13:04:30 INFO - Online: Yes 13:04:30 INFO - Rotation: Supported 13:04:30 INFO - Return code: 0 13:04:30 INFO - Running post-action listener: _resource_record_post_action 13:04:30 INFO - Running post-run listener: _resource_record_post_run 13:04:31 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 38757376; Write bytes: 684798976; Read time: 4849; Write time: 53303 13:04:31 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 342661632; Write bytes: 344770560; Read time: 35568; Write time: 6842 13:04:31 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 36475904; Write bytes: 338807808; Read time: 4159; Write time: 46445 13:04:31 INFO - Running post-run listener: _upload_blobber_files 13:04:31 INFO - Blob upload gear active. 13:04:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:04:31 INFO - Copying logs to upload dir... 13:04:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1354.218237 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2015-10-30 13:05:00.019728) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 13:05:00.022895) ========= 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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009888 build_url: 'https://queue.taskcluster.net/v1/task/lzsH4lUnSJW_oWnAj71DuA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 13:05:00.749149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 13:05:00.749764) ========= 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.Y1CUdwDp1r/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.Q49Tw0HMDa/Listeners TMPDIR=/var/folders/bs/4zn2bn7x5f5811g2xxb0cp6w00000w/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.005265 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 13:05:00.800425) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-30 13:05:00.800946) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-30 13:05:02.700075) =========