builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0019 starttime: 1447757079.15 results: success (0) buildid: 20151117004023 builduid: 8b516170c2064350abd815caeb63e8ed revision: e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.149679) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.150057) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.150331) ========= 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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.006659 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.183522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.183852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.300529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.300802) ========= 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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.005853 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.347321) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.348276) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.348917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.349191) ========= 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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 02:44:39-- 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.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% 6.65M=0.002s 2015-11-17 02:44:39 (6.65 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.347100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.714836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.715181) ========= 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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.021578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.768554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:39.768879) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8 --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 e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 02:44:39,853 truncating revision to first 12 chars 2015-11-17 02:44:39,853 Setting DEBUG logging. 2015-11-17 02:44:39,853 attempt 1/10 2015-11-17 02:44:39,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e68fb30045ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 02:44:40,123 unpacking tar archive at: mozilla-aurora-e68fb30045ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:40.326480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:40.329798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:40.346789) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:40.347156) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 02:44:40.347586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2015-11-17 02:44:40.347886) ========= /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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:44:40 INFO - MultiFileLogger online at 20151117 02:44:40 in /builds/slave/test 02:44:40 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:44:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:40 INFO - {'append_to_log': False, 02:44:40 INFO - 'base_work_dir': '/builds/slave/test', 02:44:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:44:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:40 INFO - 'branch': 'Mozilla-Aurora', 02:44:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:40 INFO - 'config_files': ('talos/mac_config.py',), 02:44:40 INFO - 'default_actions': ('clobber', 02:44:40 INFO - 'read-buildbot-config', 02:44:40 INFO - 'download-and-extract', 02:44:40 INFO - 'populate-webroot', 02:44:40 INFO - 'create-virtualenv', 02:44:40 INFO - 'install', 02:44:40 INFO - 'run-tests'), 02:44:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:40 INFO - 'download_minidump_stackwalk': True, 02:44:40 INFO - 'download_symbols': 'ondemand', 02:44:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:44:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:44:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:44:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:44:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:40 INFO - 'installer_path': 'installer.exe', 02:44:40 INFO - 'log_level': 'info', 02:44:40 INFO - 'log_name': 'talos', 02:44:40 INFO - 'log_to_console': True, 02:44:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:44:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:44:40 INFO - 'opt_config_files': (), 02:44:40 INFO - 'pip_index': False, 02:44:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:40 INFO - 'cmd': ('bash', 02:44:40 INFO - '-c', 02:44:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:40 INFO - 'enabled': True, 02:44:40 INFO - 'halt_on_failure': False, 02:44:40 INFO - 'name': 'check_screen_resolution'},), 02:44:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:40 INFO - 'cmd': ('bash', 02:44:40 INFO - '-c', 02:44:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:40 INFO - 'enabled': True, 02:44:40 INFO - 'halt_on_failure': False, 02:44:40 INFO - 'name': 'check_screen_resolution'},), 02:44:40 INFO - 'run_cmd_checks_enabled': True, 02:44:40 INFO - 'sps_profile': False, 02:44:40 INFO - 'sps_profile_interval': 0, 02:44:40 INFO - 'suite': 'dromaeojs', 02:44:40 INFO - 'system_bits': '64', 02:44:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:40 INFO - 'title': 't-yosemite-r5-0019', 02:44:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:40 INFO - 'use_talos_json': True, 02:44:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:40 INFO - 'work_dir': 'build'} 02:44:40 INFO - ##### 02:44:40 INFO - ##### Running clobber step. 02:44:40 INFO - ##### 02:44:40 INFO - Running pre-action listener: _resource_record_pre_action 02:44:40 INFO - Running main action method: clobber 02:44:40 INFO - rmtree: /builds/slave/test/build 02:44:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:43 INFO - Running post-action listener: _resource_record_post_action 02:44:43 INFO - ##### 02:44:43 INFO - ##### Running read-buildbot-config step. 02:44:43 INFO - ##### 02:44:43 INFO - Running pre-action listener: _resource_record_pre_action 02:44:43 INFO - Running main action method: read_buildbot_config 02:44:43 INFO - Using buildbot properties: 02:44:43 INFO - { 02:44:43 INFO - "properties": { 02:44:43 INFO - "buildnumber": 266, 02:44:43 INFO - "product": "firefox", 02:44:43 INFO - "script_repo_revision": "production", 02:44:43 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:44:43 INFO - "repository": "", 02:44:43 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:44:43 INFO - "buildid": "20151117004023", 02:44:43 INFO - "slavename": "t-yosemite-r5-0019", 02:44:43 INFO - "stage_platform": "macosx64", 02:44:43 INFO - "basedir": "/builds/slave/test", 02:44:43 INFO - "nightly_build": "True", 02:44:43 INFO - "project": "", 02:44:43 INFO - "platform": "yosemite", 02:44:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:44:43 INFO - "slavebuilddir": "test", 02:44:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:44:43 INFO - "branch": "mozilla-aurora", 02:44:43 INFO - "repo_path": "releases/mozilla-aurora", 02:44:43 INFO - "pgo_build": "False", 02:44:43 INFO - "builduid": "8b516170c2064350abd815caeb63e8ed", 02:44:43 INFO - "revision": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8" 02:44:43 INFO - }, 02:44:43 INFO - "sourcestamp": { 02:44:43 INFO - "repository": "", 02:44:43 INFO - "hasPatch": false, 02:44:43 INFO - "project": "", 02:44:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:44:43 INFO - "changes": [ 02:44:43 INFO - { 02:44:43 INFO - "category": null, 02:44:43 INFO - "files": [ 02:44:43 INFO - { 02:44:43 INFO - "url": null, 02:44:43 INFO - "name": "https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:44:43 INFO - } 02:44:43 INFO - ], 02:44:43 INFO - "repository": "", 02:44:43 INFO - "rev": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8", 02:44:43 INFO - "who": "sendchange", 02:44:43 INFO - "when": 1447757053, 02:44:43 INFO - "number": 6671065, 02:44:43 INFO - "comments": "", 02:44:43 INFO - "project": "", 02:44:43 INFO - "at": "Tue 17 Nov 2015 02:44:13", 02:44:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:44:43 INFO - "revlink": "", 02:44:43 INFO - "properties": [ 02:44:43 INFO - [ 02:44:43 INFO - "buildid", 02:44:43 INFO - "20151117004023", 02:44:43 INFO - "Change" 02:44:43 INFO - ], 02:44:43 INFO - [ 02:44:43 INFO - "builduid", 02:44:43 INFO - "8b516170c2064350abd815caeb63e8ed", 02:44:43 INFO - "Change" 02:44:43 INFO - ], 02:44:43 INFO - [ 02:44:43 INFO - "nightly_build", 02:44:43 INFO - "True", 02:44:43 INFO - "Change" 02:44:43 INFO - ], 02:44:43 INFO - [ 02:44:43 INFO - "pgo_build", 02:44:43 INFO - "False", 02:44:43 INFO - "Change" 02:44:43 INFO - ] 02:44:43 INFO - ], 02:44:43 INFO - "revision": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8" 02:44:43 INFO - } 02:44:43 INFO - ], 02:44:43 INFO - "revision": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8" 02:44:43 INFO - } 02:44:43 INFO - } 02:44:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:44:43 INFO - Running post-action listener: _resource_record_post_action 02:44:43 INFO - ##### 02:44:43 INFO - ##### Running download-and-extract step. 02:44:43 INFO - ##### 02:44:43 INFO - Running pre-action listener: _resource_record_pre_action 02:44:43 INFO - Running main action method: download_and_extract 02:44:43 INFO - mkdir: /builds/slave/test/build/tests 02:44: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:44:43 INFO - https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/test_packages.json 02:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/test_packages.json 02:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:44:44 INFO - Downloaded 1149 bytes. 02:44:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:44:44 INFO - Using the following test package requirements: 02:44:44 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:44:44 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:44:44 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'jsshell-mac.zip'], 02:44:44 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:44:44 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:44:44 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:44:44 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:44:44 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:44:44 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:44:44 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:44:44 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:44:44 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:44 INFO - https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:44:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:44:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:44:48 INFO - Downloaded 17447756 bytes. 02:44:48 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:44:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:44:54 INFO - Return code: 0 02:44:54 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:44:54 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:44:54 INFO - https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:44:58 INFO - Downloaded 17447756 bytes. 02:44:58 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:44:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:44:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:45:04 INFO - Return code: 0 02:45:04 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:45:04 INFO - https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:45:05 INFO - Downloaded 11131307 bytes. 02:45:05 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:45:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:45:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:45:05 INFO - Return code: 0 02:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:05 INFO - https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:45:14 INFO - Downloaded 107794106 bytes. 02:45:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:45:14 INFO - mkdir: /builds/slave/test/properties 02:45:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:14 INFO - Contents: 02:45:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:45:14 INFO - Running post-action listener: _resource_record_post_action 02:45:14 INFO - Running post-action listener: set_extra_try_arguments 02:45:14 INFO - ##### 02:45:14 INFO - ##### Running populate-webroot step. 02:45:14 INFO - ##### 02:45:14 INFO - Running pre-action listener: _resource_record_pre_action 02:45:14 INFO - Running main action method: populate_webroot 02:45:14 INFO - Guessing talos json url... 02:45: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:45:14 INFO - https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:45:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:45:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:45:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/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:45:14 INFO - Downloaded 107 bytes. 02:45:14 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:45:14 INFO - Contents: 02:45:14 INFO - 20151117004023 02:45:14 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8 02:45: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:45:14 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e68fb30045/testing/talos/talos.json 02:45:14 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e68fb30045/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e68fb30045/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:45:15 INFO - Downloaded 4264 bytes. 02:45:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:45:15 INFO - '../fennec_ids.txt'], 02:45:15 INFO - 'tests': ['tcheck2']}, 02:45:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:15 INFO - '--tppagecycles', 02:45:15 INFO - '7'], 02:45:15 INFO - 'tests': ['tsvgm']}}, 02:45:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:45:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:45:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:45:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:45:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'tests': ['damp', 'tps']}, 02:45:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['damp', 'tps']}, 02:45:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:45:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:15 INFO - 'other': {'tests': ['a11yr', 02:45:15 INFO - 'ts_paint', 02:45:15 INFO - 'tpaint', 02:45:15 INFO - 'sessionrestore', 02:45:15 INFO - 'sessionrestore_no_auto_restore']}, 02:45:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['a11yr', 02:45:15 INFO - 'ts_paint', 02:45:15 INFO - 'tpaint', 02:45:15 INFO - 'sessionrestore', 02:45:15 INFO - 'sessionrestore_no_auto_restore']}, 02:45:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['a11yr', 02:45:15 INFO - 'ts_paint', 02:45:15 INFO - 'tpaint', 02:45:15 INFO - 'sessionrestore', 02:45:15 INFO - 'sessionrestore_no_auto_restore']}, 02:45:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['a11yr', 02:45:15 INFO - 'ts_paint', 02:45:15 INFO - 'tpaint', 02:45:15 INFO - 'sessionrestore', 02:45:15 INFO - 'sessionrestore_no_auto_restore']}, 02:45:15 INFO - 'other_l64': {'tests': ['a11yr', 02:45:15 INFO - 'ts_paint', 02:45:15 INFO - 'tpaint', 02:45:15 INFO - 'sessionrestore', 02:45:15 INFO - 'sessionrestore_no_auto_restore']}, 02:45:15 INFO - 'other_nol64': {'tests': ['a11yr', 02:45:15 INFO - 'ts_paint', 02:45:15 INFO - 'tpaint', 02:45:15 INFO - 'sessionrestore', 02:45:15 INFO - 'sessionrestore_no_auto_restore']}, 02:45:15 INFO - 'svgr': {'tests': ['tsvgx', 02:45:15 INFO - 'tsvgr_opacity', 02:45:15 INFO - 'tart', 02:45:15 INFO - 'tscrollx', 02:45:15 INFO - 'cart']}, 02:45:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['tsvgx', 02:45:15 INFO - 'tsvgr_opacity', 02:45:15 INFO - 'tart', 02:45:15 INFO - 'tscrollx', 02:45:15 INFO - 'cart']}, 02:45:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'tests': ['tp5o']}, 02:45:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'talos_options': ['--e10s'], 02:45:15 INFO - 'tests': ['tp5o']}, 02:45:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'talos_options': ['--xperf_path', 02:45:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:15 INFO - 'tests': ['tp5n']}, 02:45:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:15 INFO - 'talos_options': ['--e10s', 02:45:15 INFO - '--xperf_path', 02:45:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:45:15 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:45:15 INFO - 'tests': ['tp5n']}}, 02:45:15 INFO - 'talos.zip': {'path': '', 02:45:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:15 INFO - Running post-action listener: _resource_record_post_action 02:45:15 INFO - ##### 02:45:15 INFO - ##### Running create-virtualenv step. 02:45:15 INFO - ##### 02:45:15 INFO - Running pre-action listener: _resource_record_pre_action 02:45:15 INFO - Running main action method: create_virtualenv 02:45:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:15 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:45:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:15 INFO - Using real prefix '/tools/python27' 02:45:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:20 INFO - Installing pip.................done. 02:45:20 INFO - Return code: 0 02:45:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:20 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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:20 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:45:20 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:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:20 INFO - 'HOME': '/Users/cltbld', 02:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:20 INFO - 'LOGNAME': 'cltbld', 02:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:20 INFO - 'MOZ_NO_REMOTE': '1', 02:45:20 INFO - 'NO_EM_RESTART': '1', 02:45:20 INFO - 'PAGER': '/bin/cat', 02:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:20 INFO - 'PWD': '/builds/slave/test', 02:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:20 INFO - 'SHELL': '/bin/bash', 02:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:20 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:20 INFO - 'USER': 'cltbld', 02:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:20 INFO - 'XPC_FLAGS': '0x0', 02:45:20 INFO - 'XPC_SERVICE_NAME': '0', 02:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:20 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:45:20 INFO - Cleaning up... 02:45:20 INFO - Return code: 0 02:45:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:20 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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:20 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:45:20 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:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:20 INFO - 'HOME': '/Users/cltbld', 02:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:20 INFO - 'LOGNAME': 'cltbld', 02:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:20 INFO - 'MOZ_NO_REMOTE': '1', 02:45:20 INFO - 'NO_EM_RESTART': '1', 02:45:20 INFO - 'PAGER': '/bin/cat', 02:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:20 INFO - 'PWD': '/builds/slave/test', 02:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:20 INFO - 'SHELL': '/bin/bash', 02:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:20 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:20 INFO - 'USER': 'cltbld', 02:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:20 INFO - 'XPC_FLAGS': '0x0', 02:45:20 INFO - 'XPC_SERVICE_NAME': '0', 02:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:21 INFO - Downloading/unpacking psutil>=0.7.1 02:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:23 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:45:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:24 INFO - Installing collected packages: psutil 02:45:24 INFO - Running setup.py install for psutil 02:45:24 INFO - building 'psutil._psutil_osx' extension 02:45:24 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:45:24 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:45:24 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:45:24 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:45:24 INFO - building 'psutil._psutil_posix' extension 02:45:24 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:45:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:45:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:45:24 INFO - ^ 02:45:24 INFO - 1 warning generated. 02:45:24 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:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:25 INFO - Successfully installed psutil 02:45:25 INFO - Cleaning up... 02:45:25 INFO - Return code: 0 02:45:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:45:25 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:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:25 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:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:25 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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:25 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:45:25 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:45:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:25 INFO - 'HOME': '/Users/cltbld', 02:45:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:25 INFO - 'LOGNAME': 'cltbld', 02:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:25 INFO - 'MOZ_NO_REMOTE': '1', 02:45:25 INFO - 'NO_EM_RESTART': '1', 02:45:25 INFO - 'PAGER': '/bin/cat', 02:45:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:25 INFO - 'PWD': '/builds/slave/test', 02:45:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:25 INFO - 'SHELL': '/bin/bash', 02:45:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:25 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:25 INFO - 'USER': 'cltbld', 02:45:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:25 INFO - 'XPC_FLAGS': '0x0', 02:45:25 INFO - 'XPC_SERVICE_NAME': '0', 02:45:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:45:25 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:45:25 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:45:25 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:45:25 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:45:25 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:45:25 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:45:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:45:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:28 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:45:28 INFO - Installing collected packages: mozsystemmonitor 02:45:28 INFO - Running setup.py install for mozsystemmonitor 02:45:28 INFO - Successfully installed mozsystemmonitor 02:45:28 INFO - Cleaning up... 02:45:28 INFO - Return code: 0 02:45:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:28 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:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:28 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:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:28 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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:28 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:45:28 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:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:28 INFO - 'HOME': '/Users/cltbld', 02:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:28 INFO - 'LOGNAME': 'cltbld', 02:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:28 INFO - 'MOZ_NO_REMOTE': '1', 02:45:28 INFO - 'NO_EM_RESTART': '1', 02:45:28 INFO - 'PAGER': '/bin/cat', 02:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:28 INFO - 'PWD': '/builds/slave/test', 02:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:28 INFO - 'SHELL': '/bin/bash', 02:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:28 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:28 INFO - 'USER': 'cltbld', 02:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:28 INFO - 'XPC_FLAGS': '0x0', 02:45:28 INFO - 'XPC_SERVICE_NAME': '0', 02:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45:31 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:45:31 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:45:31 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:45:31 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:45:31 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:45:31 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:45:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 INFO - Downloading docopt-0.6.1.tar.gz 02:45:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:33 INFO - Running setup.py install for blobuploader 02:45:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:33 INFO - Running setup.py install for requests 02:45:33 INFO - Running setup.py install for docopt 02:45:34 INFO - Successfully installed blobuploader requests docopt 02:45:34 INFO - Cleaning up... 02:45:34 INFO - Return code: 0 02:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45: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:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45: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:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:34 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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:34 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:45:34 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:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:34 INFO - 'HOME': '/Users/cltbld', 02:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:34 INFO - 'LOGNAME': 'cltbld', 02:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:34 INFO - 'MOZ_NO_REMOTE': '1', 02:45:34 INFO - 'NO_EM_RESTART': '1', 02:45:34 INFO - 'PAGER': '/bin/cat', 02:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:34 INFO - 'PWD': '/builds/slave/test', 02:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:34 INFO - 'SHELL': '/bin/bash', 02:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:34 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:34 INFO - 'USER': 'cltbld', 02:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:34 INFO - 'XPC_FLAGS': '0x0', 02:45:34 INFO - 'XPC_SERVICE_NAME': '0', 02:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:34 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-9DjsWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:34 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-qM_rIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:34 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-E8Ixes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:34 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-F2nmxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:34 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-RvUGcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-3y5hHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-lczsDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-f9TjyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-4_7zid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-XSzj4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-14Sv32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:35 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-f08KqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:36 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-eeHt6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:36 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-r2sAdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:36 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-xDh1ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:36 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-4gHbBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:36 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-nJr5vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:45:36 INFO - Running setup.py install for manifestparser 02:45:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:45:36 INFO - Running setup.py install for mozcrash 02:45:37 INFO - Running setup.py install for mozdebug 02:45:37 INFO - Running setup.py install for mozdevice 02:45:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:45:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:45:37 INFO - Running setup.py install for mozfile 02:45:37 INFO - Running setup.py install for mozhttpd 02:45:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:45:37 INFO - Running setup.py install for mozinfo 02:45:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Running setup.py install for mozInstall 02:45:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Running setup.py install for mozleak 02:45:38 INFO - Running setup.py install for mozlog 02:45:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Running setup.py install for moznetwork 02:45:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:38 INFO - Running setup.py install for mozprocess 02:45:39 INFO - Running setup.py install for mozprofile 02:45:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:39 INFO - Running setup.py install for mozrunner 02:45:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:39 INFO - Running setup.py install for mozscreenshot 02:45:39 INFO - Running setup.py install for moztest 02:45:39 INFO - Running setup.py install for mozversion 02:45:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:40 INFO - Cleaning up... 02:45:40 INFO - Return code: 0 02:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45: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:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45: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:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45: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', '-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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:40 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:45:40 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:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:40 INFO - 'HOME': '/Users/cltbld', 02:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:40 INFO - 'LOGNAME': 'cltbld', 02:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:40 INFO - 'MOZ_NO_REMOTE': '1', 02:45:40 INFO - 'NO_EM_RESTART': '1', 02:45:40 INFO - 'PAGER': '/bin/cat', 02:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:40 INFO - 'PWD': '/builds/slave/test', 02:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:40 INFO - 'SHELL': '/bin/bash', 02:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:40 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:40 INFO - 'USER': 'cltbld', 02:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:40 INFO - 'XPC_FLAGS': '0x0', 02:45:40 INFO - 'XPC_SERVICE_NAME': '0', 02:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-HvebAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-KIj074-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-Zq3JJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-KTWSrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-XpV1Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-VNOnPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-qrTY86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-_GKF64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-g6JuzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-Xr8coR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-0f77VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-Atiqtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:42 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:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:42 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-WwbK8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:42 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:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:42 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-AmxRTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:42 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:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:42 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-3FcJMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:42 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:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:42 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-NzqMCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:42 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:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:42 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-WzRPUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:42 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:45:42 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:45:42 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:45:42 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:45:42 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:45:42 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:45:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:45 INFO - Downloading blessings-1.5.1.tar.gz 02:45:45 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:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:45 INFO - Installing collected packages: blessings 02:45:45 INFO - Running setup.py install for blessings 02:45:45 INFO - Successfully installed blessings 02:45:45 INFO - Cleaning up... 02:45:45 INFO - Return code: 0 02:45:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:46 INFO - Reading from file tmpfile_stdout 02:45:46 INFO - Current package versions: 02:45:46 INFO - blessings == 1.5.1 02:45:46 INFO - blobuploader == 1.2.4 02:45:46 INFO - docopt == 0.6.1 02:45:46 INFO - manifestparser == 1.1 02:45:46 INFO - mozInstall == 1.12 02:45:46 INFO - mozcrash == 0.16 02:45:46 INFO - mozdebug == 0.1 02:45:46 INFO - mozdevice == 0.46 02:45:46 INFO - mozfile == 1.2 02:45:46 INFO - mozhttpd == 0.7 02:45:46 INFO - mozinfo == 0.8 02:45:46 INFO - mozleak == 0.1 02:45:46 INFO - mozlog == 3.0 02:45:46 INFO - moznetwork == 0.27 02:45:46 INFO - mozprocess == 0.22 02:45:46 INFO - mozprofile == 0.27 02:45:46 INFO - mozrunner == 6.11 02:45:46 INFO - mozscreenshot == 0.1 02:45:46 INFO - mozsystemmonitor == 0.0 02:45:46 INFO - moztest == 0.7 02:45:46 INFO - mozversion == 1.4 02:45:46 INFO - psutil == 3.1.1 02:45:46 INFO - requests == 1.2.3 02:45:46 INFO - wsgiref == 0.1.2 02:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:46 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:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:46 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:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:46 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 0x107f8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ffb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945264a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, '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.WsDgxdaOGV/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.ff29vbFbgn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:45:46 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:45:46 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:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:46 INFO - 'HOME': '/Users/cltbld', 02:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:46 INFO - 'LOGNAME': 'cltbld', 02:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:46 INFO - 'MOZ_NO_REMOTE': '1', 02:45:46 INFO - 'NO_EM_RESTART': '1', 02:45:46 INFO - 'PAGER': '/bin/cat', 02:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:46 INFO - 'PWD': '/builds/slave/test', 02:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:46 INFO - 'SHELL': '/bin/bash', 02:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:45:46 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:46 INFO - 'USER': 'cltbld', 02:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:46 INFO - 'XPC_FLAGS': '0x0', 02:45:46 INFO - 'XPC_SERVICE_NAME': '0', 02:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 INFO - Cleaning up... 02:45:46 INFO - Return code: 0 02:45:46 INFO - Running post-action listener: _resource_record_post_action 02:45:46 INFO - Running post-action listener: _start_resource_monitoring 02:45:46 INFO - Starting resource monitoring. 02:45:46 INFO - ##### 02:45:46 INFO - ##### Running install step. 02:45:46 INFO - ##### 02:45:46 INFO - Running pre-action listener: _resource_record_pre_action 02:45:46 INFO - Running main action method: install 02:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:46 INFO - Reading from file tmpfile_stdout 02:45:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:47 INFO - Reading from file tmpfile_stdout 02:45:47 INFO - Output received: 02:45:47 INFO - Usage: mozinstall [options] installer 02:45:47 INFO - Options: 02:45:47 INFO - -h, --help show this help message and exit 02:45:47 INFO - -d DEST, --destination=DEST 02:45:47 INFO - Directory to install application into. [default: 02:45:47 INFO - "/builds/slave/test"] 02:45:47 INFO - --app=APP Application being installed. [default: firefox] 02:45:47 INFO - mkdir: /builds/slave/test/build/application 02:45:47 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:45:47 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:46:28 INFO - Reading from file tmpfile_stdout 02:46:28 INFO - Output received: 02:46:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:46:28 INFO - Running post-action listener: _resource_record_post_action 02:46:28 INFO - ##### 02:46:28 INFO - ##### Running run-tests step. 02:46:28 INFO - ##### 02:46:28 INFO - Running pre-action listener: _resource_record_pre_action 02:46:28 INFO - Running main action method: run_tests 02:46:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:28 INFO - 2015-11-17 02:46:28.351 screenresolution[2562:79695] starting screenresolution argv=screenresolution get 02:46:28 INFO - 2015-11-17 02:46:28.354 screenresolution[2562:79695] Display 0: 1600x1200x32@60 02:46:28 INFO - 2015-11-17 02:46:28.362 screenresolution[2563:79697] starting screenresolution argv=screenresolution list 02:46:28 INFO - Available Modes on Display 0 02:46:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:28 INFO - Intel HD Graphics 3000: 02:46:28 INFO - Chipset Model: Intel HD Graphics 3000 02:46:28 INFO - Type: GPU 02:46:28 INFO - Bus: Built-In 02:46:28 INFO - VRAM (Total): 512 MB 02:46:28 INFO - VRAM (Dynamic, Max): 10 02:46:28 INFO - Vendor: Intel (0x8086) 02:46:28 INFO - Device ID: 0x0116 02:46:28 INFO - Revision ID: 0x0009 02:46:28 INFO - Displays: 02:46:28 INFO - Display: 02:46:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:28 INFO - Display Serial Number: 1600x1200 60 02:46:28 INFO - Main Display: Yes 02:46:28 INFO - Mirror: Off 02:46:28 INFO - Online: Yes 02:46:28 INFO - Rotation: Supported 02:46:28 INFO - Return code: 0 02:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:28 INFO - Python 2.7.3 02:46:28 INFO - Return code: 0 02:46:28 INFO - grabbing minidump binary from tooltool 02:46:28 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:46:28 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 0x107f439f0>, '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 0x107ca2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f0d990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:28 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:46:28 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:46:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:28 INFO - Return code: 0 02:46:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:46:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:46:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:28 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/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0019', '--webServer', 'localhost'] in /builds/slave/test/build 02:46:28 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/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0019 --webServer localhost 02:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WsDgxdaOGV/Render', 02:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:28 INFO - 'HOME': '/Users/cltbld', 02:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:28 INFO - 'LOGNAME': 'cltbld', 02:46:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:28 INFO - 'MOZ_NO_REMOTE': '1', 02:46:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:28 INFO - 'NO_EM_RESTART': '1', 02:46:28 INFO - 'PAGER': '/bin/cat', 02:46:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:28 INFO - 'PWD': '/builds/slave/test', 02:46:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:28 INFO - 'SHELL': '/bin/bash', 02:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ff29vbFbgn/Listeners', 02:46:28 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 02:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:28 INFO - 'USER': 'cltbld', 02:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:28 INFO - 'XPC_FLAGS': '0x0', 02:46:28 INFO - 'XPC_SERVICE_NAME': '0', 02:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:46:28 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/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0019', '--webServer', 'localhost'] with output_timeout 3600 02:46:29 INFO - mozversion INFO | application_buildid: 20151117004023 02:46:29 INFO - mozversion INFO | application_changeset: e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8 02:46:29 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:46:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:29 INFO - mozversion INFO | application_name: Firefox 02:46:29 INFO - mozversion INFO | application_remotingname: firefox-dev 02:46:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:46:29 INFO - mozversion INFO | application_vendor: Mozilla 02:46:29 INFO - mozversion INFO | application_version: 44.0a2 02:46:29 INFO - mozversion INFO | platform_buildid: 20151117004023 02:46:29 INFO - mozversion INFO | platform_changeset: e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8 02:46:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:46:29 INFO - mozversion INFO | platform_version: 44.0a2 02:46:29 INFO - 2015-11-17 02:46:29,032 DEBUG : using testdate: 1447757189 02:46:29 INFO - 2015-11-17 02:46:29,032 DEBUG : actual date: 1447757189 02:46:29 INFO - 2015-11-17 02:46:29,042 INFO : starting webserver on 'localhost:54241' 02:46:29 INFO - 2015-11-17 02:46:29,044 INFO : Starting test suite t-yosemite-r5-0019 02:46:29 INFO - 2015-11-17 02:46:29,044 INFO : Starting test dromaeo_css 02:46:29 INFO - 2015-11-17 02:46:29,044 DEBUG : operating with platform_type : mac_ 02:46:29 INFO - 2015-11-17 02:46:29,045 INFO : Initialising browser for dromaeo_css test... 02:46:29 INFO - 2015-11-17 02:46:29,060 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmphf8Q5X/profile http://localhost:54241/getInfo.html 02:46:31 INFO - 2015-11-17 02:46:31,775 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:46:31 INFO - 2015-11-17 02:46:31,776 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:46:31 INFO - 2015-11-17 02:46:31,776 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:46:31 INFO - 2015-11-17 02:46:31,776 DEBUG : BROWSER_OUTPUT: __metrics 02:46:31 INFO - 2015-11-17 02:46:31,791 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:46:32 INFO - 2015-11-17 02:46:32,588 INFO : Browser initialized. 02:46:32 INFO - 2015-11-17 02:46:32,589 INFO : Running cycle 1/1 for dromaeo_css test... 02:46:32 INFO - 2015-11-17 02:46:32,589 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmphf8Q5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:46:44 INFO - 2015-11-17 02:46:44,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 199790592 02:46:44 INFO - 2015-11-17 02:46:44,700 DEBUG : BROWSER_OUTPUT: 02:47:36 INFO - 2015-11-17 02:47:36,439 DEBUG : BROWSER_OUTPUT: 1447757256437 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:49:46 INFO - 2015-11-17 02:49:46,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54241/tests/dromaeo/cssquery-ext.html) 02:49:48 INFO - 2015-11-17 02:49:48,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 321634304 02:49:48 INFO - 2015-11-17 02:49:48,078 DEBUG : BROWSER_OUTPUT: 02:52:50 INFO - 2015-11-17 02:52:50,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-ext.html (next: http://localhost:54241/tests/dromaeo/cssquery-jquery.html) 02:52:51 INFO - 2015-11-17 02:52:51,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 345632768 02:52:51 INFO - 2015-11-17 02:52:51,548 DEBUG : BROWSER_OUTPUT: 02:55:54 INFO - 2015-11-17 02:55:54,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54241/tests/dromaeo/cssquery-mootools.html) 02:55:54 INFO - 2015-11-17 02:55:54,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 312819712 02:55:54 INFO - 2015-11-17 02:55:54,576 DEBUG : BROWSER_OUTPUT: 02:58:56 INFO - 2015-11-17 02:58:56,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54241/tests/dromaeo/cssquery-prototype.html) 02:58:57 INFO - 2015-11-17 02:58:57,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 301547520 02:58:57 INFO - 2015-11-17 02:58:57,215 DEBUG : BROWSER_OUTPUT: 03:02:00 INFO - 2015-11-17 03:02:00,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54241/tests/dromaeo/cssquery-yui.html) 03:02:01 INFO - 2015-11-17 03:02:01,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 300924928 03:02:01 INFO - 2015-11-17 03:02:01,145 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-yui.html (next: http://localhost:54241/tests/dromaeo/cssquery-dojo.html) 03:05:03 INFO - 2015-11-17 03:05:03,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 345473024 03:05:03 INFO - 2015-11-17 03:05:03,908 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:05:03 INFO - 2015-11-17 03:05:03,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:05:03 INFO - 2015-11-17 03:05:03,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:05:03 INFO - 2015-11-17 03:05:03,910 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:05:03 INFO - 2015-11-17 03:05:03,912 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2726.27753645284;2809.9578506322396;2815.3243221626817;2830.9150725478235;2833.40498495316;4746.976265118678;4788.497207793183;4828.51714828517;4833.250846118848;4882.267659851024;4844.515548445153;4861.124997500448;4870.147724148269;4888.73111978841;4902;4328.2209202343565;4434.68957172998;4527.932081018779;4582.839600613963;4589.426321709786;4404.0751442197015;4486.8878278042985;4521.525239849818;4558.544145585432;4589.334546490757;4363.54182810805;4497.437820272466;4540.114677637862;4551.067031258584;4592.920663644058;4505.391772110772;4573.519780423074;4603.746793926332;4613.492515823256;4622.884427889296;4013.518377794654;4273.679474039428;4369.366441865944;4369.6722745794195;4511.796969136397;4645.790939407735;4652.209124448852;4710.74090924999;4731.219348807443;4759.714417134948;5077.314562534048;5086.720230387327;5088.974555127238;5093.388793344822;5105.617078719111;4947.727874966876;5065.518775716338;5136.383633963911;5141.254518094893;5163.173892177271;4665.113628410591;4705.788239529229;4744.95255047452;4777.808887644455;4785.49752276013;5171.482851714798;5293.602979776532;5322.813701520428;5343.038253114477;5352.892942141136;4782.258749893772;5099.821506247264;5105.744712764347;5106.872328191751;5143.459936706592;5051.419086805065;5073.162928116893;5102.438731739506;5158.071547121479;5190.273361729361;5069.771860266297;5127.077126117335;5134.8446599515555;5135.563477104488;5183.896322073538;4857.271409288564;5073.213651883964;5142.434332223527;5147.0735267651435;5154.92267615986;3826.3686491728554;3885.048163200034;3902.512185976753;3909.100906791454;3935.7244992850797;3570.3751843427294;3606.8016259106003;3613.638636136365;3616.168281295264;3622.5290712207243;4560.908781824412;4908.165611845995;4912.140375434285;4914.72968986702;4936.062148191832;5023.422306434807;5063.87340316495;5085.669431486942;5232.084385232645;5271.288376069258;4771.427428708508;4806.543378379049;4821.180399332122;4823.397075365579;4871.780769865364;4281.250781113293;4492.124035813051;4493.370928070073;4510.2783554631105;4545.886352841139;5020.824271150492;5134.12719837636;5152.742362881916;5239.764210610456;5278.656887302313;5061.316722242597;5169.870753231049;5174.818881339135;5189.169732842727;5202.167653175474;4980.078685443204;5227.059129356752;5242.318498595158;5249.737513124405;5253.763580638804;4886.731229782396;5003.574696150868;5035.018171456531;5044.772985215601;5070.8225212117395;5150.97424512875;5200.037992971313;5208.791648334024;5216.843494695166;5222.3472065991755;5024.799008039638;5068.087744206078;5079.92380114306;5080.745962701924;5094.541491265803;4761.833335833229;4889.9022019560125;4897;4907.631927605516;5034.370703662043;4898.632602554751;4938.481459446706;4944.653874228769;4950.579200767975;4973.9751301244705;4990.126727822544;5070.2141168119;5075.061113693979;5088.236764485208;5100.923486147636;4513.1650644630845;4805.159097158054;4821.228603423576;4837.395325584302;4922.163232250455 03:05:03 INFO - 2015-11-17 03:05:03,915 DEBUG : BROWSER_OUTPUT: |1;ext.html;482.01187565490744;491.73692074740023;498.5911552526927;505.28249885163075;515.6725479320635;27978.860105699467;29546.556801647992;35538.46692299617;36159.4576081359;36159.63840361602;38659;38770.22459550807;38800.611993880055;38843.41734873979;39399.21201575974;7330.67011984462;7871.9212807872045;8058.677652893877;8094.635741391651;8169.387295952827;7273;9661.275404344668;9767.267454940873;9825.312228144032;9932.35439696421;9576.138147566717;9662.75843103921;9764.12122908938;9783.119519243266;9786.853197202048;7447.627618619102;7618.733344332977;9620.759481012996;9674.854877176778;9712.757181070494;9461.668841590581;9479.24166066713;9499;9584.28117891161;9620.855687164698;35079.12302192466;35378;35492.11269718252;35675.64324356775;35942.64057359419;2643.801714871373;2662.880170392337;2672.986635066812;2848.088611644275;3016.668166501683;24763.62854557183;24817.25548233556;24895.128670496626;25089.24732258035;25272.494550109077;2033.9084741186682;2037.5517386175018;2050.0672194151775;2064.0299059442036;2075.5226297951403;236994;242168;242863;243497;245336;48016;49705.75147124314;55544.444555554735;55612.443875561534;56512.43487565072;63969.36030639634;64838.35161648323;65408.345916540224;65482.67258663676;66169;15324.310406031755;15542.689146217012;15554.144522051396;15569.143697096542;15578.84421155774;11554.133439992034;11606.76786464266;11678.182527223184;11882.346470944009;11884.227525210834;18019.27922883096;18157;18254.17856196474;18275.08624568793;18343.449696509128;7444.776656700307;7637.389008879276;7653.617319134021;7686.077670679442;7722.266384693445;800.1958032177624;853.9359548033798;869.2871845087094;893.2050475077186;958.6548842416724;25049.37376565564;25742.613860792102;26453.470930581665;26637.600435993474;26809.463810723675;884.5754038061766;895.7268033249791;962.5187406296851;962.8170647576937;1048.358137493512;9749.853752193723;12662.36688165588;12780.105392622427;12790.552330668383;13075.150115242479;286681;288989;289403;290231;290352;42512.78743606324;43120.56879431228;47592;49353.50646493489;49855;1293.0625296659846;1299.4282515693064;1307.0327957311522;1307.1634154141168;1308.2216081431723;23807.64288535708;24770.885310161448;25358;25394.873025634755;25395.61906571366;40354;40534.594654054265;40568.1886362277;45457.318140228585;45736.771316143204;225360;227841;230688;231167;231180;26128.60807087857;26330.605040924784;26543.734562654125;26924.865375672995;27196.048138315065;36057.63942360648;37192.256154877294;37743.433848492845;38006.80996594999;39037.41443878287;30375;30517.847410762803;30669.693303066684;31787.68212317847;31981.520277195395;29304.560431593116;29408.411831762816;29429.85285073561;29562.852185738935;29921.251968700955;29805;29843.10470685883;30130;30213.848930755204;30503.54244686287;25819.225423237334;27742.86128569344;27849.860750696116;27874;27936.44127117487;20172.899135504227;20666.68999965032;21020.126606866474;21167;22493.32520024402 03:05:03 INFO - 2015-11-17 03:05:03,917 DEBUG : BROWSER_OUTPUT: |2;jquery.html;288.53977905241146;296.6144012783381;303.98784048638055;307.75379696243004;315.3912948010339;12901;13351.599452016455;14982.550523484286;15432.537023889287;15795.131267780267;13294.268815215159;15015.324310406031;15763.921180394082;16233.675326493463;16431.58921026975;4615.769211539418;4659.673822832403;4689;4745.857624271277;4764.714117152982;3513.2270900402;3665.4318580620047;3677.926441471169;4622.352870598119;4749.52504749524;4886.144924638192;5042.420121685998;5063.594912407017;5127.923081153767;5163.7676304566385;5009.323741294915;5152.665076770017;5154.278401023859;5201.661891977009;5216.739163041832;4481.327800829869;4482.731036137842;4486.416765820455;4533.727976321398;4534.77326133692;18143.183556739845;18208.271669133217;18576.44270671882;18673.53316167093;19062.237510499563;1849.2048419179748;1916.5208697825544;1940.146335612326;1941.3399444189045;1967.5081229692578;11377.317360958368;11734.413279335999;12084.577039803564;12308.261504309681;12412.937935310356;1360.9455621775116;1376.057400680537;1400.8879289656802;1426.2726009735006;1480.393713287818;51182.720431989124;51360;51770.74114629441;51857.481425185644;51902;8397.790055248668;8490.915090849136;8937.195652391316;8940.240079593308;8940.910590894007;11006.229563930448;11019.283746556448;11020.118390528738;11157;11178;6928.549644273106;7005.124359455068;7021.29787021304;7042.964785176041;7046.1192350956135;6969.407600354027;7002.929970700227;7044.471664625174;7062.364387205073;7127.358537731629;5194.896102077937;5262.2632831403635;5273.868153296198;5342.171963345688;5355.919661205085;1383.4950243161375;1427.2863568215892;1462.795208670787;1492.8059352284351;1507.6833864888276;705.8341289796894;836.2682652678906;838.1785849867165;841.7558907916635;851.684034146683;16002.599935001717;17250.309987600605;17353.826461735473;17412.21645025977;17486;358.5625536845045;363.58021924385315;364.2660040019363;376.10299435845707;383.22588371489434;4908.4846091160625;5205.167173252262;5249.763760630781;5256.159014557652;5279.44565820591;326635;328883;332650;335205;506976;65280.99999999905;65903;66518.33481665218;67839.66080169666;68845;395.33188910740756;396.0336778261091;396.221424900067;397.2511815228258;400.2595198882103;8423.5788210588;8920.598573064099;8932.598033088656;8996.145366190201;9035.186833185046;32652.83673581617;32969.67030329666;33143;33150.336993259516;33580.160495987795;41309.38035929524;42417.575824242595;42837.14325713531;45553.77223113863;45660.771696142634;6751;6903.551269167689;6971.6165610891885;6986.16166060076;7093.787186384417;10131.493425328557;10368.792624147625;10387.68836934893;10458.843117353397;10588.258821882395;8952.28381729447;8963.417377870417;9079.818403632022;9099.681511147079;9132.589033493376;8686.087960764029;8732.738017859474;8932.598033088396;8959.104089590988;9079.364444489087;9254.444733316022;9382.624695012397;9467.431954082776;9589.808203836024;9691.370060946016;6280.309165991646;6494.577852439576;7009.684564194521;7097.893531597134;7108.644567771694;9008.684696035607;9019.32355073359;9114.31642626819;9122.270218382646;9127.863082053907 03:05:03 INFO - 2015-11-17 03:05:03,918 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1395.9651008724786;1484.9257537123144;1568.9137097459643;1585.3579300383342;1596.7365384711522;6042.969785151074;6200.875982480347;6555.672216389179;6790.796276111712;6796.7281308747715;6522.347765223475;6548.246951600568;6621.370969757877;6658.933410665904;6683.164604424447;1922.1926790747884;1943.893085880276;1946.0172612830502;1950.8146726061002;1972.3195497553322;1922.0389805097452;1939.4472575316038;1948.5907959328558;1952.6387618290591;1956.814102660252;1895.1945423195157;1903.7905830358718;1905.7713074431088;1907.122723547163;1928.517870532367;1874.5219968907977;1906.9237230510832;1909.455805095541;1914.607505461384;1932.4878907089633;1847.4919397165752;1853.7497437845989;1865.0674662668666;1884.8586356023216;1890.2722451856134;5878.794242201502;6527.184101987252;6575.276719560845;6580.5393622446445;6665.300143484961;3647.434647629622;3845.365514690073;3945.28984782739;3949.3483575210344;3997.200559888034;2320.2575175943703;2394.4971555973093;2440.414300567869;2472.072972635262;2481.367251350912;678.6878036103399;683.702589373624;684.2131548718963;699.5068476723898;708.0688894104288;8661.956690216572;8699.652013919436;8703.216710496086;8799.384043117048;8861.689840855604;3567.839447224829;3576.964230357663;3689.1146124929824;3697.408414653696;3751.4185301278344;7743.303102720783;7777.066751989797;7779.572123533147;7781.8832717509285;7828.921710782934;4118.423420721101;4126.8761937141935;4135.069609337875;4158.334666453353;4192.706510544293;3722.4788529605876;3757.6993840492696;3761.1161377076364;3761.247750449921;3804.980975095162;2800.2299367674054;2846.7295606917723;2854.5432730763396;2867.211516832888;2878.7984841061343;990.1089019882164;994.6021591363512;1001.4041645221082;1008.6873069348526;1009.2228983682523;942.8020115775627;964.2045312616979;1144.7882141803627;1159.7448561316496;1174.988250117488;6386.552941294158;6459.709313080923;6471.7734879279;6475.384838440341;6480.773172938924;966.6133546581424;997.7056768253383;1002.6240159940022;1010.7068950004564;1017.1100287248657;5007.649464537448;5063.645544811901;5089.9745501272255;5095.235714642759;5105.846824595268;7066.364027237573;7288.562686238843;7601.7719468416035;7814.609269536614;7837.921620783719;7697.961510192526;7780.105287891852;7788.221177882279;7843.137254901956;7846.450748447668;6180.412860778219;6186.4741496972365;6364.459020983269;6385.201849768779;6388.105665206875;6318.27339855904;6339.017452294902;6340.587861788969;6346.650934198663;6381.042843573501;6958.617276049866;7049.08361912948;7138.286171383028;7148.928510714826;7261.092363454568;7137.571745695275;7273.018142550688;7328.193898671036;7358;7421.888671669822;5683.829485115453;5760.135979603093;5760.1935728998815;5771.711414429178;5779.739911704068;6416.839579010562;6458.22501299847;6480.8703825922275;6492.091107245084;6495;6028.3971602839365;6085.087236914321;6101.908471372844;6173.259208894961;6174.629522228681;5923.466887980103;5931.673757943355;5990.820275391745;6007.90988135187;6028.87942241144;6027.336992930686;6083.939160608337;6110.69446527663;6156.045812899008;6159.846003849761;5568.526675232489;5600.915986260128;5602.1036634138345;5603.0194715923735;5609.046462101534;5537.944620553743;5668.433156684298;5670;5680.517156041617;5682.204491371294 03:05:03 INFO - 2015-11-17 03:05:03,921 DEBUG : BROWSER_OUTPUT: |4;prototype.html;260.6468235540842;265.53398785132083;265.96941351744545;266.0376705385533;270.61032113756175;5115.616328775338;5253.369595648518;5280.656757310772;5282.788688452462;5303.7082960437165;5142.228665700147;5145.922811157826;5182.093133701606;5204.843854684365;5296.496832800878;3931.115499012728;3982.462367580383;4024.1146947671614;4029.556748757642;4069.287874621944;4068.3694027425795;4086.0193553547083;4101.63085322321;4139.896502587444;4145.751254924714;4027.5771044040393;4031.052702614883;4039.565954086301;4088;4097.160082183145;4014.759114453142;4035.475388199545;4041.4341992121126;4107.281225785476;4128.7109902307;3489.162600975773;3503.2643144939593;3531.523244362004;3556.395412779834;3574.6425357464304;4926.5812405945535;5128.974355128201;5135.845924622267;5185.507376799198;5191.506806853343;4528.343390208434;4559.726416415026;4591.862244132682;4592.540745925381;4612.7924243409125;5539.9169012464845;5548.805791797308;5558.972205138989;5582.720863956826;5629.6340737852315;3625.166211771281;3633.055405594538;3660.103274697716;3665.871694490707;3756.9624303756887;5666.150077488369;5699.373068962411;5704.258446401941;5746;5786.537077033827;3793.1275806564645;3801.6578507933864;3808;3822.10180607557;3854.6530812227033;3814.389697648363;3824.6557809796695;3865.632764887331;3871.225754848985;3872.9031774205305;4338.913221735547;4452.532484089189;4493.056458143761;4526.388937493396;4575.9084818303445;5553.805616803393;5559.499645031886;5567.721613919288;5636.210930469738;5642.915356269659;1340.483913693235;1344.2606566388447;1346.811446397505;1346.9730605387838;1361.0472669131648;855.5080828523623;860.6299291304674;861.440063958432;870.2863651805585;875.369733791669;5302.549283310885;5319.521243088063;5329;5415.593830462731;5419.593530485229;5768.826935191951;5772.826815195551;5805.216295800013;5866.5893387462465;5869.06095024794;5323.653962492425;5330.893382132335;5400.91898621521;5404.216388623628;5412.891742165213;3101.4882544380375;3156.731677807366;3177.9841100794347;3193.457112290916;3235.854386552611;5812.041013232853;5819.767209311664;5864.765409383662;5922.733476993546;5962.34414214436;5888.057910734347;5901.468867801918;5931.911021334683;5944.673042982591;6007.459328660354;5677.801276955287;5849.181114643953;5892.882142357129;5945.762169513171;5967.194428752063;5769.3942136076785;5791.681457519877;5830.708464576839;5836.649801011953;5852.795152169653;5483.396826349178;5601.6358936668985;5698.715064246854;5730.111832665943;5755.1367294906095;5724.8568785779025;5810.5061069809535;5857.121431785095;5879.853003674943;5898.557608179318;3661.0664280608275;3699.408094704834;3719.6094410086553;3737.5701794294005;3739.1960728443514;5662.7734890603915;5678.432156784289;5769.59612827098;5778;5781.797637082682;5438.70087145195;5565.1095824667855;5611.551075913835;5637.492625663546;5646.153077038477;5558;5572.665640061609;5614.29821272341;5618.381977982501;5666.263385759825;5455.618106732491;5456.2906822114455;5485.259489968803;5504.394516603091;5507.366652834975;5356.5982551308025;5553.861153471195;5624.803131890364;5636.379998200113;5663.122216056518;5514.448555144453;5521.779128834802;5591.133374326986;5624.409437009219;5641.548676105984 03:05:03 INFO - 2015-11-17 03:05:03,923 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.6535071061627;670.8926571748519;676.7631329034836;679.6805501414334;686.8145600687815;11367.147463940206;11868.22856514326;12062.155649104567;12066.51733930644;12077.335746533938;11052.281601695884;11144.219904606682;11337;12556.874431255685;12593.370331483435;626.9592476489014;792.8335049639583;801.0147518552155;801.527099011583;808.8544062068826;621.3755176048065;625.8310256230815;757.9621018949031;785.4030936488282;785.8231897823001;803.4014659078965;810.7729835646029;817.1256755271861;818.0347190315425;819.0171793847406;642.1812189458478;668.0346898731335;800.675726330834;808.0828259924998;809.4172196018857;573.962692424991;587.180882668679;594.6907608043837;595.5265563876728;595.8152972578514;11694.649160525198;11717.53129874804;11732.765344693058;11891;11925.761484770343;7962.2435868592975;8003.039635243808;8018.67925282988;8115.14790946948;8549.145085491402;7892.486988345797;7936.960315198387;7993.608309198077;8057.798555036113;8075.676972921076;2464.8397854139425;2478.863662498562;2532.3795670060767;2558.296468471167;2606.543854825417;41846;41874.37188442176;41901.999999999694;42039;42245.577544224776;5784.82645520635;5968.074948383008;5982.760689572456;6128.816135515942;6193.659348735863;10726.141908647289;10726.946365268124;10773.515191816387;10879.075278601249;10879.401632910107;5350.625456218105;5417.10617748075;5437.4562543745305;5501.174823776386;5592.944070559323;3290.111669849175;3351.162209447638;3374.0383990563064;3413.74396920227;3424;2268.115434980359;2272.091163534599;2273.772622737713;2291.8281128915396;2297.574948634508;342.97599168058497;343.8418327569296;394.9348357520977;409.2490280335558;413.78276404887674;402.16349992016535;425.87649581621605;491.6632107006712;494.33265092125345;538.9703566303891;6529.15121034272;6912.930870691329;7461.328480436787;7466.25337466249;7605.991217374944;450.9008018235983;456.4773334531942;475.5125995854277;509.421806249909;526.9420363759983;2959.156640357488;3087.4133914556164;3119;3151.2279491524264;3302.719268862126;45646.543534564895;46285.53714462812;52542.94914101773;52617;53140.73429632904;40609.79695101506;40840;40869;41099.38350924738;41175.1764964699;39021;40542;40571;40754.79622601868;40999;6876.415504681958;7077;7153;7210.747623833141;7233.132024157135;28925.276868078465;29783.255418614706;29785.702142978294;30307;30343.544846827757;41443.79278103711;42127.57872421236;42212.1557568853;42603.31363550069;42735.7863210682;6257.374262573706;6272.874542509216;6430.646314452563;6432.067350234283;6832.863342733217;9594.18449431806;9655.22758179358;9663.9033609663;9744.269179811401;9752.853707194256;9224.893012838502;9334;9347.439153650803;9374.765630859283;9377.437353758796;9186.356955013085;9239.39943903644;9268.258539316703;9275.953620231856;9296.72109836706;8745.518996455256;8938.284937205139;9044.954775226082;9048.366614336934;9091.136342047495;7775.300222979959;7976.880346794686;8008.319292860172;8289.295409890226;8508;7785;7845.6077196141105;7848.136704962564;8147.674093036212;8349.666013359398 03:05:03 INFO - 2015-11-17 03:05:03,923 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:05:03 INFO - 2015-11-17 03:05:03,923 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:05:03 INFO - 2015-11-17 03:05:03,923 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 03:05:03 INFO - 2015-11-17 03:05:03,923 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:05:03 INFO - 2015-11-17 03:05:03,924 DEBUG : BROWSER_OUTPUT: __startTimestamp1447758303908__endTimestamp 03:05:03 INFO - 2015-11-17 03:05:03,924 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,924 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:05:03 INFO - 2015-11-17 03:05:03,924 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:05:03 INFO - 2015-11-17 03:05:03,924 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,924 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4770.27 Median:4907.63 stddev:516.79 (10.5%) stddev-sans-first:492.87 03:05:03 INFO - 2015-11-17 03:05:03,926 DEBUG : BROWSER_OUTPUT: Values: 2726.3 2810.0 2815.3 2830.9 2833.4 4747.0 4788.5 4828.5 4833.3 4882.3 4844.5 4861.1 4870.1 4888.7 4902.0 4328.2 4434.7 4527.9 4582.8 4589.4 4404.1 4486.9 4521.5 4558.5 4589.3 4363.5 4497.4 4540.1 4551.1 4592.9 4505.4 4573.5 4603.7 4613.5 4622.9 4013.5 4273.7 4369.4 4369.7 4511.8 4645.8 4652.2 4710.7 4731.2 4759.7 5077.3 5086.7 5089.0 5093.4 5105.6 4947.7 5065.5 5136.4 5141.3 5163.2 4665.1 4705.8 4745.0 4777.8 4785.5 5171.5 5293.6 5322.8 5343.0 5352.9 4782.3 5099.8 5105.7 5106.9 5143.5 5051.4 5073.2 5102.4 5158.1 5190.3 5069.8 5127.1 5134.8 5135.6 5183.9 4857.3 5073.2 5142.4 5147.1 5154.9 3826.4 3885.0 3902.5 3909.1 3935.7 3570.4 3606.8 3613.6 3616.2 3622.5 4560.9 4908.2 4912.1 4914.7 4936.1 5023.4 5063.9 5085.7 5232.1 5271.3 4771.4 4806.5 4821.2 4823.4 4871.8 4281.3 4492.1 4493.4 4510.3 4545.9 5020.8 5134.1 5152.7 5239.8 5278.7 5061.3 5169.9 5174.8 5189.2 5202.2 4980.1 5227.1 5242.3 5249.7 5253.8 4886.7 5003.6 5035.0 5044.8 5070.8 5151.0 5200.0 5208.8 5216.8 5222.3 5024.8 5068.1 5079.9 5080.7 5094.5 4761.8 4889.9 4897.0 4907.6 5034.4 4898.6 4938.5 4944.7 4950.6 4974.0 4990.1 5070.2 5075.1 5088.2 5100.9 4513.2 4805.2 4821.2 4837.4 4922.2 03:05:03 INFO - 2015-11-17 03:05:03,926 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,926 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40939.32 Median:30294.42 stddev:66594.26 (219.8%) stddev-sans-first:66711.79 03:05:03 INFO - 2015-11-17 03:05:03,927 DEBUG : BROWSER_OUTPUT: Values: 482.0 491.7 498.6 505.3 515.7 27978.9 29546.6 35538.5 36159.5 36159.6 38659.0 38770.2 38800.6 38843.4 39399.2 7330.7 7871.9 8058.7 8094.6 8169.4 7273.0 9661.3 9767.3 9825.3 9932.4 9576.1 9662.8 9764.1 9783.1 9786.9 7447.6 7618.7 9620.8 9674.9 9712.8 9461.7 9479.2 9499.0 9584.3 9620.9 35079.1 35378.0 35492.1 35675.6 35942.6 2643.8 2662.9 2673.0 2848.1 3016.7 24763.6 24817.3 24895.1 25089.2 25272.5 2033.9 2037.6 2050.1 2064.0 2075.5 236994.0 242168.0 242863.0 243497.0 245336.0 48016.0 49705.8 55544.4 55612.4 56512.4 63969.4 64838.4 65408.3 65482.7 66169.0 15324.3 15542.7 15554.1 15569.1 15578.8 11554.1 11606.8 11678.2 11882.3 11884.2 18019.3 18157.0 18254.2 18275.1 18343.4 7444.8 7637.4 7653.6 7686.1 7722.3 800.2 853.9 869.3 893.2 958.7 25049.4 25742.6 26453.5 26637.6 26809.5 884.6 895.7 962.5 962.8 1048.4 9749.9 12662.4 12780.1 12790.6 13075.2 286681.0 288989.0 289403.0 290231.0 290352.0 42512.8 43120.6 47592.0 49353.5 49855.0 1293.1 1299.4 1307.0 1307.2 1308.2 23807.6 24770.9 25358.0 25394.9 25395.6 40354.0 40534.6 40568.2 45457.3 45736.8 225360.0 227841.0 230688.0 231167.0 231180.0 26128.6 26330.6 26543.7 26924.9 27196.0 36057.6 37192.3 37743.4 38006.8 39037.4 30375.0 30517.8 30669.7 31787.7 31981.5 29304.6 29408.4 29429.9 29562.9 29921.3 29805.0 29843.1 30130.0 30213.8 30503.5 25819.2 27742.9 27849.9 27874.0 27936.4 20172.9 20666.7 21020.1 21167.0 22493.3 03:05:03 INFO - 2015-11-17 03:05:03,928 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,928 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21738.70 Median:4717.43 stddev:61275.09 (1298.9%) stddev-sans-first:61425.81 03:05:03 INFO - 2015-11-17 03:05:03,929 DEBUG : BROWSER_OUTPUT: Values: 288.5 296.6 304.0 307.8 315.4 12901.0 13351.6 14982.6 15432.5 15795.1 13294.3 15015.3 15763.9 16233.7 16431.6 4615.8 4659.7 4689.0 4745.9 4764.7 3513.2 3665.4 3677.9 4622.4 4749.5 4886.1 5042.4 5063.6 5127.9 5163.8 5009.3 5152.7 5154.3 5201.7 5216.7 4481.3 4482.7 4486.4 4533.7 4534.8 18143.2 18208.3 18576.4 18673.5 19062.2 1849.2 1916.5 1940.1 1941.3 1967.5 11377.3 11734.4 12084.6 12308.3 12412.9 1360.9 1376.1 1400.9 1426.3 1480.4 51182.7 51360.0 51770.7 51857.5 51902.0 8397.8 8490.9 8937.2 8940.2 8940.9 11006.2 11019.3 11020.1 11157.0 11178.0 6928.5 7005.1 7021.3 7043.0 7046.1 6969.4 7002.9 7044.5 7062.4 7127.4 5194.9 5262.3 5273.9 5342.2 5355.9 1383.5 1427.3 1462.8 1492.8 1507.7 705.8 836.3 838.2 841.8 851.7 16002.6 17250.3 17353.8 17412.2 17486.0 358.6 363.6 364.3 376.1 383.2 4908.5 5205.2 5249.8 5256.2 5279.4 326635.0 328883.0 332650.0 335205.0 506976.0 65281.0 65903.0 66518.3 67839.7 68845.0 395.3 396.0 396.2 397.3 400.3 8423.6 8920.6 8932.6 8996.1 9035.2 32652.8 32969.7 33143.0 33150.3 33580.2 41309.4 42417.6 42837.1 45553.8 45660.8 6751.0 6903.6 6971.6 6986.2 7093.8 10131.5 10368.8 10387.7 10458.8 10588.3 8952.3 8963.4 9079.8 9099.7 9132.6 8686.1 8732.7 8932.6 8959.1 9079.4 9254.4 9382.6 9467.4 9589.8 9691.4 6280.3 6494.6 7009.7 7097.9 7108.6 9008.7 9019.3 9114.3 9122.3 9127.9 03:05:03 INFO - 2015-11-17 03:05:03,929 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,929 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4644.47 Median:5927.57 stddev:2381.89 (40.2%) stddev-sans-first:2376.06 03:05:03 INFO - 2015-11-17 03:05:03,931 DEBUG : BROWSER_OUTPUT: Values: 1396.0 1484.9 1568.9 1585.4 1596.7 6043.0 6200.9 6555.7 6790.8 6796.7 6522.3 6548.2 6621.4 6658.9 6683.2 1922.2 1943.9 1946.0 1950.8 1972.3 1922.0 1939.4 1948.6 1952.6 1956.8 1895.2 1903.8 1905.8 1907.1 1928.5 1874.5 1906.9 1909.5 1914.6 1932.5 1847.5 1853.7 1865.1 1884.9 1890.3 5878.8 6527.2 6575.3 6580.5 6665.3 3647.4 3845.4 3945.3 3949.3 3997.2 2320.3 2394.5 2440.4 2472.1 2481.4 678.7 683.7 684.2 699.5 708.1 8662.0 8699.7 8703.2 8799.4 8861.7 3567.8 3577.0 3689.1 3697.4 3751.4 7743.3 7777.1 7779.6 7781.9 7828.9 4118.4 4126.9 4135.1 4158.3 4192.7 3722.5 3757.7 3761.1 3761.2 3805.0 2800.2 2846.7 2854.5 2867.2 2878.8 990.1 994.6 1001.4 1008.7 1009.2 942.8 964.2 1144.8 1159.7 1175.0 6386.6 6459.7 6471.8 6475.4 6480.8 966.6 997.7 1002.6 1010.7 1017.1 5007.6 5063.6 5090.0 5095.2 5105.8 7066.4 7288.6 7601.8 7814.6 7837.9 7698.0 7780.1 7788.2 7843.1 7846.5 6180.4 6186.5 6364.5 6385.2 6388.1 6318.3 6339.0 6340.6 6346.7 6381.0 6958.6 7049.1 7138.3 7148.9 7261.1 7137.6 7273.0 7328.2 7358.0 7421.9 5683.8 5760.1 5760.2 5771.7 5779.7 6416.8 6458.2 6480.9 6492.1 6495.0 6028.4 6085.1 6101.9 6173.3 6174.6 5923.5 5931.7 5990.8 6007.9 6028.9 6027.3 6083.9 6110.7 6156.0 6159.8 5568.5 5600.9 5602.1 5603.0 5609.0 5537.9 5668.4 5670.0 5680.5 5682.2 03:05:03 INFO - 2015-11-17 03:05:03,931 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,931 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4639.92 Median:5378.76 stddev:1423.02 (26.5%) stddev-sans-first:1388.53 03:05:03 INFO - 2015-11-17 03:05:03,931 DEBUG : BROWSER_OUTPUT: Values: 260.6 265.5 266.0 266.0 270.6 5115.6 5253.4 5280.7 5282.8 5303.7 5142.2 5145.9 5182.1 5204.8 5296.5 3931.1 3982.5 4024.1 4029.6 4069.3 4068.4 4086.0 4101.6 4139.9 4145.8 4027.6 4031.1 4039.6 4088.0 4097.2 4014.8 4035.5 4041.4 4107.3 4128.7 3489.2 3503.3 3531.5 3556.4 3574.6 4926.6 5129.0 5135.8 5185.5 5191.5 4528.3 4559.7 4591.9 4592.5 4612.8 5539.9 5548.8 5559.0 5582.7 5629.6 3625.2 3633.1 3660.1 3665.9 3757.0 5666.2 5699.4 5704.3 5746.0 5786.5 3793.1 3801.7 3808.0 3822.1 3854.7 3814.4 3824.7 3865.6 3871.2 3872.9 4338.9 4452.5 4493.1 4526.4 4575.9 5553.8 5559.5 5567.7 5636.2 5642.9 1340.5 1344.3 1346.8 1347.0 1361.0 855.5 860.6 861.4 870.3 875.4 5302.5 5319.5 5329.0 5415.6 5419.6 5768.8 5772.8 5805.2 5866.6 5869.1 5323.7 5330.9 5400.9 5404.2 5412.9 3101.5 3156.7 3178.0 3193.5 3235.9 5812.0 5819.8 5864.8 5922.7 5962.3 5888.1 5901.5 5931.9 5944.7 6007.5 5677.8 5849.2 5892.9 5945.8 5967.2 5769.4 5791.7 5830.7 5836.6 5852.8 5483.4 5601.6 5698.7 5730.1 5755.1 5724.9 5810.5 5857.1 5879.9 5898.6 3661.1 3699.4 3719.6 3737.6 3739.2 5662.8 5678.4 5769.6 5778.0 5781.8 5438.7 5565.1 5611.6 5637.5 5646.2 5558.0 5572.7 5614.3 5618.4 5666.3 5455.6 5456.3 5485.3 5504.4 5507.4 5356.6 5553.9 5624.8 5636.4 5663.1 5514.4 5521.8 5591.1 5624.4 5641.5 03:05:03 INFO - 2015-11-17 03:05:03,933 DEBUG : BROWSER_OUTPUT: 03:05:03 INFO - 2015-11-17 03:05:03,933 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11395.07 Median:3179.39 stddev:13954.03 (438.9%) stddev-sans-first:13969.81 03:05:03 INFO - 2015-11-17 03:05:03,933 DEBUG : BROWSER_OUTPUT: Values: 641.7 670.9 676.8 679.7 686.8 11367.1 11868.2 12062.2 12066.5 12077.3 11052.3 11144.2 11337.0 12556.9 12593.4 627.0 792.8 801.0 801.5 808.9 621.4 625.8 758.0 785.4 785.8 803.4 810.8 817.1 818.0 819.0 642.2 668.0 800.7 808.1 809.4 574.0 587.2 594.7 595.5 595.8 11694.6 11717.5 11732.8 11891.0 11925.8 7962.2 8003.0 8018.7 8115.1 8549.1 7892.5 7937.0 7993.6 8057.8 8075.7 2464.8 2478.9 2532.4 2558.3 2606.5 41846.0 41874.4 41902.0 42039.0 42245.6 5784.8 5968.1 5982.8 6128.8 6193.7 10726.1 10726.9 10773.5 10879.1 10879.4 5350.6 5417.1 5437.5 5501.2 5592.9 3290.1 3351.2 3374.0 3413.7 3424.0 2268.1 2272.1 2273.8 2291.8 2297.6 343.0 343.8 394.9 409.2 413.8 402.2 425.9 491.7 494.3 539.0 6529.2 6912.9 7461.3 7466.3 7606.0 450.9 456.5 475.5 509.4 526.9 2959.2 3087.4 3119.0 3151.2 3302.7 45646.5 46285.5 52542.9 52617.0 53140.7 40609.8 40840.0 40869.0 41099.4 41175.2 39021.0 40542.0 40571.0 40754.8 40999.0 6876.4 7077.0 7153.0 7210.7 7233.1 28925.3 29783.3 29785.7 30307.0 30343.5 41443.8 42127.6 42212.2 42603.3 42735.8 6257.4 6272.9 6430.6 6432.1 6832.9 9594.2 9655.2 9663.9 9744.3 9752.9 9224.9 9334.0 9347.4 9374.8 9377.4 9186.4 9239.4 9268.3 9276.0 9296.7 8745.5 8938.3 9045.0 9048.4 9091.1 7775.3 7976.9 8008.3 8289.3 8508.0 7785.0 7845.6 7848.1 8147.7 8349.7 03:05:03 INFO - 2015-11-17 03:05:03,933 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:05:03 INFO - 2015-11-17 03:05:03,933 DEBUG : BROWSER_OUTPUT: 03:05:04 INFO - 2015-11-17 03:05:04,574 INFO : Browser exited with error code: 0 03:05:04 INFO - 2015-11-17 03:05:04,606 INFO : Completed test dromaeo_css (00:18:35) 03:05:04 INFO - 2015-11-17 03:05:04,606 INFO : Starting test kraken 03:05:04 INFO - 2015-11-17 03:05:04,606 DEBUG : operating with platform_type : mac_ 03:05:04 INFO - 2015-11-17 03:05:04,606 INFO : Initialising browser for kraken test... 03:05:04 INFO - 2015-11-17 03:05:04,622 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmptk9MHO/profile http://localhost:54241/getInfo.html 03:05:07 INFO - 2015-11-17 03:05:07,132 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:05:07 INFO - 2015-11-17 03:05:07,132 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:05:07 INFO - 2015-11-17 03:05:07,132 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:05:07 INFO - 2015-11-17 03:05:07,132 DEBUG : BROWSER_OUTPUT: __metrics 03:05:07 INFO - 2015-11-17 03:05:07,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:05:07 INFO - 2015-11-17 03:05:07,922 INFO : Browser initialized. 03:05:07 INFO - 2015-11-17 03:05:07,923 INFO : Running cycle 1/1 for kraken test... 03:05:07 INFO - 2015-11-17 03:05:07,923 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmptk9MHO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:05:20 INFO - 2015-11-17 03:05:20,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 198766592 03:05:20 INFO - 2015-11-17 03:05:20,001 DEBUG : BROWSER_OUTPUT: 03:05:22 INFO - 2015-11-17 03:05:22,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:23 INFO - 2015-11-17 03:05:23,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 264273920 03:05:23 INFO - 2015-11-17 03:05:23,457 DEBUG : BROWSER_OUTPUT: 03:05:26 INFO - 2015-11-17 03:05:26,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-dft) 03:05:27 INFO - 2015-11-17 03:05:27,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 277336064 03:05:27 INFO - 2015-11-17 03:05:27,048 DEBUG : BROWSER_OUTPUT: 03:05:30 INFO - 2015-11-17 03:05:30,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-fft) 03:05:30 INFO - 2015-11-17 03:05:30,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 264765440 03:05:30 INFO - 2015-11-17 03:05:30,820 DEBUG : BROWSER_OUTPUT: 03:05:33 INFO - 2015-11-17 03:05:33,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-oscillator) 03:05:33 INFO - 2015-11-17 03:05:33,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 265777152 03:05:33 INFO - 2015-11-17 03:05:33,666 DEBUG : BROWSER_OUTPUT: 03:05:36 INFO - 2015-11-17 03:05:36,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:36 INFO - 2015-11-17 03:05:36,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 265478144 03:05:36 INFO - 2015-11-17 03:05:36,709 DEBUG : BROWSER_OUTPUT: 03:05:40 INFO - 2015-11-17 03:05:40,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54241/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:40 INFO - 2015-11-17 03:05:40,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 263352320 03:05:40 INFO - 2015-11-17 03:05:40,788 DEBUG : BROWSER_OUTPUT: 03:05:44 INFO - 2015-11-17 03:05:44,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54241/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:44 INFO - 2015-11-17 03:05:44,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 263008256 03:05:44 INFO - 2015-11-17 03:05:44,953 DEBUG : BROWSER_OUTPUT: 03:05:48 INFO - 2015-11-17 03:05:48,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54241/tests/kraken/driver.html?testName=json-parse-financial) 03:05:48 INFO - 2015-11-17 03:05:48,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 265482240 03:05:48 INFO - 2015-11-17 03:05:48,823 DEBUG : BROWSER_OUTPUT: 03:05:50 INFO - 2015-11-17 03:05:50,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:51 INFO - 2015-11-17 03:05:51,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 296251392 03:05:51 INFO - 2015-11-17 03:05:51,141 DEBUG : BROWSER_OUTPUT: 03:05:53 INFO - 2015-11-17 03:05:53,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:53 INFO - 2015-11-17 03:05:53,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 299384832 03:05:53 INFO - 2015-11-17 03:05:53,775 DEBUG : BROWSER_OUTPUT: 03:05:56 INFO - 2015-11-17 03:05:56,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:56 INFO - 2015-11-17 03:05:56,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 305610752 03:05:56 INFO - 2015-11-17 03:05:56,691 DEBUG : BROWSER_OUTPUT: 03:05:59 INFO - 2015-11-17 03:05:59,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:00 INFO - 2015-11-17 03:06:00,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 308285440 03:06:00 INFO - 2015-11-17 03:06:00,215 DEBUG : BROWSER_OUTPUT: 03:06:03 INFO - 2015-11-17 03:06:03,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:03 INFO - 2015-11-17 03:06:03,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 305799168 03:06:03 INFO - 2015-11-17 03:06:03,707 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54241/tests/kraken/driver.html?testName=ai-astar) 03:06:05 INFO - 2015-11-17 03:06:05,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 365576192 03:06:05 INFO - 2015-11-17 03:06:05,904 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,904 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:06:05 INFO - 2015-11-17 03:06:05,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:06:05 INFO - 2015-11-17 03:06:05,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:06:05 INFO - 2015-11-17 03:06:05,905 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:06:05 INFO - 2015-11-17 03:06:05,905 DEBUG : BROWSER_OUTPUT: |0;ai-astar;124;130;122;127;129;137;120;127;125;118 03:06:05 INFO - 2015-11-17 03:06:05,905 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;179;157;184;195;148;171;153;197;181;145 03:06:05 INFO - 2015-11-17 03:06:05,905 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;189;190;188;187;189;189;190;189;189 03:06:05 INFO - 2015-11-17 03:06:05,905 DEBUG : BROWSER_OUTPUT: |3;audio-fft;89;91;93;144;81;86;85;85;141;75 03:06:05 INFO - 2015-11-17 03:06:05,905 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;119;161;104;110;112;157;103;103;156 03:06:05 INFO - 2015-11-17 03:06:05,906 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;150;136;135;135;149;139;141;142;142 03:06:05 INFO - 2015-11-17 03:06:05,906 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;153;153;146;146;147;154;150;146;146 03:06:05 INFO - 2015-11-17 03:06:05,906 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;117;124;124;123;120;118;123;124;122;119 03:06:05 INFO - 2015-11-17 03:06:05,906 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;71;74;74;73;73;73;84;70;70 03:06:05 INFO - 2015-11-17 03:06:05,906 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;75;76;78;77;77;85;82;81;81 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;96;97;107;104;105;102;100;99;97;103 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;150;154;146;147;158;158;153;155;146 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;172;182;179;177;170;161;171;169;176 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;80;82;82;86;84;87;85;83;82 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:06:05 INFO - 2015-11-17 03:06:05,907 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,950 03:06:05 INFO - 2015-11-17 03:06:05,908 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:06:05 INFO - 2015-11-17 03:06:05,908 DEBUG : BROWSER_OUTPUT: __startTimestamp1447758365898__endTimestamp 03:06:05 INFO - 2015-11-17 03:06:05,908 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,908 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:06:05 INFO - 2015-11-17 03:06:05,909 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:06:05 INFO - 2015-11-17 03:06:05,909 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,909 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.90 Median:127.00 stddev:5.47 (4.3%) stddev-sans-first:5.75 03:06:05 INFO - 2015-11-17 03:06:05,909 DEBUG : BROWSER_OUTPUT: Values: 124.0 130.0 122.0 127.0 129.0 137.0 120.0 127.0 125.0 118.0 03:06:05 INFO - 2015-11-17 03:06:05,909 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,910 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:171.00 Median:180.00 stddev:19.18 (10.7%) stddev-sans-first:20.12 03:06:05 INFO - 2015-11-17 03:06:05,910 DEBUG : BROWSER_OUTPUT: Values: 179.0 157.0 184.0 195.0 148.0 171.0 153.0 197.0 181.0 145.0 03:06:05 INFO - 2015-11-17 03:06:05,910 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,910 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:188.30 Median:189.00 stddev:2.06 (1.1%) stddev-sans-first:0.93 03:06:05 INFO - 2015-11-17 03:06:05,910 DEBUG : BROWSER_OUTPUT: Values: 183.0 189.0 190.0 188.0 187.0 189.0 189.0 190.0 189.0 189.0 03:06:05 INFO - 2015-11-17 03:06:05,910 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.00 Median:85.50 stddev:24.52 (28.7%) stddev-sans-first:25.83 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 93.0 144.0 81.0 86.0 85.0 85.0 141.0 75.0 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.60 Median:115.50 stddev:24.26 (21.0%) stddev-sans-first:25.30 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: Values: 111.0 119.0 161.0 104.0 110.0 112.0 157.0 103.0 103.0 156.0 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:141.90 Median:142.00 stddev:5.97 (4.2%) stddev-sans-first:5.57 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: Values: 150.0 150.0 136.0 135.0 135.0 149.0 139.0 141.0 142.0 142.0 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:3.43 (2.3%) stddev-sans-first:3.50 03:06:05 INFO - 2015-11-17 03:06:05,911 DEBUG : BROWSER_OUTPUT: Values: 146.0 153.0 153.0 146.0 146.0 147.0 154.0 150.0 146.0 146.0 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:121.40 Median:123.00 stddev:2.67 (2.2%) stddev-sans-first:2.32 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: Values: 117.0 124.0 124.0 123.0 120.0 118.0 123.0 124.0 122.0 119.0 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.40 Median:73.00 stddev:5.40 (7.4%) stddev-sans-first:4.22 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: Values: 62.0 71.0 74.0 74.0 73.0 73.0 73.0 84.0 70.0 70.0 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:79.50 stddev:4.03 (5.1%) stddev-sans-first:3.30 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 76.0 78.0 77.0 77.0 85.0 82.0 81.0 81.0 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:101.00 Median:101.50 stddev:3.77 (3.7%) stddev-sans-first:3.54 03:06:05 INFO - 2015-11-17 03:06:05,912 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 107.0 104.0 105.0 102.0 100.0 99.0 97.0 103.0 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:153.50 stddev:4.81 (3.1%) stddev-sans-first:4.83 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: Values: 147.0 150.0 154.0 146.0 147.0 158.0 158.0 153.0 155.0 146.0 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.00 stddev:5.96 (3.4%) stddev-sans-first:6.28 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: Values: 171.0 172.0 182.0 179.0 177.0 170.0 161.0 171.0 169.0 176.0 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.90 Median:83.50 stddev:2.73 (3.3%) stddev-sans-first:2.24 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 82.0 82.0 86.0 84.0 87.0 85.0 83.0 82.0 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:06:05 INFO - 2015-11-17 03:06:05,913 DEBUG : BROWSER_OUTPUT: 03:06:06 INFO - 2015-11-17 03:06:06,639 INFO : Browser exited with error code: 0 03:06:06 INFO - 2015-11-17 03:06:06,696 INFO : Completed test kraken (00:01:02) 03:06:06 INFO - 2015-11-17 03:06:06,696 INFO : Starting test v8_7 03:06:06 INFO - 2015-11-17 03:06:06,697 DEBUG : operating with platform_type : mac_ 03:06:06 INFO - 2015-11-17 03:06:06,697 INFO : Initialising browser for v8_7 test... 03:06:06 INFO - 2015-11-17 03:06:06,712 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmpmdH6B0/profile http://localhost:54241/getInfo.html 03:06:09 INFO - 2015-11-17 03:06:09,165 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:06:09 INFO - 2015-11-17 03:06:09,165 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:06:09 INFO - 2015-11-17 03:06:09,166 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:06:09 INFO - 2015-11-17 03:06:09,166 DEBUG : BROWSER_OUTPUT: __metrics 03:06:09 INFO - 2015-11-17 03:06:09,182 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:06:09 INFO - 2015-11-17 03:06:09,907 INFO : Browser initialized. 03:06:09 INFO - 2015-11-17 03:06:09,907 INFO : Running cycle 1/1 for v8_7 test... 03:06:09 INFO - 2015-11-17 03:06:09,908 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmpmdH6B0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:06:21 INFO - 2015-11-17 03:06:21,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 199684096 03:06:21 INFO - 2015-11-17 03:06:21,969 DEBUG : BROWSER_OUTPUT: 03:06:44 INFO - 2015-11-17 03:06:44,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54241/tests/v8_7/run.html (next: http://localhost:54241/tests/v8_7/run.html) 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 520474624 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: |0;Richards;192.30769230769232 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;217.72262138036143 03:06:45 INFO - 2015-11-17 03:06:45,087 DEBUG : BROWSER_OUTPUT: |2;Encrypt;372.0238095238095 03:06:45 INFO - 2015-11-17 03:06:45,088 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6718.120805369127 03:06:45 INFO - 2015-11-17 03:06:45,088 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1249.6878901373284 03:06:45 INFO - 2015-11-17 03:06:45,088 DEBUG : BROWSER_OUTPUT: |5;Earley;809.7165991902834 03:06:45 INFO - 2015-11-17 03:06:45,088 DEBUG : BROWSER_OUTPUT: |6;Boyer;14550.72463768116 03:06:45 INFO - 2015-11-17 03:06:45,088 DEBUG : BROWSER_OUTPUT: |7;RegExp;34423.72881355932 03:06:45 INFO - 2015-11-17 03:06:45,088 DEBUG : BROWSER_OUTPUT: |8;Splay;668.002672010688 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6731.543624161074 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: __startTimestamp1447758405086__endTimestamp 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:06:45 INFO - 2015-11-17 03:06:45,089 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,090 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:192.31 Median:192.31 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,090 DEBUG : BROWSER_OUTPUT: Values: 192.3 03:06:45 INFO - 2015-11-17 03:06:45,090 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,090 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:217.72 Median:217.72 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,091 DEBUG : BROWSER_OUTPUT: Values: 217.7 03:06:45 INFO - 2015-11-17 03:06:45,091 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,091 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:372.02 Median:372.02 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,091 DEBUG : BROWSER_OUTPUT: Values: 372.0 03:06:45 INFO - 2015-11-17 03:06:45,091 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6718.12 Median:6718.12 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: Values: 6718.1 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1249.69 Median:1249.69 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: Values: 1249.7 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: Values: 809.7 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14550.72 Median:14550.72 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: Values: 14550.7 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,092 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34423.73 Median:34423.73 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: Values: 34423.7 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:668.00 Median:668.00 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: Values: 668.0 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6731.54 Median:6731.54 stddev:0.00 (0.0%) 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: Values: 6731.5 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:06:45 INFO - 2015-11-17 03:06:45,093 DEBUG : BROWSER_OUTPUT: 03:06:45 INFO - 2015-11-17 03:06:45,826 INFO : Browser exited with error code: 0 03:06:45 INFO - 2015-11-17 03:06:45,849 INFO : Completed test v8_7 (00:00:39) 03:06:46 INFO - 2015-11-17 03:06:46,292 INFO : Completed test suite (00:20:17) 03:06:46 INFO - 2015-11-17 03:06:46,292 DEBUG : Working with test: dromaeo_css 03:06:46 INFO - 2015-11-17 03:06:46,292 DEBUG : Generating results file: dromaeo_css 03:06:46 INFO - 2015-11-17 03:06:46,293 DEBUG : Working with test: kraken 03:06:46 INFO - 2015-11-17 03:06:46,293 DEBUG : Generating results file: kraken 03:06:46 INFO - 2015-11-17 03:06:46,293 INFO : javascript benchmark 03:06:46 INFO - 2015-11-17 03:06:46,293 DEBUG : Working with test: v8_7 03:06:46 INFO - 2015-11-17 03:06:46,293 DEBUG : Generating results file: v8_7 03:06:46 INFO - 2015-11-17 03:06:46,293 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:06:46 INFO - 2015-11-17 03:06:46,337 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:06:46 INFO - 2015-11-17 03:06:46,337 DEBUG : process_Request line: dromaeo_css 5930.01 graph.html#tests=[[72,52,55]] 03:06:46 INFO - 2015-11-17 03:06:46,337 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:06:46 INFO - 2015-11-17 03:06:46,365 DEBUG : process_Request line: kraken 1776.60 graph.html#tests=[[232,52,55]] 03:06:46 INFO - 2015-11-17 03:06:46,365 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:06:46 INFO - 2015-11-17 03:06:46,392 DEBUG : process_Request line: v8_7 17468.29 graph.html#tests=[[230,52,55]] 03:06:46 INFO - 2015-11-17 03:06:46,393 INFO : javascript benchmark 03:06:46 INFO - 2015-11-17 03:06:46,395 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [288.53977905241146, 296.6144012783381, 303.98784048638055, 307.75379696243004, 315.3912948010339, 12901.0, 13351.599452016455, 14982.550523484286, 15432.537023889287, 15795.131267780267, 13294.268815215159, 15015.324310406031, 15763.921180394082, 16233.675326493463, 16431.58921026975, 4615.769211539418, 4659.673822832403, 4689.0, 4745.857624271277, 4764.714117152982, 3513.2270900402, 3665.4318580620047, 3677.926441471169, 4622.352870598119, 4749.52504749524, 4886.144924638192, 5042.420121685998, 5063.594912407017, 5127.923081153767, 5163.7676304566385, 5009.323741294915, 5152.665076770017, 5154.278401023859, 5201.661891977009, 5216.739163041832, 4481.327800829869, 4482.731036137842, 4486.416765820455, 4533.727976321398, 4534.77326133692, 18143.183556739845, 18208.271669133217, 18576.44270671882, 18673.53316167093, 19062.237510499563, 1849.2048419179748, 1916.5208697825544, 1940.146335612326, 1941.3399444189045, 1967.5081229692578, 11377.317360958368, 11734.413279335999, 12084.577039803564, 12308.261504309681, 12412.937935310356, 1360.9455621775116, 1376.057400680537, 1400.8879289656802, 1426.2726009735006, 1480.393713287818, 51182.720431989124, 51360.0, 51770.74114629441, 51857.481425185644, 51902.0, 8397.790055248668, 8490.915090849136, 8937.195652391316, 8940.240079593308, 8940.910590894007, 11006.229563930448, 11019.283746556448, 11020.118390528738, 11157.0, 11178.0, 6928.549644273106, 7005.124359455068, 7021.29787021304, 7042.964785176041, 7046.1192350956135, 6969.407600354027, 7002.929970700227, 7044.471664625174, 7062.364387205073, 7127.358537731629, 5194.896102077937, 5262.2632831403635, 5273.868153296198, 5342.171963345688, 5355.919661205085, 1383.4950243161375, 1427.2863568215892, 1462.795208670787, 1492.8059352284351, 1507.6833864888276, 705.8341289796894, 836.2682652678906, 838.1785849867165, 841.7558907916635, 851.684034146683, 16002.599935001717, 17250.309987600605, 17353.826461735473, 17412.21645025977, 17486.0, 358.5625536845045, 363.58021924385315, 364.2660040019363, 376.10299435845707, 383.22588371489434, 4908.4846091160625, 5205.167173252262, 5249.763760630781, 5256.159014557652, 5279.44565820591, 326635.0, 328883.0, 332650.0, 335205.0, 506976.0, 65280.99999999905, 65903.0, 66518.33481665218, 67839.66080169666, 68845.0, 395.33188910740756, 396.0336778261091, 396.221424900067, 397.2511815228258, 400.2595198882103, 8423.5788210588, 8920.598573064099, 8932.598033088656, 8996.145366190201, 9035.186833185046, 32652.83673581617, 32969.67030329666, 33143.0, 33150.336993259516, 33580.160495987795, 41309.38035929524, 42417.575824242595, 42837.14325713531, 45553.77223113863, 45660.771696142634, 6751.0, 6903.551269167689, 6971.6165610891885, 6986.16166060076, 7093.787186384417, 10131.493425328557, 10368.792624147625, 10387.68836934893, 10458.843117353397, 10588.258821882395, 8952.28381729447, 8963.417377870417, 9079.818403632022, 9099.681511147079, 9132.589033493376, 8686.087960764029, 8732.738017859474, 8932.598033088396, 8959.104089590988, 9079.364444489087, 9254.444733316022, 9382.624695012397, 9467.431954082776, 9589.808203836024, 9691.370060946016, 6280.309165991646, 6494.577852439576, 7009.684564194521, 7097.893531597134, 7108.644567771694, 9008.684696035607, 9019.32355073359, 9114.31642626819, 9122.270218382646, 9127.863082053907], "dojo.html": [2726.27753645284, 2809.9578506322396, 2815.3243221626817, 2830.9150725478235, 2833.40498495316, 4746.976265118678, 4788.497207793183, 4828.51714828517, 4833.250846118848, 4882.267659851024, 4844.515548445153, 4861.124997500448, 4870.147724148269, 4888.73111978841, 4902.0, 4328.2209202343565, 4434.68957172998, 4527.932081018779, 4582.839600613963, 4589.426321709786, 4404.0751442197015, 4486.8878278042985, 4521.525239849818, 4558.544145585432, 4589.334546490757, 4363.54182810805, 4497.437820272466, 4540.114677637862, 4551.067031258584, 4592.920663644058, 4505.391772110772, 4573.519780423074, 4603.746793926332, 4613.492515823256, 4622.884427889296, 4013.518377794654, 4273.679474039428, 4369.366441865944, 4369.6722745794195, 4511.796969136397, 4645.790939407735, 4652.209124448852, 4710.74090924999, 4731.219348807443, 4759.714417134948, 5077.314562534048, 5086.720230387327, 5088.974555127238, 5093.388793344822, 5105.617078719111, 4947.727874966876, 5065.518775716338, 5136.383633963911, 5141.254518094893, 5163.173892177271, 4665.113628410591, 4705.788239529229, 4744.95255047452, 4777.808887644455, 4785.49752276013, 5171.482851714798, 5293.602979776532, 5322.813701520428, 5343.038253114477, 5352.892942141136, 4782.258749893772, 5099.821506247264, 5105.744712764347, 5106.872328191751, 5143.459936706592, 5051.419086805065, 5073.162928116893, 5102.438731739506, 5158.071547121479, 5190.273361729361, 5069.771860266297, 5127.077126117335, 5134.8446599515555, 5135.563477104488, 5183.896322073538, 4857.271409288564, 5073.213651883964, 5142.434332223527, 5147.0735267651435, 5154.92267615986, 3826.3686491728554, 3885.048163200034, 3902.512185976753, 3909.100906791454, 3935.7244992850797, 3570.3751843427294, 3606.8016259106003, 3613.638636136365, 3616.168281295264, 3622.5290712207243, 4560.908781824412, 4908.165611845995, 4912.140375434285, 4914.72968986702, 4936.062148191832, 5023.422306434807, 5063.87340316495, 5085.669431486942, 5232.084385232645, 5271.288376069258, 4771.427428708508, 4806.543378379049, 4821.180399332122, 4823.397075365579, 4871.780769865364, 4281.250781113293, 4492.124035813051, 4493.370928070073, 4510.2783554631105, 4545.886352841139, 5020.824271150492, 5134.12719837636, 5152.742362881916, 5239.764210610456, 5278.656887302313, 5061.316722242597, 5169.870753231049, 5174.818881339135, 5189.169732842727, 5202.167653175474, 4980.078685443204, 5227.059129356752, 5242.318498595158, 5249.737513124405, 5253.763580638804, 4886.731229782396, 5003.574696150868, 5035.018171456531, 5044.772985215601, 5070.8225212117395, 5150.97424512875, 5200.037992971313, 5208.791648334024, 5216.843494695166, 5222.3472065991755, 5024.799008039638, 5068.087744206078, 5079.92380114306, 5080.745962701924, 5094.541491265803, 4761.833335833229, 4889.9022019560125, 4897.0, 4907.631927605516, 5034.370703662043, 4898.632602554751, 4938.481459446706, 4944.653874228769, 4950.579200767975, 4973.9751301244705, 4990.126727822544, 5070.2141168119, 5075.061113693979, 5088.236764485208, 5100.923486147636, 4513.1650644630845, 4805.159097158054, 4821.228603423576, 4837.395325584302, 4922.163232250455], "mootools.html": [1395.9651008724786, 1484.9257537123144, 1568.9137097459643, 1585.3579300383342, 1596.7365384711522, 6042.969785151074, 6200.875982480347, 6555.672216389179, 6790.796276111712, 6796.7281308747715, 6522.347765223475, 6548.246951600568, 6621.370969757877, 6658.933410665904, 6683.164604424447, 1922.1926790747884, 1943.893085880276, 1946.0172612830502, 1950.8146726061002, 1972.3195497553322, 1922.0389805097452, 1939.4472575316038, 1948.5907959328558, 1952.6387618290591, 1956.814102660252, 1895.1945423195157, 1903.7905830358718, 1905.7713074431088, 1907.122723547163, 1928.517870532367, 1874.5219968907977, 1906.9237230510832, 1909.455805095541, 1914.607505461384, 1932.4878907089633, 1847.4919397165752, 1853.7497437845989, 1865.0674662668666, 1884.8586356023216, 1890.2722451856134, 5878.794242201502, 6527.184101987252, 6575.276719560845, 6580.5393622446445, 6665.300143484961, 3647.434647629622, 3845.365514690073, 3945.28984782739, 3949.3483575210344, 3997.200559888034, 2320.2575175943703, 2394.4971555973093, 2440.414300567869, 2472.072972635262, 2481.367251350912, 678.6878036103399, 683.702589373624, 684.2131548718963, 699.5068476723898, 708.0688894104288, 8661.956690216572, 8699.652013919436, 8703.216710496086, 8799.384043117048, 8861.689840855604, 3567.839447224829, 3576.964230357663, 3689.1146124929824, 3697.408414653696, 3751.4185301278344, 7743.303102720783, 7777.066751989797, 7779.572123533147, 7781.8832717509285, 7828.921710782934, 4118.423420721101, 4126.8761937141935, 4135.069609337875, 4158.334666453353, 4192.706510544293, 3722.4788529605876, 3757.6993840492696, 3761.1161377076364, 3761.247750449921, 3804.980975095162, 2800.2299367674054, 2846.7295606917723, 2854.5432730763396, 2867.211516832888, 2878.7984841061343, 990.1089019882164, 994.6021591363512, 1001.4041645221082, 1008.6873069348526, 1009.2228983682523, 942.8020115775627, 964.2045312616979, 1144.7882141803627, 1159.7448561316496, 1174.988250117488, 6386.552941294158, 6459.709313080923, 6471.7734879279, 6475.384838440341, 6480.773172938924, 966.6133546581424, 997.7056768253383, 1002.6240159940022, 1010.7068950004564, 1017.1100287248657, 5007.649464537448, 5063.645544811901, 5089.9745501272255, 5095.235714642759, 5105.846824595268, 7066.364027237573, 7288.562686238843, 7601.7719468416035, 7814.609269536614, 7837.921620783719, 7697.961510192526, 7780.105287891852, 7788.221177882279, 7843.137254901956, 7846.450748447668, 6180.412860778219, 6186.4741496972365, 6364.459020983269, 6385.201849768779, 6388.105665206875, 6318.27339855904, 6339.017452294902, 6340.587861788969, 6346.650934198663, 6381.042843573501, 6958.617276049866, 7049.08361912948, 7138.286171383028, 7148.928510714826, 7261.092363454568, 7137.571745695275, 7273.018142550688, 7328.193898671036, 7358.0, 7421.888671669822, 5683.829485115453, 5760.135979603093, 5760.1935728998815, 5771.711414429178, 5779.739911704068, 6416.839579010562, 6458.22501299847, 6480.8703825922275, 6492.091107245084, 6495.0, 6028.3971602839365, 6085.087236914321, 6101.908471372844, 6173.259208894961, 6174.629522228681, 5923.466887980103, 5931.673757943355, 5990.820275391745, 6007.90988135187, 6028.87942241144, 6027.336992930686, 6083.939160608337, 6110.69446527663, 6156.045812899008, 6159.846003849761, 5568.526675232489, 5600.915986260128, 5602.1036634138345, 5603.0194715923735, 5609.046462101534, 5537.944620553743, 5668.433156684298, 5670.0, 5680.517156041617, 5682.204491371294], "ext.html": [482.01187565490744, 491.73692074740023, 498.5911552526927, 505.28249885163075, 515.6725479320635, 27978.860105699467, 29546.556801647992, 35538.46692299617, 36159.4576081359, 36159.63840361602, 38659.0, 38770.22459550807, 38800.611993880055, 38843.41734873979, 39399.21201575974, 7330.67011984462, 7871.9212807872045, 8058.677652893877, 8094.635741391651, 8169.387295952827, 7273.0, 9661.275404344668, 9767.267454940873, 9825.312228144032, 9932.35439696421, 9576.138147566717, 9662.75843103921, 9764.12122908938, 9783.119519243266, 9786.853197202048, 7447.627618619102, 7618.733344332977, 9620.759481012996, 9674.854877176778, 9712.757181070494, 9461.668841590581, 9479.24166066713, 9499.0, 9584.28117891161, 9620.855687164698, 35079.12302192466, 35378.0, 35492.11269718252, 35675.64324356775, 35942.64057359419, 2643.801714871373, 2662.880170392337, 2672.986635066812, 2848.088611644275, 3016.668166501683, 24763.62854557183, 24817.25548233556, 24895.128670496626, 25089.24732258035, 25272.494550109077, 2033.9084741186682, 2037.5517386175018, 2050.0672194151775, 2064.0299059442036, 2075.5226297951403, 236994.0, 242168.0, 242863.0, 243497.0, 245336.0, 48016.0, 49705.75147124314, 55544.444555554735, 55612.443875561534, 56512.43487565072, 63969.36030639634, 64838.35161648323, 65408.345916540224, 65482.67258663676, 66169.0, 15324.310406031755, 15542.689146217012, 15554.144522051396, 15569.143697096542, 15578.84421155774, 11554.133439992034, 11606.76786464266, 11678.182527223184, 11882.346470944009, 11884.227525210834, 18019.27922883096, 18157.0, 18254.17856196474, 18275.08624568793, 18343.449696509128, 7444.776656700307, 7637.389008879276, 7653.617319134021, 7686.077670679442, 7722.266384693445, 800.1958032177624, 853.9359548033798, 869.2871845087094, 893.2050475077186, 958.6548842416724, 25049.37376565564, 25742.613860792102, 26453.470930581665, 26637.600435993474, 26809.463810723675, 884.5754038061766, 895.7268033249791, 962.5187406296851, 962.8170647576937, 1048.358137493512, 9749.853752193723, 12662.36688165588, 12780.105392622427, 12790.552330668383, 13075.150115242479, 286681.0, 288989.0, 289403.0, 290231.0, 290352.0, 42512.78743606324, 43120.56879431228, 47592.0, 49353.50646493489, 49855.0, 1293.0625296659846, 1299.4282515693064, 1307.0327957311522, 1307.1634154141168, 1308.2216081431723, 23807.64288535708, 24770.885310161448, 25358.0, 25394.873025634755, 25395.61906571366, 40354.0, 40534.594654054265, 40568.1886362277, 45457.318140228585, 45736.771316143204, 225360.0, 227841.0, 230688.0, 231167.0, 231180.0, 26128.60807087857, 26330.605040924784, 26543.734562654125, 26924.865375672995, 27196.048138315065, 36057.63942360648, 37192.256154877294, 37743.433848492845, 38006.80996594999, 39037.41443878287, 30375.0, 30517.847410762803, 30669.693303066684, 31787.68212317847, 31981.520277195395, 29304.560431593116, 29408.411831762816, 29429.85285073561, 29562.852185738935, 29921.251968700955, 29805.0, 29843.10470685883, 30130.0, 30213.848930755204, 30503.54244686287, 25819.225423237334, 27742.86128569344, 27849.860750696116, 27874.0, 27936.44127117487, 20172.899135504227, 20666.68999965032, 21020.126606866474, 21167.0, 22493.32520024402], "prototype.html": [260.6468235540842, 265.53398785132083, 265.96941351744545, 266.0376705385533, 270.61032113756175, 5115.616328775338, 5253.369595648518, 5280.656757310772, 5282.788688452462, 5303.7082960437165, 5142.228665700147, 5145.922811157826, 5182.093133701606, 5204.843854684365, 5296.496832800878, 3931.115499012728, 3982.462367580383, 4024.1146947671614, 4029.556748757642, 4069.287874621944, 4068.3694027425795, 4086.0193553547083, 4101.63085322321, 4139.896502587444, 4145.751254924714, 4027.5771044040393, 4031.052702614883, 4039.565954086301, 4088.0, 4097.160082183145, 4014.759114453142, 4035.475388199545, 4041.4341992121126, 4107.281225785476, 4128.7109902307, 3489.162600975773, 3503.2643144939593, 3531.523244362004, 3556.395412779834, 3574.6425357464304, 4926.5812405945535, 5128.974355128201, 5135.845924622267, 5185.507376799198, 5191.506806853343, 4528.343390208434, 4559.726416415026, 4591.862244132682, 4592.540745925381, 4612.7924243409125, 5539.9169012464845, 5548.805791797308, 5558.972205138989, 5582.720863956826, 5629.6340737852315, 3625.166211771281, 3633.055405594538, 3660.103274697716, 3665.871694490707, 3756.9624303756887, 5666.150077488369, 5699.373068962411, 5704.258446401941, 5746.0, 5786.537077033827, 3793.1275806564645, 3801.6578507933864, 3808.0, 3822.10180607557, 3854.6530812227033, 3814.389697648363, 3824.6557809796695, 3865.632764887331, 3871.225754848985, 3872.9031774205305, 4338.913221735547, 4452.532484089189, 4493.056458143761, 4526.388937493396, 4575.9084818303445, 5553.805616803393, 5559.499645031886, 5567.721613919288, 5636.210930469738, 5642.915356269659, 1340.483913693235, 1344.2606566388447, 1346.811446397505, 1346.9730605387838, 1361.0472669131648, 855.5080828523623, 860.6299291304674, 861.440063958432, 870.2863651805585, 875.369733791669, 5302.549283310885, 5319.521243088063, 5329.0, 5415.593830462731, 5419.593530485229, 5768.826935191951, 5772.826815195551, 5805.216295800013, 5866.5893387462465, 5869.06095024794, 5323.653962492425, 5330.893382132335, 5400.91898621521, 5404.216388623628, 5412.891742165213, 3101.4882544380375, 3156.731677807366, 3177.9841100794347, 3193.457112290916, 3235.854386552611, 5812.041013232853, 5819.767209311664, 5864.765409383662, 5922.733476993546, 5962.34414214436, 5888.057910734347, 5901.468867801918, 5931.911021334683, 5944.673042982591, 6007.459328660354, 5677.801276955287, 5849.181114643953, 5892.882142357129, 5945.762169513171, 5967.194428752063, 5769.3942136076785, 5791.681457519877, 5830.708464576839, 5836.649801011953, 5852.795152169653, 5483.396826349178, 5601.6358936668985, 5698.715064246854, 5730.111832665943, 5755.1367294906095, 5724.8568785779025, 5810.5061069809535, 5857.121431785095, 5879.853003674943, 5898.557608179318, 3661.0664280608275, 3699.408094704834, 3719.6094410086553, 3737.5701794294005, 3739.1960728443514, 5662.7734890603915, 5678.432156784289, 5769.59612827098, 5778.0, 5781.797637082682, 5438.70087145195, 5565.1095824667855, 5611.551075913835, 5637.492625663546, 5646.153077038477, 5558.0, 5572.665640061609, 5614.29821272341, 5618.381977982501, 5666.263385759825, 5455.618106732491, 5456.2906822114455, 5485.259489968803, 5504.394516603091, 5507.366652834975, 5356.5982551308025, 5553.861153471195, 5624.803131890364, 5636.379998200113, 5663.122216056518, 5514.448555144453, 5521.779128834802, 5591.133374326986, 5624.409437009219, 5641.548676105984], "yui.html": [641.6535071061627, 670.8926571748519, 676.7631329034836, 679.6805501414334, 686.8145600687815, 11367.147463940206, 11868.22856514326, 12062.155649104567, 12066.51733930644, 12077.335746533938, 11052.281601695884, 11144.219904606682, 11337.0, 12556.874431255685, 12593.370331483435, 626.9592476489014, 792.8335049639583, 801.0147518552155, 801.527099011583, 808.8544062068826, 621.3755176048065, 625.8310256230815, 757.9621018949031, 785.4030936488282, 785.8231897823001, 803.4014659078965, 810.7729835646029, 817.1256755271861, 818.0347190315425, 819.0171793847406, 642.1812189458478, 668.0346898731335, 800.675726330834, 808.0828259924998, 809.4172196018857, 573.962692424991, 587.180882668679, 594.6907608043837, 595.5265563876728, 595.8152972578514, 11694.649160525198, 11717.53129874804, 11732.765344693058, 11891.0, 11925.761484770343, 7962.2435868592975, 8003.039635243808, 8018.67925282988, 8115.14790946948, 8549.145085491402, 7892.486988345797, 7936.960315198387, 7993.608309198077, 8057.798555036113, 8075.676972921076, 2464.8397854139425, 2478.863662498562, 2532.3795670060767, 2558.296468471167, 2606.543854825417, 41846.0, 41874.37188442176, 41901.999999999694, 42039.0, 42245.577544224776, 5784.82645520635, 5968.074948383008, 5982.760689572456, 6128.816135515942, 6193.659348735863, 10726.141908647289, 10726.946365268124, 10773.515191816387, 10879.075278601249, 10879.401632910107, 5350.625456218105, 5417.10617748075, 5437.4562543745305, 5501.174823776386, 5592.944070559323, 3290.111669849175, 3351.162209447638, 3374.0383990563064, 3413.74396920227, 3424.0, 2268.115434980359, 2272.091163534599, 2273.772622737713, 2291.8281128915396, 2297.574948634508, 342.97599168058497, 343.8418327569296, 394.9348357520977, 409.2490280335558, 413.78276404887674, 402.16349992016535, 425.87649581621605, 491.6632107006712, 494.33265092125345, 538.9703566303891, 6529.15121034272, 6912.930870691329, 7461.328480436787, 7466.25337466249, 7605.991217374944, 450.9008018235983, 456.4773334531942, 475.5125995854277, 509.421806249909, 526.9420363759983, 2959.156640357488, 3087.4133914556164, 3119.0, 3151.2279491524264, 3302.719268862126, 45646.543534564895, 46285.53714462812, 52542.94914101773, 52617.0, 53140.73429632904, 40609.79695101506, 40840.0, 40869.0, 41099.38350924738, 41175.1764964699, 39021.0, 40542.0, 40571.0, 40754.79622601868, 40999.0, 6876.415504681958, 7077.0, 7153.0, 7210.747623833141, 7233.132024157135, 28925.276868078465, 29783.255418614706, 29785.702142978294, 30307.0, 30343.544846827757, 41443.79278103711, 42127.57872421236, 42212.1557568853, 42603.31363550069, 42735.7863210682, 6257.374262573706, 6272.874542509216, 6430.646314452563, 6432.067350234283, 6832.863342733217, 9594.18449431806, 9655.22758179358, 9663.9033609663, 9744.269179811401, 9752.853707194256, 9224.893012838502, 9334.0, 9347.439153650803, 9374.765630859283, 9377.437353758796, 9186.356955013085, 9239.39943903644, 9268.258539316703, 9275.953620231856, 9296.72109836706, 8745.518996455256, 8938.284937205139, 9044.954775226082, 9048.366614336934, 9091.136342047495, 7775.300222979959, 7976.880346794686, 8008.319292860172, 8289.295409890226, 8508.0, 7785.0, 7845.6077196141105, 7848.136704962564, 8147.674093036212, 8349.666013359398]}, "summary": {"suite": 5930.006373373524, "subtests": {"jquery.html": {"filtered": 6938.878488152305, "value": 6938.878488152305}, "dojo.html": {"filtered": 4737.267468448901, "value": 4737.267468448901}, "mootools.html": {"filtered": 3817.3603815403635, "value": 3817.3603815403635}, "ext.html": {"filtered": 16546.012323620427, "value": 16546.012323620427}, "prototype.html": {"filtered": 4159.713347470589, "value": 4159.713347470589}, "yui.html": {"filtered": 5034.407285221664, "value": 5034.407285221664}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0019"}, "testrun": {"date": 1447757189, "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": "20151117004023", "branch": "Mozilla-Aurora", "revision": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 189.0, 190.0, 188.0, 187.0, 189.0, 189.0, 190.0, 189.0, 189.0], "ai-astar": [124.0, 130.0, 122.0, 127.0, 129.0, 137.0, 120.0, 127.0, 125.0, 118.0], "imaging-gaussian-blur": [150.0, 150.0, 136.0, 135.0, 135.0, 149.0, 139.0, 141.0, 142.0, 142.0], "audio-beat-detection": [179.0, 157.0, 184.0, 195.0, 148.0, 171.0, 153.0, 197.0, 181.0, 145.0], "json-stringify-tinderbox": [71.0, 75.0, 76.0, 78.0, 77.0, 77.0, 85.0, 82.0, 81.0, 81.0], "stanford-crypto-pbkdf2": [171.0, 172.0, 182.0, 179.0, 177.0, 170.0, 161.0, 171.0, 169.0, 176.0], "json-parse-financial": [62.0, 71.0, 74.0, 74.0, 73.0, 73.0, 73.0, 84.0, 70.0, 70.0], "stanford-crypto-sha256-iterative": [78.0, 80.0, 82.0, 82.0, 86.0, 84.0, 87.0, 85.0, 83.0, 82.0], "audio-fft": [89.0, 91.0, 93.0, 144.0, 81.0, 86.0, 85.0, 85.0, 141.0, 75.0], "imaging-darkroom": [146.0, 153.0, 153.0, 146.0, 146.0, 147.0, 154.0, 150.0, 146.0, 146.0], "stanford-crypto-ccm": [147.0, 150.0, 154.0, 146.0, 147.0, 158.0, 158.0, 153.0, 155.0, 146.0], "audio-oscillator": [111.0, 119.0, 161.0, 104.0, 110.0, 112.0, 157.0, 103.0, 103.0, 156.0], "stanford-crypto-aes": [96.0, 97.0, 107.0, 104.0, 105.0, 102.0, 100.0, 99.0, 97.0, 103.0], "imaging-desaturate": [117.0, 124.0, 124.0, 123.0, 120.0, 118.0, 123.0, 124.0, 122.0, 119.0]}, "summary": {"suite": 1776.6000000000004, "subtests": {"audio-fft": {"filtered": 97.0, "value": 97.0}, "stanford-crypto-pbkdf2": {"filtered": 172.8, "value": 172.8}, "audio-beat-detection": {"filtered": 171.0, "value": 171.0}, "stanford-crypto-ccm": {"filtered": 151.4, "value": 151.4}, "imaging-darkroom": {"filtered": 148.7, "value": 148.7}, "json-parse-financial": {"filtered": 72.4, "value": 72.4}, "audio-oscillator": {"filtered": 123.6, "value": 123.6}, "ai-astar": {"filtered": 125.9, "value": 125.9}, "audio-dft": {"filtered": 188.3, "value": 188.3}, "stanford-crypto-sha256-iterative": {"filtered": 82.9, "value": 82.9}, "json-stringify-tinderbox": {"filtered": 78.3, "value": 78.3}, "imaging-gaussian-blur": {"filtered": 141.9, "value": 141.9}, "stanford-crypto-aes": {"filtered": 101.0, "value": 101.0}, "imaging-desaturate": {"filtered": 121.4, "value": 121.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0019"}, "testrun": {"date": 1447757189, "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": "20151117004023", "branch": "Mozilla-Aurora", "revision": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [217.72262138036143], "Encrypt": [372.0238095238095], "NavierStokes": [6731.543624161074], "Decrypt": [6718.120805369127], "Splay": [668.002672010688], "Richards": [192.30769230769232], "RegExp": [34423.72881355932], "Earley": [809.7165991902834], "Boyer": [14550.72463768116], "RayTrace": [1249.6878901373284]}, "summary": {"suite": 17468.28906133936, "subtests": {"DeltaBlue": {"filtered": 303.6799740000001, "value": 303.6799740000001}, "Encrypt": {"filtered": 715.4945280000001, "value": 715.4945280000001}, "NavierStokes": {"filtered": 220.45463609172492, "value": 220.45463609172492}, "Decrypt": {"filtered": 39.62134765234768, "value": 39.62134765234768}, "Splay": {"filtered": 121.99202700000001, "value": 121.99202700000001}, "RegExp": {"filtered": 26.46386755292958, "value": 26.46386755292958}, "Richards": {"filtered": 183.57039999999992, "value": 183.57039999999992}, "Earley": {"filtered": 823.0818049999997, "value": 823.0818049999997}, "Boyer": {"filtered": 45.80273605577688, "value": 45.80273605577688}, "RayTrace": {"filtered": 592.13904995005, "value": 592.13904995005}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0019"}, "testrun": {"date": 1447757189, "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": "20151117004023", "branch": "Mozilla-Aurora", "revision": "e68fb30045aeadb1c4b578e55e8b7ea9ddc86ea8"}}] 03:06:46 INFO - RETURN: dromaeo_css: 5930.01 03:06:46 INFO - RETURN: kraken: 1776.60 03:06:46 INFO - RETURN: v8_7: 17468.29 03:06:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17468.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1776.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5930.01"}}} 03:06:46 INFO - Return code: 0 03:06:46 INFO - # TBPL SUCCESS # 03:06:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:46 INFO - 2015-11-17 03:06:46.492 screenresolution[2587:81783] starting screenresolution argv=screenresolution get 03:06:46 INFO - 2015-11-17 03:06:46.496 screenresolution[2587:81783] Display 0: 1600x1200x32@60 03:06:46 INFO - 2015-11-17 03:06:46.502 screenresolution[2588:81786] starting screenresolution argv=screenresolution list 03:06:46 INFO - Available Modes on Display 0 03:06:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:46 INFO - Intel HD Graphics 3000: 03:06:46 INFO - Chipset Model: Intel HD Graphics 3000 03:06:46 INFO - Type: GPU 03:06:46 INFO - Bus: Built-In 03:06:46 INFO - VRAM (Total): 512 MB 03:06:46 INFO - VRAM (Dynamic, Max): 10 03:06:46 INFO - Vendor: Intel (0x8086) 03:06:46 INFO - Device ID: 0x0116 03:06:46 INFO - Revision ID: 0x0009 03:06:46 INFO - Displays: 03:06:46 INFO - Display: 03:06:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:46 INFO - Display Serial Number: 1600x1200 60 03:06:46 INFO - Main Display: Yes 03:06:46 INFO - Mirror: Off 03:06:46 INFO - Online: Yes 03:06:46 INFO - Rotation: Supported 03:06:46 INFO - Return code: 0 03:06:46 INFO - Running post-action listener: _resource_record_post_action 03:06:46 INFO - Running post-run listener: _resource_record_post_run 03:06:47 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 118784; Write bytes: 686130176; Read time: 77; Write time: 48675 03:06:47 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 335395328; Write bytes: 336130048; Read time: 36019; Write time: 7080 03:06:47 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 118784; Write bytes: 339682304; Read time: 77; Write time: 40727 03:06:47 INFO - Running post-run listener: _upload_blobber_files 03:06:47 INFO - Blob upload gear active. 03:06:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:06:47 INFO - Copying logs to upload dir... 03:06:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1327.547973 ========= master_lag: 12.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2015-11-17 03:07:00.679849) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-17 03:07:00.683210) ========= 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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010507 build_url: 'https://queue.taskcluster.net/v1/task/HBhfmwGbQR-sBcZZHyGB0Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 2.73 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-17 03:07:03.428306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:07:03.428696) ========= 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.WsDgxdaOGV/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.ff29vbFbgn/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.005488 ========= master_lag: 0.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:07:03.948081) ========= ========= Started reboot skipped (results: 3, elapsed: 18 secs) (at 2015-11-17 03:07:03.948376) ========= ========= Finished reboot skipped (results: 3, elapsed: 18 secs) (at 2015-11-17 03:07:22.135624) ========= ========= Total master_lag: 16.17 =========