builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0041 starttime: 1446632425.95 results: success (0) buildid: 20151104012241 builduid: f20a5e2785594ec48fe3cb79c44cba3e revision: d30fb6c197893e3498dcb5a3d8dbc890ff954045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:25.950295) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:25.950869) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:25.951191) ========= 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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.006140 basedir: '/builds/slave/test' ========= master_lag: 0.38 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.333592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.334056) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.410854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.411369) ========= 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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.005436 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.480141) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.480619) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.481099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.481468) ========= 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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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-04 02:20:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.54M=0.002s 2015-11-04 02:20:26 (7.54 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151181 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.669044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.669405) ========= 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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.020465 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.720169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:26.720552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d30fb6c197893e3498dcb5a3d8dbc890ff954045 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d30fb6c197893e3498dcb5a3d8dbc890ff954045 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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-04 02:20:26,797 truncating revision to first 12 chars 2015-11-04 02:20:26,798 Setting DEBUG logging. 2015-11-04 02:20:26,798 attempt 1/10 2015-11-04 02:20:26,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d30fb6c19789?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-04 02:20:27,050 unpacking tar archive at: fx-team-d30fb6c19789/testing/mozharness/ program finished with exit code 0 elapsedTime=0.496759 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:27.235540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:27.235897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:27.250456) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:27.250891) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 02:20:27.251437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-04 02:20:27.251785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:20:27 INFO - MultiFileLogger online at 20151104 02:20:27 in /builds/slave/test 02:20:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:20:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:27 INFO - {'append_to_log': False, 02:20:27 INFO - 'base_work_dir': '/builds/slave/test', 02:20:27 INFO - 'blob_upload_branch': 'Fx-Team', 02:20:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:27 INFO - 'branch': 'Fx-Team', 02:20:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:27 INFO - 'config_files': ('talos/mac_config.py',), 02:20:27 INFO - 'default_actions': ('clobber', 02:20:27 INFO - 'read-buildbot-config', 02:20:27 INFO - 'download-and-extract', 02:20:27 INFO - 'populate-webroot', 02:20:27 INFO - 'create-virtualenv', 02:20:27 INFO - 'install', 02:20:27 INFO - 'run-tests'), 02:20:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:27 INFO - 'download_minidump_stackwalk': True, 02:20:27 INFO - 'download_symbols': 'ondemand', 02:20:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:27 INFO - 'installer_path': 'installer.exe', 02:20:27 INFO - 'log_level': 'info', 02:20:27 INFO - 'log_name': 'talos', 02:20:27 INFO - 'log_to_console': True, 02:20:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:20:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:20:27 INFO - 'opt_config_files': (), 02:20:27 INFO - 'pip_index': False, 02:20:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:27 INFO - 'cmd': ('bash', 02:20:27 INFO - '-c', 02:20:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:27 INFO - 'enabled': True, 02:20:27 INFO - 'halt_on_failure': False, 02:20:27 INFO - 'name': 'check_screen_resolution'},), 02:20:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:27 INFO - 'cmd': ('bash', 02:20:27 INFO - '-c', 02:20:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:27 INFO - 'enabled': True, 02:20:27 INFO - 'halt_on_failure': False, 02:20:27 INFO - 'name': 'check_screen_resolution'},), 02:20:27 INFO - 'run_cmd_checks_enabled': True, 02:20:27 INFO - 'sps_profile': False, 02:20:27 INFO - 'sps_profile_interval': 0, 02:20:27 INFO - 'suite': 'dromaeojs', 02:20:27 INFO - 'system_bits': '64', 02:20:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:27 INFO - 'title': 't-yosemite-r5-0041', 02:20:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:27 INFO - 'use_talos_json': True, 02:20:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:27 INFO - 'work_dir': 'build'} 02:20:27 INFO - ##### 02:20:27 INFO - ##### Running clobber step. 02:20:27 INFO - ##### 02:20:27 INFO - Running pre-action listener: _resource_record_pre_action 02:20:27 INFO - Running main action method: clobber 02:20:27 INFO - rmtree: /builds/slave/test/build 02:20:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:29 INFO - Running post-action listener: _resource_record_post_action 02:20:29 INFO - ##### 02:20:29 INFO - ##### Running read-buildbot-config step. 02:20:29 INFO - ##### 02:20:29 INFO - Running pre-action listener: _resource_record_pre_action 02:20:29 INFO - Running main action method: read_buildbot_config 02:20:29 INFO - Using buildbot properties: 02:20:29 INFO - { 02:20:29 INFO - "properties": { 02:20:29 INFO - "buildnumber": 1305, 02:20:29 INFO - "product": "firefox", 02:20:29 INFO - "script_repo_revision": "production", 02:20:29 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 02:20:29 INFO - "repository": "", 02:20:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 02:20:29 INFO - "buildid": "20151104012241", 02:20:29 INFO - "slavename": "t-yosemite-r5-0041", 02:20:29 INFO - "pgo_build": "False", 02:20:29 INFO - "basedir": "/builds/slave/test", 02:20:29 INFO - "project": "", 02:20:29 INFO - "platform": "yosemite", 02:20:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:20:29 INFO - "slavebuilddir": "test", 02:20:29 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:20:29 INFO - "branch": "fx-team", 02:20:29 INFO - "repo_path": "integration/fx-team", 02:20:29 INFO - "stage_platform": "macosx64", 02:20:29 INFO - "builduid": "f20a5e2785594ec48fe3cb79c44cba3e", 02:20:29 INFO - "revision": "d30fb6c197893e3498dcb5a3d8dbc890ff954045" 02:20:29 INFO - }, 02:20:29 INFO - "sourcestamp": { 02:20:29 INFO - "repository": "", 02:20:29 INFO - "hasPatch": false, 02:20:29 INFO - "project": "", 02:20:29 INFO - "branch": "fx-team-macosx64-talos", 02:20:29 INFO - "changes": [ 02:20:29 INFO - { 02:20:29 INFO - "category": null, 02:20:29 INFO - "files": [ 02:20:29 INFO - { 02:20:29 INFO - "url": null, 02:20:29 INFO - "name": "https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:20:29 INFO - } 02:20:29 INFO - ], 02:20:29 INFO - "repository": "", 02:20:29 INFO - "rev": "d30fb6c197893e3498dcb5a3d8dbc890ff954045", 02:20:29 INFO - "who": "dgottwald@mozilla.com", 02:20:29 INFO - "when": 1446632363, 02:20:29 INFO - "number": 6618934, 02:20:29 INFO - "comments": "Bug 691849 - Replace custom Sync notification bars with standard ones. r=markh", 02:20:29 INFO - "project": "", 02:20:29 INFO - "at": "Wed 04 Nov 2015 02:19:23", 02:20:29 INFO - "branch": "fx-team-macosx64-talos", 02:20:29 INFO - "revlink": "", 02:20:29 INFO - "properties": [ 02:20:29 INFO - [ 02:20:29 INFO - "buildid", 02:20:29 INFO - "20151104012241", 02:20:29 INFO - "Change" 02:20:29 INFO - ], 02:20:29 INFO - [ 02:20:29 INFO - "builduid", 02:20:29 INFO - "f20a5e2785594ec48fe3cb79c44cba3e", 02:20:29 INFO - "Change" 02:20:29 INFO - ], 02:20:29 INFO - [ 02:20:29 INFO - "pgo_build", 02:20:29 INFO - "False", 02:20:29 INFO - "Change" 02:20:29 INFO - ] 02:20:29 INFO - ], 02:20:29 INFO - "revision": "d30fb6c197893e3498dcb5a3d8dbc890ff954045" 02:20:29 INFO - } 02:20:29 INFO - ], 02:20:29 INFO - "revision": "d30fb6c197893e3498dcb5a3d8dbc890ff954045" 02:20:29 INFO - } 02:20:29 INFO - } 02:20:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 02:20:29 INFO - Running post-action listener: _resource_record_post_action 02:20:29 INFO - ##### 02:20:29 INFO - ##### Running download-and-extract step. 02:20:29 INFO - ##### 02:20:29 INFO - Running pre-action listener: _resource_record_pre_action 02:20:29 INFO - Running main action method: download_and_extract 02:20:29 INFO - mkdir: /builds/slave/test/build/tests 02:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:29 INFO - https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:20:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/test_packages.json 02:20:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/test_packages.json 02:20:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:20:31 INFO - Downloaded 1149 bytes. 02:20:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:20:31 INFO - Using the following test package requirements: 02:20:31 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:20:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 02:20:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'jsshell-mac.zip'], 02:20:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 02:20:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:20:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 02:20:31 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 02:20:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 02:20:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:20:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:20:31 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 02:20:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:20:51 INFO - Downloaded 17452627 bytes. 02:20:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:20:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:20:56 INFO - Return code: 0 02:20:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:20:56 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:20:56 INFO - https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:20:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:20:57 INFO - Downloaded 17452627 bytes. 02:20:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:20:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:20:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:21:04 INFO - Return code: 0 02:21: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:21:04 INFO - https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:21:05 INFO - Downloaded 11131307 bytes. 02:21:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:21:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:21:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:21:06 INFO - Return code: 0 02:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:06 INFO - https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:21:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:21:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:21:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 02:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 02:21:13 INFO - Downloaded 108618112 bytes. 02:21:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:21:13 INFO - mkdir: /builds/slave/test/properties 02:21:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:13 INFO - Contents: 02:21:13 INFO - build_url:https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:21:13 INFO - Running post-action listener: _resource_record_post_action 02:21:13 INFO - Running post-action listener: set_extra_try_arguments 02:21:13 INFO - ##### 02:21:13 INFO - ##### Running populate-webroot step. 02:21:13 INFO - ##### 02:21:13 INFO - Running pre-action listener: _resource_record_pre_action 02:21:13 INFO - Running main action method: populate_webroot 02:21:13 INFO - Guessing talos json url... 02:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:13 INFO - https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 02:21:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 02:21:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 02:21:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 02:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 02:21:13 INFO - Downloaded 103 bytes. 02:21:13 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 02:21:13 INFO - Contents: 02:21:13 INFO - 20151104012241 02:21:13 INFO - https://hg.mozilla.org/integration/fx-team/rev/d30fb6c197893e3498dcb5a3d8dbc890ff954045 02:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:13 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/d30fb6c197/testing/talos/talos.json 02:21:13 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/d30fb6c197/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/d30fb6c197/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:21:14 INFO - Downloaded 4264 bytes. 02:21:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:14 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:21:14 INFO - '../fennec_ids.txt'], 02:21:14 INFO - 'tests': ['tcheck2']}, 02:21:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:14 INFO - '--tppagecycles', 02:21:14 INFO - '7'], 02:21:14 INFO - 'tests': ['tsvgm']}}, 02:21:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:21:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:21:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:21:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'tests': ['damp', 'tps']}, 02:21:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['damp', 'tps']}, 02:21:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:21:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:14 INFO - 'other': {'tests': ['a11yr', 02:21:14 INFO - 'ts_paint', 02:21:14 INFO - 'tpaint', 02:21:14 INFO - 'sessionrestore', 02:21:14 INFO - 'sessionrestore_no_auto_restore']}, 02:21:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['a11yr', 02:21:14 INFO - 'ts_paint', 02:21:14 INFO - 'tpaint', 02:21:14 INFO - 'sessionrestore', 02:21:14 INFO - 'sessionrestore_no_auto_restore']}, 02:21:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['a11yr', 02:21:14 INFO - 'ts_paint', 02:21:14 INFO - 'tpaint', 02:21:14 INFO - 'sessionrestore', 02:21:14 INFO - 'sessionrestore_no_auto_restore']}, 02:21:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['a11yr', 02:21:14 INFO - 'ts_paint', 02:21:14 INFO - 'tpaint', 02:21:14 INFO - 'sessionrestore', 02:21:14 INFO - 'sessionrestore_no_auto_restore']}, 02:21:14 INFO - 'other_l64': {'tests': ['a11yr', 02:21:14 INFO - 'ts_paint', 02:21:14 INFO - 'tpaint', 02:21:14 INFO - 'sessionrestore', 02:21:14 INFO - 'sessionrestore_no_auto_restore']}, 02:21:14 INFO - 'other_nol64': {'tests': ['a11yr', 02:21:14 INFO - 'ts_paint', 02:21:14 INFO - 'tpaint', 02:21:14 INFO - 'sessionrestore', 02:21:14 INFO - 'sessionrestore_no_auto_restore']}, 02:21:14 INFO - 'svgr': {'tests': ['tsvgx', 02:21:14 INFO - 'tsvgr_opacity', 02:21:14 INFO - 'tart', 02:21:14 INFO - 'tscrollx', 02:21:14 INFO - 'cart']}, 02:21:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['tsvgx', 02:21:14 INFO - 'tsvgr_opacity', 02:21:14 INFO - 'tart', 02:21:14 INFO - 'tscrollx', 02:21:14 INFO - 'cart']}, 02:21:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'tests': ['tp5o']}, 02:21:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'talos_options': ['--e10s'], 02:21:14 INFO - 'tests': ['tp5o']}, 02:21:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'talos_options': ['--xperf_path', 02:21:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:14 INFO - 'tests': ['tp5n']}, 02:21:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:14 INFO - 'talos_options': ['--e10s', 02:21:14 INFO - '--xperf_path', 02:21:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:21:14 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:21:14 INFO - 'tests': ['tp5n']}}, 02:21:14 INFO - 'talos.zip': {'path': '', 02:21:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:14 INFO - Running post-action listener: _resource_record_post_action 02:21:14 INFO - ##### 02:21:14 INFO - ##### Running create-virtualenv step. 02:21:14 INFO - ##### 02:21:14 INFO - Running pre-action listener: _resource_record_pre_action 02:21:14 INFO - Running main action method: create_virtualenv 02:21:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:14 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:21:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:14 INFO - Using real prefix '/tools/python27' 02:21:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:18 INFO - Installing pip.................done. 02:21:18 INFO - Return code: 0 02:21:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:18 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:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 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:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:18 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:21:18 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:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:18 INFO - 'HOME': '/Users/cltbld', 02:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:18 INFO - 'LOGNAME': 'cltbld', 02:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:18 INFO - 'MOZ_NO_REMOTE': '1', 02:21:18 INFO - 'NO_EM_RESTART': '1', 02:21:18 INFO - 'PAGER': '/bin/cat', 02:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:18 INFO - 'PWD': '/builds/slave/test', 02:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:18 INFO - 'SHELL': '/bin/bash', 02:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:18 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:18 INFO - 'USER': 'cltbld', 02:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:18 INFO - 'XPC_FLAGS': '0x0', 02:21:18 INFO - 'XPC_SERVICE_NAME': '0', 02:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:19 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:21:19 INFO - Cleaning up... 02:21:19 INFO - Return code: 0 02:21:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:21:19 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:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:19 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:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:19 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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:19 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:21:19 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:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:19 INFO - 'HOME': '/Users/cltbld', 02:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:19 INFO - 'LOGNAME': 'cltbld', 02:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:19 INFO - 'MOZ_NO_REMOTE': '1', 02:21:19 INFO - 'NO_EM_RESTART': '1', 02:21:19 INFO - 'PAGER': '/bin/cat', 02:21:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:19 INFO - 'PWD': '/builds/slave/test', 02:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:19 INFO - 'SHELL': '/bin/bash', 02:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:19 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:19 INFO - 'USER': 'cltbld', 02:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:19 INFO - 'XPC_FLAGS': '0x0', 02:21:19 INFO - 'XPC_SERVICE_NAME': '0', 02:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:19 INFO - Downloading/unpacking psutil>=0.7.1 02:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:21:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:22 INFO - Installing collected packages: psutil 02:21:22 INFO - Running setup.py install for psutil 02:21:22 INFO - building 'psutil._psutil_osx' extension 02:21:22 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:21:22 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:21:22 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:21:22 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:21:22 INFO - building 'psutil._psutil_posix' extension 02:21:22 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:21:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:21:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:21:22 INFO - ^ 02:21:22 INFO - 1 warning generated. 02:21:22 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:21:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:23 INFO - Successfully installed psutil 02:21:23 INFO - Cleaning up... 02:21:23 INFO - Return code: 0 02:21:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:23 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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:23 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:21:23 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:21:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:23 INFO - 'HOME': '/Users/cltbld', 02:21:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:23 INFO - 'LOGNAME': 'cltbld', 02:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:23 INFO - 'MOZ_NO_REMOTE': '1', 02:21:23 INFO - 'NO_EM_RESTART': '1', 02:21:23 INFO - 'PAGER': '/bin/cat', 02:21:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:23 INFO - 'PWD': '/builds/slave/test', 02:21:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:23 INFO - 'SHELL': '/bin/bash', 02:21:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:23 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:23 INFO - 'USER': 'cltbld', 02:21:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:23 INFO - 'XPC_FLAGS': '0x0', 02:21:23 INFO - 'XPC_SERVICE_NAME': '0', 02:21:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:21:23 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:21:23 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:21:23 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:21:23 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:21:23 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:21:23 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:21:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:21:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:25 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:21:25 INFO - Installing collected packages: mozsystemmonitor 02:21:25 INFO - Running setup.py install for mozsystemmonitor 02:21:25 INFO - Successfully installed mozsystemmonitor 02:21:25 INFO - Cleaning up... 02:21:26 INFO - Return code: 0 02:21:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:26 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:21:26 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:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:26 INFO - 'HOME': '/Users/cltbld', 02:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:26 INFO - 'LOGNAME': 'cltbld', 02:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:26 INFO - 'MOZ_NO_REMOTE': '1', 02:21:26 INFO - 'NO_EM_RESTART': '1', 02:21:26 INFO - 'PAGER': '/bin/cat', 02:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:26 INFO - 'PWD': '/builds/slave/test', 02:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:26 INFO - 'SHELL': '/bin/bash', 02:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:26 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:26 INFO - 'USER': 'cltbld', 02:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:26 INFO - 'XPC_FLAGS': '0x0', 02:21:26 INFO - 'XPC_SERVICE_NAME': '0', 02:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:26 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:21:26 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:21:26 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:21:26 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:21:26 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:21:26 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:21:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21: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:21: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:21: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:21: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:21: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:21: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:21:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 INFO - Downloading docopt-0.6.1.tar.gz 02:21:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:29 INFO - Running setup.py install for blobuploader 02:21:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:30 INFO - Running setup.py install for requests 02:21:30 INFO - Running setup.py install for docopt 02:21:30 INFO - Successfully installed blobuploader requests docopt 02:21:30 INFO - Cleaning up... 02:21:30 INFO - Return code: 0 02:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:30 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:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:30 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:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:30 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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:30 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:21:30 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:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:30 INFO - 'HOME': '/Users/cltbld', 02:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:30 INFO - 'LOGNAME': 'cltbld', 02:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:30 INFO - 'MOZ_NO_REMOTE': '1', 02:21:30 INFO - 'NO_EM_RESTART': '1', 02:21:30 INFO - 'PAGER': '/bin/cat', 02:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:30 INFO - 'PWD': '/builds/slave/test', 02:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:30 INFO - 'SHELL': '/bin/bash', 02:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:30 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:30 INFO - 'USER': 'cltbld', 02:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:30 INFO - 'XPC_FLAGS': '0x0', 02:21:30 INFO - 'XPC_SERVICE_NAME': '0', 02:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-cW6h6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-q8qSc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-phIeRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-scX56P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-qpybIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-dPAclv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-oZ77ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-4Xb5XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-jeW2rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-aq5B3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-20qQ9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-dGij9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-mhk4OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-wkqinC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-d6qWHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-7OhLff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-UH7qeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:33 INFO - Running setup.py install for manifestparser 02:21:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:33 INFO - Running setup.py install for mozcrash 02:21:33 INFO - Running setup.py install for mozdebug 02:21:33 INFO - Running setup.py install for mozdevice 02:21:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Running setup.py install for mozfile 02:21:34 INFO - Running setup.py install for mozhttpd 02:21:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Running setup.py install for mozinfo 02:21:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Running setup.py install for mozInstall 02:21:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:34 INFO - Running setup.py install for mozleak 02:21:34 INFO - Running setup.py install for mozlog 02:21:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Running setup.py install for moznetwork 02:21:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Running setup.py install for mozprocess 02:21:35 INFO - Running setup.py install for mozprofile 02:21:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Running setup.py install for mozrunner 02:21:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Running setup.py install for mozscreenshot 02:21:35 INFO - Running setup.py install for moztest 02:21:36 INFO - Running setup.py install for mozversion 02:21:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:36 INFO - Cleaning up... 02:21:36 INFO - Return code: 0 02:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:36 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:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:36 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:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:36 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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:36 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:21:36 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:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:36 INFO - 'HOME': '/Users/cltbld', 02:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:36 INFO - 'LOGNAME': 'cltbld', 02:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:36 INFO - 'MOZ_NO_REMOTE': '1', 02:21:36 INFO - 'NO_EM_RESTART': '1', 02:21:36 INFO - 'PAGER': '/bin/cat', 02:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:36 INFO - 'PWD': '/builds/slave/test', 02:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:36 INFO - 'SHELL': '/bin/bash', 02:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:36 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:36 INFO - 'USER': 'cltbld', 02:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:36 INFO - 'XPC_FLAGS': '0x0', 02:21:36 INFO - 'XPC_SERVICE_NAME': '0', 02:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:36 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-sRdQiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:36 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-9p76GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:36 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-8O5Jma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-D05c7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-ukVZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-9bWjgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-kDN8WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-YKZFjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-Qm7geg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-70EEBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-QFEb1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-zFMV8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-gtxl9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-zXQOlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-IyNZlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-y4Ahvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-XQ_vv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:38 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:21:38 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:21:38 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:21:38 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:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:41 INFO - Downloading blessings-1.5.1.tar.gz 02:21:41 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:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:41 INFO - Installing collected packages: blessings 02:21:41 INFO - Running setup.py install for blessings 02:21:41 INFO - Successfully installed blessings 02:21:41 INFO - Cleaning up... 02:21:41 INFO - Return code: 0 02:21:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:41 INFO - Reading from file tmpfile_stdout 02:21:41 INFO - Current package versions: 02:21:41 INFO - blessings == 1.5.1 02:21:41 INFO - blobuploader == 1.2.4 02:21:41 INFO - docopt == 0.6.1 02:21:41 INFO - manifestparser == 1.1 02:21:41 INFO - mozInstall == 1.12 02:21:41 INFO - mozcrash == 0.16 02:21:41 INFO - mozdebug == 0.1 02:21:41 INFO - mozdevice == 0.47 02:21:41 INFO - mozfile == 1.2 02:21:41 INFO - mozhttpd == 0.7 02:21:41 INFO - mozinfo == 0.9 02:21:41 INFO - mozleak == 0.1 02:21:41 INFO - mozlog == 3.0 02:21:41 INFO - moznetwork == 0.27 02:21:41 INFO - mozprocess == 0.22 02:21:41 INFO - mozprofile == 0.27 02:21:41 INFO - mozrunner == 6.11 02:21:41 INFO - mozscreenshot == 0.1 02:21:41 INFO - mozsystemmonitor == 0.0 02:21:41 INFO - moztest == 0.7 02:21:41 INFO - mozversion == 1.4 02:21:41 INFO - psutil == 3.1.1 02:21:41 INFO - requests == 1.2.3 02:21:41 INFO - wsgiref == 0.1.2 02:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:41 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:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:41 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:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:41 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 0x10f4bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f529228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449d15d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, '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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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:21:41 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:21:41 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:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:41 INFO - 'HOME': '/Users/cltbld', 02:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:41 INFO - 'LOGNAME': 'cltbld', 02:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:41 INFO - 'MOZ_NO_REMOTE': '1', 02:21:41 INFO - 'NO_EM_RESTART': '1', 02:21:41 INFO - 'PAGER': '/bin/cat', 02:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:41 INFO - 'PWD': '/builds/slave/test', 02:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:41 INFO - 'SHELL': '/bin/bash', 02:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:21:41 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:41 INFO - 'USER': 'cltbld', 02:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:41 INFO - 'XPC_FLAGS': '0x0', 02:21:41 INFO - 'XPC_SERVICE_NAME': '0', 02:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:42 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:21:42 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:21:42 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:21:42 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:21:42 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:21:42 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:21:42 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:21:42 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:21: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:42 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:21:42 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:21:42 INFO - Cleaning up... 02:21:42 INFO - Return code: 0 02:21:42 INFO - Running post-action listener: _resource_record_post_action 02:21:42 INFO - Running post-action listener: _start_resource_monitoring 02:21:42 INFO - Starting resource monitoring. 02:21:42 INFO - ##### 02:21:42 INFO - ##### Running install step. 02:21:42 INFO - ##### 02:21:42 INFO - Running pre-action listener: _resource_record_pre_action 02:21:42 INFO - Running main action method: install 02:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:42 INFO - Reading from file tmpfile_stdout 02:21:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:42 INFO - Reading from file tmpfile_stdout 02:21:42 INFO - Output received: 02:21:42 INFO - Usage: mozinstall [options] installer 02:21:42 INFO - Options: 02:21:42 INFO - -h, --help show this help message and exit 02:21:42 INFO - -d DEST, --destination=DEST 02:21:42 INFO - Directory to install application into. [default: 02:21:42 INFO - "/builds/slave/test"] 02:21:42 INFO - --app=APP Application being installed. [default: firefox] 02:21:42 INFO - mkdir: /builds/slave/test/build/application 02:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:22:20 INFO - Reading from file tmpfile_stdout 02:22:20 INFO - Output received: 02:22:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running run-tests step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: run_tests 02:22:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:20 INFO - 2015-11-04 02:22:20.289 screenresolution[2869:35560] starting screenresolution argv=screenresolution get 02:22:20 INFO - 2015-11-04 02:22:20.292 screenresolution[2869:35560] Display 0: 1600x1200x32@60 02:22:20 INFO - 2015-11-04 02:22:20.299 screenresolution[2870:35562] starting screenresolution argv=screenresolution list 02:22:20 INFO - Available Modes on Display 0 02:22:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:20 INFO - Intel HD Graphics 3000: 02:22:20 INFO - Chipset Model: Intel HD Graphics 3000 02:22:20 INFO - Type: GPU 02:22:20 INFO - Bus: Built-In 02:22:20 INFO - VRAM (Total): 512 MB 02:22:20 INFO - VRAM (Dynamic, Max): 10 02:22:20 INFO - Vendor: Intel (0x8086) 02:22:20 INFO - Device ID: 0x0116 02:22:20 INFO - Revision ID: 0x0009 02:22:20 INFO - Displays: 02:22:20 INFO - Display: 02:22:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:20 INFO - Display Serial Number: 1600x1200 60 02:22:20 INFO - Main Display: Yes 02:22:20 INFO - Mirror: Off 02:22:20 INFO - Online: Yes 02:22:20 INFO - Rotation: Supported 02:22:20 INFO - Return code: 0 02:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:22:20 INFO - Python 2.7.3 02:22:20 INFO - Return code: 0 02:22:20 INFO - grabbing minidump binary from tooltool 02:22: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:22:20 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 0x10f4719f0>, '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 0x10f1d0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f43b990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:22:20 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:22:20 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:22:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:22:20 INFO - Return code: 0 02:22:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:22:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:22:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:22:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:22:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0041', '--webServer', 'localhost'] in /builds/slave/test/build 02:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0041 --webServer localhost 02:22:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zGEWMHfz4g/Render', 02:22:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:20 INFO - 'HOME': '/Users/cltbld', 02:22:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:20 INFO - 'LOGNAME': 'cltbld', 02:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:20 INFO - 'MOZ_NO_REMOTE': '1', 02:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:22:20 INFO - 'NO_EM_RESTART': '1', 02:22:20 INFO - 'PAGER': '/bin/cat', 02:22:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:20 INFO - 'PWD': '/builds/slave/test', 02:22:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:22:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:20 INFO - 'SHELL': '/bin/bash', 02:22:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9SsRv1HKuC/Listeners', 02:22:20 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 02:22:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:20 INFO - 'USER': 'cltbld', 02:22:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:20 INFO - 'XPC_FLAGS': '0x0', 02:22:20 INFO - 'XPC_SERVICE_NAME': '0', 02:22:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:22:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0041', '--webServer', 'localhost'] with output_timeout 3600 02:22:20 INFO - mozversion INFO | application_buildid: 20151104012241 02:22:20 INFO - mozversion INFO | application_changeset: d30fb6c197893e3498dcb5a3d8dbc890ff954045 02:22:20 INFO - mozversion INFO | application_display_name: Nightly 02:22:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:22:20 INFO - mozversion INFO | application_name: Firefox 02:22:20 INFO - mozversion INFO | application_remotingname: firefox 02:22:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:22:20 INFO - mozversion INFO | application_vendor: Mozilla 02:22:20 INFO - mozversion INFO | application_version: 45.0a1 02:22:20 INFO - mozversion INFO | platform_buildid: 20151104012241 02:22:20 INFO - mozversion INFO | platform_changeset: d30fb6c197893e3498dcb5a3d8dbc890ff954045 02:22:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:22:20 INFO - mozversion INFO | platform_version: 45.0a1 02:22:20 INFO - 2015-11-04 02:22:20,898 DEBUG : using testdate: 1446632540 02:22:20 INFO - 2015-11-04 02:22:20,898 DEBUG : actual date: 1446632540 02:22:20 INFO - 2015-11-04 02:22:20,909 INFO : starting webserver on 'localhost:55110' 02:22:20 INFO - 2015-11-04 02:22:20,910 INFO : Starting test suite t-yosemite-r5-0041 02:22:20 INFO - 2015-11-04 02:22:20,911 INFO : Starting test dromaeo_css 02:22:20 INFO - 2015-11-04 02:22:20,911 DEBUG : operating with platform_type : mac_ 02:22:20 INFO - 2015-11-04 02:22:20,911 INFO : Initialising browser for dromaeo_css test... 02:22:20 INFO - 2015-11-04 02:22:20,925 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpolw8TV/profile http://localhost:55110/getInfo.html 02:22:23 INFO - 2015-11-04 02:22:23,215 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:22:23 INFO - 2015-11-04 02:22:23,215 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:22:23 INFO - 2015-11-04 02:22:23,216 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:22:23 INFO - 2015-11-04 02:22:23,216 DEBUG : BROWSER_OUTPUT: __metrics 02:22:23 INFO - 2015-11-04 02:22:23,233 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:22:23 INFO - 2015-11-04 02:22:23,944 INFO : Browser initialized. 02:22:23 INFO - 2015-11-04 02:22:23,945 INFO : Running cycle 1/1 for dromaeo_css test... 02:22:23 INFO - 2015-11-04 02:22:23,945 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpolw8TV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:22:35 INFO - 2015-11-04 02:22:35,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 223563776 02:22:35 INFO - 2015-11-04 02:22:35,850 DEBUG : BROWSER_OUTPUT: 02:23:26 INFO - 2015-11-04 02:23:26,833 DEBUG : BROWSER_OUTPUT: 1446632606829 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:25:38 INFO - 2015-11-04 02:25:38,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55110/tests/dromaeo/cssquery-ext.html) 02:25:39 INFO - 2015-11-04 02:25:39,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 342384640 02:25:39 INFO - 2015-11-04 02:25:39,428 DEBUG : BROWSER_OUTPUT: 02:28:42 INFO - 2015-11-04 02:28:42,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/dromaeo/cssquery-ext.html (next: http://localhost:55110/tests/dromaeo/cssquery-jquery.html) 02:28:42 INFO - 2015-11-04 02:28:42,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 351932416 02:28:42 INFO - 2015-11-04 02:28:42,737 DEBUG : BROWSER_OUTPUT: 02:31:44 INFO - 2015-11-04 02:31:44,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55110/tests/dromaeo/cssquery-mootools.html) 02:31:45 INFO - 2015-11-04 02:31:45,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 332238848 02:31:45 INFO - 2015-11-04 02:31:45,412 DEBUG : BROWSER_OUTPUT: 02:34:47 INFO - 2015-11-04 02:34:47,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55110/tests/dromaeo/cssquery-prototype.html) 02:34:48 INFO - 2015-11-04 02:34:48,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 311627776 02:34:48 INFO - 2015-11-04 02:34:48,041 DEBUG : BROWSER_OUTPUT: 02:37:51 INFO - 2015-11-04 02:37:51,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55110/tests/dromaeo/cssquery-yui.html) 02:37:51 INFO - 2015-11-04 02:37:51,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 311341056 02:37:51 INFO - 2015-11-04 02:37:51,644 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/dromaeo/cssquery-yui.html (next: http://localhost:55110/tests/dromaeo/cssquery-dojo.html) 02:40:54 INFO - 2015-11-04 02:40:54,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 355835904 02:40:54 INFO - 2015-11-04 02:40:54,705 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,705 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:40:54 INFO - 2015-11-04 02:40:54,705 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:40:54 INFO - 2015-11-04 02:40:54,705 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:40:54 INFO - 2015-11-04 02:40:54,705 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:40:54 INFO - 2015-11-04 02:40:54,705 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3208.9358212835746;3281.27811881386;3297.109780359303;3297.241634424081;3315.2872132491516;5147.922781158286;5275;5300.602454815889;5444.074507333763;5491.368492623349;5016.896282817775;5089.720065396402;5235.371755389349;5295.391030031547;5425.6202065855305;4745.976270118662;4757.976210118944;4793.137235297645;4810.639202059842;4861.586765124968;4536.55368417969;4922.655414121013;4987.875303117415;5004.349434573501;5060.9240861386925;4628.745419001987;4707.7881495332795;4735.313379559979;4876.926846097276;4905.533974272438;4887.608991280725;4901.730404827733;4909.533594308535;4926.433460152057;4951.801927922878;4842.394700662418;4845.636577256684;4869.050535145648;4874.366332376769;4875.195592727196;5137;5167.483251674803;5293.417724050351;5308.469153084699;5320.042392369372;5477.972610136963;5624.072028115356;5649.661020338793;5697.77208911643;5716.57125715573;5644;5680.949024430493;5705.343885453184;5748.741306641211;5752.626079304831;5022.6233032522705;5084.593232541388;5172.844814655567;5208.296879921238;5410.161424979135;5714.2571465710025;5779.24869766936;5795.159701843209;5836.562257830679;5902.616329938626;5449.7275136243825;5456;5472.151816468454;5566.638168519034;5570.275864137717;5412.134058550691;5552.028395030934;5641.661500309994;5681.460261275172;5709.628874123168;5567.66594004361;5654.208410822488;5656.321241451053;5661.716914154275;5703.657780533182;5569.248151499496;5646.915296270559;5648;5665.773369065274;5690.430956904276;4207.347861081537;4353.499347575006;4354.586314300136;4356.411884395629;4422;3982.123932734794;3998.600139986036;4001.7398869073418;4006.579309172553;4010.578889216649;5242.816501422432;5312.548433383128;5321.574274058066;5362.490563396471;5423.240746295522;5537.252470916455;5640.520555752807;5663.886722265532;5702.173184888251;5720.799772007959;5275.7362131894015;5330.093884039723;5331.253624492574;5331.5201631853315;5350.384705758887;4988.900221995613;4988.975055124701;4991.101601711654;5030.471800460972;5085.847424577269;5487;5534.280543529235;5632.690202038763;5685.061964775931;5802.274715660543;5633.126865335879;5636.5208957237455;5675.77296908119;5680.6875621839545;5745.052066408995;5731.283589551306;5749.338826035059;5761.8559536011935;5767.567432442667;5819.79630712923;5323.361196656426;5520.834374968596;5570.777168913198;5583.609147359646;5602.971985140048;5660.688662123623;5694;5715.714214289352;5719.6568205906115;5765.106408506688;5492.423295554069;5513.8345849624575;5519.420460851713;5521.69630670317;5568.1091025435735;5287.471252874681;5314.62797604164;5338.199270109515;5434.891302174014;5507.421720719267;5215.322008138917;5446.1558458439;5455.672659640434;5463.7814487420055;5549.195366671891;5548.916766248429;5555.833325000256;5556.944430555643;5616.017196990592;5640.464155905182;5216.347956505437;5304.469553044819;5386.973065134649;5411.107167317348;5440.129579267298 02:40:54 INFO - 2015-11-04 02:40:54,706 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.3111033432374;555.6443875919413;556.563097968095;563.6730696196206;570.3099249907611;31067;31784.84107579462;37403.251934961285;37434;37938.810305948435;41045.58954410455;41435.17129657405;41625.37561936573;41751;42103.15793684124;7934.563599002053;8876.822463550725;9068.682596109138;9191;9212.355135140542;8097.878531821998;10748.516316765725;10958.890411095907;11094.722631934226;11108.722281942935;10870.728231794228;10970.177236707239;10977.83533247002;11011.28426652269;11021.338719676845;8324.500529968162;8505.574721263913;10857.511411986401;10924.508397122148;10939.28894621851;10719.624813131502;10729.517171727291;10870.61952831647;10907.945460272727;10916.454177291183;39797.204055919006;40164;40255.39616905749;40266.59733402687;40366.19267614661;2871;2955.06915321673;3014.0957712686327;3037.7569794416613;3049.9542506862413;27298.727012730014;27318.86340568304;27575.586366204523;27656.86171569129;27838.86080569584;2301.97698023021;2328.4295347639936;2332.486852892361;2357.104300365867;2479.1199124310792;293008;293925;294469;294884;296017.5199124012;55546.16680749792;57053;60334.39665603376;60784;65435;60047;60156;60869;60875;61259;16153.757693634605;16554.089525076237;16772.245248963583;16844.57888552796;16981.320747169975;12644.114911956258;12816.55142070023;12848;12863.356832158355;12881.420336084899;19145.745417586262;19333.226670933287;19417.708734368996;19531.414057578295;19563.217471301272;7609.885851712229;7782.186728503106;7788.844223115506;7909.762707118795;7947.483413578099;859.9785005374915;909.5134103254859;1089.8665387996396;1104.26566333389;1114.5820317380983;26851.462970740475;27129;27264.727352726615;27459.17622471329;27553.17340479789;1041.4272150317295;1069.9942054468775;1169.976600467986;1186.4483015397882;1219.9878001219874;14081.718365632834;14148;14389.42442302317;14423.42306307736;14438.639034024023;323709;328329;329651;330479;330484;51889.2216616751;53785.731071344395;53965.1905221422;53977;54077.45922540803;1375.195510626295;1392.8119703840055;1394.9232792196324;1397.6505873531617;1400.9159450433006;23206.824599234424;28104.578431323138;29244.7075529242;29768;30180.69819301779;50604.24093638672;51083.23375149301;51110.23334650058;51123;51133.48866511287;256944;260271;260358;260672;264819;31365.686343136276;32113.197170070936;32166.67833321637;32175.356492869545;32706.67293327036;40192.7990360058;41019.36920812945;41207.58792412037;41472.37791433191;41820.58179418167;34895;34988.32125531508;35788.82105589456;35958.10104747298;36105;27503;33706.66293337035;34177;35267.82366088153;35963.64036359603;33862.83068584641;35625.1093722659;36587.45118823273;36687.816560918094;36725;26602.287065462562;29975.250618734706;30916.82622845887;31411.528827067155;31613.20966975844;22331.330060098222;22742.20402285912;22845.200417985292;22890.54218915646;23510.29469115929 02:40:54 INFO - 2015-11-04 02:40:54,706 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.31337444863567;336.20990671920976;339.7502835415969;340.37541112059387;340.59469231614383;14575.489857854976;15048.924755376207;17030.574235644115;17495.82504174958;18187.272509099635;14133;15352.385904563804;17543.298268069295;17874.37439689611;18076.36732714355;5194.2208668699805;5322.76047577858;5343.118385466393;5364.490373414519;5371.865703357428;3396.371671240816;3479.2867462170193;4633.351330813689;4779.80880764769;5316.38861530925;4642.442906851183;4740.36005139307;4740.834070807505;4756.881077973061;4784.234522476405;4471.955280447219;4710.387649605546;4746.145693775119;4751.596114330268;4850.442199147108;4043.454133691973;4084.65280451162;4086.6322031017353;4087.346024636044;4101.036256479725;12773.936130319382;13177.736445271137;13245;13338;13629.454821807116;1763.8588912886937;1798.6402719456162;1825.0783354406074;1847.048769883511;1850.7871594766639;9583.185429238523;9605.37565058269;9605.567749451291;9734.951325243328;9850.556724947395;1455.89080818939;1463.253740592295;1489.6722721001363;1500.047469856638;1511.8639322460922;57359.71320143414;57689.42310576882;58198.70900645512;59017.40982590205;72600.91098633577;16601.750973735405;17492.300307987793;17689.557761055818;17751.911240443715;17768.55578610545;25072.373190670016;25381.36546586313;25383.238502844943;25396;25447.491050178895;10015.549300281506;10144.13774829133;10159.7460063499;10221.846672299922;10234.078932895925;8710.12898710124;8719.564021798884;8743.344249181337;8791.340649451316;8892.59983300753;8112.716054938049;8244.54654993969;8271.296939760188;8275.668973241003;8284.50292982423;1337.71239183576;2147.947505722185;3081.6918308169;3184.172115250052;3264.7877887937207;413.2891426745992;417.44688288018494;418.0218289203279;451.5304083752926;473.30187972740623;11734.178607497564;11851.170418070653;11960.102992275613;12022.978046866114;12103.636890893287;445.56779923474176;446.91955448019667;450.257075824885;455.26702009764256;474.6369027693817;5156.793728250903;5310.6813591184655;6427.517936154807;6567.2447668518735;6649.4347980421235;367493;375939;377943;379139;382989;40627.18745625071;73688.63155684188;73714.63142684252;75823;75921.62039189768;501.28566792321527;505.14125985824245;508.1006618285614;509.18784538660776;509.8368522072901;10886.61896833607;11043.503042362952;11173.441327933733;11273.154513411362;11319.660410187707;34214;34379.31241375108;34424.655753442144;36601.81699091488;36944.81527592345;47443.52556474391;47714.28428573505;48470.27294590513;48670.26994595155;48711.75644121757;6202.34875338083;6315.621062736251;6316.810495685137;6385.074164246251;6426.807195784134;11890.76218475643;11917.761644766882;11999.100067495147;12044.819327710267;12136.089793265364;8712.39013269065;8784.824303513766;8939.463632182089;10010.899891000996;10409.583616655249;2054.6404379233873;6041.516678665608;10076.798464030824;10196.368581027;10408.791824163625;10421.895781042092;10527.526261318411;10771.569137234423;10784.676459706221;10801.405922674328;6237.251529816451;6273.309935906956;6277.246730392382;6296.748130074929;6316.715747791269;10116.595336186765;10298.845517317097;10426.113780328757;10432.269741118049;10559.472026398496 02:40:54 INFO - 2015-11-04 02:40:54,709 DEBUG : BROWSER_OUTPUT: |3;mootools.html;842.9030661473932;1391.0957877379706;1396.1413730555712;1410.9012369134164;1495.8653721165097;6745.696443660035;7170.713171473141;7305.452091093162;7310.2689731027;7319.15829679587;7161.82095447614;7326.450516211279;7330.560166390007;7346.59593722345;7410.147832999207;1907.4754442528276;1920.7599050118736;2123.1189056541516;2181.3674034529968;2182.0944308112194;2180;2198.8240940724704;2209.248855389167;2212.037763572843;2216.091402524965;1987.0859404673868;2112.9788702113015;2127.2448280860303;2138.4546940530145;2141.025833245877;1911.5985643014915;1946.9415917522497;2154.429076294783;2172.9782702172934;2197.824174066071;2166.393409845246;2195.9451013724624;2220.400491867203;2246.4945387287894;2246.696695946043;7293.088363954505;7314.853702925911;7387.187409384964;7431.405487560982;7440.330370266702;4510.729356238603;4566.589006989354;4600.585947264763;4602.792874320664;4636.4899861015265;2662.9334266643295;2731.5356389413846;2753.8072334936564;2785.5821626755946;2801.229661842989;851.8509260879383;854.9953804279946;865.0873328638285;871.6949067826273;893.9463632182025;9563.90436095637;9785.853212201822;9794.2654300927;9799.853002205044;9807.26445516589;4088.1619268049976;4115.773632450184;4179.4357761701785;4181.1010632714115;4192.81132349045;8626.051134375213;8643.481391116427;8706.91293087061;8733.519656418957;8757.430767000125;4691.859244222679;4692.1084993851055;4692.1084993851055;4693.929591056137;4699.624030077585;4259.936100958488;4263.914721705611;4266.616004559604;4269.807858646368;4283.207606592728;3464.5496085509226;3519.6832285094465;3531.311394278091;3541.026217790128;3560.839762210707;1129.1023636209234;1172.2087590876124;1176.3294921894437;1180.2387460088196;1180.7874582575218;971.3006635222629;977.1352353167498;1009;1012.584840215508;1195.9342236177094;6525.249596296392;7016.473764467685;7017.964910175417;7152.964235178895;7226.277372262837;632.3518393646549;647.3785166240368;658.7826017414242;662.1491383572087;671.8253254153955;5492.47821456961;5516.448355164532;5603.159526071122;5604.719764011783;5618.690971996498;8583.227509524173;8726.858726858676;8791.252743516745;8833.469991800512;8863.512506812187;8723.258523025486;8785.385023048453;8790.824183516293;8803.823923521493;8906.198442140238;6986.476014298948;6998.4751143664425;7032.156141262979;7054.365107140382;7056.6118863463;6633.834154146185;6682.198136223684;6780.660966951534;6799.456043516606;6883.827904302432;7661.965634639252;7848.9215107848195;7886.171951944963;7901.960490197513;7923.960380198062;7844.21557844211;8073.6770529178175;8074.273315401642;8078.676852925817;8173.427860049977;6647;6652.800415987528;6662.56693314933;6662.56693314933;6675.265720770614;7108.680109395193;7149;7176.928230717626;7183.604901730455;7202.027726256888;6722.495812814156;6755.864882702417;6790.98135279712;6803.7618683345845;6866.588004719732;6570;6571.112899758471;6610.3389661035435;6734.831629209309;6754.763583274562;6014.6391216527145;6155.907661385172;6734.427573656294;6817.625030623165;6867.690953906987;5957.255343082114;6008.218931538872;6033.276006879202;6086.543509236736;6091;5894.469497745052;6086.543509236913;6117.632942023315;6128.32588415265;6191.102290167991 02:40:54 INFO - 2015-11-04 02:40:54,709 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.39219394858844;318.1648173544446;323.51634306711463;323.75394700028;325.8468519795697;5871.383504731995;6005.549583781218;6063.87872242556;6091.847703807407;6098.75604975801;5867.1492633568105;5950.613210141338;5971.134185543094;6004.609700369473;6023.87952240956;4518.412606361185;4577.542245775412;4610.308453731934;4625.9768701156445;4662.370579971711;4552.726836389811;4585.862424127282;4619.538046195387;4625.768711564425;4637.930431043537;4574.702644328108;4584.816607335702;4587;4605.171069207541;4606.884827879313;4605.4933957264675;4609.608183304423;4610.9077818443775;4614.515475875052;4626.514216007305;3837.7889216093104;3957.465742124834;3969.206158768258;3976;3979.761214327121;5848.502877255439;5863;5866.6186697864505;5879.147523609053;5893.911591326134;5168.405633352175;5172.172452407634;5177.068127737006;5179.19722443022;5181.896362072775;6084.726187321537;6174.104754810573;6202.81391558254;6304.148939893147;6342.9365706342805;4197.811098500575;4204.957950420518;4207.831686732527;4226.873193804191;4231.788410579489;6446.903296450557;6634.767783127616;6652.667366631697;6671.566348187353;6683.2314283857;4194.832206711697;4262.637675797592;4303.548127446636;4326.545712700121;4347.434833471629;4404.141192467502;4433.600975912119;4444.555544445594;4456.77716114193;4503;5165.251038599382;5173.172292433268;5174.767135478837;5222.686638801608;5238.5547228486;6345.143405640272;6350.301466838644;6359.077933699587;6391.904121438182;6396.71214795326;1524.3673875341608;1553.3708847916612;1569.7096037233148;1586.643005323816;1587.8491543303367;1011.0344620887035;1018.7198520406947;1021.7292417509366;1027.2244455436098;1032.0402026115785;5998.910016349758;6009.609375390585;6016.037434010537;6021.608595441282;6038.698065096815;6480.092787009822;6483.254425741005;6531.118299029666;6542.672866356663;6558.081868538313;5995.490383317467;6074.665893375818;6085.726142323606;6096.481799047131;6097.268327800603;3447.5345828312857;3621.257642183346;3622.8007459589976;3622.855085796539;3646.5259516262718;6636.336366363325;6645.06969024337;6652.600843949379;6706.094677218611;6727.192736871607;6701.530892837454;6749.865002700017;6764.5603035802515;6799.694013769392;6822.897656535156;6458.095866578683;6499.577527460889;6633.204015518072;6641.8007459777255;6642.236142843538;6528.053432252392;6556.0493728410065;6658.800235992928;6670.966645166937;6696.866062678817;6550.705218265094;6550.868982620225;6565.277819439953;6578.276389597237;6615.834604134935;6575.30959249291;6763.695633696397;6775.1531058617675;6805.65971701403;6808.28513006147;4375.234333991602;4380.080183161572;4388.188185185751;4388.517263100993;4396.626286765661;6624.900626490703;6665.400113989765;6674.299198584079;6687.899681504879;6689.899651505329;6267.5299352549655;6445.323241059621;6470.579412338183;6480.319566445644;6511.055896895018;6396.200474940632;6407.295197528175;6414.486841052798;6439.356064393523;6449.4840412765925;6282.591631543935;6297.307296197506;6297.811065667854;6306.243250809932;6313.46335561464;6268.4671802897265;6495.2855185928565;6496.545241833026;6502.544821862613;6509.218893732783;6261.7182226799;6284.842878928063;6305.621662700252;6318.210223722035;6321.747130114928 02:40:54 INFO - 2015-11-04 02:40:54,713 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.550176883257;755.6863901480885;756.9280918312759;766.6473422225774;767.6852490478905;13617.931910340447;14115.551486685506;14219.715605687892;14221.288935553233;14232.501862434818;12861.614151575444;13183.934080329609;13335.066545341806;13352.33238338084;13464.394102265396;696.7909627111871;710.0591715976326;869.026690107081;912.9863052054225;915.839728047589;891.1400498518927;898.4384759525296;908.7591788176138;917.5687426909342;918.1048477734222;918.0681608167715;932.2914584915445;950.6435086842434;958.8609651600514;959.3188835926501;717.5766297884247;726.6512074204411;867.9001914779818;929.3355250995503;953.9379940303893;686.6463771157808;687.4672129099938;687.6114995027793;696.3106524540719;700.4886432904009;13357.065005449622;13464.057515973886;13489.258090805002;13511.054226204169;13528.25594592297;11127.888721112766;11536;11814.704632384173;12088;12275.140740148194;9273.258139348836;9368.859467107999;9405.670801521983;9513.857292140554;10050.095491405735;3218.5976752905885;3289.5394644749754;3452.654734526552;3491.94762078569;3496.7552271341015;47439.5256047442;48173.27740083937;48533.27200092001;49047.264291035666;49195.75402123002;8907.287417006624;8907.827624397156;9116.58975346111;9371.578278977462;9671.177949874198;19506;19600.60798784045;19660.213591456468;19728.210871564977;19876.41606591134;7144.821379465555;7171.677274522659;7212.891806622905;7224.1692205396;7304.086989126359;3707.0917625182;3710.18375957289;3884.261990221849;3921.1569512554365;3931.803409829497;3029.560713696502;3061.601991741104;3077.2614572502885;3078.6459557151215;3097.98451007748;440.8082484119418;444.4200318584214;451.1563376485992;451.36357735592657;451.59356579079093;470.56243177093626;526.4919352824467;528.6141116984622;536.1020291012538;571.6341541413499;7780.610969451504;7995.760127196193;8017.599120044091;8123.512589244664;8258.628361723617;407.5598353777972;517.3713937565875;537.5081800152816;564.1594024902865;594.5897330841792;3561.5904171020147;3794.203217324393;3906.628870257321;3953.743006704555;3971.543272523697;58480.7075964626;58848;60738.392616074154;60858;61145.69427152836;51791.7410412953;51898;52066;52206;53772.73113634407;48588.02823943572;48917;49033.509664903606;49182.75408622934;49223.26165107526;8234.094249632655;8273.627686754231;8326;8414.83170336602;8477.364197685074;34637.48043779396;35367.82316088403;35502.46746298756;35759.106022349646;36746;44139.77930110329;46320.53679463297;48148.98137732784;48286.275705863736;49145.50854491409;7164.996900433839;7220.675069621985;7241.782746517613;7258.600776957318;7289.307515785992;10891.18316126278;11085;11129.777404452028;11446.82829757571;11591.362475063615;10369.9481502592;10417;10593;10682.465876705977;10729.731756705833;10145.34055286404;10321.329113607891;10447.634332798316;10692.091172250446;11097.445127743742;7051.964740176266;9736.853947190939;9834.164096051916;10178.643747468803;10353.792924141626;8521.701740439055;8724.825503489768;8817.294616430798;9006.594703238501;9090.454572725657;8684.565771711515;8733.737987860375;8798.604062817061;8956;9025.638974440948 02:40:54 INFO - 2015-11-04 02:40:54,713 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:40:54 INFO - 2015-11-04 02:40:54,713 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:40:54 INFO - 2015-11-04 02:40:54,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,964 02:40:54 INFO - 2015-11-04 02:40:54,714 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:40:54 INFO - 2015-11-04 02:40:54,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1446633654698__endTimestamp 02:40:54 INFO - 2015-11-04 02:40:54,714 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,714 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:40:54 INFO - 2015-11-04 02:40:54,714 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:40:54 INFO - 2015-11-04 02:40:54,714 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5250.29 Median:5425.62 stddev:547.44 (10.1%) stddev-sans-first:525.17 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: Values: 3208.9 3281.3 3297.1 3297.2 3315.3 5147.9 5275.0 5300.6 5444.1 5491.4 5016.9 5089.7 5235.4 5295.4 5425.6 4746.0 4758.0 4793.1 4810.6 4861.6 4536.6 4922.7 4987.9 5004.3 5060.9 4628.7 4707.8 4735.3 4876.9 4905.5 4887.6 4901.7 4909.5 4926.4 4951.8 4842.4 4845.6 4869.1 4874.4 4875.2 5137.0 5167.5 5293.4 5308.5 5320.0 5478.0 5624.1 5649.7 5697.8 5716.6 5644.0 5680.9 5705.3 5748.7 5752.6 5022.6 5084.6 5172.8 5208.3 5410.2 5714.3 5779.2 5795.2 5836.6 5902.6 5449.7 5456.0 5472.2 5566.6 5570.3 5412.1 5552.0 5641.7 5681.5 5709.6 5567.7 5654.2 5656.3 5661.7 5703.7 5569.2 5646.9 5648.0 5665.8 5690.4 4207.3 4353.5 4354.6 4356.4 4422.0 3982.1 3998.6 4001.7 4006.6 4010.6 5242.8 5312.5 5321.6 5362.5 5423.2 5537.3 5640.5 5663.9 5702.2 5720.8 5275.7 5330.1 5331.3 5331.5 5350.4 4988.9 4989.0 4991.1 5030.5 5085.8 5487.0 5534.3 5632.7 5685.1 5802.3 5633.1 5636.5 5675.8 5680.7 5745.1 5731.3 5749.3 5761.9 5767.6 5819.8 5323.4 5520.8 5570.8 5583.6 5603.0 5660.7 5694.0 5715.7 5719.7 5765.1 5492.4 5513.8 5519.4 5521.7 5568.1 5287.5 5314.6 5338.2 5434.9 5507.4 5215.3 5446.2 5455.7 5463.8 5549.2 5548.9 5555.8 5556.9 5616.0 5640.5 5216.3 5304.5 5387.0 5411.1 5440.1 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46410.48 Median:16609.23 stddev:77335.24 (465.6%) stddev-sans-first:77475.50 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: Values: 540.3 555.6 556.6 563.7 570.3 31067.0 31784.8 37403.3 37434.0 37938.8 41045.6 41435.2 41625.4 41751.0 42103.2 7934.6 8876.8 9068.7 9191.0 9212.4 8097.9 10748.5 10958.9 11094.7 11108.7 10870.7 10970.2 10977.8 11011.3 11021.3 8324.5 8505.6 10857.5 10924.5 10939.3 10719.6 10729.5 10870.6 10907.9 10916.5 39797.2 40164.0 40255.4 40266.6 40366.2 2871.0 2955.1 3014.1 3037.8 3050.0 27298.7 27318.9 27575.6 27656.9 27838.9 2302.0 2328.4 2332.5 2357.1 2479.1 293008.0 293925.0 294469.0 294884.0 296017.5 55546.2 57053.0 60334.4 60784.0 65435.0 60047.0 60156.0 60869.0 60875.0 61259.0 16153.8 16554.1 16772.2 16844.6 16981.3 12644.1 12816.6 12848.0 12863.4 12881.4 19145.7 19333.2 19417.7 19531.4 19563.2 7609.9 7782.2 7788.8 7909.8 7947.5 860.0 909.5 1089.9 1104.3 1114.6 26851.5 27129.0 27264.7 27459.2 27553.2 1041.4 1070.0 1170.0 1186.4 1220.0 14081.7 14148.0 14389.4 14423.4 14438.6 323709.0 328329.0 329651.0 330479.0 330484.0 51889.2 53785.7 53965.2 53977.0 54077.5 1375.2 1392.8 1394.9 1397.7 1400.9 23206.8 28104.6 29244.7 29768.0 30180.7 50604.2 51083.2 51110.2 51123.0 51133.5 256944.0 260271.0 260358.0 260672.0 264819.0 31365.7 32113.2 32166.7 32175.4 32706.7 40192.8 41019.4 41207.6 41472.4 41820.6 34895.0 34988.3 35788.8 35958.1 36105.0 27503.0 33706.7 34177.0 35267.8 35963.6 33862.8 35625.1 36587.5 36687.8 36725.0 26602.3 29975.3 30916.8 31411.5 31613.2 22331.3 22742.2 22845.2 22890.5 23510.3 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,715 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23270.39 Median:378541.00 stddev:61998.66 (16.4%) stddev-sans-first:62148.66 02:40:54 INFO - 2015-11-04 02:40:54,717 DEBUG : BROWSER_OUTPUT: Values: 333.3 336.2 339.8 340.4 340.6 14575.5 15048.9 17030.6 17495.8 18187.3 14133.0 15352.4 17543.3 17874.4 18076.4 5194.2 5322.8 5343.1 5364.5 5371.9 3396.4 3479.3 4633.4 4779.8 5316.4 4642.4 4740.4 4740.8 4756.9 4784.2 4472.0 4710.4 4746.1 4751.6 4850.4 4043.5 4084.7 4086.6 4087.3 4101.0 12773.9 13177.7 13245.0 13338.0 13629.5 1763.9 1798.6 1825.1 1847.0 1850.8 9583.2 9605.4 9605.6 9735.0 9850.6 1455.9 1463.3 1489.7 1500.0 1511.9 57359.7 57689.4 58198.7 59017.4 72600.9 16601.8 17492.3 17689.6 17751.9 17768.6 25072.4 25381.4 25383.2 25396.0 25447.5 10015.5 10144.1 10159.7 10221.8 10234.1 8710.1 8719.6 8743.3 8791.3 8892.6 8112.7 8244.5 8271.3 8275.7 8284.5 1337.7 2147.9 3081.7 3184.2 3264.8 413.3 417.4 418.0 451.5 473.3 11734.2 11851.2 11960.1 12023.0 12103.6 445.6 446.9 450.3 455.3 474.6 5156.8 5310.7 6427.5 6567.2 6649.4 367493.0 375939.0 377943.0 379139.0 382989.0 40627.2 73688.6 73714.6 75823.0 75921.6 501.3 505.1 508.1 509.2 509.8 10886.6 11043.5 11173.4 11273.2 11319.7 34214.0 34379.3 34424.7 36601.8 36944.8 47443.5 47714.3 48470.3 48670.3 48711.8 6202.3 6315.6 6316.8 6385.1 6426.8 11890.8 11917.8 11999.1 12044.8 12136.1 8712.4 8784.8 8939.5 10010.9 10409.6 2054.6 6041.5 10076.8 10196.4 10408.8 10421.9 10527.5 10771.6 10784.7 10801.4 6237.3 6273.3 6277.2 6296.7 6316.7 10116.6 10298.8 10426.1 10432.3 10559.5 02:40:54 INFO - 2015-11-04 02:40:54,717 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,717 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5156.92 Median:3636.24 stddev:2677.97 (73.6%) stddev-sans-first:2665.83 02:40:54 INFO - 2015-11-04 02:40:54,719 DEBUG : BROWSER_OUTPUT: Values: 842.9 1391.1 1396.1 1410.9 1495.9 6745.7 7170.7 7305.5 7310.3 7319.2 7161.8 7326.5 7330.6 7346.6 7410.1 1907.5 1920.8 2123.1 2181.4 2182.1 2180.0 2198.8 2209.2 2212.0 2216.1 1987.1 2113.0 2127.2 2138.5 2141.0 1911.6 1946.9 2154.4 2173.0 2197.8 2166.4 2195.9 2220.4 2246.5 2246.7 7293.1 7314.9 7387.2 7431.4 7440.3 4510.7 4566.6 4600.6 4602.8 4636.5 2662.9 2731.5 2753.8 2785.6 2801.2 851.9 855.0 865.1 871.7 893.9 9563.9 9785.9 9794.3 9799.9 9807.3 4088.2 4115.8 4179.4 4181.1 4192.8 8626.1 8643.5 8706.9 8733.5 8757.4 4691.9 4692.1 4692.1 4693.9 4699.6 4259.9 4263.9 4266.6 4269.8 4283.2 3464.5 3519.7 3531.3 3541.0 3560.8 1129.1 1172.2 1176.3 1180.2 1180.8 971.3 977.1 1009.0 1012.6 1195.9 6525.2 7016.5 7018.0 7153.0 7226.3 632.4 647.4 658.8 662.1 671.8 5492.5 5516.4 5603.2 5604.7 5618.7 8583.2 8726.9 8791.3 8833.5 8863.5 8723.3 8785.4 8790.8 8803.8 8906.2 6986.5 6998.5 7032.2 7054.4 7056.6 6633.8 6682.2 6780.7 6799.5 6883.8 7662.0 7848.9 7886.2 7902.0 7924.0 7844.2 8073.7 8074.3 8078.7 8173.4 6647.0 6652.8 6662.6 6662.6 6675.3 7108.7 7149.0 7176.9 7183.6 7202.0 6722.5 6755.9 6791.0 6803.8 6866.6 6570.0 6571.1 6610.3 6734.8 6754.8 6014.6 6155.9 6734.4 6817.6 6867.7 5957.3 6008.2 6033.3 6086.5 6091.0 5894.5 6086.5 6117.6 6128.3 6191.1 02:40:54 INFO - 2015-11-04 02:40:54,719 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,719 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5299.05 Median:6022.74 stddev:1621.31 (26.9%) stddev-sans-first:1582.15 02:40:54 INFO - 2015-11-04 02:40:54,720 DEBUG : BROWSER_OUTPUT: Values: 317.4 318.2 323.5 323.8 325.8 5871.4 6005.5 6063.9 6091.8 6098.8 5867.1 5950.6 5971.1 6004.6 6023.9 4518.4 4577.5 4610.3 4626.0 4662.4 4552.7 4585.9 4619.5 4625.8 4637.9 4574.7 4584.8 4587.0 4605.2 4606.9 4605.5 4609.6 4610.9 4614.5 4626.5 3837.8 3957.5 3969.2 3976.0 3979.8 5848.5 5863.0 5866.6 5879.1 5893.9 5168.4 5172.2 5177.1 5179.2 5181.9 6084.7 6174.1 6202.8 6304.1 6342.9 4197.8 4205.0 4207.8 4226.9 4231.8 6446.9 6634.8 6652.7 6671.6 6683.2 4194.8 4262.6 4303.5 4326.5 4347.4 4404.1 4433.6 4444.6 4456.8 4503.0 5165.3 5173.2 5174.8 5222.7 5238.6 6345.1 6350.3 6359.1 6391.9 6396.7 1524.4 1553.4 1569.7 1586.6 1587.8 1011.0 1018.7 1021.7 1027.2 1032.0 5998.9 6009.6 6016.0 6021.6 6038.7 6480.1 6483.3 6531.1 6542.7 6558.1 5995.5 6074.7 6085.7 6096.5 6097.3 3447.5 3621.3 3622.8 3622.9 3646.5 6636.3 6645.1 6652.6 6706.1 6727.2 6701.5 6749.9 6764.6 6799.7 6822.9 6458.1 6499.6 6633.2 6641.8 6642.2 6528.1 6556.0 6658.8 6671.0 6696.9 6550.7 6550.9 6565.3 6578.3 6615.8 6575.3 6763.7 6775.2 6805.7 6808.3 4375.2 4380.1 4388.2 4388.5 4396.6 6624.9 6665.4 6674.3 6687.9 6689.9 6267.5 6445.3 6470.6 6480.3 6511.1 6396.2 6407.3 6414.5 6439.4 6449.5 6282.6 6297.3 6297.8 6306.2 6313.5 6268.5 6495.3 6496.5 6502.5 6509.2 6261.7 6284.8 6305.6 6318.2 6321.7 02:40:54 INFO - 2015-11-04 02:40:54,720 DEBUG : BROWSER_OUTPUT: 02:40:54 INFO - 2015-11-04 02:40:54,721 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13733.93 Median:26154.56 stddev:16670.66 (63.7%) stddev-sans-first:16688.61 02:40:54 INFO - 2015-11-04 02:40:54,722 DEBUG : BROWSER_OUTPUT: Values: 681.6 755.7 756.9 766.6 767.7 13617.9 14115.6 14219.7 14221.3 14232.5 12861.6 13183.9 13335.1 13352.3 13464.4 696.8 710.1 869.0 913.0 915.8 891.1 898.4 908.8 917.6 918.1 918.1 932.3 950.6 958.9 959.3 717.6 726.7 867.9 929.3 953.9 686.6 687.5 687.6 696.3 700.5 13357.1 13464.1 13489.3 13511.1 13528.3 11127.9 11536.0 11814.7 12088.0 12275.1 9273.3 9368.9 9405.7 9513.9 10050.1 3218.6 3289.5 3452.7 3491.9 3496.8 47439.5 48173.3 48533.3 49047.3 49195.8 8907.3 8907.8 9116.6 9371.6 9671.2 19506.0 19600.6 19660.2 19728.2 19876.4 7144.8 7171.7 7212.9 7224.2 7304.1 3707.1 3710.2 3884.3 3921.2 3931.8 3029.6 3061.6 3077.3 3078.6 3098.0 440.8 444.4 451.2 451.4 451.6 470.6 526.5 528.6 536.1 571.6 7780.6 7995.8 8017.6 8123.5 8258.6 407.6 517.4 537.5 564.2 594.6 3561.6 3794.2 3906.6 3953.7 3971.5 58480.7 58848.0 60738.4 60858.0 61145.7 51791.7 51898.0 52066.0 52206.0 53772.7 48588.0 48917.0 49033.5 49182.8 49223.3 8234.1 8273.6 8326.0 8414.8 8477.4 34637.5 35367.8 35502.5 35759.1 36746.0 44139.8 46320.5 48149.0 48286.3 49145.5 7165.0 7220.7 7241.8 7258.6 7289.3 10891.2 11085.0 11129.8 11446.8 11591.4 10369.9 10417.0 10593.0 10682.5 10729.7 10145.3 10321.3 10447.6 10692.1 11097.4 7052.0 9736.9 9834.2 10178.6 10353.8 8521.7 8724.8 8817.3 9006.6 9090.5 8684.6 8733.7 8798.6 8956.0 9025.6 02:40:54 INFO - 2015-11-04 02:40:54,722 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:40:54 INFO - 2015-11-04 02:40:54,722 DEBUG : BROWSER_OUTPUT: 02:40:55 INFO - 2015-11-04 02:40:55,358 INFO : Browser exited with error code: 0 02:40:55 INFO - 2015-11-04 02:40:55,386 INFO : Completed test dromaeo_css (00:18:34) 02:40:55 INFO - 2015-11-04 02:40:55,386 INFO : Starting test kraken 02:40:55 INFO - 2015-11-04 02:40:55,386 DEBUG : operating with platform_type : mac_ 02:40:55 INFO - 2015-11-04 02:40:55,386 INFO : Initialising browser for kraken test... 02:40:55 INFO - 2015-11-04 02:40:55,402 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpRmJGUc/profile http://localhost:55110/getInfo.html 02:40:57 INFO - 2015-11-04 02:40:57,581 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:40:57 INFO - 2015-11-04 02:40:57,581 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:40:57 INFO - 2015-11-04 02:40:57,581 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:40:57 INFO - 2015-11-04 02:40:57,581 DEBUG : BROWSER_OUTPUT: __metrics 02:40:57 INFO - 2015-11-04 02:40:57,599 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:40:58 INFO - 2015-11-04 02:40:58,288 INFO : Browser initialized. 02:40:58 INFO - 2015-11-04 02:40:58,289 INFO : Running cycle 1/1 for kraken test... 02:40:58 INFO - 2015-11-04 02:40:58,289 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpRmJGUc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:41:10 INFO - 2015-11-04 02:41:10,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 221106176 02:41:10 INFO - 2015-11-04 02:41:10,180 DEBUG : BROWSER_OUTPUT: 02:41:12 INFO - 2015-11-04 02:41:12,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55110/tests/kraken/driver.html?testName=audio-beat-detection) 02:41:13 INFO - 2015-11-04 02:41:13,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 278695936 02:41:13 INFO - 2015-11-04 02:41:13,343 DEBUG : BROWSER_OUTPUT: 02:41:15 INFO - 2015-11-04 02:41:15,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55110/tests/kraken/driver.html?testName=audio-dft) 02:41:16 INFO - 2015-11-04 02:41:16,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 291741696 02:41:16 INFO - 2015-11-04 02:41:16,574 DEBUG : BROWSER_OUTPUT: 02:41:19 INFO - 2015-11-04 02:41:19,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55110/tests/kraken/driver.html?testName=audio-fft) 02:41:20 INFO - 2015-11-04 02:41:20,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 273874944 02:41:20 INFO - 2015-11-04 02:41:20,121 DEBUG : BROWSER_OUTPUT: 02:41:22 INFO - 2015-11-04 02:41:22,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55110/tests/kraken/driver.html?testName=audio-oscillator) 02:41:22 INFO - 2015-11-04 02:41:22,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 275562496 02:41:22 INFO - 2015-11-04 02:41:22,718 DEBUG : BROWSER_OUTPUT: 02:41:24 INFO - 2015-11-04 02:41:24,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:25 INFO - 2015-11-04 02:41:25,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 276750336 02:41:25 INFO - 2015-11-04 02:41:25,495 DEBUG : BROWSER_OUTPUT: 02:41:28 INFO - 2015-11-04 02:41:28,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55110/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:29 INFO - 2015-11-04 02:41:29,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 276598784 02:41:29 INFO - 2015-11-04 02:41:29,125 DEBUG : BROWSER_OUTPUT: 02:41:32 INFO - 2015-11-04 02:41:32,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55110/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:32 INFO - 2015-11-04 02:41:32,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 277716992 02:41:32 INFO - 2015-11-04 02:41:32,870 DEBUG : BROWSER_OUTPUT: 02:41:35 INFO - 2015-11-04 02:41:35,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55110/tests/kraken/driver.html?testName=json-parse-financial) 02:41:36 INFO - 2015-11-04 02:41:36,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 277786624 02:41:36 INFO - 2015-11-04 02:41:36,326 DEBUG : BROWSER_OUTPUT: 02:41:37 INFO - 2015-11-04 02:41:37,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:41:38 INFO - 2015-11-04 02:41:38,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 311775232 02:41:38 INFO - 2015-11-04 02:41:38,465 DEBUG : BROWSER_OUTPUT: 02:41:40 INFO - 2015-11-04 02:41:40,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:40 INFO - 2015-11-04 02:41:40,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 312635392 02:41:40 INFO - 2015-11-04 02:41:40,915 DEBUG : BROWSER_OUTPUT: 02:41:43 INFO - 2015-11-04 02:41:43,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:43 INFO - 2015-11-04 02:41:43,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 320421888 02:41:43 INFO - 2015-11-04 02:41:43,587 DEBUG : BROWSER_OUTPUT: 02:41:46 INFO - 2015-11-04 02:41:46,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:46 INFO - 2015-11-04 02:41:46,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 321929216 02:41:46 INFO - 2015-11-04 02:41:46,719 DEBUG : BROWSER_OUTPUT: 02:41:49 INFO - 2015-11-04 02:41:49,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:49 INFO - 2015-11-04 02:41:49,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 319381504 02:41:49 INFO - 2015-11-04 02:41:49,906 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55110/tests/kraken/driver.html?testName=ai-astar) 02:41:51 INFO - 2015-11-04 02:41:51,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 379809792 02:41:51 INFO - 2015-11-04 02:41:51,871 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,873 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:41:51 INFO - 2015-11-04 02:41:51,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:41:51 INFO - 2015-11-04 02:41:51,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:41:51 INFO - 2015-11-04 02:41:51,873 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:41:51 INFO - 2015-11-04 02:41:51,874 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;107;105;107;106;109;106;105;103;106 02:41:51 INFO - 2015-11-04 02:41:51,874 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;129;151;161;129;149;152;126;162;126 02:41:51 INFO - 2015-11-04 02:41:51,874 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;162;164;162;162;163;163;163 02:41:51 INFO - 2015-11-04 02:41:51,874 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;82;85;85;68;68;71;77;84;67 02:41:51 INFO - 2015-11-04 02:41:51,874 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;95;141;88;89;89;131;88;88;136 02:41:51 INFO - 2015-11-04 02:41:51,875 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;114;114;120;115;121;121;115;120;115 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;124;124;125;124;125;125;125;126;127 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;99;101;100;100;100;101;101;100;99 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;57;57;57;57;57;65;55;56 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;67;69;68;69;68;68 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;86;86;86;86;86;86;88;86 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;124;125;121;123;129;131;132;125;124 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;151;149;147;149;152;150;149;150;140 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;69;69;71;72;69;71;70 02:41:51 INFO - 2015-11-04 02:41:51,876 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:41:51 INFO - 2015-11-04 02:41:51,877 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:41:51 INFO - 2015-11-04 02:41:51,877 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,916 02:41:51 INFO - 2015-11-04 02:41:51,877 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:41:51 INFO - 2015-11-04 02:41:51,877 DEBUG : BROWSER_OUTPUT: __startTimestamp1446633711872__endTimestamp 02:41:51 INFO - 2015-11-04 02:41:51,877 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,878 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:41:51 INFO - 2015-11-04 02:41:51,878 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:41:51 INFO - 2015-11-04 02:41:51,878 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,878 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.20 Median:106.50 stddev:1.69 (1.6%) stddev-sans-first:1.66 02:41:51 INFO - 2015-11-04 02:41:51,878 DEBUG : BROWSER_OUTPUT: Values: 108.0 107.0 105.0 107.0 106.0 109.0 106.0 105.0 103.0 106.0 02:41:51 INFO - 2015-11-04 02:41:51,878 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,880 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:151.50 stddev:15.07 (9.9%) stddev-sans-first:15.15 02:41:51 INFO - 2015-11-04 02:41:51,880 DEBUG : BROWSER_OUTPUT: Values: 158.0 129.0 151.0 161.0 129.0 149.0 152.0 126.0 162.0 126.0 02:41:51 INFO - 2015-11-04 02:41:51,880 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,880 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 02:41:51 INFO - 2015-11-04 02:41:51,880 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 162.0 164.0 162.0 162.0 163.0 163.0 163.0 02:41:51 INFO - 2015-11-04 02:41:51,881 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,881 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.90 Median:79.50 stddev:7.55 (9.5%) stddev-sans-first:7.87 02:41:51 INFO - 2015-11-04 02:41:51,881 DEBUG : BROWSER_OUTPUT: Values: 72.0 82.0 85.0 85.0 68.0 68.0 71.0 77.0 84.0 67.0 02:41:51 INFO - 2015-11-04 02:41:51,881 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,881 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:88.50 stddev:22.25 (25.1%) stddev-sans-first:23.48 02:41:51 INFO - 2015-11-04 02:41:51,881 DEBUG : BROWSER_OUTPUT: Values: 98.0 95.0 141.0 88.0 89.0 89.0 131.0 88.0 88.0 136.0 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:120.00 stddev:3.20 (2.7%) stddev-sans-first:3.15 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: Values: 121.0 114.0 114.0 120.0 115.0 121.0 121.0 115.0 120.0 115.0 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.90 Median:125.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 124.0 125.0 124.0 125.0 125.0 125.0 126.0 127.0 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,882 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.20 Median:101.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: Values: 101.0 99.0 101.0 100.0 100.0 100.0 101.0 101.0 100.0 99.0 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.72 (4.8%) stddev-sans-first:2.88 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 57.0 57.0 57.0 57.0 57.0 65.0 55.0 56.0 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 02:41:51 INFO - 2015-11-04 02:41:51,883 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 67.0 69.0 68.0 69.0 68.0 68.0 02:41:51 INFO - 2015-11-04 02:41:51,884 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,885 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:41:51 INFO - 2015-11-04 02:41:51,885 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 86.0 86.0 86.0 86.0 86.0 86.0 88.0 86.0 02:41:51 INFO - 2015-11-04 02:41:51,885 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.50 stddev:3.56 (2.8%) stddev-sans-first:3.77 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: Values: 126.0 124.0 125.0 121.0 123.0 129.0 131.0 132.0 125.0 124.0 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:150.00 stddev:3.48 (2.3%) stddev-sans-first:3.50 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: Values: 152.0 151.0 149.0 147.0 149.0 152.0 150.0 149.0 150.0 140.0 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.27 02:41:51 INFO - 2015-11-04 02:41:51,886 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 69.0 69.0 71.0 72.0 69.0 71.0 70.0 02:41:51 INFO - 2015-11-04 02:41:51,887 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:41:51 INFO - 2015-11-04 02:41:51,887 DEBUG : BROWSER_OUTPUT: 02:41:52 INFO - 2015-11-04 02:41:52,526 INFO : Browser exited with error code: 0 02:41:52 INFO - 2015-11-04 02:41:52,576 INFO : Completed test kraken (00:00:57) 02:41:52 INFO - 2015-11-04 02:41:52,576 INFO : Starting test v8_7 02:41:52 INFO - 2015-11-04 02:41:52,576 DEBUG : operating with platform_type : mac_ 02:41:52 INFO - 2015-11-04 02:41:52,576 INFO : Initialising browser for v8_7 test... 02:41:52 INFO - 2015-11-04 02:41:52,593 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpZxd1Q4/profile http://localhost:55110/getInfo.html 02:41:54 INFO - 2015-11-04 02:41:54,714 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:41:54 INFO - 2015-11-04 02:41:54,714 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:41:54 INFO - 2015-11-04 02:41:54,714 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:41:54 INFO - 2015-11-04 02:41:54,714 DEBUG : BROWSER_OUTPUT: __metrics 02:41:54 INFO - 2015-11-04 02:41:54,732 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:41:55 INFO - 2015-11-04 02:41:55,491 INFO : Browser initialized. 02:41:55 INFO - 2015-11-04 02:41:55,492 INFO : Running cycle 1/1 for v8_7 test... 02:41:55 INFO - 2015-11-04 02:41:55,492 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpZxd1Q4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:42:07 INFO - 2015-11-04 02:42:07,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 220905472 02:42:07 INFO - 2015-11-04 02:42:07,348 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55110/tests/v8_7/run.html (next: http://localhost:55110/tests/v8_7/run.html) 02:42:29 INFO - 2015-11-04 02:42:29,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 695160832 02:42:29 INFO - 2015-11-04 02:42:29,318 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,318 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.60758766047135 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.5208333333333 02:42:29 INFO - 2015-11-04 02:42:29,319 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5775.862068965517 02:42:29 INFO - 2015-11-04 02:42:29,320 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2053.388090349076 02:42:29 INFO - 2015-11-04 02:42:29,320 DEBUG : BROWSER_OUTPUT: |5;Earley;919.1176470588235 02:42:29 INFO - 2015-11-04 02:42:29,320 DEBUG : BROWSER_OUTPUT: |6;Boyer;12858.97435897436 02:42:29 INFO - 2015-11-04 02:42:29,320 DEBUG : BROWSER_OUTPUT: |7;RegExp;29852.941176470587 02:42:29 INFO - 2015-11-04 02:42:29,320 DEBUG : BROWSER_OUTPUT: |8;Splay;616.9031462060457 02:42:29 INFO - 2015-11-04 02:42:29,320 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 02:42:29 INFO - 2015-11-04 02:42:29,321 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:42:29 INFO - 2015-11-04 02:42:29,321 DEBUG : BROWSER_OUTPUT: __startTimestamp1446633749316__endTimestamp 02:42:29 INFO - 2015-11-04 02:42:29,321 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,321 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:42:29 INFO - 2015-11-04 02:42:29,321 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:42:29 INFO - 2015-11-04 02:42:29,321 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,322 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,322 DEBUG : BROWSER_OUTPUT: Values: 166.0 02:42:29 INFO - 2015-11-04 02:42:29,322 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,322 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,322 DEBUG : BROWSER_OUTPUT: Values: 191.6 02:42:29 INFO - 2015-11-04 02:42:29,322 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.52 Median:325.52 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: Values: 325.5 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5775.86 Median:5775.86 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: Values: 5775.9 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,323 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2053.39 Median:2053.39 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: Values: 2053.4 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:919.12 Median:919.12 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: Values: 919.1 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12858.97 Median:12858.97 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: Values: 12859.0 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,324 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29852.94 Median:29852.94 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: Values: 29852.9 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.90 Median:616.90 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: Values: 616.9 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: Values: 5803.5 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:42:29 INFO - 2015-11-04 02:42:29,325 DEBUG : BROWSER_OUTPUT: 02:42:29 INFO - 2015-11-04 02:42:29,959 INFO : Browser exited with error code: 0 02:42:29 INFO - 2015-11-04 02:42:29,979 INFO : Completed test v8_7 (00:00:37) 02:42:30 INFO - 2015-11-04 02:42:30,159 INFO : Completed test suite (00:20:09) 02:42:30 INFO - 2015-11-04 02:42:30,159 DEBUG : Working with test: dromaeo_css 02:42:30 INFO - 2015-11-04 02:42:30,159 DEBUG : Generating results file: dromaeo_css 02:42:30 INFO - 2015-11-04 02:42:30,160 DEBUG : Working with test: kraken 02:42:30 INFO - 2015-11-04 02:42:30,160 DEBUG : Generating results file: kraken 02:42:30 INFO - 2015-11-04 02:42:30,160 INFO : javascript benchmark 02:42:30 INFO - 2015-11-04 02:42:30,160 DEBUG : Working with test: v8_7 02:42:30 INFO - 2015-11-04 02:42:30,160 DEBUG : Generating results file: v8_7 02:42:30 INFO - 2015-11-04 02:42:30,161 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:42:30 INFO - 2015-11-04 02:42:30,215 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 02:42:30 INFO - 2015-11-04 02:42:30,215 DEBUG : process_Request line: dromaeo_css 6662.11 graph.html#tests=[[72,64,55]] 02:42:30 INFO - 2015-11-04 02:42:30,215 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:42:30 INFO - 2015-11-04 02:42:30,318 DEBUG : process_Request line: kraken 1491.80 graph.html#tests=[[232,64,55]] 02:42:30 INFO - 2015-11-04 02:42:30,319 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:42:30 INFO - 2015-11-04 02:42:30,423 DEBUG : process_Request line: v8_7 18218.05 graph.html#tests=[[230,64,55]] 02:42:30 INFO - 2015-11-04 02:42:30,424 INFO : javascript benchmark 02:42:30 INFO - 2015-11-04 02:42:30,425 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [333.31337444863567, 336.20990671920976, 339.7502835415969, 340.37541112059387, 340.59469231614383, 14575.489857854976, 15048.924755376207, 17030.574235644115, 17495.82504174958, 18187.272509099635, 14133.0, 15352.385904563804, 17543.298268069295, 17874.37439689611, 18076.36732714355, 5194.2208668699805, 5322.76047577858, 5343.118385466393, 5364.490373414519, 5371.865703357428, 3396.371671240816, 3479.2867462170193, 4633.351330813689, 4779.80880764769, 5316.38861530925, 4642.442906851183, 4740.36005139307, 4740.834070807505, 4756.881077973061, 4784.234522476405, 4471.955280447219, 4710.387649605546, 4746.145693775119, 4751.596114330268, 4850.442199147108, 4043.454133691973, 4084.65280451162, 4086.6322031017353, 4087.346024636044, 4101.036256479725, 12773.936130319382, 13177.736445271137, 13245.0, 13338.0, 13629.454821807116, 1763.8588912886937, 1798.6402719456162, 1825.0783354406074, 1847.048769883511, 1850.7871594766639, 9583.185429238523, 9605.37565058269, 9605.567749451291, 9734.951325243328, 9850.556724947395, 1455.89080818939, 1463.253740592295, 1489.6722721001363, 1500.047469856638, 1511.8639322460922, 57359.71320143414, 57689.42310576882, 58198.70900645512, 59017.40982590205, 72600.91098633577, 16601.750973735405, 17492.300307987793, 17689.557761055818, 17751.911240443715, 17768.55578610545, 25072.373190670016, 25381.36546586313, 25383.238502844943, 25396.0, 25447.491050178895, 10015.549300281506, 10144.13774829133, 10159.7460063499, 10221.846672299922, 10234.078932895925, 8710.12898710124, 8719.564021798884, 8743.344249181337, 8791.340649451316, 8892.59983300753, 8112.716054938049, 8244.54654993969, 8271.296939760188, 8275.668973241003, 8284.50292982423, 1337.71239183576, 2147.947505722185, 3081.6918308169, 3184.172115250052, 3264.7877887937207, 413.2891426745992, 417.44688288018494, 418.0218289203279, 451.5304083752926, 473.30187972740623, 11734.178607497564, 11851.170418070653, 11960.102992275613, 12022.978046866114, 12103.636890893287, 445.56779923474176, 446.91955448019667, 450.257075824885, 455.26702009764256, 474.6369027693817, 5156.793728250903, 5310.6813591184655, 6427.517936154807, 6567.2447668518735, 6649.4347980421235, 367493.0, 375939.0, 377943.0, 379139.0, 382989.0, 40627.18745625071, 73688.63155684188, 73714.63142684252, 75823.0, 75921.62039189768, 501.28566792321527, 505.14125985824245, 508.1006618285614, 509.18784538660776, 509.8368522072901, 10886.61896833607, 11043.503042362952, 11173.441327933733, 11273.154513411362, 11319.660410187707, 34214.0, 34379.31241375108, 34424.655753442144, 36601.81699091488, 36944.81527592345, 47443.52556474391, 47714.28428573505, 48470.27294590513, 48670.26994595155, 48711.75644121757, 6202.34875338083, 6315.621062736251, 6316.810495685137, 6385.074164246251, 6426.807195784134, 11890.76218475643, 11917.761644766882, 11999.100067495147, 12044.819327710267, 12136.089793265364, 8712.39013269065, 8784.824303513766, 8939.463632182089, 10010.899891000996, 10409.583616655249, 2054.6404379233873, 6041.516678665608, 10076.798464030824, 10196.368581027, 10408.791824163625, 10421.895781042092, 10527.526261318411, 10771.569137234423, 10784.676459706221, 10801.405922674328, 6237.251529816451, 6273.309935906956, 6277.246730392382, 6296.748130074929, 6316.715747791269, 10116.595336186765, 10298.845517317097, 10426.113780328757, 10432.269741118049, 10559.472026398496], "dojo.html": [3208.9358212835746, 3281.27811881386, 3297.109780359303, 3297.241634424081, 3315.2872132491516, 5147.922781158286, 5275.0, 5300.602454815889, 5444.074507333763, 5491.368492623349, 5016.896282817775, 5089.720065396402, 5235.371755389349, 5295.391030031547, 5425.6202065855305, 4745.976270118662, 4757.976210118944, 4793.137235297645, 4810.639202059842, 4861.586765124968, 4536.55368417969, 4922.655414121013, 4987.875303117415, 5004.349434573501, 5060.9240861386925, 4628.745419001987, 4707.7881495332795, 4735.313379559979, 4876.926846097276, 4905.533974272438, 4887.608991280725, 4901.730404827733, 4909.533594308535, 4926.433460152057, 4951.801927922878, 4842.394700662418, 4845.636577256684, 4869.050535145648, 4874.366332376769, 4875.195592727196, 5137.0, 5167.483251674803, 5293.417724050351, 5308.469153084699, 5320.042392369372, 5477.972610136963, 5624.072028115356, 5649.661020338793, 5697.77208911643, 5716.57125715573, 5644.0, 5680.949024430493, 5705.343885453184, 5748.741306641211, 5752.626079304831, 5022.6233032522705, 5084.593232541388, 5172.844814655567, 5208.296879921238, 5410.161424979135, 5714.2571465710025, 5779.24869766936, 5795.159701843209, 5836.562257830679, 5902.616329938626, 5449.7275136243825, 5456.0, 5472.151816468454, 5566.638168519034, 5570.275864137717, 5412.134058550691, 5552.028395030934, 5641.661500309994, 5681.460261275172, 5709.628874123168, 5567.66594004361, 5654.208410822488, 5656.321241451053, 5661.716914154275, 5703.657780533182, 5569.248151499496, 5646.915296270559, 5648.0, 5665.773369065274, 5690.430956904276, 4207.347861081537, 4353.499347575006, 4354.586314300136, 4356.411884395629, 4422.0, 3982.123932734794, 3998.600139986036, 4001.7398869073418, 4006.579309172553, 4010.578889216649, 5242.816501422432, 5312.548433383128, 5321.574274058066, 5362.490563396471, 5423.240746295522, 5537.252470916455, 5640.520555752807, 5663.886722265532, 5702.173184888251, 5720.799772007959, 5275.7362131894015, 5330.093884039723, 5331.253624492574, 5331.5201631853315, 5350.384705758887, 4988.900221995613, 4988.975055124701, 4991.101601711654, 5030.471800460972, 5085.847424577269, 5487.0, 5534.280543529235, 5632.690202038763, 5685.061964775931, 5802.274715660543, 5633.126865335879, 5636.5208957237455, 5675.77296908119, 5680.6875621839545, 5745.052066408995, 5731.283589551306, 5749.338826035059, 5761.8559536011935, 5767.567432442667, 5819.79630712923, 5323.361196656426, 5520.834374968596, 5570.777168913198, 5583.609147359646, 5602.971985140048, 5660.688662123623, 5694.0, 5715.714214289352, 5719.6568205906115, 5765.106408506688, 5492.423295554069, 5513.8345849624575, 5519.420460851713, 5521.69630670317, 5568.1091025435735, 5287.471252874681, 5314.62797604164, 5338.199270109515, 5434.891302174014, 5507.421720719267, 5215.322008138917, 5446.1558458439, 5455.672659640434, 5463.7814487420055, 5549.195366671891, 5548.916766248429, 5555.833325000256, 5556.944430555643, 5616.017196990592, 5640.464155905182, 5216.347956505437, 5304.469553044819, 5386.973065134649, 5411.107167317348, 5440.129579267298], "mootools.html": [842.9030661473932, 1391.0957877379706, 1396.1413730555712, 1410.9012369134164, 1495.8653721165097, 6745.696443660035, 7170.713171473141, 7305.452091093162, 7310.2689731027, 7319.15829679587, 7161.82095447614, 7326.450516211279, 7330.560166390007, 7346.59593722345, 7410.147832999207, 1907.4754442528276, 1920.7599050118736, 2123.1189056541516, 2181.3674034529968, 2182.0944308112194, 2180.0, 2198.8240940724704, 2209.248855389167, 2212.037763572843, 2216.091402524965, 1987.0859404673868, 2112.9788702113015, 2127.2448280860303, 2138.4546940530145, 2141.025833245877, 1911.5985643014915, 1946.9415917522497, 2154.429076294783, 2172.9782702172934, 2197.824174066071, 2166.393409845246, 2195.9451013724624, 2220.400491867203, 2246.4945387287894, 2246.696695946043, 7293.088363954505, 7314.853702925911, 7387.187409384964, 7431.405487560982, 7440.330370266702, 4510.729356238603, 4566.589006989354, 4600.585947264763, 4602.792874320664, 4636.4899861015265, 2662.9334266643295, 2731.5356389413846, 2753.8072334936564, 2785.5821626755946, 2801.229661842989, 851.8509260879383, 854.9953804279946, 865.0873328638285, 871.6949067826273, 893.9463632182025, 9563.90436095637, 9785.853212201822, 9794.2654300927, 9799.853002205044, 9807.26445516589, 4088.1619268049976, 4115.773632450184, 4179.4357761701785, 4181.1010632714115, 4192.81132349045, 8626.051134375213, 8643.481391116427, 8706.91293087061, 8733.519656418957, 8757.430767000125, 4691.859244222679, 4692.1084993851055, 4692.1084993851055, 4693.929591056137, 4699.624030077585, 4259.936100958488, 4263.914721705611, 4266.616004559604, 4269.807858646368, 4283.207606592728, 3464.5496085509226, 3519.6832285094465, 3531.311394278091, 3541.026217790128, 3560.839762210707, 1129.1023636209234, 1172.2087590876124, 1176.3294921894437, 1180.2387460088196, 1180.7874582575218, 971.3006635222629, 977.1352353167498, 1009.0, 1012.584840215508, 1195.9342236177094, 6525.249596296392, 7016.473764467685, 7017.964910175417, 7152.964235178895, 7226.277372262837, 632.3518393646549, 647.3785166240368, 658.7826017414242, 662.1491383572087, 671.8253254153955, 5492.47821456961, 5516.448355164532, 5603.159526071122, 5604.719764011783, 5618.690971996498, 8583.227509524173, 8726.858726858676, 8791.252743516745, 8833.469991800512, 8863.512506812187, 8723.258523025486, 8785.385023048453, 8790.824183516293, 8803.823923521493, 8906.198442140238, 6986.476014298948, 6998.4751143664425, 7032.156141262979, 7054.365107140382, 7056.6118863463, 6633.834154146185, 6682.198136223684, 6780.660966951534, 6799.456043516606, 6883.827904302432, 7661.965634639252, 7848.9215107848195, 7886.171951944963, 7901.960490197513, 7923.960380198062, 7844.21557844211, 8073.6770529178175, 8074.273315401642, 8078.676852925817, 8173.427860049977, 6647.0, 6652.800415987528, 6662.56693314933, 6662.56693314933, 6675.265720770614, 7108.680109395193, 7149.0, 7176.928230717626, 7183.604901730455, 7202.027726256888, 6722.495812814156, 6755.864882702417, 6790.98135279712, 6803.7618683345845, 6866.588004719732, 6570.0, 6571.112899758471, 6610.3389661035435, 6734.831629209309, 6754.763583274562, 6014.6391216527145, 6155.907661385172, 6734.427573656294, 6817.625030623165, 6867.690953906987, 5957.255343082114, 6008.218931538872, 6033.276006879202, 6086.543509236736, 6091.0, 5894.469497745052, 6086.543509236913, 6117.632942023315, 6128.32588415265, 6191.102290167991], "ext.html": [540.3111033432374, 555.6443875919413, 556.563097968095, 563.6730696196206, 570.3099249907611, 31067.0, 31784.84107579462, 37403.251934961285, 37434.0, 37938.810305948435, 41045.58954410455, 41435.17129657405, 41625.37561936573, 41751.0, 42103.15793684124, 7934.563599002053, 8876.822463550725, 9068.682596109138, 9191.0, 9212.355135140542, 8097.878531821998, 10748.516316765725, 10958.890411095907, 11094.722631934226, 11108.722281942935, 10870.728231794228, 10970.177236707239, 10977.83533247002, 11011.28426652269, 11021.338719676845, 8324.500529968162, 8505.574721263913, 10857.511411986401, 10924.508397122148, 10939.28894621851, 10719.624813131502, 10729.517171727291, 10870.61952831647, 10907.945460272727, 10916.454177291183, 39797.204055919006, 40164.0, 40255.39616905749, 40266.59733402687, 40366.19267614661, 2871.0, 2955.06915321673, 3014.0957712686327, 3037.7569794416613, 3049.9542506862413, 27298.727012730014, 27318.86340568304, 27575.586366204523, 27656.86171569129, 27838.86080569584, 2301.97698023021, 2328.4295347639936, 2332.486852892361, 2357.104300365867, 2479.1199124310792, 293008.0, 293925.0, 294469.0, 294884.0, 296017.5199124012, 55546.16680749792, 57053.0, 60334.39665603376, 60784.0, 65435.0, 60047.0, 60156.0, 60869.0, 60875.0, 61259.0, 16153.757693634605, 16554.089525076237, 16772.245248963583, 16844.57888552796, 16981.320747169975, 12644.114911956258, 12816.55142070023, 12848.0, 12863.356832158355, 12881.420336084899, 19145.745417586262, 19333.226670933287, 19417.708734368996, 19531.414057578295, 19563.217471301272, 7609.885851712229, 7782.186728503106, 7788.844223115506, 7909.762707118795, 7947.483413578099, 859.9785005374915, 909.5134103254859, 1089.8665387996396, 1104.26566333389, 1114.5820317380983, 26851.462970740475, 27129.0, 27264.727352726615, 27459.17622471329, 27553.17340479789, 1041.4272150317295, 1069.9942054468775, 1169.976600467986, 1186.4483015397882, 1219.9878001219874, 14081.718365632834, 14148.0, 14389.42442302317, 14423.42306307736, 14438.639034024023, 323709.0, 328329.0, 329651.0, 330479.0, 330484.0, 51889.2216616751, 53785.731071344395, 53965.1905221422, 53977.0, 54077.45922540803, 1375.195510626295, 1392.8119703840055, 1394.9232792196324, 1397.6505873531617, 1400.9159450433006, 23206.824599234424, 28104.578431323138, 29244.7075529242, 29768.0, 30180.69819301779, 50604.24093638672, 51083.23375149301, 51110.23334650058, 51123.0, 51133.48866511287, 256944.0, 260271.0, 260358.0, 260672.0, 264819.0, 31365.686343136276, 32113.197170070936, 32166.67833321637, 32175.356492869545, 32706.67293327036, 40192.7990360058, 41019.36920812945, 41207.58792412037, 41472.37791433191, 41820.58179418167, 34895.0, 34988.32125531508, 35788.82105589456, 35958.10104747298, 36105.0, 27503.0, 33706.66293337035, 34177.0, 35267.82366088153, 35963.64036359603, 33862.83068584641, 35625.1093722659, 36587.45118823273, 36687.816560918094, 36725.0, 26602.287065462562, 29975.250618734706, 30916.82622845887, 31411.528827067155, 31613.20966975844, 22331.330060098222, 22742.20402285912, 22845.200417985292, 22890.54218915646, 23510.29469115929], "prototype.html": [317.39219394858844, 318.1648173544446, 323.51634306711463, 323.75394700028, 325.8468519795697, 5871.383504731995, 6005.549583781218, 6063.87872242556, 6091.847703807407, 6098.75604975801, 5867.1492633568105, 5950.613210141338, 5971.134185543094, 6004.609700369473, 6023.87952240956, 4518.412606361185, 4577.542245775412, 4610.308453731934, 4625.9768701156445, 4662.370579971711, 4552.726836389811, 4585.862424127282, 4619.538046195387, 4625.768711564425, 4637.930431043537, 4574.702644328108, 4584.816607335702, 4587.0, 4605.171069207541, 4606.884827879313, 4605.4933957264675, 4609.608183304423, 4610.9077818443775, 4614.515475875052, 4626.514216007305, 3837.7889216093104, 3957.465742124834, 3969.206158768258, 3976.0, 3979.761214327121, 5848.502877255439, 5863.0, 5866.6186697864505, 5879.147523609053, 5893.911591326134, 5168.405633352175, 5172.172452407634, 5177.068127737006, 5179.19722443022, 5181.896362072775, 6084.726187321537, 6174.104754810573, 6202.81391558254, 6304.148939893147, 6342.9365706342805, 4197.811098500575, 4204.957950420518, 4207.831686732527, 4226.873193804191, 4231.788410579489, 6446.903296450557, 6634.767783127616, 6652.667366631697, 6671.566348187353, 6683.2314283857, 4194.832206711697, 4262.637675797592, 4303.548127446636, 4326.545712700121, 4347.434833471629, 4404.141192467502, 4433.600975912119, 4444.555544445594, 4456.77716114193, 4503.0, 5165.251038599382, 5173.172292433268, 5174.767135478837, 5222.686638801608, 5238.5547228486, 6345.143405640272, 6350.301466838644, 6359.077933699587, 6391.904121438182, 6396.71214795326, 1524.3673875341608, 1553.3708847916612, 1569.7096037233148, 1586.643005323816, 1587.8491543303367, 1011.0344620887035, 1018.7198520406947, 1021.7292417509366, 1027.2244455436098, 1032.0402026115785, 5998.910016349758, 6009.609375390585, 6016.037434010537, 6021.608595441282, 6038.698065096815, 6480.092787009822, 6483.254425741005, 6531.118299029666, 6542.672866356663, 6558.081868538313, 5995.490383317467, 6074.665893375818, 6085.726142323606, 6096.481799047131, 6097.268327800603, 3447.5345828312857, 3621.257642183346, 3622.8007459589976, 3622.855085796539, 3646.5259516262718, 6636.336366363325, 6645.06969024337, 6652.600843949379, 6706.094677218611, 6727.192736871607, 6701.530892837454, 6749.865002700017, 6764.5603035802515, 6799.694013769392, 6822.897656535156, 6458.095866578683, 6499.577527460889, 6633.204015518072, 6641.8007459777255, 6642.236142843538, 6528.053432252392, 6556.0493728410065, 6658.800235992928, 6670.966645166937, 6696.866062678817, 6550.705218265094, 6550.868982620225, 6565.277819439953, 6578.276389597237, 6615.834604134935, 6575.30959249291, 6763.695633696397, 6775.1531058617675, 6805.65971701403, 6808.28513006147, 4375.234333991602, 4380.080183161572, 4388.188185185751, 4388.517263100993, 4396.626286765661, 6624.900626490703, 6665.400113989765, 6674.299198584079, 6687.899681504879, 6689.899651505329, 6267.5299352549655, 6445.323241059621, 6470.579412338183, 6480.319566445644, 6511.055896895018, 6396.200474940632, 6407.295197528175, 6414.486841052798, 6439.356064393523, 6449.4840412765925, 6282.591631543935, 6297.307296197506, 6297.811065667854, 6306.243250809932, 6313.46335561464, 6268.4671802897265, 6495.2855185928565, 6496.545241833026, 6502.544821862613, 6509.218893732783, 6261.7182226799, 6284.842878928063, 6305.621662700252, 6318.210223722035, 6321.747130114928], "yui.html": [681.550176883257, 755.6863901480885, 756.9280918312759, 766.6473422225774, 767.6852490478905, 13617.931910340447, 14115.551486685506, 14219.715605687892, 14221.288935553233, 14232.501862434818, 12861.614151575444, 13183.934080329609, 13335.066545341806, 13352.33238338084, 13464.394102265396, 696.7909627111871, 710.0591715976326, 869.026690107081, 912.9863052054225, 915.839728047589, 891.1400498518927, 898.4384759525296, 908.7591788176138, 917.5687426909342, 918.1048477734222, 918.0681608167715, 932.2914584915445, 950.6435086842434, 958.8609651600514, 959.3188835926501, 717.5766297884247, 726.6512074204411, 867.9001914779818, 929.3355250995503, 953.9379940303893, 686.6463771157808, 687.4672129099938, 687.6114995027793, 696.3106524540719, 700.4886432904009, 13357.065005449622, 13464.057515973886, 13489.258090805002, 13511.054226204169, 13528.25594592297, 11127.888721112766, 11536.0, 11814.704632384173, 12088.0, 12275.140740148194, 9273.258139348836, 9368.859467107999, 9405.670801521983, 9513.857292140554, 10050.095491405735, 3218.5976752905885, 3289.5394644749754, 3452.654734526552, 3491.94762078569, 3496.7552271341015, 47439.5256047442, 48173.27740083937, 48533.27200092001, 49047.264291035666, 49195.75402123002, 8907.287417006624, 8907.827624397156, 9116.58975346111, 9371.578278977462, 9671.177949874198, 19506.0, 19600.60798784045, 19660.213591456468, 19728.210871564977, 19876.41606591134, 7144.821379465555, 7171.677274522659, 7212.891806622905, 7224.1692205396, 7304.086989126359, 3707.0917625182, 3710.18375957289, 3884.261990221849, 3921.1569512554365, 3931.803409829497, 3029.560713696502, 3061.601991741104, 3077.2614572502885, 3078.6459557151215, 3097.98451007748, 440.8082484119418, 444.4200318584214, 451.1563376485992, 451.36357735592657, 451.59356579079093, 470.56243177093626, 526.4919352824467, 528.6141116984622, 536.1020291012538, 571.6341541413499, 7780.610969451504, 7995.760127196193, 8017.599120044091, 8123.512589244664, 8258.628361723617, 407.5598353777972, 517.3713937565875, 537.5081800152816, 564.1594024902865, 594.5897330841792, 3561.5904171020147, 3794.203217324393, 3906.628870257321, 3953.743006704555, 3971.543272523697, 58480.7075964626, 58848.0, 60738.392616074154, 60858.0, 61145.69427152836, 51791.7410412953, 51898.0, 52066.0, 52206.0, 53772.73113634407, 48588.02823943572, 48917.0, 49033.509664903606, 49182.75408622934, 49223.26165107526, 8234.094249632655, 8273.627686754231, 8326.0, 8414.83170336602, 8477.364197685074, 34637.48043779396, 35367.82316088403, 35502.46746298756, 35759.106022349646, 36746.0, 44139.77930110329, 46320.53679463297, 48148.98137732784, 48286.275705863736, 49145.50854491409, 7164.996900433839, 7220.675069621985, 7241.782746517613, 7258.600776957318, 7289.307515785992, 10891.18316126278, 11085.0, 11129.777404452028, 11446.82829757571, 11591.362475063615, 10369.9481502592, 10417.0, 10593.0, 10682.465876705977, 10729.731756705833, 10145.34055286404, 10321.329113607891, 10447.634332798316, 10692.091172250446, 11097.445127743742, 7051.964740176266, 9736.853947190939, 9834.164096051916, 10178.643747468803, 10353.792924141626, 8521.701740439055, 8724.825503489768, 8817.294616430798, 9006.594703238501, 9090.454572725657, 8684.565771711515, 8733.737987860375, 8798.604062817061, 8956.0, 9025.638974440948]}, "summary": {"suite": 6662.107585998114, "subtests": {"jquery.html": {"filtered": 7579.145559642368, "value": 7579.145559642368}, "dojo.html": {"filtered": 5217.715436146224, "value": 5217.715436146224}, "mootools.html": {"filtered": 4175.328264235868, "value": 4175.328264235868}, "ext.html": {"filtered": 18454.790490507778, "value": 18454.790490507778}, "prototype.html": {"filtered": 4762.21377786461, "value": 4762.21377786461}, "yui.html": {"filtered": 6024.490968322945, "value": 6024.490968322945}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0041"}, "testrun": {"date": 1446632540, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151104012241", "branch": "Fx-Team", "revision": "d30fb6c197893e3498dcb5a3d8dbc890ff954045"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 161.0, 162.0, 164.0, 162.0, 162.0, 163.0, 163.0, 163.0], "ai-astar": [108.0, 107.0, 105.0, 107.0, 106.0, 109.0, 106.0, 105.0, 103.0, 106.0], "imaging-gaussian-blur": [121.0, 114.0, 114.0, 120.0, 115.0, 121.0, 121.0, 115.0, 120.0, 115.0], "audio-beat-detection": [158.0, 129.0, 151.0, 161.0, 129.0, 149.0, 152.0, 126.0, 162.0, 126.0], "json-stringify-tinderbox": [67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 68.0, 69.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [152.0, 151.0, 149.0, 147.0, 149.0, 152.0, 150.0, 149.0, 150.0, 140.0], "json-parse-financial": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 65.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [68.0, 70.0, 68.0, 69.0, 69.0, 71.0, 72.0, 69.0, 71.0, 70.0], "audio-fft": [72.0, 82.0, 85.0, 85.0, 68.0, 68.0, 71.0, 77.0, 84.0, 67.0], "imaging-darkroom": [124.0, 124.0, 124.0, 125.0, 124.0, 125.0, 125.0, 125.0, 126.0, 127.0], "stanford-crypto-ccm": [126.0, 124.0, 125.0, 121.0, 123.0, 129.0, 131.0, 132.0, 125.0, 124.0], "audio-oscillator": [98.0, 95.0, 141.0, 88.0, 89.0, 89.0, 131.0, 88.0, 88.0, 136.0], "stanford-crypto-aes": [86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 88.0, 86.0], "imaging-desaturate": [101.0, 99.0, 101.0, 100.0, 100.0, 100.0, 101.0, 101.0, 100.0, 99.0]}, "summary": {"suite": 1491.8000000000002, "subtests": {"audio-fft": {"filtered": 75.9, "value": 75.9}, "stanford-crypto-pbkdf2": {"filtered": 148.9, "value": 148.9}, "audio-beat-detection": {"filtered": 144.3, "value": 144.3}, "stanford-crypto-ccm": {"filtered": 126.0, "value": 126.0}, "imaging-darkroom": {"filtered": 124.9, "value": 124.9}, "json-parse-financial": {"filtered": 57.6, "value": 57.6}, "audio-oscillator": {"filtered": 104.3, "value": 104.3}, "ai-astar": {"filtered": 106.2, "value": 106.2}, "audio-dft": {"filtered": 162.3, "value": 162.3}, "stanford-crypto-sha256-iterative": {"filtered": 69.7, "value": 69.7}, "json-stringify-tinderbox": {"filtered": 67.7, "value": 67.7}, "imaging-gaussian-blur": {"filtered": 117.6, "value": 117.6}, "stanford-crypto-aes": {"filtered": 86.2, "value": 86.2}, "imaging-desaturate": {"filtered": 100.2, "value": 100.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0041"}, "testrun": {"date": 1446632540, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151104012241", "branch": "Fx-Team", "revision": "d30fb6c197893e3498dcb5a3d8dbc890ff954045"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.60758766047135], "Encrypt": [325.5208333333333], "NavierStokes": [5803.468208092486], "Decrypt": [5775.862068965517], "Splay": [616.9031462060457], "Richards": [166.03021749958492], "RegExp": [29852.941176470587], "Earley": [919.1176470588235], "Boyer": [12858.97435897436], "RayTrace": [2053.388090349076]}, "summary": {"suite": 18218.05447209521, "subtests": {"DeltaBlue": {"filtered": 345.06984200000005, "value": 345.06984200000005}, "Encrypt": {"filtered": 817.7080319999998, "value": 817.7080319999998}, "NavierStokes": {"filtered": 255.70916334661337, "value": 255.70916334661337}, "Decrypt": {"filtered": 46.08506865671644, "value": 46.08506865671644}, "Splay": {"filtered": 132.096911, "value": 132.096911}, "RegExp": {"filtered": 30.5157536945813, "value": 30.5157536945813}, "Richards": {"filtered": 212.62394600000007, "value": 212.62394600000007}, "Earley": {"filtered": 725.111744, "value": 725.111744}, "Boyer": {"filtered": 51.828628115653075, "value": 51.828628115653075}, "RayTrace": {"filtered": 360.37464300000005, "value": 360.37464300000005}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0041"}, "testrun": {"date": 1446632540, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151104012241", "branch": "Fx-Team", "revision": "d30fb6c197893e3498dcb5a3d8dbc890ff954045"}}] 02:42:30 INFO - RETURN: dromaeo_css: 6662.11 02:42:30 INFO - RETURN: kraken: 1491.80 02:42:30 INFO - RETURN: v8_7: 18218.05 02:42:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "18218.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1491.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6662.11"}}} 02:42:30 INFO - Return code: 0 02:42:30 INFO - # TBPL SUCCESS # 02:42:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:42:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:42:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:42:30 INFO - 2015-11-04 02:42:30.544 screenresolution[2960:37835] starting screenresolution argv=screenresolution get 02:42:30 INFO - 2015-11-04 02:42:30.547 screenresolution[2960:37835] Display 0: 1600x1200x32@60 02:42:30 INFO - 2015-11-04 02:42:30.554 screenresolution[2961:37838] starting screenresolution argv=screenresolution list 02:42:30 INFO - Available Modes on Display 0 02:42:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:42:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:42:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:42:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:42:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:42:30 INFO - Intel HD Graphics 3000: 02:42:30 INFO - Chipset Model: Intel HD Graphics 3000 02:42:30 INFO - Type: GPU 02:42:30 INFO - Bus: Built-In 02:42:30 INFO - VRAM (Total): 512 MB 02:42:30 INFO - VRAM (Dynamic, Max): 10 02:42:30 INFO - Vendor: Intel (0x8086) 02:42:30 INFO - Device ID: 0x0116 02:42:30 INFO - Revision ID: 0x0009 02:42:30 INFO - Displays: 02:42:30 INFO - Display: 02:42:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:42:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:42:30 INFO - Display Serial Number: 1600x1200 60 02:42:30 INFO - Main Display: Yes 02:42:30 INFO - Mirror: Off 02:42:30 INFO - Online: Yes 02:42:30 INFO - Rotation: Supported 02:42:30 INFO - Return code: 0 02:42:30 INFO - Running post-action listener: _resource_record_post_action 02:42:30 INFO - Running post-run listener: _resource_record_post_run 02:42:31 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 86016; Write bytes: 688066560; Read time: 162; Write time: 97113 02:42:31 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 333304320; Write bytes: 335702016; Read time: 32323; Write time: 12164 02:42:31 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 86016; Write bytes: 342009856; Read time: 162; Write time: 84144 02:42:31 INFO - Running post-run listener: _upload_blobber_files 02:42:31 INFO - Blob upload gear active. 02:42:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:42:31 INFO - Copying logs to upload dir... 02:42:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1324.669723 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-04 02:42:32.007735) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 02:42:32.013588) ========= 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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009944 build_url: 'https://queue.taskcluster.net/v1/task/QrMbO4A1Tniri4-sNyfyHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 02:42:32.049797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:42:32.050229) ========= 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.zGEWMHfz4g/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.9SsRv1HKuC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.005198 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 02:42:32.105028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 02:42:32.105474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 02:42:32.106041) ========= ========= Total master_lag: 0.69 =========