builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0051 starttime: 1446197881.01 results: success (0) buildid: 20151030004047 builduid: fe86e4fd100a4a17a58eb8e29c7bf213 revision: e902b5a2882bcc6a751e77fd8bb812d438d5886b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.014150) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.014753) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.015106) ========= 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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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.006007 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.191182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.191560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.515989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.516545) ========= 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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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.031595 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.565943) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.566320) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.566748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.567070) ========= 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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:01-- 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% 8.49M=0.001s 2015-10-30 02:38:01 (8.49 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153952 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.738067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.738455) ========= 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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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.108184 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.863033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:01.863457) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e902b5a2882bcc6a751e77fd8bb812d438d5886b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e902b5a2882bcc6a751e77fd8bb812d438d5886b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:01,955 truncating revision to first 12 chars 2015-10-30 02:38:01,955 Setting DEBUG logging. 2015-10-30 02:38:01,955 attempt 1/10 2015-10-30 02:38:01,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e902b5a2882b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 02:38:02,258 unpacking tar archive at: mozilla-aurora-e902b5a2882b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583184 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:02.465262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:02.465643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:02.481000) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:02.481382) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 02:38:02.481856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2015-10-30 02:38:02.482246) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:02 INFO - MultiFileLogger online at 20151030 02:38:02 in /builds/slave/test 02:38:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:38:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:02 INFO - {'append_to_log': False, 02:38:02 INFO - 'base_work_dir': '/builds/slave/test', 02:38:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:38:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:02 INFO - 'branch': 'Mozilla-Aurora', 02:38:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:02 INFO - 'config_files': ('talos/mac_config.py',), 02:38:02 INFO - 'default_actions': ('clobber', 02:38:02 INFO - 'read-buildbot-config', 02:38:02 INFO - 'download-and-extract', 02:38:02 INFO - 'populate-webroot', 02:38:02 INFO - 'create-virtualenv', 02:38:02 INFO - 'install', 02:38:02 INFO - 'run-tests'), 02:38:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:02 INFO - 'download_minidump_stackwalk': True, 02:38:02 INFO - 'download_symbols': 'ondemand', 02:38:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:02 INFO - 'installer_path': 'installer.exe', 02:38:02 INFO - 'log_level': 'info', 02:38:02 INFO - 'log_name': 'talos', 02:38:02 INFO - 'log_to_console': True, 02:38:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:38:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:38:02 INFO - 'opt_config_files': (), 02:38:02 INFO - 'pip_index': False, 02:38:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:02 INFO - 'cmd': ('bash', 02:38:02 INFO - '-c', 02:38:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:02 INFO - 'enabled': True, 02:38:02 INFO - 'halt_on_failure': False, 02:38:02 INFO - 'name': 'check_screen_resolution'},), 02:38:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:02 INFO - 'cmd': ('bash', 02:38:02 INFO - '-c', 02:38:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:02 INFO - 'enabled': True, 02:38:02 INFO - 'halt_on_failure': False, 02:38:02 INFO - 'name': 'check_screen_resolution'},), 02:38:02 INFO - 'run_cmd_checks_enabled': True, 02:38:02 INFO - 'sps_profile': False, 02:38:02 INFO - 'sps_profile_interval': 0, 02:38:02 INFO - 'suite': 'dromaeojs', 02:38:02 INFO - 'system_bits': '64', 02:38:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:02 INFO - 'title': 't-yosemite-r5-0051', 02:38:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:02 INFO - 'use_talos_json': True, 02:38:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:02 INFO - 'work_dir': 'build'} 02:38:02 INFO - ##### 02:38:02 INFO - ##### Running clobber step. 02:38:02 INFO - ##### 02:38:02 INFO - Running pre-action listener: _resource_record_pre_action 02:38:02 INFO - Running main action method: clobber 02:38:02 INFO - rmtree: /builds/slave/test/build 02:38:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:06 INFO - Running post-action listener: _resource_record_post_action 02:38:06 INFO - ##### 02:38:06 INFO - ##### Running read-buildbot-config step. 02:38:06 INFO - ##### 02:38:06 INFO - Running pre-action listener: _resource_record_pre_action 02:38:06 INFO - Running main action method: read_buildbot_config 02:38:06 INFO - Using buildbot properties: 02:38:06 INFO - { 02:38:06 INFO - "properties": { 02:38:06 INFO - "buildnumber": 394, 02:38:06 INFO - "product": "firefox", 02:38:06 INFO - "script_repo_revision": "production", 02:38:06 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:38:06 INFO - "repository": "", 02:38:06 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:38:06 INFO - "buildid": "20151030004047", 02:38:06 INFO - "slavename": "t-yosemite-r5-0051", 02:38:06 INFO - "stage_platform": "macosx64", 02:38:06 INFO - "basedir": "/builds/slave/test", 02:38:06 INFO - "nightly_build": "True", 02:38:06 INFO - "project": "", 02:38:06 INFO - "platform": "yosemite", 02:38:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:38:06 INFO - "slavebuilddir": "test", 02:38:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:38:06 INFO - "branch": "mozilla-aurora", 02:38:06 INFO - "repo_path": "releases/mozilla-aurora", 02:38:06 INFO - "pgo_build": "False", 02:38:06 INFO - "builduid": "fe86e4fd100a4a17a58eb8e29c7bf213", 02:38:06 INFO - "revision": "e902b5a2882bcc6a751e77fd8bb812d438d5886b" 02:38:06 INFO - }, 02:38:06 INFO - "sourcestamp": { 02:38:06 INFO - "repository": "", 02:38:06 INFO - "hasPatch": false, 02:38:06 INFO - "project": "", 02:38:06 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:38:06 INFO - "changes": [ 02:38:06 INFO - { 02:38:06 INFO - "category": null, 02:38:06 INFO - "files": [ 02:38:06 INFO - { 02:38:06 INFO - "url": null, 02:38:06 INFO - "name": "https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:38:06 INFO - } 02:38:06 INFO - ], 02:38:06 INFO - "repository": "", 02:38:06 INFO - "rev": "e902b5a2882bcc6a751e77fd8bb812d438d5886b", 02:38:06 INFO - "who": "sendchange", 02:38:06 INFO - "when": 1446197819, 02:38:06 INFO - "number": 6599186, 02:38:06 INFO - "comments": "", 02:38:06 INFO - "project": "", 02:38:06 INFO - "at": "Fri 30 Oct 2015 02:36:59", 02:38:06 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:38:06 INFO - "revlink": "", 02:38:06 INFO - "properties": [ 02:38:06 INFO - [ 02:38:06 INFO - "buildid", 02:38:06 INFO - "20151030004047", 02:38:06 INFO - "Change" 02:38:06 INFO - ], 02:38:06 INFO - [ 02:38:06 INFO - "builduid", 02:38:06 INFO - "fe86e4fd100a4a17a58eb8e29c7bf213", 02:38:06 INFO - "Change" 02:38:06 INFO - ], 02:38:06 INFO - [ 02:38:06 INFO - "nightly_build", 02:38:06 INFO - "True", 02:38:06 INFO - "Change" 02:38:06 INFO - ], 02:38:06 INFO - [ 02:38:06 INFO - "pgo_build", 02:38:06 INFO - "False", 02:38:06 INFO - "Change" 02:38:06 INFO - ] 02:38:06 INFO - ], 02:38:06 INFO - "revision": "e902b5a2882bcc6a751e77fd8bb812d438d5886b" 02:38:06 INFO - } 02:38:06 INFO - ], 02:38:06 INFO - "revision": "e902b5a2882bcc6a751e77fd8bb812d438d5886b" 02:38:06 INFO - } 02:38:06 INFO - } 02:38:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:38:06 INFO - Running post-action listener: _resource_record_post_action 02:38:06 INFO - ##### 02:38:06 INFO - ##### Running download-and-extract step. 02:38:06 INFO - ##### 02:38:06 INFO - Running pre-action listener: _resource_record_pre_action 02:38:06 INFO - Running main action method: download_and_extract 02:38:06 INFO - mkdir: /builds/slave/test/build/tests 02:38: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')]} 02:38:06 INFO - https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:38:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/test_packages.json 02:38:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/test_packages.json 02:38:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:38:07 INFO - Downloaded 1149 bytes. 02:38:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:38:07 INFO - Using the following test package requirements: 02:38:07 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:38:07 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:38:07 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'jsshell-mac.zip'], 02:38:07 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:38:07 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:38:07 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:38:07 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:38:07 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:38:07 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:38:07 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:38:07 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:38:07 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:07 INFO - https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:38:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:38:08 INFO - Downloaded 17445408 bytes. 02:38:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:38:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:38:14 INFO - Return code: 0 02:38:14 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:14 INFO - https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:38:15 INFO - Downloaded 17445408 bytes. 02:38:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:38:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:38:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:38:21 INFO - Return code: 0 02:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:21 INFO - https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:38:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:38:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:38:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:38:22 INFO - Downloaded 11131307 bytes. 02:38:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:38:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:38:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:38:22 INFO - Return code: 0 02:38: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')]} 02:38:22 INFO - https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:38:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:38:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:38:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:38:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:38:26 INFO - Downloaded 107847989 bytes. 02:38:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:38:26 INFO - mkdir: /builds/slave/test/properties 02:38:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:26 INFO - Contents: 02:38:26 INFO - build_url:https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:38:26 INFO - Running post-action listener: _resource_record_post_action 02:38:26 INFO - Running post-action listener: set_extra_try_arguments 02:38:26 INFO - ##### 02:38:26 INFO - ##### Running populate-webroot step. 02:38:26 INFO - ##### 02:38:26 INFO - Running pre-action listener: _resource_record_pre_action 02:38:26 INFO - Running main action method: populate_webroot 02:38:26 INFO - Guessing talos json url... 02:38: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')]} 02:38:26 INFO - https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:38:27 INFO - Downloaded 107 bytes. 02:38:27 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:38:27 INFO - Contents: 02:38:27 INFO - 20151030004047 02:38:27 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/e902b5a2882bcc6a751e77fd8bb812d438d5886b 02:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:27 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e902b5a288/testing/talos/talos.json 02:38:27 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e902b5a288/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e902b5a288/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:38:27 INFO - Downloaded 4264 bytes. 02:38:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:27 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:38:27 INFO - '../fennec_ids.txt'], 02:38:27 INFO - 'tests': ['tcheck2']}, 02:38:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:27 INFO - '--tppagecycles', 02:38:27 INFO - '7'], 02:38:27 INFO - 'tests': ['tsvgm']}}, 02:38:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:38:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:38:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:38:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'tests': ['damp', 'tps']}, 02:38:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['damp', 'tps']}, 02:38:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:38:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:27 INFO - 'other': {'tests': ['a11yr', 02:38:27 INFO - 'ts_paint', 02:38:27 INFO - 'tpaint', 02:38:27 INFO - 'sessionrestore', 02:38:27 INFO - 'sessionrestore_no_auto_restore']}, 02:38:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['a11yr', 02:38:27 INFO - 'ts_paint', 02:38:27 INFO - 'tpaint', 02:38:27 INFO - 'sessionrestore', 02:38:27 INFO - 'sessionrestore_no_auto_restore']}, 02:38:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['a11yr', 02:38:27 INFO - 'ts_paint', 02:38:27 INFO - 'tpaint', 02:38:27 INFO - 'sessionrestore', 02:38:27 INFO - 'sessionrestore_no_auto_restore']}, 02:38:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['a11yr', 02:38:27 INFO - 'ts_paint', 02:38:27 INFO - 'tpaint', 02:38:27 INFO - 'sessionrestore', 02:38:27 INFO - 'sessionrestore_no_auto_restore']}, 02:38:27 INFO - 'other_l64': {'tests': ['a11yr', 02:38:27 INFO - 'ts_paint', 02:38:27 INFO - 'tpaint', 02:38:27 INFO - 'sessionrestore', 02:38:27 INFO - 'sessionrestore_no_auto_restore']}, 02:38:27 INFO - 'other_nol64': {'tests': ['a11yr', 02:38:27 INFO - 'ts_paint', 02:38:27 INFO - 'tpaint', 02:38:27 INFO - 'sessionrestore', 02:38:27 INFO - 'sessionrestore_no_auto_restore']}, 02:38:27 INFO - 'svgr': {'tests': ['tsvgx', 02:38:27 INFO - 'tsvgr_opacity', 02:38:27 INFO - 'tart', 02:38:27 INFO - 'tscrollx', 02:38:27 INFO - 'cart']}, 02:38:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['tsvgx', 02:38:27 INFO - 'tsvgr_opacity', 02:38:27 INFO - 'tart', 02:38:27 INFO - 'tscrollx', 02:38:27 INFO - 'cart']}, 02:38:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'tests': ['tp5o']}, 02:38:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'talos_options': ['--e10s'], 02:38:27 INFO - 'tests': ['tp5o']}, 02:38:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'talos_options': ['--xperf_path', 02:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:27 INFO - 'tests': ['tp5n']}, 02:38:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:27 INFO - 'talos_options': ['--e10s', 02:38:27 INFO - '--xperf_path', 02:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:38:27 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:38:27 INFO - 'tests': ['tp5n']}}, 02:38:27 INFO - 'talos.zip': {'path': '', 02:38:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:27 INFO - Running post-action listener: _resource_record_post_action 02:38:27 INFO - ##### 02:38:27 INFO - ##### Running create-virtualenv step. 02:38:27 INFO - ##### 02:38:27 INFO - Running pre-action listener: _resource_record_pre_action 02:38:27 INFO - Running main action method: create_virtualenv 02:38:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:27 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 02:38:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:28 INFO - Using real prefix '/tools/python27' 02:38:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:29 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:32 INFO - Installing pip.................done. 02:38:32 INFO - Return code: 0 02:38:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:32 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 02:38:32 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 02:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:32 INFO - 'HOME': '/Users/cltbld', 02:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:32 INFO - 'LOGNAME': 'cltbld', 02:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:32 INFO - 'MOZ_NO_REMOTE': '1', 02:38:32 INFO - 'NO_EM_RESTART': '1', 02:38:32 INFO - 'PAGER': '/bin/cat', 02:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:32 INFO - 'PWD': '/builds/slave/test', 02:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:32 INFO - 'SHELL': '/bin/bash', 02:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:38:32 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:32 INFO - 'USER': 'cltbld', 02:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:32 INFO - 'XPC_FLAGS': '0x0', 02:38:32 INFO - 'XPC_SERVICE_NAME': '0', 02:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:34 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 02:38:34 INFO - Cleaning up... 02:38:34 INFO - Return code: 0 02:38:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:34 INFO - 'HOME': '/Users/cltbld', 02:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:34 INFO - 'LOGNAME': 'cltbld', 02:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:34 INFO - 'MOZ_NO_REMOTE': '1', 02:38:34 INFO - 'NO_EM_RESTART': '1', 02:38:34 INFO - 'PAGER': '/bin/cat', 02:38:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:34 INFO - 'PWD': '/builds/slave/test', 02:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:34 INFO - 'SHELL': '/bin/bash', 02:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:38:34 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:34 INFO - 'USER': 'cltbld', 02:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:34 INFO - 'XPC_FLAGS': '0x0', 02:38:34 INFO - 'XPC_SERVICE_NAME': '0', 02:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:34 INFO - Downloading/unpacking psutil>=0.7.1 02:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:37 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:38:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:37 INFO - Installing collected packages: psutil 02:38:37 INFO - Running setup.py install for psutil 02:38:37 INFO - building 'psutil._psutil_osx' extension 02:38:37 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 INFO - building 'psutil._psutil_posix' extension 02:38:39 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 02:38:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:38:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:38:40 INFO - ^ 02:38:40 INFO - 1 warning generated. 02:38:40 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 02:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:40 INFO - Successfully installed psutil 02:38:40 INFO - Cleaning up... 02:38:40 INFO - Return code: 0 02:38:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:38:40 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')]} 02:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:40 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')]} 02:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:40 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 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:40 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 02:38:40 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 02:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:40 INFO - 'HOME': '/Users/cltbld', 02:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:40 INFO - 'LOGNAME': 'cltbld', 02:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:40 INFO - 'MOZ_NO_REMOTE': '1', 02:38:40 INFO - 'NO_EM_RESTART': '1', 02:38:40 INFO - 'PAGER': '/bin/cat', 02:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:40 INFO - 'PWD': '/builds/slave/test', 02:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:40 INFO - 'SHELL': '/bin/bash', 02:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:38:40 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:40 INFO - 'USER': 'cltbld', 02:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:40 INFO - 'XPC_FLAGS': '0x0', 02:38:40 INFO - 'XPC_SERVICE_NAME': '0', 02:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:38:40 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 02:38:40 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 02:38:40 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 02:38:40 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 02:38:40 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 02:38:40 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 02:38:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:38:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:38:43 INFO - Installing collected packages: mozsystemmonitor 02:38:43 INFO - Running setup.py install for mozsystemmonitor 02:38:43 INFO - Successfully installed mozsystemmonitor 02:38:43 INFO - Cleaning up... 02:38:43 INFO - Return code: 0 02:38:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:43 INFO - 'HOME': '/Users/cltbld', 02:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:43 INFO - 'LOGNAME': 'cltbld', 02:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:43 INFO - 'MOZ_NO_REMOTE': '1', 02:38:43 INFO - 'NO_EM_RESTART': '1', 02:38:43 INFO - 'PAGER': '/bin/cat', 02:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:43 INFO - 'PWD': '/builds/slave/test', 02:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:43 INFO - 'SHELL': '/bin/bash', 02:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:38:43 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:43 INFO - 'USER': 'cltbld', 02:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:43 INFO - 'XPC_FLAGS': '0x0', 02:38:43 INFO - 'XPC_SERVICE_NAME': '0', 02:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:44 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 02:38:44 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 02:38:44 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 02:38:44 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 02:38:44 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 02:38:44 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 02:38:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:48 INFO - Downloading docopt-0.6.1.tar.gz 02:38:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:48 INFO - Running setup.py install for blobuploader 02:38:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:38:48 INFO - Running setup.py install for requests 02:38:49 INFO - Running setup.py install for docopt 02:38:49 INFO - Successfully installed blobuploader requests docopt 02:38:49 INFO - Cleaning up... 02:38:49 INFO - Return code: 0 02:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:49 INFO - 'HOME': '/Users/cltbld', 02:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:49 INFO - 'LOGNAME': 'cltbld', 02:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:49 INFO - 'MOZ_NO_REMOTE': '1', 02:38:49 INFO - 'NO_EM_RESTART': '1', 02:38:49 INFO - 'PAGER': '/bin/cat', 02:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:49 INFO - 'PWD': '/builds/slave/test', 02:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:49 INFO - 'SHELL': '/bin/bash', 02:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:38:49 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:49 INFO - 'USER': 'cltbld', 02:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:49 INFO - 'XPC_FLAGS': '0x0', 02:38:49 INFO - 'XPC_SERVICE_NAME': '0', 02:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:49 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-HKwS6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-cqZTJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-QApqPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-yluLrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-yL4s7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-54jaFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-thY7KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:50 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-tjgVO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-0QVNmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-bWpjVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-x1Idbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-G0VRns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-chAXJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-g6ts8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:51 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-kbFDWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:52 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-AIFmGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:52 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-UO3twX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:52 INFO - Running setup.py install for manifestparser 02:38:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:38:52 INFO - Running setup.py install for mozcrash 02:38:52 INFO - Running setup.py install for mozdebug 02:38:52 INFO - Running setup.py install for mozdevice 02:38:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Running setup.py install for mozfile 02:38:53 INFO - Running setup.py install for mozhttpd 02:38:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Running setup.py install for mozinfo 02:38:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Running setup.py install for mozInstall 02:38:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:38:53 INFO - Running setup.py install for mozleak 02:38:54 INFO - Running setup.py install for mozlog 02:38:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:54 INFO - Running setup.py install for moznetwork 02:38:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:54 INFO - Running setup.py install for mozprocess 02:38:54 INFO - Running setup.py install for mozprofile 02:38:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:54 INFO - Running setup.py install for mozrunner 02:38:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:55 INFO - Running setup.py install for mozscreenshot 02:38:55 INFO - Running setup.py install for moztest 02:38:55 INFO - Running setup.py install for mozversion 02:38:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:55 INFO - Cleaning up... 02:38:55 INFO - Return code: 0 02:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:55 INFO - 'HOME': '/Users/cltbld', 02:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:55 INFO - 'LOGNAME': 'cltbld', 02:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:55 INFO - 'MOZ_NO_REMOTE': '1', 02:38:55 INFO - 'NO_EM_RESTART': '1', 02:38:55 INFO - 'PAGER': '/bin/cat', 02:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:55 INFO - 'PWD': '/builds/slave/test', 02:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:55 INFO - 'SHELL': '/bin/bash', 02:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:38:55 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:55 INFO - 'USER': 'cltbld', 02:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:55 INFO - 'XPC_FLAGS': '0x0', 02:38:55 INFO - 'XPC_SERVICE_NAME': '0', 02:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-Er3Xrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:56 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)) 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-kVMfwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:56 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)) 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-sQr1Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:56 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)) 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-YvPvvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:56 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)) 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-MkKHpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-h5_7TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:56 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-uID9Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:57 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)) 02:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:57 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-RtasNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:57 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)) 02:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:57 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-2pIWBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:57 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)) 02:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:57 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-pyQXxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:57 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)) 02:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:57 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-qF_bhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:57 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)) 02:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:57 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-sW5lvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:57 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-vYQvfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:58 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)) 02:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:58 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-U1faxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:58 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)) 02:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:58 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-HFqXLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:58 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)) 02:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:58 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-XVdE9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:58 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)) 02:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:58 INFO - Running setup.py (path:/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/pip-yzBzbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:58 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)) 02:38:58 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)) 02:38:58 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)) 02:38:58 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)) 02:38:58 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)) 02:38:58 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)) 02:38:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:58 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 02:38:58 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 02:38:58 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 02:38:58 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 02:38:58 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 02:38:58 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 02:39:01 INFO - Downloading blessings-1.5.1.tar.gz 02:39:01 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 02:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:01 INFO - Installing collected packages: blessings 02:39:01 INFO - Running setup.py install for blessings 02:39:01 INFO - Successfully installed blessings 02:39:01 INFO - Cleaning up... 02:39:01 INFO - Return code: 0 02:39:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:02 INFO - Reading from file tmpfile_stdout 02:39:02 INFO - Current package versions: 02:39:02 INFO - blessings == 1.5.1 02:39:02 INFO - blobuploader == 1.2.4 02:39:02 INFO - docopt == 0.6.1 02:39:02 INFO - manifestparser == 1.1 02:39:02 INFO - mozInstall == 1.12 02:39:02 INFO - mozcrash == 0.16 02:39:02 INFO - mozdebug == 0.1 02:39:02 INFO - mozdevice == 0.46 02:39:02 INFO - mozfile == 1.2 02:39:02 INFO - mozhttpd == 0.7 02:39:02 INFO - mozinfo == 0.8 02:39:02 INFO - mozleak == 0.1 02:39:02 INFO - mozlog == 3.0 02:39:02 INFO - moznetwork == 0.27 02:39:02 INFO - mozprocess == 0.22 02:39:02 INFO - mozprofile == 0.27 02:39:02 INFO - mozrunner == 6.11 02:39:02 INFO - mozscreenshot == 0.1 02:39:02 INFO - mozsystemmonitor == 0.0 02:39:02 INFO - moztest == 0.7 02:39:02 INFO - mozversion == 1.4 02:39:02 INFO - psutil == 3.1.1 02:39:02 INFO - requests == 1.2.3 02:39:02 INFO - wsgiref == 0.1.2 02:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:02 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 0x10d697a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d704228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cad481d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, '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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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 02:39:02 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 02:39:02 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 02:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:02 INFO - 'HOME': '/Users/cltbld', 02:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:02 INFO - 'LOGNAME': 'cltbld', 02:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:02 INFO - 'MOZ_NO_REMOTE': '1', 02:39:02 INFO - 'NO_EM_RESTART': '1', 02:39:02 INFO - 'PAGER': '/bin/cat', 02:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:02 INFO - 'PWD': '/builds/slave/test', 02:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:02 INFO - 'SHELL': '/bin/bash', 02:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:39:02 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:02 INFO - 'USER': 'cltbld', 02:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:02 INFO - 'XPC_FLAGS': '0x0', 02:39:02 INFO - 'XPC_SERVICE_NAME': '0', 02:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 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)) 02:39:02 INFO - Cleaning up... 02:39:02 INFO - Return code: 0 02:39:02 INFO - Running post-action listener: _resource_record_post_action 02:39:02 INFO - Running post-action listener: _start_resource_monitoring 02:39:02 INFO - Starting resource monitoring. 02:39:02 INFO - ##### 02:39:02 INFO - ##### Running install step. 02:39:02 INFO - ##### 02:39:02 INFO - Running pre-action listener: _resource_record_pre_action 02:39:02 INFO - Running main action method: install 02:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:02 INFO - Reading from file tmpfile_stdout 02:39:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:03 INFO - Reading from file tmpfile_stdout 02:39:03 INFO - Output received: 02:39:03 INFO - Usage: mozinstall [options] installer 02:39:03 INFO - Options: 02:39:03 INFO - -h, --help show this help message and exit 02:39:03 INFO - -d DEST, --destination=DEST 02:39:03 INFO - Directory to install application into. [default: 02:39:03 INFO - "/builds/slave/test"] 02:39:03 INFO - --app=APP Application being installed. [default: firefox] 02:39:03 INFO - mkdir: /builds/slave/test/build/application 02:39:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:39:45 INFO - Reading from file tmpfile_stdout 02:39:45 INFO - Output received: 02:39:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:39:45 INFO - Running post-action listener: _resource_record_post_action 02:39:45 INFO - ##### 02:39:45 INFO - ##### Running run-tests step. 02:39:45 INFO - ##### 02:39:45 INFO - Running pre-action listener: _resource_record_pre_action 02:39:45 INFO - Running main action method: run_tests 02:39:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:39:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:39:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:39:45 INFO - 2015-10-30 02:39:45.495 screenresolution[1626:7697] starting screenresolution argv=screenresolution get 02:39:45 INFO - 2015-10-30 02:39:45.498 screenresolution[1626:7697] Display 0: 1600x1200x32@60 02:39:45 INFO - 2015-10-30 02:39:45.506 screenresolution[1627:7699] starting screenresolution argv=screenresolution list 02:39:45 INFO - Available Modes on Display 0 02:39:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:39:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:39:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:39:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:39:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:39:45 INFO - Intel HD Graphics 3000: 02:39:45 INFO - Chipset Model: Intel HD Graphics 3000 02:39:45 INFO - Type: GPU 02:39:45 INFO - Bus: Built-In 02:39:45 INFO - VRAM (Total): 512 MB 02:39:45 INFO - VRAM (Dynamic, Max): 10 02:39:45 INFO - Vendor: Intel (0x8086) 02:39:45 INFO - Device ID: 0x0116 02:39:45 INFO - Revision ID: 0x0009 02:39:45 INFO - Displays: 02:39:45 INFO - Display: 02:39:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:39:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:39:45 INFO - Display Serial Number: 1600x1200 60 02:39:45 INFO - Main Display: Yes 02:39:45 INFO - Mirror: Off 02:39:45 INFO - Online: Yes 02:39:45 INFO - Rotation: Supported 02:39:45 INFO - Return code: 0 02:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:45 INFO - Python 2.7.3 02:39:45 INFO - Return code: 0 02:39:45 INFO - grabbing minidump binary from tooltool 02:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:45 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 0x10d64c9f0>, '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 0x10d3abcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d616990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:45 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 02:39:45 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 02:39:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:45 INFO - Return code: 0 02:39:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:39:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:39:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0051', '--webServer', 'localhost'] in /builds/slave/test/build 02:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0051 --webServer localhost 02:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucA8ZTZU0T/Render', 02:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:45 INFO - 'HOME': '/Users/cltbld', 02:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:45 INFO - 'LOGNAME': 'cltbld', 02:39:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:45 INFO - 'MOZ_NO_REMOTE': '1', 02:39:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:45 INFO - 'NO_EM_RESTART': '1', 02:39:45 INFO - 'PAGER': '/bin/cat', 02:39:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:45 INFO - 'PWD': '/builds/slave/test', 02:39:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:45 INFO - 'SHELL': '/bin/bash', 02:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvLbTZGrKL/Listeners', 02:39:45 INFO - 'TMPDIR': '/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/', 02:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:45 INFO - 'USER': 'cltbld', 02:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:45 INFO - 'XPC_FLAGS': '0x0', 02:39:45 INFO - 'XPC_SERVICE_NAME': '0', 02:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:39:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0051', '--webServer', 'localhost'] with output_timeout 3600 02:39:46 INFO - mozversion INFO | application_buildid: 20151030004047 02:39:46 INFO - mozversion INFO | application_changeset: e902b5a2882bcc6a751e77fd8bb812d438d5886b 02:39:46 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:39:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:46 INFO - mozversion INFO | application_name: Firefox 02:39:46 INFO - mozversion INFO | application_remotingname: firefox-dev 02:39:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:46 INFO - mozversion INFO | application_vendor: Mozilla 02:39:46 INFO - mozversion INFO | application_version: 44.0a2 02:39:46 INFO - mozversion INFO | platform_buildid: 20151030004047 02:39:46 INFO - mozversion INFO | platform_changeset: e902b5a2882bcc6a751e77fd8bb812d438d5886b 02:39:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:46 INFO - mozversion INFO | platform_version: 44.0a2 02:39:46 INFO - 2015-10-30 02:39:46,273 DEBUG : using testdate: 1446197986 02:39:46 INFO - 2015-10-30 02:39:46,273 DEBUG : actual date: 1446197986 02:39:46 INFO - 2015-10-30 02:39:46,283 INFO : starting webserver on 'localhost:49263' 02:39:46 INFO - 2015-10-30 02:39:46,284 INFO : Starting test suite t-yosemite-r5-0051 02:39:46 INFO - 2015-10-30 02:39:46,284 INFO : Starting test dromaeo_css 02:39:46 INFO - 2015-10-30 02:39:46,284 DEBUG : operating with platform_type : mac_ 02:39:46 INFO - 2015-10-30 02:39:46,285 INFO : Initialising browser for dromaeo_css test... 02:39:46 INFO - 2015-10-30 02:39:46,309 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/tmpPs0D4U/profile http://localhost:49263/getInfo.html 02:39:49 INFO - 2015-10-30 02:39:49,681 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:39:49 INFO - 2015-10-30 02:39:49,681 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:39:49 INFO - 2015-10-30 02:39:49,682 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:39:49 INFO - 2015-10-30 02:39:49,682 DEBUG : BROWSER_OUTPUT: __metrics 02:39:49 INFO - 2015-10-30 02:39:49,699 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:50 INFO - 2015-10-30 02:39:50,507 INFO : Browser initialized. 02:39:50 INFO - 2015-10-30 02:39:50,507 INFO : Running cycle 1/1 for dromaeo_css test... 02:39:50 INFO - 2015-10-30 02:39:50,508 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/tmpPs0D4U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:40:02 INFO - 2015-10-30 02:40:02,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 199626752 02:40:02 INFO - 2015-10-30 02:40:02,694 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-10-30 02:40:54,557 DEBUG : BROWSER_OUTPUT: 1446198054556 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] 02:43:04 INFO - 2015-10-30 02:43:04,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 02:43:06 INFO - 2015-10-30 02:43:06,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 318849024 02:43:06 INFO - 2015-10-30 02:43:06,143 DEBUG : BROWSER_OUTPUT: 02:46:09 INFO - 2015-10-30 02:46:09,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 02:46:09 INFO - 2015-10-30 02:46:09,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 346689536 02:46:09 INFO - 2015-10-30 02:46:09,592 DEBUG : BROWSER_OUTPUT: 02:49:11 INFO - 2015-10-30 02:49:11,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 02:49:12 INFO - 2015-10-30 02:49:12,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 314355712 02:49:12 INFO - 2015-10-30 02:49:12,432 DEBUG : BROWSER_OUTPUT: 02:52:14 INFO - 2015-10-30 02:52:14,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 02:52:15 INFO - 2015-10-30 02:52:15,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 305012736 02:52:15 INFO - 2015-10-30 02:52:15,100 DEBUG : BROWSER_OUTPUT: 02:55:18 INFO - 2015-10-30 02:55:18,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 02:55:18 INFO - 2015-10-30 02:55:18,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 303210496 02:55:18 INFO - 2015-10-30 02:55:18,837 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 02:58:21 INFO - 2015-10-30 02:58:21,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 349708288 02:58:21 INFO - 2015-10-30 02:58:21,676 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,677 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:58:21 INFO - 2015-10-30 02:58:21,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:58:21 INFO - 2015-10-30 02:58:21,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:58:21 INFO - 2015-10-30 02:58:21,677 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:58:21 INFO - 2015-10-30 02:58:21,679 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2620;2675.6120362547417;2678.116221646856;2711.1324376199623;2779.3885345224057;4487.730736155833;4534.47853496848;4632.629389648829;4688.413948256468;4705.929411058833;4599.81600735971;4608.10142022305;4661.184292748772;4672.906541869169;4693.084848454553;4072.735272207312;4237;4284.378765079062;4336.21948049351;4337.1325734853;4205.2640787862;4216.831326746927;4266.296061149907;4310;4392.714473559208;4159.9376009359885;4261.424707664472;4315.913681726363;4332.7833608319615;4373.343998400233;4263.829446822124;4355.041890784022;4413.007073408489;4432.490263619693;4435.844745433927;4108.4864391951005;4233.089885674594;4282.42187304713;4300.548442413564;4307.203167414038;4254.957450425487;4452.844150454751;4516.096780643851;4563.566461186215;4691.601213896823;4805.471398146201;4846.079244943485;4858.5384388483035;4929.876753081166;4939.209726443752;4890.706557606555;4895.339129217546;4901.01979604077;4947.90104197914;4965.354503914468;4315.8057887394825;4340.65274778017;4409.603135717736;4442.378067070613;4517.435320584927;5013.172826483589;5067.771950262247;5070.898582028412;5114.41184263807;5115.693058416433;4781.067691800065;4846.151923413388;4846.80612775485;4856.490068542823;4885.389326334208;4668.883277918079;4731.739754313477;4772.976135119302;4841.540053694894;4942.332785074041;4732.148213321566;4759.23852183649;4772.308015337757;4821.734804585782;4832.903341933142;4742.786574604151;4809.470958194595;4826.444958829709;4844.636652251025;4853.005133947532;3637.199816040467;3651.543557055368;3674.540682414698;3724.944125838115;3770.792606406619;3322.2358857462436;3329.6170940341685;3340.064781861083;3395.6774106459848;3404.727621790251;4562.726236425825;4604.88487787808;4658.906821863611;4684.929726054112;4700.130475861976;4663.743494107789;4760.571548560577;4857.684250523705;4864.708117512961;4939;4564.246899261585;4568.70303430276;4575.428071491064;4604.930926036112;4640.095181439587;4192.224438478891;4233.91532169361;4252.128313695685;4312.180685669713;4335.566443355702;4704.882377940579;4808.374911261513;4911.361523002059;4954.752262386938;4994.650374473752;4849.660523763303;4873.537013983666;4952.678075925053;4962.33008543842;4985.8005679772405;4929.975350123226;4940.530649588283;4963.429205641253;5006.299118123538;5014.34813474246;4617.676762626584;4687.601553867959;4697.342372067845;4806.327114204084;4839.1531481991215;4868.707877527359;4905.8037678492465;4919.53264439892;4924.4090709115135;4928.700262080053;4715.3869996900185;4805.783739731791;4828.37231159947;4851.95148048515;4858;4640.280756482751;4654.348391225163;4662.393888794435;4727.432708075053;4815.879603009953;4486.618637415726;4595.1958407277925;4653.464851542116;4667.229907065296;4673.602743766818;4721.197396442682;4745.857624271277;4790.01804630057;4817.686850354716;4841.370621819141;4392.69251152429;4549.999000220078;4555.567221114122;4582.977085114553;4653.9295961928265 02:58:21 INFO - 2015-10-30 02:58:21,682 DEBUG : BROWSER_OUTPUT: |1;ext.html;464.844277167149;465.6344769356056;483.9128956787778;485.88095916500464;502.0686626308196;28593.857030714844;29271.414571708552;34695.306093878105;35305.11737206571;35579.82210088953;37512.62487375126;37626;37640.43539346905;37688.81155594225;38098.619013809854;7222.061132052826;7735.187805280449;7746.302832745037;7962.243586859239;8004.999375078115;7200.207977122539;9263.814723705522;9454.007329230435;9494.762630934247;9560.426374417557;9186.86219706705;9228.815423691522;9245.953770231139;9318.813623727521;9349.76625584359;7283.016792732966;7634.312911837961;9272.258219342437;9367.625294988193;9446.669366572205;8999.5050272235;9148;9150.81698366029;9319.580618872167;9341.299402544837;33282.83358583192;34363;34382.82808585941;34928.126796830285;35010.82494587536;2542.2500362392952;2543.1988923489043;2579.6646435963203;2581.3288544978254;2596.883140258693;23710.644340334908;23825.523489530286;24155.63766543503;24364.878175609185;24469.38826529351;1986.9801301987084;2019.555697746508;2024.5647185854964;2047.8566500344982;2073.792620737929;253099.99999999817;253221.99999999817;253320;253712;256646;47464.5253547467;54392.728036359564;54478;55546.055888043724;55568.444315557135;44570.55429445729;61828;63394.36605633885;63419.6829015852;63522.682386587774;14922.70154596902;15160.09039457636;15173.317200725773;15187;15405.691886162438;11469.139814513945;11553.267009948408;11553.36456494884;11566.248193867372;11579.594714184963;17976.91011544934;18265.45203643893;18328.633427331646;18419.539511512052;18540.258389664534;7350.558966462029;7461.925380746123;7470.439717021245;7505.962470187724;7616.314531692175;733.8935854301096;762.8016715653858;823.6581818545236;912.8128733609594;921.2077613252598;24557.508849822905;24857.378565535644;25173.748262517507;25619.487610247692;25630.487390252092;749.6776386153897;878.468526541446;883.4787475389551;898.4294972692256;904.9321300902327;12005.699857503632;12258;12538.937305313597;12693.746125077447;12727.17273377246;379512;386403;387356;390266;393910;48005.75997119992;48392.75803620959;48615.756921215165;48624.27063594049;48859;1205.3732059329275;1223.3821919930378;1229.0536287059094;1234.160770675949;1342.7046049869014;24700.653437923367;25492.362690932132;25614.23157305284;26081.478370432866;26144.34639134037;42416.787916060224;42564.36153457763;42710.14579708326;42987;43122.137557248054;223214;226578;227479;229461;232394;24114.87942560276;24759.87620061888;27621;27977.621902138548;28318.292042699097;33458.16354591155;33515.06058400386;34085.82957085298;34175;34307.313853722284;28853.567196492488;30796;30900.381992360475;31325.216869577533;31477.370452590363;23509.882450587636;24949.87525062363;30200.395992080474;31079.0676279712;31147;29860.552091718208;30791.53812692856;31823.840880795447;32054.519182211818;32312;20988.47528811792;22583.497789213492;22993.88503057474;23028.309150725505;27408.86295568589;20362.18551257933;20657.58684826325;20779.8961005194;20832;21052.157913683895 02:58:21 INFO - 2015-10-30 02:58:21,686 DEBUG : BROWSER_OUTPUT: |2;jquery.html;290.4466990383318;290.62389585313537;293.7840687094985;303.6098613281933;304.92986613079006;12873.291968941705;13111.278879661615;14561.490347837827;14787;15110.168940708256;13157.210567365964;15278;15460.304286307115;15816.76274855878;15936.601584960354;3888.105735680795;3992.6406623403886;4071.7149799514045;4470.418845550074;4551.362809206714;2950.6754257031816;3068.248279171606;3080.445519806434;4029.919401611966;4043.6360727534516;3959.8614048508307;4037.8586749463775;4046.635802777764;4058.715889887709;4101.651359634419;4027.4562934003975;4043.5147782266167;4047.6559492442884;4060.654844338235;4069.6337329640473;3397.6262611112757;3441.1913200397885;3476.0788391076385;3523.541939547868;3526.770759900624;11368.317900925971;11372.260803047775;11400.885991140149;11559.653210403701;11710.063194944383;1599.0166047880587;1609.6378314879175;1632.1711348798435;1718.6734520441075;1752.7896652401794;7995.480293780944;8201.179882011811;8472.44929079608;8487.3210143189;8495;1311.7048664050512;1350.2641060621984;1352.9120607160503;1360.653033476467;1365.8838998685123;50480.495195048316;53072.469275307136;53222.20166697502;53564;54066.45933540693;5670.432956704379;5683.971580142155;5736.713164341766;5757.165211044375;5822.184894114827;6499.902501462482;6507.219133703986;6507.3167317431935;6604.339566043357;6627.370399812106;4723.488483685256;4771.6898401603785;4783.56947874686;4792.760361981887;4932.284818701268;5151.5106064923775;5208.114620514446;5218.6868787872845;5240.868978275497;5300.310959575308;2574.0733335999025;2577.2525967469223;2598.0257403473697;2608.6478325426206;2633.39431930657;892.0499667853715;905.8369493491103;916.7295647783919;917.0508523677961;931.7065124485765;332.8118616538933;333.8264102666648;340.962494125646;341.6651681352289;349.18291198594903;8206.794830129174;8572;8600.139986001475;8670.436421632574;8832.470051796912;319.48243844971296;329.3478911754739;333.788044591686;337.23447773554386;350;4848.757562121879;4879.219324908068;4998.4251811042195;5018.222175562793;5090.389153301628;443320;452457;454486;458127;464373;63447.36552634507;63732;63893.36106638967;64687.67656161689;65119.674401627686;378.281265595371;378.4814803718868;382.24697346227885;384.70185606154894;391.0673044788144;8582.442141260799;8666;8822.33832462555;8823;8882;29779.851100745225;29831.701682982894;29970.70029299679;30053.549196762502;30129;38564;40727.79636101801;41256.58743412527;41306.586934130275;42509.5749042518;5253.054450198848;5341.679499230058;5455.509004189642;5484.61607687458;5488.067028605067;10005.499725013575;10073.445960472245;10309.845352319871;10317.071463568314;10350.120239779702;7564.924350756422;8127.593620318842;8750.168733970262;8802.163794439519;9000.684976025808;8469.830603388022;8528.104549022264;8556.315494760529;8703.825923481621;8880.1563851434;8894.688685895962;8931.374803763674;9059.682911098344;9066.048064953085;9110.681126160553;5359.249705041219;5396.865078373072;5408.13469844823;5414.891702165856;5467.261919640957;8580.356473264656;8793.076726943578;8845.24815390699;8846.203841654282;8850.380473366802 02:58:21 INFO - 2015-10-30 02:58:21,686 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1134.943252837358;1193.7015746063487;1234.7345320756035;1337.478383430462;1485.4132617616042;5916.674582897945;6183.134361189426;6267.18526591543;6394.296627370985;6459.192600924873;6401.231852177745;6475.352464753522;6476.093346931421;6505.5120865935005;6588.703508342124;1815.7821061472575;1826.917788699505;1828.6159906419634;1831.7893442254112;1852.7220916862511;1853.7775466943986;1860.9813901860944;1876.9530761730998;1890.4612185527128;1909.9045047747627;1819.6178802451434;1833.779946406433;1840.411068458094;1851.6481868445019;1852.2776117314258;1820.2900868661234;1863.5713785829266;1869.9345522906633;1890.9243630254773;1891.404207674585;1859.758231429919;1870.4575673054799;1877.793442721313;1888.386274460792;1924.4803902946267;5779.133130030487;6388.393102655286;6392.584482008655;6479.74081036758;6528.3145269746465;3498.0555250082334;3646.5259516262718;3937.7440466369594;4054.837806487737;4095.5494895561465;2358.363241924688;2376.2158487699016;2423.5152969406013;2449.6570480132796;2456.361346050022;733.3216774483635;748.6406524868094;764.3464837563914;764.8929149919015;774.573984308628;8523.14768523149;8585.699500517452;8585.914140858575;8607.09625489321;8663.913360866374;3519.296140771856;3593.748437609342;3603.4054381027363;3658.762180458315;3683.0976410778994;7556.546607203585;7598.12621548529;7614.048243969504;7629.008228930204;7650;4011.7392369495888;4025.456563363967;4040.939385909214;4056.9391459128137;4058.857939972087;3574.392353299945;3634.9818250908575;3648.1244501319493;3674.6876515496483;3707.8876337098764;2961.392914452532;2998.895038673636;3013.9246518836767;3032.696730326994;3067.4171907337536;972.863799068131;975.512243878061;976.6532880827347;982.8378317577663;983.9655612053543;857.2541888556871;857.2927334948693;866.9696560620348;867.7440155154245;1068.3643232276784;5989.341172471025;5990.28116625999;6000.33996260411;6031.849203769941;6104.481119104926;392.05123600885923;392.2782080971027;395.1563412115155;397.8189923584762;399.98000099994886;4832.44426890905;4879.951200488021;4972.179590367549;4994.500549945049;4996.925046124311;6324.6521441321165;6416.358364163546;7436.814079648052;7588.354989825816;7673.693052277958;7493.775186744407;7580.431467639839;7585.810354741066;7647.770566883002;7655.311022008046;6044.7582096716515;6066.817995460143;6174.753009879644;6229.2524897012645;6247.531435142382;6037.034074548052;6066.423689749467;6108.08378743192;6116.908246376397;6135.907961380493;6791.185057792899;6937.265683579105;7041.295870412918;7102.822429439306;7142.071530700976;7066.116735408074;7095.467839911924;7248.746293879689;7282.380997615051;7306.525075870264;5771.826845194651;5779.768809247583;5783.074708046693;5855.3559108497175;5900.321463031634;6000.459958603747;6033.487153591994;6134.171886795404;6144.1398204250545;6144.508439324753;5584.190292407497;5698.800541981011;5729.197912292199;5730.856728581819;5843.29880414353;5858.443447872445;5885.852853678693;5888.216589080818;5911.793087241926;5975.55183361241;5950.613210141327;5966.3138739043825;6047.153398524122;6090.512758979359;6111.572189946839;5019.573336266459;5104.821331253388;5377.569794416359;5377.951299496561;5520.033994051106;5398.811041613525;5413.621046526705;5434.049041417815;5516.751746171512;5530.889382212253 02:58:21 INFO - 2015-10-30 02:58:21,690 DEBUG : BROWSER_OUTPUT: |4;prototype.html;266.3155689877016;277.35376572585864;281.6268444311288;282.18730057434584;284.20847938491306;4925.876853078675;5006.148954677705;5041.521055499727;5071.391433028032;5125.333706618135;4948.950510494894;4950.13372659784;4986.127427700156;5008.49915008499;5008.974955125228;3946.7237293389476;4028.315186418316;4031.21391328691;4035.656969157625;4069.3895915612597;3980.7412518186225;4010.679145668354;4038.8586399476026;4041.7777022263763;4064.227796718614;3941.724079314449;3966.643002129808;3989;3994.560598334181;4014.0767623446623;3820.9426858597144;3971.126352202511;3992.061865461614;4035.273650742865;4044.8786536403954;3455.3953058214965;3486.3027394520946;3495.370833250014;3500.527428797105;3517.859285628572;4908.361912951294;4932.506749325074;4971.27916452116;4977.9751101244265;4978.950210497921;4400.647948164139;4409.691321607489;4460.6208472279895;4467.374567560544;4469.664775141845;5055.69665820052;5254.4220135785035;5294.470552944713;5319.17552779316;5359;3672.6510981456718;3701.592824789298;3710.499082623838;3733.8693145739767;3736.925261494755;5312.92030619541;5407.134858422633;5462.426445223274;5488.7530061147345;5541.33503979521;3596.6583174598895;3664.0107171064196;3682.5949145593963;3733.328000959799;3798.0315019669806;3804.524434445694;3848.4419759134767;3849.846006159722;3867.4778904847485;3876.282887665791;4230.175115852379;4350.456192975878;4400.625946794495;4406.515283318832;4415.139047885696;5164.070467315919;5239.607029472729;5263.4473380295285;5273.894522109536;5276.947230527646;1355.8779709826163;1366.6173471428017;1380.1236215003546;1380.4823191303262;1384.9376778045012;846.2933450568721;859.8194379180442;861.0915484164267;866.5840396609663;899.581694512055;5075.771590278447;5086.033653605803;5090.643654944119;5144.6655967362;5229.08491014071;5521.4478552144465;5544.750486228129;5562.888742225214;5596.384397716248;5601.719914004283;5135.948640513622;5152.458991805881;5168.2764412982215;5208.218767184952;5235.188545775335;3020.0788759428146;3024.758019358446;3083.491223948068;3089.675584063641;3102.782805203614;5635.605507614509;5654.6324488908085;5667.886642267132;5671.858203544944;5723.141528770634;5674.319081710221;5689.34572524165;5708.71456427177;5737.713114344266;5738.110592858114;5628.943710562842;5648.209250704905;5648.74580643872;5671.291088613841;5693.003724348306;5374.495141360425;5607.383187849415;5610.747516361692;5619.943800561942;5645.491905728504;5400.297961265011;5458.672479651074;5500.064988951968;5531.502164805187;5563.749631266522;5630.831075067755;5672.829815105553;5750.913736294043;5757.021306377842;5759.94240057594;3314.8508317125306;3474.652534746505;3484.0593039879595;3517.824108794601;3541.468779683068;5348.438413966477;5411.296531451044;5535.833924982257;5547.833564993057;5618.85952851182;5236;5295.920561191662;5318.255444237887;5326.121190003606;5389.919151212656;5286.735663216747;5299.49654782795;5303.761330740049;5362.410134885237;5383.623146379716;5142.485751424828;5172.612054096033;5176.7152806596;5181.3005244293045;5236.633435659467;5115.2071428928575;5370.543503802221;5372.301600791872;5385.946140538545;5449.809256675997;5266.210068489757;5289.074411977812;5353.143497040455;5353.9732301338245;5361.946380536145 02:58:21 INFO - 2015-10-30 02:58:21,690 DEBUG : BROWSER_OUTPUT: |5;yui.html;556.8941901038805;617.8764247150568;626.7900253415106;629.9968500157498;636.5766765101208;11799.7640047199;11945.522179112835;11961.342126183057;12057.51769929203;12082.81875771862;10908.563657453693;11312.208145429802;11421.42892855356;11515.021223196018;11519.48162332695;595.330253464852;602.2111034544738;752.0862152484743;761.9619019049053;764.8814433762748;733.2557454184008;738.5753191914644;743.657917358016;754.852803703278;755.7997130760353;797.5693125712108;805.6495424490336;811.407672399149;813.3940214540175;818.0878320672438;622.6233128957007;630.8170630517144;788.5268838696793;795.0975642645581;807.2694211738386;587.9735411906474;589.113384356545;590.9527237820964;596.8239369385998;601.2394321183706;10150.340227885164;10258.384496930134;10262.076413122855;10293.794124117476;10343.586256549728;9537.761555961088;9856.50717464124;10239.948800255952;10427.635032773893;10475.947620261926;7775.8444831103625;8041.477303975223;8101.797455063612;8120.0661923878915;8339.916600833974;2753.2153336299257;2779.8888044478194;2828.6708613238434;2876.424715056997;2962.837043962581;40259.39610905809;40570;40753.184936301106;40970.590294096975;41299.587004130175;7541.8114547135665;7644.961775191088;7689;7793.347628783656;7920.801979950432;16260;16351.591210219602;16426.342946282013;16477;16510.83489165093;5872.442117998783;6068.423499767515;6203.16257305258;6227.626342419469;6336.303006669263;3111.8910838120555;3285.6385797562248;3296.5220043094096;3363.899083027513;3364.327134573095;2506.8370555913807;2538.898444062254;2543.987280063588;2555.514452254066;2565.3073670108965;345.50765159647403;364.246010757729;365.4317536231186;368.58165981611063;369.64514066496463;420.1512943853399;457.8786621545293;480.2723873331905;481.8217259613965;513.1800754852112;6184.226971628546;6527.445167160845;6719.832004199837;6739.224989126215;6744.055832183498;419.588802973082;429.63695677152754;432.3864367201963;475.6028716022091;502.63558919783594;3055.3125546751803;3081.645610754747;3252.3983063133396;3327.9168020799675;3333.4999750037687;51776;51977.22034169415;52122;52860.73569632127;52872.59783630295;42251;42272;42765;42888.356674649905;43172.78413607912;40587.797061014506;43899;44399;44685.776571116934;45098.09803803971;6885.8967115492305;6946.895796562954;7149.939462185215;7252.311030452099;7264.455165862687;28742.137735867957;28988.13035608935;29001;29448.852755736083;31076.68923310738;39187.6081239184;39535.406968896066;40207.1958560833;40320.19359612733;40957.795211024946;9099.499527525784;9128.132827381389;9300.767480813034;9456.385334953206;9511.524423778921;9312.394694344846;9418.152366287068;9553.426794392359;9578.233741300819;9687.225021998082;8993.32550058735;9259.305552083755;9356.298277629341;9436.292278079034;9784.9021509784;8992.640294388413;9159.084091590788;9160.816783664422;9240.214581760625;9278.396904201205;8987.640494380152;9003.672432899664;9047.547622618711;9075.13786190311;9076.228520575825;7604.695812167452;7799.376049916106;8102.837943240984;8188.672453102047;8345.290650294794;7801.082375240134;7982;7986.361091112581;8023.277904988579;8058.355331573577 02:58:21 INFO - 2015-10-30 02:58:21,690 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:58:21 INFO - 2015-10-30 02:58:21,692 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:58:21 INFO - 2015-10-30 02:58:21,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 02:58:21 INFO - 2015-10-30 02:58:21,692 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:58:21 INFO - 2015-10-30 02:58:21,692 DEBUG : BROWSER_OUTPUT: __startTimestamp1446199101675__endTimestamp 02:58:21 INFO - 2015-10-30 02:58:21,692 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,692 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:58:21 INFO - 2015-10-30 02:58:21,693 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:58:21 INFO - 2015-10-30 02:58:21,693 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,693 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4534.42 Median:4668.88 stddev:488.23 (10.5%) stddev-sans-first:466.06 02:58:21 INFO - 2015-10-30 02:58:21,693 DEBUG : BROWSER_OUTPUT: Values: 2620.0 2675.6 2678.1 2711.1 2779.4 4487.7 4534.5 4632.6 4688.4 4705.9 4599.8 4608.1 4661.2 4672.9 4693.1 4072.7 4237.0 4284.4 4336.2 4337.1 4205.3 4216.8 4266.3 4310.0 4392.7 4159.9 4261.4 4315.9 4332.8 4373.3 4263.8 4355.0 4413.0 4432.5 4435.8 4108.5 4233.1 4282.4 4300.5 4307.2 4255.0 4452.8 4516.1 4563.6 4691.6 4805.5 4846.1 4858.5 4929.9 4939.2 4890.7 4895.3 4901.0 4947.9 4965.4 4315.8 4340.7 4409.6 4442.4 4517.4 5013.2 5067.8 5070.9 5114.4 5115.7 4781.1 4846.2 4846.8 4856.5 4885.4 4668.9 4731.7 4773.0 4841.5 4942.3 4732.1 4759.2 4772.3 4821.7 4832.9 4742.8 4809.5 4826.4 4844.6 4853.0 3637.2 3651.5 3674.5 3724.9 3770.8 3322.2 3329.6 3340.1 3395.7 3404.7 4562.7 4604.9 4658.9 4684.9 4700.1 4663.7 4760.6 4857.7 4864.7 4939.0 4564.2 4568.7 4575.4 4604.9 4640.1 4192.2 4233.9 4252.1 4312.2 4335.6 4704.9 4808.4 4911.4 4954.8 4994.7 4849.7 4873.5 4952.7 4962.3 4985.8 4930.0 4940.5 4963.4 5006.3 5014.3 4617.7 4687.6 4697.3 4806.3 4839.2 4868.7 4905.8 4919.5 4924.4 4928.7 4715.4 4805.8 4828.4 4852.0 4858.0 4640.3 4654.3 4662.4 4727.4 4815.9 4486.6 4595.2 4653.5 4667.2 4673.6 4721.2 4745.9 4790.0 4817.7 4841.4 4392.7 4550.0 4555.6 4583.0 4653.9 02:58:21 INFO - 2015-10-30 02:58:21,694 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,695 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43462.80 Median:32183.26 stddev:78687.26 (244.5%) stddev-sans-first:78841.77 02:58:21 INFO - 2015-10-30 02:58:21,696 DEBUG : BROWSER_OUTPUT: Values: 464.8 465.6 483.9 485.9 502.1 28593.9 29271.4 34695.3 35305.1 35579.8 37512.6 37626.0 37640.4 37688.8 38098.6 7222.1 7735.2 7746.3 7962.2 8005.0 7200.2 9263.8 9454.0 9494.8 9560.4 9186.9 9228.8 9246.0 9318.8 9349.8 7283.0 7634.3 9272.3 9367.6 9446.7 8999.5 9148.0 9150.8 9319.6 9341.3 33282.8 34363.0 34382.8 34928.1 35010.8 2542.3 2543.2 2579.7 2581.3 2596.9 23710.6 23825.5 24155.6 24364.9 24469.4 1987.0 2019.6 2024.6 2047.9 2073.8 253100.0 253222.0 253320.0 253712.0 256646.0 47464.5 54392.7 54478.0 55546.1 55568.4 44570.6 61828.0 63394.4 63419.7 63522.7 14922.7 15160.1 15173.3 15187.0 15405.7 11469.1 11553.3 11553.4 11566.2 11579.6 17976.9 18265.5 18328.6 18419.5 18540.3 7350.6 7461.9 7470.4 7506.0 7616.3 733.9 762.8 823.7 912.8 921.2 24557.5 24857.4 25173.7 25619.5 25630.5 749.7 878.5 883.5 898.4 904.9 12005.7 12258.0 12538.9 12693.7 12727.2 379512.0 386403.0 387356.0 390266.0 393910.0 48005.8 48392.8 48615.8 48624.3 48859.0 1205.4 1223.4 1229.1 1234.2 1342.7 24700.7 25492.4 25614.2 26081.5 26144.3 42416.8 42564.4 42710.1 42987.0 43122.1 223214.0 226578.0 227479.0 229461.0 232394.0 24114.9 24759.9 27621.0 27977.6 28318.3 33458.2 33515.1 34085.8 34175.0 34307.3 28853.6 30796.0 30900.4 31325.2 31477.4 23509.9 24949.9 30200.4 31079.1 31147.0 29860.6 30791.5 31823.8 32054.5 32312.0 20988.5 22583.5 22993.9 23028.3 27408.9 20362.2 20657.6 20779.9 20832.0 21052.2 02:58:21 INFO - 2015-10-30 02:58:21,696 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,697 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22751.07 Median:453471.50 stddev:74557.25 (16.4%) stddev-sans-first:74747.32 02:58:21 INFO - 2015-10-30 02:58:21,697 DEBUG : BROWSER_OUTPUT: Values: 290.4 290.6 293.8 303.6 304.9 12873.3 13111.3 14561.5 14787.0 15110.2 13157.2 15278.0 15460.3 15816.8 15936.6 3888.1 3992.6 4071.7 4470.4 4551.4 2950.7 3068.2 3080.4 4029.9 4043.6 3959.9 4037.9 4046.6 4058.7 4101.7 4027.5 4043.5 4047.7 4060.7 4069.6 3397.6 3441.2 3476.1 3523.5 3526.8 11368.3 11372.3 11400.9 11559.7 11710.1 1599.0 1609.6 1632.2 1718.7 1752.8 7995.5 8201.2 8472.4 8487.3 8495.0 1311.7 1350.3 1352.9 1360.7 1365.9 50480.5 53072.5 53222.2 53564.0 54066.5 5670.4 5684.0 5736.7 5757.2 5822.2 6499.9 6507.2 6507.3 6604.3 6627.4 4723.5 4771.7 4783.6 4792.8 4932.3 5151.5 5208.1 5218.7 5240.9 5300.3 2574.1 2577.3 2598.0 2608.6 2633.4 892.0 905.8 916.7 917.1 931.7 332.8 333.8 341.0 341.7 349.2 8206.8 8572.0 8600.1 8670.4 8832.5 319.5 329.3 333.8 337.2 350.0 4848.8 4879.2 4998.4 5018.2 5090.4 443320.0 452457.0 454486.0 458127.0 464373.0 63447.4 63732.0 63893.4 64687.7 65119.7 378.3 378.5 382.2 384.7 391.1 8582.4 8666.0 8822.3 8823.0 8882.0 29779.9 29831.7 29970.7 30053.5 30129.0 38564.0 40727.8 41256.6 41306.6 42509.6 5253.1 5341.7 5455.5 5484.6 5488.1 10005.5 10073.4 10309.8 10317.1 10350.1 7564.9 8127.6 8750.2 8802.2 9000.7 8469.8 8528.1 8556.3 8703.8 8880.2 8894.7 8931.4 9059.7 9066.0 9110.7 5359.2 5396.9 5408.1 5414.9 5467.3 8580.4 8793.1 8845.2 8846.2 8850.4 02:58:21 INFO - 2015-10-30 02:58:21,697 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,697 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4495.13 Median:5856.90 stddev:2344.04 (40.0%) stddev-sans-first:2337.01 02:58:21 INFO - 2015-10-30 02:58:21,699 DEBUG : BROWSER_OUTPUT: Values: 1134.9 1193.7 1234.7 1337.5 1485.4 5916.7 6183.1 6267.2 6394.3 6459.2 6401.2 6475.4 6476.1 6505.5 6588.7 1815.8 1826.9 1828.6 1831.8 1852.7 1853.8 1861.0 1877.0 1890.5 1909.9 1819.6 1833.8 1840.4 1851.6 1852.3 1820.3 1863.6 1869.9 1890.9 1891.4 1859.8 1870.5 1877.8 1888.4 1924.5 5779.1 6388.4 6392.6 6479.7 6528.3 3498.1 3646.5 3937.7 4054.8 4095.5 2358.4 2376.2 2423.5 2449.7 2456.4 733.3 748.6 764.3 764.9 774.6 8523.1 8585.7 8585.9 8607.1 8663.9 3519.3 3593.7 3603.4 3658.8 3683.1 7556.5 7598.1 7614.0 7629.0 7650.0 4011.7 4025.5 4040.9 4056.9 4058.9 3574.4 3635.0 3648.1 3674.7 3707.9 2961.4 2998.9 3013.9 3032.7 3067.4 972.9 975.5 976.7 982.8 984.0 857.3 857.3 867.0 867.7 1068.4 5989.3 5990.3 6000.3 6031.8 6104.5 392.1 392.3 395.2 397.8 400.0 4832.4 4880.0 4972.2 4994.5 4996.9 6324.7 6416.4 7436.8 7588.4 7673.7 7493.8 7580.4 7585.8 7647.8 7655.3 6044.8 6066.8 6174.8 6229.3 6247.5 6037.0 6066.4 6108.1 6116.9 6135.9 6791.2 6937.3 7041.3 7102.8 7142.1 7066.1 7095.5 7248.7 7282.4 7306.5 5771.8 5779.8 5783.1 5855.4 5900.3 6000.5 6033.5 6134.2 6144.1 6144.5 5584.2 5698.8 5729.2 5730.9 5843.3 5858.4 5885.9 5888.2 5911.8 5975.6 5950.6 5966.3 6047.2 6090.5 6111.6 5019.6 5104.8 5377.6 5378.0 5520.0 5398.8 5413.6 5434.0 5516.8 5530.9 02:58:21 INFO - 2015-10-30 02:58:21,699 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,699 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4477.14 Median:5139.22 stddev:1341.56 (26.1%) stddev-sans-first:1307.57 02:58:21 INFO - 2015-10-30 02:58:21,700 DEBUG : BROWSER_OUTPUT: Values: 266.3 277.4 281.6 282.2 284.2 4925.9 5006.1 5041.5 5071.4 5125.3 4949.0 4950.1 4986.1 5008.5 5009.0 3946.7 4028.3 4031.2 4035.7 4069.4 3980.7 4010.7 4038.9 4041.8 4064.2 3941.7 3966.6 3989.0 3994.6 4014.1 3820.9 3971.1 3992.1 4035.3 4044.9 3455.4 3486.3 3495.4 3500.5 3517.9 4908.4 4932.5 4971.3 4978.0 4979.0 4400.6 4409.7 4460.6 4467.4 4469.7 5055.7 5254.4 5294.5 5319.2 5359.0 3672.7 3701.6 3710.5 3733.9 3736.9 5312.9 5407.1 5462.4 5488.8 5541.3 3596.7 3664.0 3682.6 3733.3 3798.0 3804.5 3848.4 3849.8 3867.5 3876.3 4230.2 4350.5 4400.6 4406.5 4415.1 5164.1 5239.6 5263.4 5273.9 5276.9 1355.9 1366.6 1380.1 1380.5 1384.9 846.3 859.8 861.1 866.6 899.6 5075.8 5086.0 5090.6 5144.7 5229.1 5521.4 5544.8 5562.9 5596.4 5601.7 5135.9 5152.5 5168.3 5208.2 5235.2 3020.1 3024.8 3083.5 3089.7 3102.8 5635.6 5654.6 5667.9 5671.9 5723.1 5674.3 5689.3 5708.7 5737.7 5738.1 5628.9 5648.2 5648.7 5671.3 5693.0 5374.5 5607.4 5610.7 5619.9 5645.5 5400.3 5458.7 5500.1 5531.5 5563.7 5630.8 5672.8 5750.9 5757.0 5759.9 3314.9 3474.7 3484.1 3517.8 3541.5 5348.4 5411.3 5535.8 5547.8 5618.9 5236.0 5295.9 5318.3 5326.1 5389.9 5286.7 5299.5 5303.8 5362.4 5383.6 5142.5 5172.6 5176.7 5181.3 5236.6 5115.2 5370.5 5372.3 5385.9 5449.8 5266.2 5289.1 5353.1 5354.0 5361.9 02:58:21 INFO - 2015-10-30 02:58:21,701 DEBUG : BROWSER_OUTPUT: 02:58:21 INFO - 2015-10-30 02:58:21,701 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11788.66 Median:3230.78 stddev:14188.85 (439.2%) stddev-sans-first:14203.59 02:58:21 INFO - 2015-10-30 02:58:21,702 DEBUG : BROWSER_OUTPUT: Values: 556.9 617.9 626.8 630.0 636.6 11799.8 11945.5 11961.3 12057.5 12082.8 10908.6 11312.2 11421.4 11515.0 11519.5 595.3 602.2 752.1 762.0 764.9 733.3 738.6 743.7 754.9 755.8 797.6 805.6 811.4 813.4 818.1 622.6 630.8 788.5 795.1 807.3 588.0 589.1 591.0 596.8 601.2 10150.3 10258.4 10262.1 10293.8 10343.6 9537.8 9856.5 10239.9 10427.6 10475.9 7775.8 8041.5 8101.8 8120.1 8339.9 2753.2 2779.9 2828.7 2876.4 2962.8 40259.4 40570.0 40753.2 40970.6 41299.6 7541.8 7645.0 7689.0 7793.3 7920.8 16260.0 16351.6 16426.3 16477.0 16510.8 5872.4 6068.4 6203.2 6227.6 6336.3 3111.9 3285.6 3296.5 3363.9 3364.3 2506.8 2538.9 2544.0 2555.5 2565.3 345.5 364.2 365.4 368.6 369.6 420.2 457.9 480.3 481.8 513.2 6184.2 6527.4 6719.8 6739.2 6744.1 419.6 429.6 432.4 475.6 502.6 3055.3 3081.6 3252.4 3327.9 3333.5 51776.0 51977.2 52122.0 52860.7 52872.6 42251.0 42272.0 42765.0 42888.4 43172.8 40587.8 43899.0 44399.0 44685.8 45098.1 6885.9 6946.9 7149.9 7252.3 7264.5 28742.1 28988.1 29001.0 29448.9 31076.7 39187.6 39535.4 40207.2 40320.2 40957.8 9099.5 9128.1 9300.8 9456.4 9511.5 9312.4 9418.2 9553.4 9578.2 9687.2 8993.3 9259.3 9356.3 9436.3 9784.9 8992.6 9159.1 9160.8 9240.2 9278.4 8987.6 9003.7 9047.5 9075.1 9076.2 7604.7 7799.4 8102.8 8188.7 8345.3 7801.1 7982.0 7986.4 8023.3 8058.4 02:58:21 INFO - 2015-10-30 02:58:21,703 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:58:21 INFO - 2015-10-30 02:58:21,703 DEBUG : BROWSER_OUTPUT: 02:58:22 INFO - 2015-10-30 02:58:22,349 INFO : Browser exited with error code: 0 02:58:22 INFO - 2015-10-30 02:58:22,382 INFO : Completed test dromaeo_css (00:18:36) 02:58:22 INFO - 2015-10-30 02:58:22,382 INFO : Starting test kraken 02:58:22 INFO - 2015-10-30 02:58:22,382 DEBUG : operating with platform_type : mac_ 02:58:22 INFO - 2015-10-30 02:58:22,382 INFO : Initialising browser for kraken test... 02:58:22 INFO - 2015-10-30 02:58:22,397 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/tmpKHPhGX/profile http://localhost:49263/getInfo.html 02:58:25 INFO - 2015-10-30 02:58:25,051 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:58:25 INFO - 2015-10-30 02:58:25,051 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:58:25 INFO - 2015-10-30 02:58:25,051 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:58:25 INFO - 2015-10-30 02:58:25,051 DEBUG : BROWSER_OUTPUT: __metrics 02:58:25 INFO - 2015-10-30 02:58:25,071 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:25 INFO - 2015-10-30 02:58:25,850 INFO : Browser initialized. 02:58:25 INFO - 2015-10-30 02:58:25,850 INFO : Running cycle 1/1 for kraken test... 02:58:25 INFO - 2015-10-30 02:58:25,850 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/tmpKHPhGX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:58:37 INFO - 2015-10-30 02:58:37,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 200052736 02:58:37 INFO - 2015-10-30 02:58:37,964 DEBUG : BROWSER_OUTPUT: 02:58:40 INFO - 2015-10-30 02:58:40,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:41 INFO - 2015-10-30 02:58:41,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 266371072 02:58:41 INFO - 2015-10-30 02:58:41,550 DEBUG : BROWSER_OUTPUT: 02:58:44 INFO - 2015-10-30 02:58:44,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 02:58:45 INFO - 2015-10-30 02:58:45,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 281808896 02:58:45 INFO - 2015-10-30 02:58:45,231 DEBUG : BROWSER_OUTPUT: 02:58:48 INFO - 2015-10-30 02:58:48,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 02:58:49 INFO - 2015-10-30 02:58:49,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 269520896 02:58:49 INFO - 2015-10-30 02:58:49,098 DEBUG : BROWSER_OUTPUT: 02:58:51 INFO - 2015-10-30 02:58:51,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 02:58:52 INFO - 2015-10-30 02:58:52,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 270028800 02:58:52 INFO - 2015-10-30 02:58:52,046 DEBUG : BROWSER_OUTPUT: 02:58:54 INFO - 2015-10-30 02:58:54,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:55 INFO - 2015-10-30 02:58:55,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 271204352 02:58:55 INFO - 2015-10-30 02:58:55,123 DEBUG : BROWSER_OUTPUT: 02:58:58 INFO - 2015-10-30 02:58:58,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:59 INFO - 2015-10-30 02:58:59,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 266047488 02:58:59 INFO - 2015-10-30 02:58:59,301 DEBUG : BROWSER_OUTPUT: 02:59:02 INFO - 2015-10-30 02:59:02,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:03 INFO - 2015-10-30 02:59:03,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 265445376 02:59:03 INFO - 2015-10-30 02:59:03,566 DEBUG : BROWSER_OUTPUT: 02:59:06 INFO - 2015-10-30 02:59:06,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 02:59:07 INFO - 2015-10-30 02:59:07,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 267292672 02:59:07 INFO - 2015-10-30 02:59:07,514 DEBUG : BROWSER_OUTPUT: 02:59:09 INFO - 2015-10-30 02:59:09,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:09 INFO - 2015-10-30 02:59:09,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 300154880 02:59:09 INFO - 2015-10-30 02:59:09,878 DEBUG : BROWSER_OUTPUT: 02:59:11 INFO - 2015-10-30 02:59:11,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:12 INFO - 2015-10-30 02:59:12,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 303165440 02:59:12 INFO - 2015-10-30 02:59:12,562 DEBUG : BROWSER_OUTPUT: 02:59:14 INFO - 2015-10-30 02:59:14,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:15 INFO - 2015-10-30 02:59:15,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 309059584 02:59:15 INFO - 2015-10-30 02:59:15,510 DEBUG : BROWSER_OUTPUT: 02:59:18 INFO - 2015-10-30 02:59:18,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:19 INFO - 2015-10-30 02:59:19,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 310452224 02:59:19 INFO - 2015-10-30 02:59:19,087 DEBUG : BROWSER_OUTPUT: 02:59:22 INFO - 2015-10-30 02:59:22,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:22 INFO - 2015-10-30 02:59:22,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 310882304 02:59:22 INFO - 2015-10-30 02:59:22,589 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 02:59:24 INFO - 2015-10-30 02:59:24,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 369410048 02:59:24 INFO - 2015-10-30 02:59:24,799 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,799 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:59:24 INFO - 2015-10-30 02:59:24,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:59:24 INFO - 2015-10-30 02:59:24,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:59:24 INFO - 2015-10-30 02:59:24,800 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:59:24 INFO - 2015-10-30 02:59:24,800 DEBUG : BROWSER_OUTPUT: |0;ai-astar;130;129;132;132;135;137;143;132;134;132 02:59:24 INFO - 2015-10-30 02:59:24,800 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;184;167;201;193;157;178;151;191;179;162 02:59:24 INFO - 2015-10-30 02:59:24,801 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;195;195;196;197;197;197;197;197;196 02:59:24 INFO - 2015-10-30 02:59:24,801 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;93;96;148;85;90;89;85;141;80 02:59:24 INFO - 2015-10-30 02:59:24,801 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;114;117;163;107;109;112;155;107;107;156 02:59:24 INFO - 2015-10-30 02:59:24,801 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;148;149;142;141;149;149;141;149;149;149 02:59:24 INFO - 2015-10-30 02:59:24,801 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;153;154;154;154;154;153;161;155;153;155 02:59:24 INFO - 2015-10-30 02:59:24,801 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;123;123;129;130;128;129;124;123;124;128 02:59:24 INFO - 2015-10-30 02:59:24,802 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;72;72;76;79;76;77;87;69;69 02:59:24 INFO - 2015-10-30 02:59:24,802 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;76;81;81;82;82;82;85;82;82 02:59:24 INFO - 2015-10-30 02:59:24,802 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;100;101;98;104;104;104;100;101;105 02:59:24 INFO - 2015-10-30 02:59:24,802 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;146;149;169;155;165;147;145;154;163;157 02:59:24 INFO - 2015-10-30 02:59:24,802 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;165;179;179;178;164;176;176;177;163 02:59:24 INFO - 2015-10-30 02:59:24,803 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;81;85;85;85;84;85;85;86;88 02:59:24 INFO - 2015-10-30 02:59:24,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:59:24 INFO - 2015-10-30 02:59:24,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:59:24 INFO - 2015-10-30 02:59:24,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,981 02:59:24 INFO - 2015-10-30 02:59:24,803 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:59:24 INFO - 2015-10-30 02:59:24,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1446199164793__endTimestamp 02:59:24 INFO - 2015-10-30 02:59:24,804 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:59:24 INFO - 2015-10-30 02:59:24,804 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:59:24 INFO - 2015-10-30 02:59:24,804 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,804 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:133.60 Median:133.00 stddev:4.03 (3.0%) stddev-sans-first:4.06 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: Values: 130.0 129.0 132.0 132.0 135.0 137.0 143.0 132.0 134.0 132.0 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:176.30 Median:181.50 stddev:16.59 (9.1%) stddev-sans-first:17.36 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: Values: 184.0 167.0 201.0 193.0 157.0 178.0 151.0 191.0 179.0 162.0 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:195.90 Median:197.00 stddev:1.60 (0.8%) stddev-sans-first:0.87 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: Values: 192.0 195.0 195.0 196.0 197.0 197.0 197.0 197.0 197.0 196.0 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,805 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:99.70 Median:89.50 stddev:24.08 (26.9%) stddev-sans-first:25.29 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: Values: 90.0 93.0 96.0 148.0 85.0 90.0 89.0 85.0 141.0 80.0 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:124.70 Median:115.50 stddev:23.30 (20.2%) stddev-sans-first:24.39 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: Values: 114.0 117.0 163.0 107.0 109.0 112.0 155.0 107.0 107.0 156.0 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:146.60 Median:149.00 stddev:3.66 (2.5%) stddev-sans-first:3.84 02:59:24 INFO - 2015-10-30 02:59:24,806 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 142.0 141.0 149.0 149.0 141.0 149.0 149.0 149.0 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.60 Median:154.00 stddev:2.37 (1.5%) stddev-sans-first:2.44 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: Values: 153.0 154.0 154.0 154.0 154.0 153.0 161.0 155.0 153.0 155.0 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:126.10 Median:128.00 stddev:2.92 (2.3%) stddev-sans-first:2.88 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: Values: 123.0 123.0 129.0 130.0 128.0 129.0 124.0 123.0 124.0 128.0 02:59:24 INFO - 2015-10-30 02:59:24,807 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:76.00 stddev:6.40 (8.4%) stddev-sans-first:5.65 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: Values: 64.0 72.0 72.0 76.0 79.0 76.0 77.0 87.0 69.0 69.0 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.70 Median:82.00 stddev:3.23 (3.9%) stddev-sans-first:2.35 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 81.0 81.0 82.0 82.0 82.0 85.0 82.0 82.0 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,808 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:101.20 Median:104.00 stddev:3.16 (3.0%) stddev-sans-first:2.42 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: Values: 95.0 100.0 101.0 98.0 104.0 104.0 104.0 100.0 101.0 105.0 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:155.00 Median:156.00 stddev:8.47 (5.4%) stddev-sans-first:8.34 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: Values: 146.0 149.0 169.0 155.0 165.0 147.0 145.0 154.0 163.0 157.0 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:176.50 stddev:7.20 (4.1%) stddev-sans-first:6.86 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 179.0 179.0 178.0 164.0 176.0 176.0 177.0 163.0 02:59:24 INFO - 2015-10-30 02:59:24,809 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-10-30 02:59:24,810 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.30 Median:85.00 stddev:2.54 (3.0%) stddev-sans-first:1.83 02:59:24 INFO - 2015-10-30 02:59:24,810 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 85.0 85.0 85.0 84.0 85.0 85.0 86.0 88.0 02:59:24 INFO - 2015-10-30 02:59:24,810 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:59:24 INFO - 2015-10-30 02:59:24,810 DEBUG : BROWSER_OUTPUT: 02:59:25 INFO - 2015-10-30 02:59:25,568 INFO : Browser exited with error code: 0 02:59:25 INFO - 2015-10-30 02:59:25,625 INFO : Completed test kraken (00:01:03) 02:59:25 INFO - 2015-10-30 02:59:25,625 INFO : Starting test v8_7 02:59:25 INFO - 2015-10-30 02:59:25,625 DEBUG : operating with platform_type : mac_ 02:59:25 INFO - 2015-10-30 02:59:25,626 INFO : Initialising browser for v8_7 test... 02:59:25 INFO - 2015-10-30 02:59:25,641 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/tmpt0wIak/profile http://localhost:49263/getInfo.html 02:59:28 INFO - 2015-10-30 02:59:28,136 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:59:28 INFO - 2015-10-30 02:59:28,136 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:59:28 INFO - 2015-10-30 02:59:28,136 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:59:28 INFO - 2015-10-30 02:59:28,136 DEBUG : BROWSER_OUTPUT: __metrics 02:59:28 INFO - 2015-10-30 02:59:28,157 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:59:29 INFO - 2015-10-30 02:59:29,056 INFO : Browser initialized. 02:59:29 INFO - 2015-10-30 02:59:29,056 INFO : Running cycle 1/1 for v8_7 test... 02:59:29 INFO - 2015-10-30 02:59:29,056 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/T/tmpt0wIak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:59:41 INFO - 2015-10-30 02:59:41,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 201011200 02:59:41 INFO - 2015-10-30 02:59:41,155 DEBUG : BROWSER_OUTPUT: 03:00:03 INFO - 2015-10-30 03:00:03,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html) 03:00:04 INFO - 2015-10-30 03:00:04,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 522805248 03:00:04 INFO - 2015-10-30 03:00:04,039 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,039 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: |0;Richards;200.2803925495694 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;232.66635644485808 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: |2;Encrypt;378.0718336483932 03:00:04 INFO - 2015-10-30 03:00:04,041 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6951.388888888889 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1283.6970474967907 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: |5;Earley;824.4023083264633 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: |6;Boyer;15181.818181818182 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: |7;RegExp;34965.51724137931 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: |8;Splay;713.2667617689016 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6979.166666666667 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: __startTimestamp1446199204039__endTimestamp 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:200.28 Median:200.28 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,042 DEBUG : BROWSER_OUTPUT: Values: 200.3 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:232.67 Median:232.67 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: Values: 232.7 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:378.07 Median:378.07 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: Values: 378.1 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6951.39 Median:6951.39 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: Values: 6951.4 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1283.70 Median:1283.70 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: Values: 1283.7 03:00:04 INFO - 2015-10-30 03:00:04,043 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:824.40 Median:824.40 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: Values: 824.4 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15181.82 Median:15181.82 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: Values: 15181.8 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34965.52 Median:34965.52 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: Values: 34965.5 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: Values: 713.3 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6979.17 Median:6979.17 stddev:0.00 (0.0%) 03:00:04 INFO - 2015-10-30 03:00:04,044 DEBUG : BROWSER_OUTPUT: Values: 6979.2 03:00:04 INFO - 2015-10-30 03:00:04,045 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:00:04 INFO - 2015-10-30 03:00:04,045 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-10-30 03:00:04,781 INFO : Browser exited with error code: 0 03:00:04 INFO - 2015-10-30 03:00:04,805 INFO : Completed test v8_7 (00:00:39) 03:00:05 INFO - 2015-10-30 03:00:05,043 INFO : Completed test suite (00:20:18) 03:00:05 INFO - 2015-10-30 03:00:05,043 DEBUG : Working with test: dromaeo_css 03:00:05 INFO - 2015-10-30 03:00:05,043 DEBUG : Generating results file: dromaeo_css 03:00:05 INFO - 2015-10-30 03:00:05,044 DEBUG : Working with test: kraken 03:00:05 INFO - 2015-10-30 03:00:05,044 DEBUG : Generating results file: kraken 03:00:05 INFO - 2015-10-30 03:00:05,044 INFO : javascript benchmark 03:00:05 INFO - 2015-10-30 03:00:05,045 DEBUG : Working with test: v8_7 03:00:05 INFO - 2015-10-30 03:00:05,045 DEBUG : Generating results file: v8_7 03:00:05 INFO - 2015-10-30 03:00:05,045 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:05 INFO - 2015-10-30 03:00:05,493 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:00:05 INFO - 2015-10-30 03:00:05,494 DEBUG : process_Request line: dromaeo_css 5616.48 graph.html#tests=[[72,52,55]] 03:00:05 INFO - 2015-10-30 03:00:05,494 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:07 INFO - 2015-10-30 03:00:07,288 DEBUG : process_Request line: kraken 1824.80 graph.html#tests=[[232,52,55]] 03:00:07 INFO - 2015-10-30 03:00:07,289 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:07 INFO - 2015-10-30 03:00:07,579 DEBUG : process_Request line: v8_7 16850.06 graph.html#tests=[[230,52,55]] 03:00:07 INFO - 2015-10-30 03:00:07,579 INFO : javascript benchmark 03:00:07 INFO - 2015-10-30 03:00:07,581 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [290.4466990383318, 290.62389585313537, 293.7840687094985, 303.6098613281933, 304.92986613079006, 12873.291968941705, 13111.278879661615, 14561.490347837827, 14787.0, 15110.168940708256, 13157.210567365964, 15278.0, 15460.304286307115, 15816.76274855878, 15936.601584960354, 3888.105735680795, 3992.6406623403886, 4071.7149799514045, 4470.418845550074, 4551.362809206714, 2950.6754257031816, 3068.248279171606, 3080.445519806434, 4029.919401611966, 4043.6360727534516, 3959.8614048508307, 4037.8586749463775, 4046.635802777764, 4058.715889887709, 4101.651359634419, 4027.4562934003975, 4043.5147782266167, 4047.6559492442884, 4060.654844338235, 4069.6337329640473, 3397.6262611112757, 3441.1913200397885, 3476.0788391076385, 3523.541939547868, 3526.770759900624, 11368.317900925971, 11372.260803047775, 11400.885991140149, 11559.653210403701, 11710.063194944383, 1599.0166047880587, 1609.6378314879175, 1632.1711348798435, 1718.6734520441075, 1752.7896652401794, 7995.480293780944, 8201.179882011811, 8472.44929079608, 8487.3210143189, 8495.0, 1311.7048664050512, 1350.2641060621984, 1352.9120607160503, 1360.653033476467, 1365.8838998685123, 50480.495195048316, 53072.469275307136, 53222.20166697502, 53564.0, 54066.45933540693, 5670.432956704379, 5683.971580142155, 5736.713164341766, 5757.165211044375, 5822.184894114827, 6499.902501462482, 6507.219133703986, 6507.3167317431935, 6604.339566043357, 6627.370399812106, 4723.488483685256, 4771.6898401603785, 4783.56947874686, 4792.760361981887, 4932.284818701268, 5151.5106064923775, 5208.114620514446, 5218.6868787872845, 5240.868978275497, 5300.310959575308, 2574.0733335999025, 2577.2525967469223, 2598.0257403473697, 2608.6478325426206, 2633.39431930657, 892.0499667853715, 905.8369493491103, 916.7295647783919, 917.0508523677961, 931.7065124485765, 332.8118616538933, 333.8264102666648, 340.962494125646, 341.6651681352289, 349.18291198594903, 8206.794830129174, 8572.0, 8600.139986001475, 8670.436421632574, 8832.470051796912, 319.48243844971296, 329.3478911754739, 333.788044591686, 337.23447773554386, 350.0, 4848.757562121879, 4879.219324908068, 4998.4251811042195, 5018.222175562793, 5090.389153301628, 443320.0, 452457.0, 454486.0, 458127.0, 464373.0, 63447.36552634507, 63732.0, 63893.36106638967, 64687.67656161689, 65119.674401627686, 378.281265595371, 378.4814803718868, 382.24697346227885, 384.70185606154894, 391.0673044788144, 8582.442141260799, 8666.0, 8822.33832462555, 8823.0, 8882.0, 29779.851100745225, 29831.701682982894, 29970.70029299679, 30053.549196762502, 30129.0, 38564.0, 40727.79636101801, 41256.58743412527, 41306.586934130275, 42509.5749042518, 5253.054450198848, 5341.679499230058, 5455.509004189642, 5484.61607687458, 5488.067028605067, 10005.499725013575, 10073.445960472245, 10309.845352319871, 10317.071463568314, 10350.120239779702, 7564.924350756422, 8127.593620318842, 8750.168733970262, 8802.163794439519, 9000.684976025808, 8469.830603388022, 8528.104549022264, 8556.315494760529, 8703.825923481621, 8880.1563851434, 8894.688685895962, 8931.374803763674, 9059.682911098344, 9066.048064953085, 9110.681126160553, 5359.249705041219, 5396.865078373072, 5408.13469844823, 5414.891702165856, 5467.261919640957, 8580.356473264656, 8793.076726943578, 8845.24815390699, 8846.203841654282, 8850.380473366802], "dojo.html": [2620.0, 2675.6120362547417, 2678.116221646856, 2711.1324376199623, 2779.3885345224057, 4487.730736155833, 4534.47853496848, 4632.629389648829, 4688.413948256468, 4705.929411058833, 4599.81600735971, 4608.10142022305, 4661.184292748772, 4672.906541869169, 4693.084848454553, 4072.735272207312, 4237.0, 4284.378765079062, 4336.21948049351, 4337.1325734853, 4205.2640787862, 4216.831326746927, 4266.296061149907, 4310.0, 4392.714473559208, 4159.9376009359885, 4261.424707664472, 4315.913681726363, 4332.7833608319615, 4373.343998400233, 4263.829446822124, 4355.041890784022, 4413.007073408489, 4432.490263619693, 4435.844745433927, 4108.4864391951005, 4233.089885674594, 4282.42187304713, 4300.548442413564, 4307.203167414038, 4254.957450425487, 4452.844150454751, 4516.096780643851, 4563.566461186215, 4691.601213896823, 4805.471398146201, 4846.079244943485, 4858.5384388483035, 4929.876753081166, 4939.209726443752, 4890.706557606555, 4895.339129217546, 4901.01979604077, 4947.90104197914, 4965.354503914468, 4315.8057887394825, 4340.65274778017, 4409.603135717736, 4442.378067070613, 4517.435320584927, 5013.172826483589, 5067.771950262247, 5070.898582028412, 5114.41184263807, 5115.693058416433, 4781.067691800065, 4846.151923413388, 4846.80612775485, 4856.490068542823, 4885.389326334208, 4668.883277918079, 4731.739754313477, 4772.976135119302, 4841.540053694894, 4942.332785074041, 4732.148213321566, 4759.23852183649, 4772.308015337757, 4821.734804585782, 4832.903341933142, 4742.786574604151, 4809.470958194595, 4826.444958829709, 4844.636652251025, 4853.005133947532, 3637.199816040467, 3651.543557055368, 3674.540682414698, 3724.944125838115, 3770.792606406619, 3322.2358857462436, 3329.6170940341685, 3340.064781861083, 3395.6774106459848, 3404.727621790251, 4562.726236425825, 4604.88487787808, 4658.906821863611, 4684.929726054112, 4700.130475861976, 4663.743494107789, 4760.571548560577, 4857.684250523705, 4864.708117512961, 4939.0, 4564.246899261585, 4568.70303430276, 4575.428071491064, 4604.930926036112, 4640.095181439587, 4192.224438478891, 4233.91532169361, 4252.128313695685, 4312.180685669713, 4335.566443355702, 4704.882377940579, 4808.374911261513, 4911.361523002059, 4954.752262386938, 4994.650374473752, 4849.660523763303, 4873.537013983666, 4952.678075925053, 4962.33008543842, 4985.8005679772405, 4929.975350123226, 4940.530649588283, 4963.429205641253, 5006.299118123538, 5014.34813474246, 4617.676762626584, 4687.601553867959, 4697.342372067845, 4806.327114204084, 4839.1531481991215, 4868.707877527359, 4905.8037678492465, 4919.53264439892, 4924.4090709115135, 4928.700262080053, 4715.3869996900185, 4805.783739731791, 4828.37231159947, 4851.95148048515, 4858.0, 4640.280756482751, 4654.348391225163, 4662.393888794435, 4727.432708075053, 4815.879603009953, 4486.618637415726, 4595.1958407277925, 4653.464851542116, 4667.229907065296, 4673.602743766818, 4721.197396442682, 4745.857624271277, 4790.01804630057, 4817.686850354716, 4841.370621819141, 4392.69251152429, 4549.999000220078, 4555.567221114122, 4582.977085114553, 4653.9295961928265], "mootools.html": [1134.943252837358, 1193.7015746063487, 1234.7345320756035, 1337.478383430462, 1485.4132617616042, 5916.674582897945, 6183.134361189426, 6267.18526591543, 6394.296627370985, 6459.192600924873, 6401.231852177745, 6475.352464753522, 6476.093346931421, 6505.5120865935005, 6588.703508342124, 1815.7821061472575, 1826.917788699505, 1828.6159906419634, 1831.7893442254112, 1852.7220916862511, 1853.7775466943986, 1860.9813901860944, 1876.9530761730998, 1890.4612185527128, 1909.9045047747627, 1819.6178802451434, 1833.779946406433, 1840.411068458094, 1851.6481868445019, 1852.2776117314258, 1820.2900868661234, 1863.5713785829266, 1869.9345522906633, 1890.9243630254773, 1891.404207674585, 1859.758231429919, 1870.4575673054799, 1877.793442721313, 1888.386274460792, 1924.4803902946267, 5779.133130030487, 6388.393102655286, 6392.584482008655, 6479.74081036758, 6528.3145269746465, 3498.0555250082334, 3646.5259516262718, 3937.7440466369594, 4054.837806487737, 4095.5494895561465, 2358.363241924688, 2376.2158487699016, 2423.5152969406013, 2449.6570480132796, 2456.361346050022, 733.3216774483635, 748.6406524868094, 764.3464837563914, 764.8929149919015, 774.573984308628, 8523.14768523149, 8585.699500517452, 8585.914140858575, 8607.09625489321, 8663.913360866374, 3519.296140771856, 3593.748437609342, 3603.4054381027363, 3658.762180458315, 3683.0976410778994, 7556.546607203585, 7598.12621548529, 7614.048243969504, 7629.008228930204, 7650.0, 4011.7392369495888, 4025.456563363967, 4040.939385909214, 4056.9391459128137, 4058.857939972087, 3574.392353299945, 3634.9818250908575, 3648.1244501319493, 3674.6876515496483, 3707.8876337098764, 2961.392914452532, 2998.895038673636, 3013.9246518836767, 3032.696730326994, 3067.4171907337536, 972.863799068131, 975.512243878061, 976.6532880827347, 982.8378317577663, 983.9655612053543, 857.2541888556871, 857.2927334948693, 866.9696560620348, 867.7440155154245, 1068.3643232276784, 5989.341172471025, 5990.28116625999, 6000.33996260411, 6031.849203769941, 6104.481119104926, 392.05123600885923, 392.2782080971027, 395.1563412115155, 397.8189923584762, 399.98000099994886, 4832.44426890905, 4879.951200488021, 4972.179590367549, 4994.500549945049, 4996.925046124311, 6324.6521441321165, 6416.358364163546, 7436.814079648052, 7588.354989825816, 7673.693052277958, 7493.775186744407, 7580.431467639839, 7585.810354741066, 7647.770566883002, 7655.311022008046, 6044.7582096716515, 6066.817995460143, 6174.753009879644, 6229.2524897012645, 6247.531435142382, 6037.034074548052, 6066.423689749467, 6108.08378743192, 6116.908246376397, 6135.907961380493, 6791.185057792899, 6937.265683579105, 7041.295870412918, 7102.822429439306, 7142.071530700976, 7066.116735408074, 7095.467839911924, 7248.746293879689, 7282.380997615051, 7306.525075870264, 5771.826845194651, 5779.768809247583, 5783.074708046693, 5855.3559108497175, 5900.321463031634, 6000.459958603747, 6033.487153591994, 6134.171886795404, 6144.1398204250545, 6144.508439324753, 5584.190292407497, 5698.800541981011, 5729.197912292199, 5730.856728581819, 5843.29880414353, 5858.443447872445, 5885.852853678693, 5888.216589080818, 5911.793087241926, 5975.55183361241, 5950.613210141327, 5966.3138739043825, 6047.153398524122, 6090.512758979359, 6111.572189946839, 5019.573336266459, 5104.821331253388, 5377.569794416359, 5377.951299496561, 5520.033994051106, 5398.811041613525, 5413.621046526705, 5434.049041417815, 5516.751746171512, 5530.889382212253], "ext.html": [464.844277167149, 465.6344769356056, 483.9128956787778, 485.88095916500464, 502.0686626308196, 28593.857030714844, 29271.414571708552, 34695.306093878105, 35305.11737206571, 35579.82210088953, 37512.62487375126, 37626.0, 37640.43539346905, 37688.81155594225, 38098.619013809854, 7222.061132052826, 7735.187805280449, 7746.302832745037, 7962.243586859239, 8004.999375078115, 7200.207977122539, 9263.814723705522, 9454.007329230435, 9494.762630934247, 9560.426374417557, 9186.86219706705, 9228.815423691522, 9245.953770231139, 9318.813623727521, 9349.76625584359, 7283.016792732966, 7634.312911837961, 9272.258219342437, 9367.625294988193, 9446.669366572205, 8999.5050272235, 9148.0, 9150.81698366029, 9319.580618872167, 9341.299402544837, 33282.83358583192, 34363.0, 34382.82808585941, 34928.126796830285, 35010.82494587536, 2542.2500362392952, 2543.1988923489043, 2579.6646435963203, 2581.3288544978254, 2596.883140258693, 23710.644340334908, 23825.523489530286, 24155.63766543503, 24364.878175609185, 24469.38826529351, 1986.9801301987084, 2019.555697746508, 2024.5647185854964, 2047.8566500344982, 2073.792620737929, 253099.99999999817, 253221.99999999817, 253320.0, 253712.0, 256646.0, 47464.5253547467, 54392.728036359564, 54478.0, 55546.055888043724, 55568.444315557135, 44570.55429445729, 61828.0, 63394.36605633885, 63419.6829015852, 63522.682386587774, 14922.70154596902, 15160.09039457636, 15173.317200725773, 15187.0, 15405.691886162438, 11469.139814513945, 11553.267009948408, 11553.36456494884, 11566.248193867372, 11579.594714184963, 17976.91011544934, 18265.45203643893, 18328.633427331646, 18419.539511512052, 18540.258389664534, 7350.558966462029, 7461.925380746123, 7470.439717021245, 7505.962470187724, 7616.314531692175, 733.8935854301096, 762.8016715653858, 823.6581818545236, 912.8128733609594, 921.2077613252598, 24557.508849822905, 24857.378565535644, 25173.748262517507, 25619.487610247692, 25630.487390252092, 749.6776386153897, 878.468526541446, 883.4787475389551, 898.4294972692256, 904.9321300902327, 12005.699857503632, 12258.0, 12538.937305313597, 12693.746125077447, 12727.17273377246, 379512.0, 386403.0, 387356.0, 390266.0, 393910.0, 48005.75997119992, 48392.75803620959, 48615.756921215165, 48624.27063594049, 48859.0, 1205.3732059329275, 1223.3821919930378, 1229.0536287059094, 1234.160770675949, 1342.7046049869014, 24700.653437923367, 25492.362690932132, 25614.23157305284, 26081.478370432866, 26144.34639134037, 42416.787916060224, 42564.36153457763, 42710.14579708326, 42987.0, 43122.137557248054, 223214.0, 226578.0, 227479.0, 229461.0, 232394.0, 24114.87942560276, 24759.87620061888, 27621.0, 27977.621902138548, 28318.292042699097, 33458.16354591155, 33515.06058400386, 34085.82957085298, 34175.0, 34307.313853722284, 28853.567196492488, 30796.0, 30900.381992360475, 31325.216869577533, 31477.370452590363, 23509.882450587636, 24949.87525062363, 30200.395992080474, 31079.0676279712, 31147.0, 29860.552091718208, 30791.53812692856, 31823.840880795447, 32054.519182211818, 32312.0, 20988.47528811792, 22583.497789213492, 22993.88503057474, 23028.309150725505, 27408.86295568589, 20362.18551257933, 20657.58684826325, 20779.8961005194, 20832.0, 21052.157913683895], "prototype.html": [266.3155689877016, 277.35376572585864, 281.6268444311288, 282.18730057434584, 284.20847938491306, 4925.876853078675, 5006.148954677705, 5041.521055499727, 5071.391433028032, 5125.333706618135, 4948.950510494894, 4950.13372659784, 4986.127427700156, 5008.49915008499, 5008.974955125228, 3946.7237293389476, 4028.315186418316, 4031.21391328691, 4035.656969157625, 4069.3895915612597, 3980.7412518186225, 4010.679145668354, 4038.8586399476026, 4041.7777022263763, 4064.227796718614, 3941.724079314449, 3966.643002129808, 3989.0, 3994.560598334181, 4014.0767623446623, 3820.9426858597144, 3971.126352202511, 3992.061865461614, 4035.273650742865, 4044.8786536403954, 3455.3953058214965, 3486.3027394520946, 3495.370833250014, 3500.527428797105, 3517.859285628572, 4908.361912951294, 4932.506749325074, 4971.27916452116, 4977.9751101244265, 4978.950210497921, 4400.647948164139, 4409.691321607489, 4460.6208472279895, 4467.374567560544, 4469.664775141845, 5055.69665820052, 5254.4220135785035, 5294.470552944713, 5319.17552779316, 5359.0, 3672.6510981456718, 3701.592824789298, 3710.499082623838, 3733.8693145739767, 3736.925261494755, 5312.92030619541, 5407.134858422633, 5462.426445223274, 5488.7530061147345, 5541.33503979521, 3596.6583174598895, 3664.0107171064196, 3682.5949145593963, 3733.328000959799, 3798.0315019669806, 3804.524434445694, 3848.4419759134767, 3849.846006159722, 3867.4778904847485, 3876.282887665791, 4230.175115852379, 4350.456192975878, 4400.625946794495, 4406.515283318832, 4415.139047885696, 5164.070467315919, 5239.607029472729, 5263.4473380295285, 5273.894522109536, 5276.947230527646, 1355.8779709826163, 1366.6173471428017, 1380.1236215003546, 1380.4823191303262, 1384.9376778045012, 846.2933450568721, 859.8194379180442, 861.0915484164267, 866.5840396609663, 899.581694512055, 5075.771590278447, 5086.033653605803, 5090.643654944119, 5144.6655967362, 5229.08491014071, 5521.4478552144465, 5544.750486228129, 5562.888742225214, 5596.384397716248, 5601.719914004283, 5135.948640513622, 5152.458991805881, 5168.2764412982215, 5208.218767184952, 5235.188545775335, 3020.0788759428146, 3024.758019358446, 3083.491223948068, 3089.675584063641, 3102.782805203614, 5635.605507614509, 5654.6324488908085, 5667.886642267132, 5671.858203544944, 5723.141528770634, 5674.319081710221, 5689.34572524165, 5708.71456427177, 5737.713114344266, 5738.110592858114, 5628.943710562842, 5648.209250704905, 5648.74580643872, 5671.291088613841, 5693.003724348306, 5374.495141360425, 5607.383187849415, 5610.747516361692, 5619.943800561942, 5645.491905728504, 5400.297961265011, 5458.672479651074, 5500.064988951968, 5531.502164805187, 5563.749631266522, 5630.831075067755, 5672.829815105553, 5750.913736294043, 5757.021306377842, 5759.94240057594, 3314.8508317125306, 3474.652534746505, 3484.0593039879595, 3517.824108794601, 3541.468779683068, 5348.438413966477, 5411.296531451044, 5535.833924982257, 5547.833564993057, 5618.85952851182, 5236.0, 5295.920561191662, 5318.255444237887, 5326.121190003606, 5389.919151212656, 5286.735663216747, 5299.49654782795, 5303.761330740049, 5362.410134885237, 5383.623146379716, 5142.485751424828, 5172.612054096033, 5176.7152806596, 5181.3005244293045, 5236.633435659467, 5115.2071428928575, 5370.543503802221, 5372.301600791872, 5385.946140538545, 5449.809256675997, 5266.210068489757, 5289.074411977812, 5353.143497040455, 5353.9732301338245, 5361.946380536145], "yui.html": [556.8941901038805, 617.8764247150568, 626.7900253415106, 629.9968500157498, 636.5766765101208, 11799.7640047199, 11945.522179112835, 11961.342126183057, 12057.51769929203, 12082.81875771862, 10908.563657453693, 11312.208145429802, 11421.42892855356, 11515.021223196018, 11519.48162332695, 595.330253464852, 602.2111034544738, 752.0862152484743, 761.9619019049053, 764.8814433762748, 733.2557454184008, 738.5753191914644, 743.657917358016, 754.852803703278, 755.7997130760353, 797.5693125712108, 805.6495424490336, 811.407672399149, 813.3940214540175, 818.0878320672438, 622.6233128957007, 630.8170630517144, 788.5268838696793, 795.0975642645581, 807.2694211738386, 587.9735411906474, 589.113384356545, 590.9527237820964, 596.8239369385998, 601.2394321183706, 10150.340227885164, 10258.384496930134, 10262.076413122855, 10293.794124117476, 10343.586256549728, 9537.761555961088, 9856.50717464124, 10239.948800255952, 10427.635032773893, 10475.947620261926, 7775.8444831103625, 8041.477303975223, 8101.797455063612, 8120.0661923878915, 8339.916600833974, 2753.2153336299257, 2779.8888044478194, 2828.6708613238434, 2876.424715056997, 2962.837043962581, 40259.39610905809, 40570.0, 40753.184936301106, 40970.590294096975, 41299.587004130175, 7541.8114547135665, 7644.961775191088, 7689.0, 7793.347628783656, 7920.801979950432, 16260.0, 16351.591210219602, 16426.342946282013, 16477.0, 16510.83489165093, 5872.442117998783, 6068.423499767515, 6203.16257305258, 6227.626342419469, 6336.303006669263, 3111.8910838120555, 3285.6385797562248, 3296.5220043094096, 3363.899083027513, 3364.327134573095, 2506.8370555913807, 2538.898444062254, 2543.987280063588, 2555.514452254066, 2565.3073670108965, 345.50765159647403, 364.246010757729, 365.4317536231186, 368.58165981611063, 369.64514066496463, 420.1512943853399, 457.8786621545293, 480.2723873331905, 481.8217259613965, 513.1800754852112, 6184.226971628546, 6527.445167160845, 6719.832004199837, 6739.224989126215, 6744.055832183498, 419.588802973082, 429.63695677152754, 432.3864367201963, 475.6028716022091, 502.63558919783594, 3055.3125546751803, 3081.645610754747, 3252.3983063133396, 3327.9168020799675, 3333.4999750037687, 51776.0, 51977.22034169415, 52122.0, 52860.73569632127, 52872.59783630295, 42251.0, 42272.0, 42765.0, 42888.356674649905, 43172.78413607912, 40587.797061014506, 43899.0, 44399.0, 44685.776571116934, 45098.09803803971, 6885.8967115492305, 6946.895796562954, 7149.939462185215, 7252.311030452099, 7264.455165862687, 28742.137735867957, 28988.13035608935, 29001.0, 29448.852755736083, 31076.68923310738, 39187.6081239184, 39535.406968896066, 40207.1958560833, 40320.19359612733, 40957.795211024946, 9099.499527525784, 9128.132827381389, 9300.767480813034, 9456.385334953206, 9511.524423778921, 9312.394694344846, 9418.152366287068, 9553.426794392359, 9578.233741300819, 9687.225021998082, 8993.32550058735, 9259.305552083755, 9356.298277629341, 9436.292278079034, 9784.9021509784, 8992.640294388413, 9159.084091590788, 9160.816783664422, 9240.214581760625, 9278.396904201205, 8987.640494380152, 9003.672432899664, 9047.547622618711, 9075.13786190311, 9076.228520575825, 7604.695812167452, 7799.376049916106, 8102.837943240984, 8188.672453102047, 8345.290650294794, 7801.082375240134, 7982.0, 7986.361091112581, 8023.277904988579, 8058.355331573577]}, "summary": {"suite": 5616.4789119446295, "subtests": {"jquery.html": {"filtered": 5667.317574724958, "value": 5667.317574724958}, "dojo.html": {"filtered": 4503.3498457495125, "value": 4503.3498457495125}, "mootools.html": {"filtered": 3610.742947436935, "value": 3610.742947436935}, "ext.html": {"filtered": 16255.77812308347, "value": 16255.77812308347}, "prototype.html": {"filtered": 4036.035509818578, "value": 4036.035509818578}, "yui.html": {"filtered": 5191.16559297168, "value": 5191.16559297168}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0051"}, "testrun": {"date": 1446197986, "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": "44.0a2", "id": "20151030004047", "branch": "Mozilla-Aurora", "revision": "e902b5a2882bcc6a751e77fd8bb812d438d5886b"}}, {"talos_counters": {}, "results": {"audio-dft": [192.0, 195.0, 195.0, 196.0, 197.0, 197.0, 197.0, 197.0, 197.0, 196.0], "ai-astar": [130.0, 129.0, 132.0, 132.0, 135.0, 137.0, 143.0, 132.0, 134.0, 132.0], "imaging-gaussian-blur": [148.0, 149.0, 142.0, 141.0, 149.0, 149.0, 141.0, 149.0, 149.0, 149.0], "audio-beat-detection": [184.0, 167.0, 201.0, 193.0, 157.0, 178.0, 151.0, 191.0, 179.0, 162.0], "json-stringify-tinderbox": [74.0, 76.0, 81.0, 81.0, 82.0, 82.0, 82.0, 85.0, 82.0, 82.0], "stanford-crypto-pbkdf2": [163.0, 165.0, 179.0, 179.0, 178.0, 164.0, 176.0, 176.0, 177.0, 163.0], "json-parse-financial": [64.0, 72.0, 72.0, 76.0, 79.0, 76.0, 77.0, 87.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [79.0, 81.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 86.0, 88.0], "audio-fft": [90.0, 93.0, 96.0, 148.0, 85.0, 90.0, 89.0, 85.0, 141.0, 80.0], "imaging-darkroom": [153.0, 154.0, 154.0, 154.0, 154.0, 153.0, 161.0, 155.0, 153.0, 155.0], "stanford-crypto-ccm": [146.0, 149.0, 169.0, 155.0, 165.0, 147.0, 145.0, 154.0, 163.0, 157.0], "audio-oscillator": [114.0, 117.0, 163.0, 107.0, 109.0, 112.0, 155.0, 107.0, 107.0, 156.0], "stanford-crypto-aes": [95.0, 100.0, 101.0, 98.0, 104.0, 104.0, 104.0, 100.0, 101.0, 105.0], "imaging-desaturate": [123.0, 123.0, 129.0, 130.0, 128.0, 129.0, 124.0, 123.0, 124.0, 128.0]}, "summary": {"suite": 1824.8, "subtests": {"audio-fft": {"filtered": 99.7, "value": 99.7}, "stanford-crypto-pbkdf2": {"filtered": 172.0, "value": 172.0}, "audio-beat-detection": {"filtered": 176.3, "value": 176.3}, "stanford-crypto-ccm": {"filtered": 155.0, "value": 155.0}, "imaging-darkroom": {"filtered": 154.6, "value": 154.6}, "json-parse-financial": {"filtered": 74.1, "value": 74.1}, "audio-oscillator": {"filtered": 124.7, "value": 124.7}, "ai-astar": {"filtered": 133.6, "value": 133.6}, "audio-dft": {"filtered": 195.9, "value": 195.9}, "stanford-crypto-sha256-iterative": {"filtered": 84.3, "value": 84.3}, "json-stringify-tinderbox": {"filtered": 80.7, "value": 80.7}, "imaging-gaussian-blur": {"filtered": 146.6, "value": 146.6}, "stanford-crypto-aes": {"filtered": 101.2, "value": 101.2}, "imaging-desaturate": {"filtered": 126.1, "value": 126.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0051"}, "testrun": {"date": 1446197986, "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": "44.0a2", "id": "20151030004047", "branch": "Mozilla-Aurora", "revision": "e902b5a2882bcc6a751e77fd8bb812d438d5886b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [232.66635644485808], "Encrypt": [378.0718336483932], "NavierStokes": [6979.166666666667], "Decrypt": [6951.388888888889], "Splay": [713.2667617689016], "Richards": [200.2803925495694], "RegExp": [34965.51724137931], "Earley": [824.4023083264633], "Boyer": [15181.818181818182], "RayTrace": [1283.6970474967907]}, "summary": {"suite": 16850.06101465093, "subtests": {"DeltaBlue": {"filtered": 284.17516400000005, "value": 284.17516400000005}, "Encrypt": {"filtered": 704.048745, "value": 704.048745}, "NavierStokes": {"filtered": 212.63283582089556, "value": 212.63283582089556}, "Decrypt": {"filtered": 38.29177222777224, "value": 38.29177222777224}, "Splay": {"filtered": 114.25038200000003, "value": 114.25038200000003}, "RegExp": {"filtered": 26.053811637080845, "value": 26.053811637080845}, "Richards": {"filtered": 176.26288599999998, "value": 176.26288599999998}, "Earley": {"filtered": 808.4196190000002, "value": 808.4196190000002}, "Boyer": {"filtered": 43.89876047904192, "value": 43.89876047904192}, "RayTrace": {"filtered": 576.451431, "value": 576.451431}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0051"}, "testrun": {"date": 1446197986, "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": "44.0a2", "id": "20151030004047", "branch": "Mozilla-Aurora", "revision": "e902b5a2882bcc6a751e77fd8bb812d438d5886b"}}] 03:00:07 INFO - RETURN: dromaeo_css: 5616.48 03:00:07 INFO - RETURN: kraken: 1824.80 03:00:07 INFO - RETURN: v8_7: 16850.06 03:00:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "16850.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1824.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5616.48"}}} 03:00:07 INFO - Return code: 0 03:00:07 INFO - # TBPL SUCCESS # 03:00:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:00:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:00:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:00:07 INFO - 2015-10-30 03:00:07.684 screenresolution[1654:9856] starting screenresolution argv=screenresolution get 03:00:07 INFO - 2015-10-30 03:00:07.688 screenresolution[1654:9856] Display 0: 1600x1200x32@60 03:00:07 INFO - 2015-10-30 03:00:07.694 screenresolution[1655:9859] starting screenresolution argv=screenresolution list 03:00:07 INFO - Available Modes on Display 0 03:00:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:00:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:00:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:00:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:00:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:00:07 INFO - Intel HD Graphics 3000: 03:00:07 INFO - Chipset Model: Intel HD Graphics 3000 03:00:07 INFO - Type: GPU 03:00:07 INFO - Bus: Built-In 03:00:07 INFO - VRAM (Total): 512 MB 03:00:07 INFO - VRAM (Dynamic, Max): 10 03:00:07 INFO - Vendor: Intel (0x8086) 03:00:07 INFO - Device ID: 0x0116 03:00:07 INFO - Revision ID: 0x0009 03:00:07 INFO - Displays: 03:00:07 INFO - Display: 03:00:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:00:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:00:07 INFO - Display Serial Number: 1600x1200 60 03:00:07 INFO - Main Display: Yes 03:00:07 INFO - Mirror: Off 03:00:07 INFO - Online: Yes 03:00:07 INFO - Rotation: Supported 03:00:07 INFO - Return code: 0 03:00:07 INFO - Running post-action listener: _resource_record_post_action 03:00:07 INFO - Running post-run listener: _resource_record_post_run 03:00:09 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 39474176; Write bytes: 687412224; Read time: 4141; Write time: 52134 03:00:09 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 334146048; Write bytes: 332933120; Read time: 37287; Write time: 7390 03:00:09 INFO - run-tests - Wall time: 1222s; CPU: 30.0%; Read bytes: 38556672; Write bytes: 344222720; Read time: 3923; Write time: 43738 03:00:09 INFO - Running post-run listener: _upload_blobber_files 03:00:09 INFO - Blob upload gear active. 03:00:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:00:09 INFO - Copying logs to upload dir... 03:00:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.621628 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2015-10-30 03:00:12.530975) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 03:00:12.537879) ========= 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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010293 build_url: 'https://queue.taskcluster.net/v1/task/TTB_a5pyQQylbfuAGkNO8g/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 03:00:12.580188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 03:00:12.580616) ========= 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.ucA8ZTZU0T/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.VvLbTZGrKL/Listeners TMPDIR=/var/folders/81/n6hzvz4n6w7bwxy4tf6vhmcm00000w/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.005970 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 03:00:12.641348) ========= ========= Started reboot slave lost (results: 0, elapsed: 6 secs) (at 2015-10-30 03:00:12.641784) ========= ========= Finished reboot slave lost (results: 0, elapsed: 6 secs) (at 2015-10-30 03:00:18.843348) =========