builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0026 starttime: 1447889637.58 results: success (0) buildid: 20151118130439 builduid: f891794703fb4545aadfcae3c5f9dadb revision: a1ac4564029cec65bed930613865e0111adc7c7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.583444) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.583920) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.584247) ========= 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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005457 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.606386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.606737) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.622852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.623295) ========= 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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005428 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.672152) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.672515) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.672971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.673305) ========= 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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False --2015-11-18 15:33:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-18 15:33:57 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.880780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.881144) ========= 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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025220 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.931138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:57.931571) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1ac4564029cec65bed930613865e0111adc7c7f --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 a1ac4564029cec65bed930613865e0111adc7c7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False 2015-11-18 15:33:58,000 truncating revision to first 12 chars 2015-11-18 15:33:58,001 Setting DEBUG logging. 2015-11-18 15:33:58,001 attempt 1/10 2015-11-18 15:33:58,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1ac4564029c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 15:33:58,590 unpacking tar archive at: fx-team-a1ac4564029c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828412 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:58.774343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:58.774876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:58.786749) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:58.787210) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 15:33:58.787714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-18 15:33:58.788082) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False 15:33:58 INFO - MultiFileLogger online at 20151118 15:33:58 in /builds/slave/test 15:33:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:33:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:58 INFO - {'append_to_log': False, 15:33:58 INFO - 'base_work_dir': '/builds/slave/test', 15:33:58 INFO - 'blob_upload_branch': 'Fx-Team', 15:33:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:58 INFO - 'branch': 'Fx-Team', 15:33:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:58 INFO - 'config_files': ('talos/mac_config.py',), 15:33:58 INFO - 'default_actions': ('clobber', 15:33:58 INFO - 'read-buildbot-config', 15:33:58 INFO - 'download-and-extract', 15:33:58 INFO - 'populate-webroot', 15:33:58 INFO - 'create-virtualenv', 15:33:58 INFO - 'install', 15:33:58 INFO - 'run-tests'), 15:33:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:58 INFO - 'download_minidump_stackwalk': True, 15:33:58 INFO - 'download_symbols': 'ondemand', 15:33:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:58 INFO - 'installer_path': 'installer.exe', 15:33:58 INFO - 'log_level': 'info', 15:33:58 INFO - 'log_name': 'talos', 15:33:58 INFO - 'log_to_console': True, 15:33:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:33:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:33:58 INFO - 'opt_config_files': (), 15:33:58 INFO - 'pip_index': False, 15:33:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:58 INFO - 'cmd': ('bash', 15:33:58 INFO - '-c', 15:33:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:58 INFO - 'enabled': True, 15:33:58 INFO - 'halt_on_failure': False, 15:33:58 INFO - 'name': 'check_screen_resolution'},), 15:33:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:58 INFO - 'cmd': ('bash', 15:33:58 INFO - '-c', 15:33:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:58 INFO - 'enabled': True, 15:33:58 INFO - 'halt_on_failure': False, 15:33:58 INFO - 'name': 'check_screen_resolution'},), 15:33:58 INFO - 'run_cmd_checks_enabled': True, 15:33:58 INFO - 'sps_profile': False, 15:33:58 INFO - 'sps_profile_interval': 0, 15:33:58 INFO - 'suite': 'dromaeojs-e10s', 15:33:58 INFO - 'system_bits': '64', 15:33:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:58 INFO - 'title': 't-yosemite-r7-0026', 15:33:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:58 INFO - 'use_talos_json': True, 15:33:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:58 INFO - 'work_dir': 'build'} 15:33:58 INFO - ##### 15:33:58 INFO - ##### Running clobber step. 15:33:58 INFO - ##### 15:33:58 INFO - Running pre-action listener: _resource_record_pre_action 15:33:58 INFO - Running main action method: clobber 15:33:58 INFO - rmtree: /builds/slave/test/build 15:33:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:00 INFO - Running post-action listener: _resource_record_post_action 15:34:00 INFO - ##### 15:34:00 INFO - ##### Running read-buildbot-config step. 15:34:00 INFO - ##### 15:34:00 INFO - Running pre-action listener: _resource_record_pre_action 15:34:00 INFO - Running main action method: read_buildbot_config 15:34:00 INFO - Using buildbot properties: 15:34:00 INFO - { 15:34:00 INFO - "properties": { 15:34:00 INFO - "buildnumber": 2, 15:34:00 INFO - "product": "firefox", 15:34:00 INFO - "script_repo_revision": "production", 15:34:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:34:00 INFO - "repository": "", 15:34:00 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:34:00 INFO - "buildid": "20151118130439", 15:34:00 INFO - "slavename": "t-yosemite-r7-0026", 15:34:00 INFO - "pgo_build": "False", 15:34:00 INFO - "basedir": "/builds/slave/test", 15:34:00 INFO - "project": "", 15:34:00 INFO - "platform": "yosemite_r7", 15:34:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:34:00 INFO - "slavebuilddir": "test", 15:34:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:34:00 INFO - "branch": "fx-team", 15:34:00 INFO - "repo_path": "integration/fx-team", 15:34:00 INFO - "stage_platform": "macosx64", 15:34:00 INFO - "builduid": "f891794703fb4545aadfcae3c5f9dadb", 15:34:00 INFO - "revision": "a1ac4564029cec65bed930613865e0111adc7c7f" 15:34:00 INFO - }, 15:34:00 INFO - "sourcestamp": { 15:34:00 INFO - "repository": "", 15:34:00 INFO - "hasPatch": false, 15:34:00 INFO - "project": "", 15:34:00 INFO - "branch": "fx-team-macosx64-talos", 15:34:00 INFO - "changes": [ 15:34:00 INFO - { 15:34:00 INFO - "category": null, 15:34:00 INFO - "files": [ 15:34:00 INFO - { 15:34:00 INFO - "url": null, 15:34:00 INFO - "name": "https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:34:00 INFO - } 15:34:00 INFO - ], 15:34:00 INFO - "repository": "", 15:34:00 INFO - "rev": "a1ac4564029cec65bed930613865e0111adc7c7f", 15:34:00 INFO - "who": "mconley@mozilla.com", 15:34:00 INFO - "when": 1447886229, 15:34:00 INFO - "number": 6679112, 15:34:00 INFO - "comments": "Bug 1171708 - Add tests for async window flushing. r=billm", 15:34:00 INFO - "project": "", 15:34:00 INFO - "at": "Wed 18 Nov 2015 14:37:09", 15:34:00 INFO - "branch": "fx-team-macosx64-talos", 15:34:00 INFO - "revlink": "", 15:34:00 INFO - "properties": [ 15:34:00 INFO - [ 15:34:00 INFO - "buildid", 15:34:00 INFO - "20151118130439", 15:34:00 INFO - "Change" 15:34:00 INFO - ], 15:34:00 INFO - [ 15:34:00 INFO - "builduid", 15:34:00 INFO - "f891794703fb4545aadfcae3c5f9dadb", 15:34:00 INFO - "Change" 15:34:00 INFO - ], 15:34:00 INFO - [ 15:34:00 INFO - "pgo_build", 15:34:00 INFO - "False", 15:34:00 INFO - "Change" 15:34:00 INFO - ] 15:34:00 INFO - ], 15:34:00 INFO - "revision": "a1ac4564029cec65bed930613865e0111adc7c7f" 15:34:00 INFO - } 15:34:00 INFO - ], 15:34:00 INFO - "revision": "a1ac4564029cec65bed930613865e0111adc7c7f" 15:34:00 INFO - } 15:34:00 INFO - } 15:34:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:34:00 INFO - Running post-action listener: _resource_record_post_action 15:34:00 INFO - ##### 15:34:00 INFO - ##### Running download-and-extract step. 15:34:00 INFO - ##### 15:34:00 INFO - Running pre-action listener: _resource_record_pre_action 15:34:00 INFO - Running main action method: download_and_extract 15:34:00 INFO - mkdir: /builds/slave/test/build/tests 15:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:00 INFO - https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:34:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/test_packages.json 15:34:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/test_packages.json 15:34:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:34:01 INFO - Downloaded 1149 bytes. 15:34:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:34:01 INFO - Using the following test package requirements: 15:34:01 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:34:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:34:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'jsshell-mac.zip'], 15:34:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:34:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:34:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:34:01 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:34:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:34:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:34:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:34:01 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:34:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:01 INFO - https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:02 INFO - Downloaded 17477382 bytes. 15:34:02 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 15:34:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:34:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:34:05 INFO - Return code: 0 15:34:05 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 15:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:05 INFO - https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:34:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:34:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:34:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:06 INFO - Downloaded 17477382 bytes. 15:34:06 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 15:34:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:34:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:34:09 INFO - Return code: 0 15:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:09 INFO - https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:10 INFO - Downloaded 11130997 bytes. 15:34:10 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 15:34:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:34:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:34:10 INFO - Return code: 0 15:34:10 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')]} 15:34:10 INFO - https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:34:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:34:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:34:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T73OpfkgRsKsYRgDEL7eeA/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 15:34:13 INFO - Downloaded 108852655 bytes. 15:34:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:34:13 INFO - mkdir: /builds/slave/test/properties 15:34:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:13 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:13 INFO - Contents: 15:34:13 INFO - build_url:https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:34:13 INFO - Running post-action listener: _resource_record_post_action 15:34:13 INFO - Running post-action listener: set_extra_try_arguments 15:34:13 INFO - ##### 15:34:13 INFO - ##### Running populate-webroot step. 15:34:13 INFO - ##### 15:34:13 INFO - Running pre-action listener: _resource_record_pre_action 15:34:13 INFO - Running main action method: populate_webroot 15:34:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:13 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:34:13 INFO - '../fennec_ids.txt'], 15:34:13 INFO - 'tests': ['tcheck2']}, 15:34:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:13 INFO - '--tppagecycles', 15:34:13 INFO - '7'], 15:34:13 INFO - 'tests': ['tsvgm']}}, 15:34:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:34:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:34:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:34:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'tests': ['damp', 'tps']}, 15:34:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['damp', 'tps']}, 15:34:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:34:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:13 INFO - 'other': {'tests': ['a11yr', 15:34:13 INFO - 'ts_paint', 15:34:13 INFO - 'tpaint', 15:34:13 INFO - 'sessionrestore', 15:34:13 INFO - 'sessionrestore_no_auto_restore']}, 15:34:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['a11yr', 15:34:13 INFO - 'ts_paint', 15:34:13 INFO - 'tpaint', 15:34:13 INFO - 'sessionrestore', 15:34:13 INFO - 'sessionrestore_no_auto_restore']}, 15:34:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['a11yr', 15:34:13 INFO - 'ts_paint', 15:34:13 INFO - 'tpaint', 15:34:13 INFO - 'sessionrestore', 15:34:13 INFO - 'sessionrestore_no_auto_restore']}, 15:34:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['a11yr', 15:34:13 INFO - 'ts_paint', 15:34:13 INFO - 'tpaint', 15:34:13 INFO - 'sessionrestore', 15:34:13 INFO - 'sessionrestore_no_auto_restore']}, 15:34:13 INFO - 'other_l64': {'tests': ['a11yr', 15:34:13 INFO - 'ts_paint', 15:34:13 INFO - 'tpaint', 15:34:13 INFO - 'sessionrestore', 15:34:13 INFO - 'sessionrestore_no_auto_restore']}, 15:34:13 INFO - 'other_nol64': {'tests': ['a11yr', 15:34:13 INFO - 'ts_paint', 15:34:13 INFO - 'tpaint', 15:34:13 INFO - 'sessionrestore', 15:34:13 INFO - 'sessionrestore_no_auto_restore']}, 15:34:13 INFO - 'svgr': {'tests': ['tsvgx', 15:34:13 INFO - 'tsvgr_opacity', 15:34:13 INFO - 'tart', 15:34:13 INFO - 'tscrollx', 15:34:13 INFO - 'cart']}, 15:34:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['tsvgx', 15:34:13 INFO - 'tsvgr_opacity', 15:34:13 INFO - 'tart', 15:34:13 INFO - 'tscrollx', 15:34:13 INFO - 'cart']}, 15:34:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'tests': ['tp5o']}, 15:34:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'talos_options': ['--e10s'], 15:34:13 INFO - 'tests': ['tp5o']}, 15:34:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'talos_options': ['--xperf_path', 15:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:13 INFO - 'tests': ['tp5n']}, 15:34:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:13 INFO - 'talos_options': ['--e10s', 15:34:13 INFO - '--xperf_path', 15:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:13 INFO - 'tests': ['tp5n']}}, 15:34:13 INFO - 'talos.zip': {'path': '', 15:34:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:13 INFO - Running post-action listener: _resource_record_post_action 15:34:13 INFO - ##### 15:34:13 INFO - ##### Running create-virtualenv step. 15:34:13 INFO - ##### 15:34:13 INFO - Running pre-action listener: _resource_record_pre_action 15:34:13 INFO - Running main action method: create_virtualenv 15:34:13 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:13 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 15:34:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:13 INFO - Using real prefix '/tools/python27' 15:34:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:14 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:17 INFO - Installing pip.................done. 15:34:17 INFO - Return code: 0 15:34:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:17 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')]} 15:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 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')]} 15:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34:17 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 15:34:17 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 15:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:17 INFO - 'HOME': '/Users/cltbld', 15:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:17 INFO - 'LOGNAME': 'cltbld', 15:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:17 INFO - 'MOZ_NO_REMOTE': '1', 15:34:17 INFO - 'NO_EM_RESTART': '1', 15:34:17 INFO - 'PAGER': '/bin/cat', 15:34:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:17 INFO - 'PWD': '/builds/slave/test', 15:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:17 INFO - 'SHELL': '/bin/bash', 15:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:17 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:17 INFO - 'USER': 'cltbld', 15:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:17 INFO - 'XPC_FLAGS': '0x0', 15:34:17 INFO - 'XPC_SERVICE_NAME': '0', 15:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:17 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 15:34:17 INFO - Cleaning up... 15:34:17 INFO - Return code: 0 15:34:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:34:17 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')]} 15:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 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')]} 15:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34:17 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 15:34:17 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 15:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:17 INFO - 'HOME': '/Users/cltbld', 15:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:17 INFO - 'LOGNAME': 'cltbld', 15:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:17 INFO - 'MOZ_NO_REMOTE': '1', 15:34:17 INFO - 'NO_EM_RESTART': '1', 15:34:17 INFO - 'PAGER': '/bin/cat', 15:34:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:17 INFO - 'PWD': '/builds/slave/test', 15:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:17 INFO - 'SHELL': '/bin/bash', 15:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:17 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:17 INFO - 'USER': 'cltbld', 15:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:17 INFO - 'XPC_FLAGS': '0x0', 15:34:17 INFO - 'XPC_SERVICE_NAME': '0', 15:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:17 INFO - Downloading/unpacking psutil>=0.7.1 15:34:17 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 15:34:17 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 15:34:17 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 15:34:17 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 15:34:17 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 15:34:17 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 15:34:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:34:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:20 INFO - Installing collected packages: psutil 15:34:20 INFO - Running setup.py install for psutil 15:34:20 INFO - building 'psutil._psutil_osx' extension 15:34:20 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 15:34:20 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 15:34:20 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 15:34:20 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 15:34:21 INFO - building 'psutil._psutil_posix' extension 15:34:21 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 15:34:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:34:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:34:21 INFO - ^ 15:34:21 INFO - 1 warning generated. 15:34:21 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 15:34:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:21 INFO - Successfully installed psutil 15:34:21 INFO - Cleaning up... 15:34:21 INFO - Return code: 0 15:34:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:21 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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34:21 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 15:34:21 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 15:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:21 INFO - 'HOME': '/Users/cltbld', 15:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:21 INFO - 'LOGNAME': 'cltbld', 15:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:21 INFO - 'MOZ_NO_REMOTE': '1', 15:34:21 INFO - 'NO_EM_RESTART': '1', 15:34:21 INFO - 'PAGER': '/bin/cat', 15:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:21 INFO - 'PWD': '/builds/slave/test', 15:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:21 INFO - 'SHELL': '/bin/bash', 15:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:21 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:21 INFO - 'USER': 'cltbld', 15:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:21 INFO - 'XPC_FLAGS': '0x0', 15:34:21 INFO - 'XPC_SERVICE_NAME': '0', 15:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:34:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:34:23 INFO - Installing collected packages: mozsystemmonitor 15:34:23 INFO - Running setup.py install for mozsystemmonitor 15:34:23 INFO - Successfully installed mozsystemmonitor 15:34:23 INFO - Cleaning up... 15:34:23 INFO - Return code: 0 15:34:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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', '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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:34: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 blobuploader==1.2.4 15:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:23 INFO - 'HOME': '/Users/cltbld', 15:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:23 INFO - 'LOGNAME': 'cltbld', 15:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:23 INFO - 'MOZ_NO_REMOTE': '1', 15:34:23 INFO - 'NO_EM_RESTART': '1', 15:34:23 INFO - 'PAGER': '/bin/cat', 15:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:23 INFO - 'PWD': '/builds/slave/test', 15:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:23 INFO - 'SHELL': '/bin/bash', 15:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:23 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:23 INFO - 'USER': 'cltbld', 15:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:23 INFO - 'XPC_FLAGS': '0x0', 15:34:23 INFO - 'XPC_SERVICE_NAME': '0', 15:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:24 INFO - Downloading/unpacking blobuploader==1.2.4 15:34:24 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 15:34:24 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 15:34:24 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 15:34:24 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 15:34:24 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 15:34:24 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 15:34:26 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34:27 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 15:34:27 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 15:34:27 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 15:34:27 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 15:34:27 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 15:34:27 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 15:34:27 INFO - Downloading docopt-0.6.1.tar.gz 15:34:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:27 INFO - Running setup.py install for blobuploader 15:34:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:27 INFO - Running setup.py install for requests 15:34:28 INFO - Running setup.py install for docopt 15:34:28 INFO - Successfully installed blobuploader requests docopt 15:34:28 INFO - Cleaning up... 15:34:28 INFO - Return code: 0 15:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34:28 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 15:34:28 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 15:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:28 INFO - 'HOME': '/Users/cltbld', 15:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:28 INFO - 'LOGNAME': 'cltbld', 15:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:28 INFO - 'MOZ_NO_REMOTE': '1', 15:34:28 INFO - 'NO_EM_RESTART': '1', 15:34:28 INFO - 'PAGER': '/bin/cat', 15:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:28 INFO - 'PWD': '/builds/slave/test', 15:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:28 INFO - 'SHELL': '/bin/bash', 15:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:28 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:28 INFO - 'USER': 'cltbld', 15:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:28 INFO - 'XPC_FLAGS': '0x0', 15:34:28 INFO - 'XPC_SERVICE_NAME': '0', 15:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-5detYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0fQxxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-89E9Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gfEFgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-wCkWp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-9N8ntL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Yi1Aw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-scVT75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-w_J_od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-DaPL2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-NV35Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-fIdqRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-uAewRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-6JK568-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-iUoEVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-e7HJGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-KHZKAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:30 INFO - Running setup.py install for manifestparser 15:34:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:30 INFO - Running setup.py install for mozcrash 15:34:30 INFO - Running setup.py install for mozdebug 15:34:30 INFO - Running setup.py install for mozdevice 15:34:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozfile 15:34:31 INFO - Running setup.py install for mozhttpd 15:34:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozinfo 15:34:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozInstall 15:34:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozleak 15:34:31 INFO - Running setup.py install for mozlog 15:34:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for moznetwork 15:34:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Running setup.py install for mozprocess 15:34:32 INFO - Running setup.py install for mozprofile 15:34:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Running setup.py install for mozrunner 15:34:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Running setup.py install for mozscreenshot 15:34:32 INFO - Running setup.py install for moztest 15:34:32 INFO - Running setup.py install for mozversion 15:34:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:32 INFO - Cleaning up... 15:34:32 INFO - Return code: 0 15:34:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34:32 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 15:34:32 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 15:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:32 INFO - 'HOME': '/Users/cltbld', 15:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:32 INFO - 'LOGNAME': 'cltbld', 15:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:32 INFO - 'MOZ_NO_REMOTE': '1', 15:34:32 INFO - 'NO_EM_RESTART': '1', 15:34:32 INFO - 'PAGER': '/bin/cat', 15:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:32 INFO - 'PWD': '/builds/slave/test', 15:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:32 INFO - 'SHELL': '/bin/bash', 15:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:32 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:32 INFO - 'USER': 'cltbld', 15:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:32 INFO - 'XPC_FLAGS': '0x0', 15:34:32 INFO - 'XPC_SERVICE_NAME': '0', 15:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-UN2sa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0z3M6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-RzTEYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-vaA2pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-uQIQxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GW8yj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Vj1_bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:33 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-UjcaEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-P7VN8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LxxqjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-2Sz_0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GpurO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-9KCnnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-bf8xk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-WI7u1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Ffwlm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:34 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)) 15:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:34 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-UbA6e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:34 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)) 15:34:34 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)) 15:34:34 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)) 15:34:34 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)) 15:34:34 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)) 15:34:34 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)) 15:34:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:35 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 15:34:35 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 15:34:35 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 15:34:35 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 15:34:35 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 15:34:35 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 15:34:37 INFO - Downloading blessings-1.5.1.tar.gz 15:34:37 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 15:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:37 INFO - Installing collected packages: blessings 15:34:37 INFO - Running setup.py install for blessings 15:34:37 INFO - Successfully installed blessings 15:34:37 INFO - Cleaning up... 15:34:37 INFO - Return code: 0 15:34:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:37 INFO - Reading from file tmpfile_stdout 15:34:37 INFO - Current package versions: 15:34:37 INFO - blessings == 1.5.1 15:34:37 INFO - blobuploader == 1.2.4 15:34:37 INFO - docopt == 0.6.1 15:34:37 INFO - manifestparser == 1.1 15:34:37 INFO - mozInstall == 1.12 15:34:37 INFO - mozcrash == 0.16 15:34:37 INFO - mozdebug == 0.1 15:34:37 INFO - mozdevice == 0.47 15:34:37 INFO - mozfile == 1.2 15:34:37 INFO - mozhttpd == 0.7 15:34:37 INFO - mozinfo == 0.9 15:34:37 INFO - mozleak == 0.1 15:34:37 INFO - mozlog == 3.0 15:34:37 INFO - moznetwork == 0.27 15:34:37 INFO - mozprocess == 0.22 15:34:37 INFO - mozprofile == 0.27 15:34:37 INFO - mozrunner == 6.11 15:34:37 INFO - mozscreenshot == 0.1 15:34:37 INFO - mozsystemmonitor == 0.0 15:34:37 INFO - moztest == 0.7 15:34:37 INFO - mozversion == 1.4 15:34:37 INFO - psutil == 3.1.1 15:34:37 INFO - requests == 1.2.3 15:34:37 INFO - wsgiref == 0.1.2 15:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:37 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')]} 15:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:37 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')]} 15:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:37 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 0x10093c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100919228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1cbca01f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/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.odX65tGspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:34:37 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 15:34:37 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 15:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:37 INFO - 'HOME': '/Users/cltbld', 15:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:37 INFO - 'LOGNAME': 'cltbld', 15:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:37 INFO - 'MOZ_NO_REMOTE': '1', 15:34:37 INFO - 'NO_EM_RESTART': '1', 15:34:37 INFO - 'PAGER': '/bin/cat', 15:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:37 INFO - 'PWD': '/builds/slave/test', 15:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:37 INFO - 'SHELL': '/bin/bash', 15:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:34:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:37 INFO - 'USER': 'cltbld', 15:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:37 INFO - 'XPC_FLAGS': '0x0', 15:34:37 INFO - 'XPC_SERVICE_NAME': '0', 15:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:38 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)) 15:34:38 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)) 15:34:38 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)) 15:34:38 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)) 15:34:38 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)) 15:34:38 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)) 15:34:38 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)) 15:34:38 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)) 15:34: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:34:38 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)) 15:34:38 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)) 15:34:38 INFO - Cleaning up... 15:34:38 INFO - Return code: 0 15:34:38 INFO - Running post-action listener: _resource_record_post_action 15:34:38 INFO - Running post-action listener: _start_resource_monitoring 15:34:38 INFO - Starting resource monitoring. 15:34:38 INFO - ##### 15:34:38 INFO - ##### Running install step. 15:34:38 INFO - ##### 15:34:38 INFO - Running pre-action listener: _resource_record_pre_action 15:34:38 INFO - Running main action method: install 15:34:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:38 INFO - Reading from file tmpfile_stdout 15:34:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:38 INFO - Reading from file tmpfile_stdout 15:34:38 INFO - Output received: 15:34:38 INFO - Usage: mozinstall [options] installer 15:34:38 INFO - Options: 15:34:38 INFO - -h, --help show this help message and exit 15:34:38 INFO - -d DEST, --destination=DEST 15:34:38 INFO - Directory to install application into. [default: 15:34:38 INFO - "/builds/slave/test"] 15:34:38 INFO - --app=APP Application being installed. [default: firefox] 15:34:38 INFO - mkdir: /builds/slave/test/build/application 15:34:38 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'] 15:34:38 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 15:35:09 INFO - Reading from file tmpfile_stdout 15:35:09 INFO - Output received: 15:35:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:35:09 INFO - Running post-action listener: _resource_record_post_action 15:35:09 INFO - ##### 15:35:09 INFO - ##### Running run-tests step. 15:35:09 INFO - ##### 15:35:09 INFO - Running pre-action listener: _resource_record_pre_action 15:35:09 INFO - Running main action method: run_tests 15:35:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:35:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:35:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:35:09 INFO - 2015-11-18 15:35:09.740 screenresolution[1636:7473] starting screenresolution argv=screenresolution get 15:35:09 INFO - 2015-11-18 15:35:09.743 screenresolution[1636:7473] Display 0: 1600x1200x32@60 15:35:09 INFO - 2015-11-18 15:35:09.748 screenresolution[1637:7476] starting screenresolution argv=screenresolution list 15:35:09 INFO - Available Modes on Display 0 15:35:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:35:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:35:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:35:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:35:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:35:09 INFO - Intel Iris: 15:35:09 INFO - Chipset Model: Intel Iris 15:35:09 INFO - Type: GPU 15:35:09 INFO - Bus: Built-In 15:35:09 INFO - VRAM (Dynamic, Max): 1536 MB 15:35:09 INFO - Vendor: Intel (0x8086) 15:35:09 INFO - Device ID: 0x0a2e 15:35:09 INFO - Revision ID: 0x0009 15:35:09 INFO - Displays: 15:35:09 INFO - Display: 15:35:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:35:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:35:09 INFO - Display Serial Number: 1600x1200 60 15:35:09 INFO - Main Display: Yes 15:35:09 INFO - Mirror: Off 15:35:09 INFO - Online: Yes 15:35:09 INFO - Rotation: Supported 15:35:09 INFO - Return code: 0 15:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:09 INFO - Python 2.7.3 15:35:09 INFO - Return code: 0 15:35:09 INFO - grabbing minidump binary from tooltool 15:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:09 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 0x1008609f0>, '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 0x1005bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008538c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:09 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 15:35:09 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 15:35:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:10 INFO - Return code: 0 15:35:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:35:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:35:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--webServer', 'localhost'] in /builds/slave/test/build 15:35:10 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --webServer localhost 15:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hN2wWOycyK/Render', 15:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:10 INFO - 'HOME': '/Users/cltbld', 15:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:10 INFO - 'LOGNAME': 'cltbld', 15:35:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:10 INFO - 'MOZ_NO_REMOTE': '1', 15:35:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:10 INFO - 'NO_EM_RESTART': '1', 15:35:10 INFO - 'PAGER': '/bin/cat', 15:35:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:10 INFO - 'PWD': '/builds/slave/test', 15:35:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:10 INFO - 'SHELL': '/bin/bash', 15:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.odX65tGspG/Listeners', 15:35:10 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 15:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:10 INFO - 'USER': 'cltbld', 15:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:10 INFO - 'XPC_FLAGS': '0x0', 15:35:10 INFO - 'XPC_SERVICE_NAME': '0', 15:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--webServer', 'localhost'] with output_timeout 3600 15:35:10 INFO - mozversion INFO | application_buildid: 20151118130439 15:35:10 INFO - mozversion INFO | application_changeset: a1ac4564029cec65bed930613865e0111adc7c7f 15:35:10 INFO - mozversion INFO | application_display_name: Nightly 15:35:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:10 INFO - mozversion INFO | application_name: Firefox 15:35:10 INFO - mozversion INFO | application_remotingname: firefox 15:35:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:35:10 INFO - mozversion INFO | application_vendor: Mozilla 15:35:10 INFO - mozversion INFO | application_version: 45.0a1 15:35:10 INFO - mozversion INFO | platform_buildid: 20151118130439 15:35:10 INFO - mozversion INFO | platform_changeset: a1ac4564029cec65bed930613865e0111adc7c7f 15:35:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:35:10 INFO - mozversion INFO | platform_version: 45.0a1 15:35:10 INFO - 2015-11-18 15:35:10,293 DEBUG : using testdate: 1447889710 15:35:10 INFO - 2015-11-18 15:35:10,293 DEBUG : actual date: 1447889710 15:35:10 INFO - 2015-11-18 15:35:10,383 INFO : starting webserver on 'localhost:49264' 15:35:10 INFO - 2015-11-18 15:35:10,384 INFO : Starting test suite t-yosemite-r7-0026.e 15:35:10 INFO - 2015-11-18 15:35:10,384 INFO : Starting test dromaeo_css 15:35:10 INFO - 2015-11-18 15:35:10,384 DEBUG : operating with platform_type : mac_ 15:35:10 INFO - 2015-11-18 15:35:10,385 INFO : Initialising browser for dromaeo_css test... 15:35:10 INFO - 2015-11-18 15:35:10,401 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpNsyOFW/profile http://localhost:49264/getInfo.html 15:35:13 INFO - 2015-11-18 15:35:13,067 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:35:13 INFO - 2015-11-18 15:35:13,067 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:35:13 INFO - 2015-11-18 15:35:13,067 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:35:13 INFO - 2015-11-18 15:35:13,067 DEBUG : BROWSER_OUTPUT: __metrics 15:35:13 INFO - 2015-11-18 15:35:13,681 INFO : Browser initialized. 15:35:13 INFO - 2015-11-18 15:35:13,681 INFO : Running cycle 1/1 for dromaeo_css test... 15:35:13 INFO - 2015-11-18 15:35:13,681 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpNsyOFW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:35:25 INFO - 2015-11-18 15:35:25,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 237391872 15:35:25 INFO - 2015-11-18 15:35:25,504 DEBUG : BROWSER_OUTPUT: 15:36:15 INFO - 2015-11-18 15:36:15,197 DEBUG : BROWSER_OUTPUT: 1447889775197 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] 15:38:25 INFO - 2015-11-18 15:38:25,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 15:38:26 INFO - 2015-11-18 15:38:26,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 257978368 15:38:26 INFO - 2015-11-18 15:38:26,175 DEBUG : BROWSER_OUTPUT: 15:41:28 INFO - 2015-11-18 15:41:28,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 15:41:28 INFO - 2015-11-18 15:41:28,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 268046336 15:41:28 INFO - 2015-11-18 15:41:28,792 DEBUG : BROWSER_OUTPUT: 15:44:30 INFO - 2015-11-18 15:44:30,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 15:44:31 INFO - 2015-11-18 15:44:31,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 269893632 15:44:31 INFO - 2015-11-18 15:44:31,035 DEBUG : BROWSER_OUTPUT: 15:47:32 INFO - 2015-11-18 15:47:32,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 15:47:33 INFO - 2015-11-18 15:47:33,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 270979072 15:47:33 INFO - 2015-11-18 15:47:33,256 DEBUG : BROWSER_OUTPUT: 15:50:35 INFO - 2015-11-18 15:50:35,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 15:50:36 INFO - 2015-11-18 15:50:36,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 274190336 15:50:36 INFO - 2015-11-18 15:50:36,389 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 15:53:38 INFO - 2015-11-18 15:53:38,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 276312064 15:53:38 INFO - 2015-11-18 15:53:38,883 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,883 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:38 INFO - 2015-11-18 15:53:38,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:38 INFO - 2015-11-18 15:53:38,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:38 INFO - 2015-11-18 15:53:38,883 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:38 INFO - 2015-11-18 15:53:38,885 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3435.57055368079;3517.929641407172;3523.823808809559;3542.557180352456;3552.7157827373812;5616.466435688608;5711.086226203808;5721.513671337931;5722.141678748189;5742.9138562921535;5515.972420137894;5646.096624540074;5670.37625861156;5713.742881570329;5772.307323121221;5210.713410762407;5217.608679349045;5264.684118952875;5322.8137015204475;5327.254184414185;5300.337457817773;5328.17413300939;5358.678479291255;5362.061639213122;5382.434844341346;5071.46749591295;5077.771500282496;5174.275601415805;5260.605454590902;5289.233061206123;5250.448702886219;5266.735983364003;5282.815101471469;5286.735663216862;5318.893622127574;5215.973920130413;5261.894762104736;5301.257823904656;5317.096093664087;5372.2210279509645;3992.500937382827;4388.802503887333;5463.989162005002;5662.745176467069;5686.459786320334;6202.915858088281;6231.688415579203;6231.719572619198;6236.469900058501;6250.312465628777;6286.245650521967;6330.828796672584;6331.905021424683;6351.904721429182;6374.490040796772;5800.187973683687;5828.679422631753;5908.438698323653;5969.432903874125;6017.548683848641;6285.057241413733;6364.809055728336;6403.711832967528;6418.293987661354;6423.678816059271;5944.613600115978;6205.81382558524;6214.782482613087;6218;6226.439620434183;4959.702417854868;6201.7519299228425;6228.781992630236;6292.119103325538;6310.274318453345;5794.130880367894;5798.565107616945;6206.410391012847;6230.439693304349;6272.905906411407;6025.9096113558335;6127.7393367763425;6250.812475625738;6273.560850740404;6291.9685401573615;4875.780589873464;4981.850544483671;4984.850454486371;4993.975030124826;5000.224965130411;3832.9616703833162;4455.198064348384;4455.977720111378;4477.216487114807;4477.261251893467;5627.409122042127;5629.211910332557;5683.630564013326;5835.854103647358;5845.503132233723;6251.531135164881;6265.843353916098;6269.780557680459;6273.247210334789;6287.779927702509;5050.292958985745;5854.385289544622;5894.233749612523;5926.703664816742;5966.463018328372;5221.582273418117;5359.705216213068;5362.463753624606;5467.425920278393;5495.203195536705;6415.518836087312;6422.678866056678;6466.030095485715;6468.353164683494;6473.287938326875;6256.687165641791;6260.186175797117;6278.717457714322;6281.874362512633;6291.685415729104;5526.557875370041;5805.651660900359;6337.809865704036;6338.714757835816;6433.646149461637;6190.14587065764;6212.471939884979;6217.4715149212825;6243.906341404973;6255.218097737783;6080.300765412034;6256.593321434092;6264.404881536247;6265.843353916189;6266;5505.174223866452;5785.334686510937;6013.158157857816;6070.666113363807;6119.07606531266;6074.3925607438905;6078.878422431439;6086.360932102066;6093.177421048102;6096.78661246872;4931.5315045070665;5762.740676669476;5827.6794776286015;5996.580239383201;6056.121862329849;5319.787208511616;5867.471927526372;6101.420365065312;6127.816165515042;6129.601575897553;5951.494122999594;5970.611910225822;6006.159137720635;6047.848803779764;6052.848678783065 15:53:38 INFO - 2015-11-18 15:53:38,886 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.5252903709252;564.1058921609249;584.0450862839259;610.8992016317308;622.9159063526423;42290;42322;42377.576224237746;42380.57619423805;42562.723118306465;36964.26071478569;45543.316850247276;46180.53819461804;46235.76882115593;46323.76838115805;9894.307398482128;9938.751531211705;10063.949680251626;10071.446070466121;10091.596336146546;9861.211103111735;9922.404655720644;9984.50077496126;9993.400395976229;10000.899991000106;8932.732018039469;9324.440533568008;9811.313208075437;9836.704898853046;9887.653932112378;9969.950150249275;9998.2001439885;10012.349197302225;10030.749231269203;10051.396916185016;8344.707935222237;9048.728538143867;9769.951150244275;9860.753481162956;9902.702918912444;41653.375199372036;42188.57811421877;42387.36418953687;42397.244179128254;42588.57411425877;3075.199635179422;3249.675032496755;3449.448088305884;3622.855085796565;4048.7773172475504;24380.171487138534;29971.400571988655;30052.398952020838;30097.398052038836;30098.69901300981;2528.4816612594373;2547.872606369674;2556.2459074573044;2673.1980405878157;2705.8105932584726;424733;511112;511138;511376;511562.9999999963;51295;60762.8351590111;71269.2873071273;71879.64060179665;75867;74178.77463676098;75006;75053;75699.62150189214;76073.61963190149;17133.828661713473;17177.88343757652;17232.138393080295;17364.305427782747;17374.305027799;12591.24452532851;12806.871931280753;12882.162659427107;12915.612531624067;13008.089433739548;22324.55350892973;22373.888130559244;22531.436714081952;22640.207592734503;22646.547069058855;9483.857742133874;9628.47043412619;9634.470104144339;9709.223262139154;9719.757006074904;950.9476978766096;987.4914419074182;1010.7978404319166;1073.6671631794168;1110.6667999600088;31083.68916310853;32545.860894868565;33630.831845840614;33675.49486757701;34543.654563454045;921.2952091649893;1060.6022741471947;1085.3921803789904;1142.3146112332533;1202.4949521201117;12284.754304913851;15365.617094461551;15672.686546269011;15784.973976691479;17758.535452652406;667140;675697;677292;677889;678756;64088;64906.05281841553;65322;65349;65508.344916550224;1448.9927550362393;1450.579331993731;1452.012631410651;1457.7084583083213;1598.5124537016088;29718;31933.042008739776;31969.520457193626;32169.678303216668;32559.511607325436;54611;54834.72582637061;54918;55167.17249241345;55357.16964245459;461827;466489;469925;470799;471609;34327.65672343245;45547.772261139806;47089.52910470989;47180.52819471761;47219;48912.77718057077;49148.50851491439;49553.75223123861;50743.238851418;51107;33961.66038339585;36808.81595592005;39967.60032399639;40820.59179408168;41176.794116029225;39429.408558871066;39887;40584.79707601443;40610.59389406068;40968;40457.797711012434;41929;42524.362134568626;42746.1450770989;43050.569494305906;38018.42972355472;40203.59796401999;41050.38424423576;41134.794326028175;41469.37795933003;31890.628952969364;32018.51972220465;32174.873879414106;32667;32800.671993279764 15:53:38 INFO - 2015-11-18 15:53:38,890 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.7935639469408;361.10806308418216;361.8787706118449;362.62106099126413;363.17559140750495;16077.633401160887;19385.903070484645;20023.699644505345;20570.89714551427;21364.57270854582;19459.610807783873;19972.400827975183;20073.297434589793;20703.689444658343;20840.89579552104;5458.85364073545;5554.361248456439;5670.631408958425;5713.885722285552;5864.970675146618;4938.925916111243;5010.549050585447;5075.9746201268945;5077.619178561604;5754.079347304432;4483.529229430912;4909.3126962225315;4990.176620857555;5000.049990501811;5015.949840501585;5076.568491678212;5083.84748457545;5093.337866077386;5103.15797893349;5110.66780659256;4274.572542745701;4299.935500967488;4311.223979683656;4315.417418648505;4330.653547716175;13858.722825543533;14192.929035354757;14212.289385530683;14398.928005359907;14403.135811851218;1660.3192690996755;1897.3359324236544;1967.4982879365814;2012.164951545107;2142.1217300906555;10123.493825308778;10124.746881327952;10315.79368412635;10333.689989300334;10427.843582346271;1596.5609457399191;1613.3224045900633;1647.472808701216;1686.7216909209965;1689.2567270401107;94601.0539894599;97357.99999999929;97756;99354.5032274834;100090;6832.45340372769;6835.931640683629;6878.8624227515165;6884.724611015503;6915.723371065101;6883.89857622778;7456.888146677804;7655.732049378245;7706.07527096752;7733.265339792711;5715.31416230055;5719.513841323451;5767.452092051249;5781.508571771363;5802.65184088956;6166.969165154145;6201.379862013853;6272.372762723691;6272.686365681698;6293;2807.171884294138;2954.985225073861;3011.141824580028;3065.6474505431715;3100.162956001912;1096.6764804382567;1098.1983152298867;1102.9448527573588;1103.6358001859367;1152.2395219155317;385.78781670081906;386.08690447092425;431.5598089948235;448.3634733223759;460.5624656576266;10855.620053298097;10860.859609740863;11116.110711143088;11409.657710268706;11716.589919352782;423.9576042395736;439.47702234341034;453.4603821452527;468.6157350972238;487.4613552025032;6346.27017892939;6395.912694841888;6457.2896981332015;6460.483161347081;6516.055172000033;718854;748452;758255;787418;792477;98821.5176772349;115006.42496787463;116519;118170;119080;472.6974736168855;516.8010316028356;538.5530010091614;542.9484199001089;545.7162275616657;11542.307461552333;11817.763644726885;11914.642560723192;11953.641390758292;12056.156069075081;38191.04522386852;48735.75632121817;49670.758231043066;50078.24882626836;50495.24257136219;69353;72165.6391718038;75887.62056189684;76223;77033.2296677026;6267.4045965633195;6278.121063051268;6298.968505157445;6323.747050117944;6391.96804015977;10321;10551.841722374016;11756.94187523127;12283.75432491363;12377.195482293622;10370.27408081427;10562.366258024544;10769.515371808444;10779.02988731018;10898.673039808818;9885.703428897144;10413.166946644402;10682.57269709234;10815.24293299493;10833.86244444322;8740.781480462785;10771.946140269249;10773.946130269298;11053.944730276296;11236.66290011301;6290.779822706183;6366.77716279928;6369;6440.967795160994;6459.386358295955;10834.837477438003;10846.783064338511;11015.889841101487;11074.723131921766;11087.889121109009 15:53:38 INFO - 2015-11-18 15:53:38,891 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1532.1420004797308;1566.8589826915575;1680.8907421017634;1824.6624374490711;1931.4109196695003;7280.781576552698;7374.520656157346;7558.395328373731;7964.362850971923;7966.641501132442;7507.4369422293275;7625.504342217766;7666.425018123635;7737.264959828807;7744.535327880331;2341.5316936612703;2370.9407264818346;2377.465070359164;2380.3097101840444;2382.03527571333;2364.9408764780846;2395.5089206712582;2421.443068094339;2424.224248240555;2430.635404689302;2344.5193735284224;2362.6574146748712;2392.234484964812;2396.6405039244078;2403.0267741564694;2301.8043466305385;2325.3140323604493;2338.251759436981;2345.355027367479;2375.0143690368477;2291.5073259249343;2316.872572008539;2328.9650655240184;2336.19401306549;2339.812814974798;7909.802254943615;7975.361971042303;7975.920240797575;7985.401094917905;7995.640196191185;4430.26900561407;5033.421156566968;5104.719240441774;5136.845894623168;5153.072446959546;3115.641701204368;3418.4017796885446;3441.2601290722614;3493.9301213975577;3514.4376899695926;1022.6062965758163;1039.0648416425202;1042.95828166874;1065.8667666541683;1071.2715353559577;8523.701670441505;8753.562321883881;8888.02231754513;8964.820703585958;10340.793184136275;4558.544145585415;4630;4673.462551806518;4678.7660616969015;4681.461631912373;7803.765887023398;8951.597178127;9005.729828105168;9064.184223419923;9087.727368178834;4284.892877678083;5062.848114556496;5097.974510127426;5122.974385128051;5143.331366922351;4005.619466150711;4014.598540145962;4530.275155975029;4604.1712491751805;4665.6967297125575;3791.3554695701796;3820.8089595520114;3821.6942644588366;3834.1948190880225;3856.8842934712;1256.2211428914131;1277.6137890388845;1278.5525066226746;1281.4874050379922;1286.5432771366031;1339.6516905604612;1354.1130559483554;1354.7561438941086;1360.081944687332;1395.9022868399318;7366.926330736731;7526.32263096313;7538.434617403716;7542.057242844645;7553.395728341719;484.88847565060235;492.9186684197139;495.6951474842946;497.86308765089166;500.8096923169172;5583.832485025456;5940.34656187819;5952.345242023374;5954.285485741739;5966.224390829165;8141.51150930946;9368.718938431857;9414.105659962293;9496.43021418717;9534.809303813885;9170.541472926327;9320.487373194404;9324.90675093254;9373.437593744397;9420.670276540426;7484.513506622052;7524.623768811647;7565.394768418513;7566.092068951761;7599.924000759922;7253.8186545336785;7355.264473552816;7364.447666424932;7372.373348265243;7406.629668516445;8252.46358986664;8444.831103378021;8520.872186917077;8550.82898342042;8628.52543110135;8514.74455766328;8769.254613357936;8814.5592720365;8824.823503530022;8942.284617230736;6948.478864085315;6960.721571137098;6971.2331643518155;6976.616286104313;7007;7547.811304717426;7629.3133617974645;7667.194944530744;7668.731594394169;7675.04061992251;7088.503804733619;7094.9290507094265;7119.786406407816;7217.206107328295;7299.124105107421;6901.413379862768;6951;6983.336583024605;6990.965045174741;7205.71177152908;7156.1770396403;7168.996340512437;7197.316254955771;7201.991721158937;7210.927890721236;6362.6818659067785;6440.5491615588335;6461.57999730016;6549.901751473636;6569.737210511526;6632.303608121078;6642.701078451578;6653.733850646114;6674.365935236145;6706.195256569243 15:53:38 INFO - 2015-11-18 15:53:38,894 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.4841800578899;318.3410340594968;325.1156853358863;328.3203768199826;331.36543519160807;6785.1518560179975;6816.829579260515;6944.444444444445;7058.858822823547;7123.821904452385;6744.08954791103;6779.2542820289855;6844.315568443153;6927.203371612266;6941.54879932804;5025.472325405825;5082.364704411949;5084.898302033957;5092.79628814847;5114.721319670082;4885.5114488551035;5058.392992840846;5067.898642027158;5086.593072554206;5105.463926287742;4115.382692596119;4118.670506359484;5002.849914502571;5017.749112544377;5068.5438310552045;5009.874753131183;5015.84952451427;5016.924746128811;5019.046381187581;5019.996000799854;4023.5574086850424;4081.755094694328;4177.248095342837;4246.830126794925;4261.893452663678;6578.473722102221;6659.6670166491485;6668.499862510283;6674.132362792854;6687.933120668779;5209.505097015777;5530.834074977757;5830.2420685310635;5884.058550631921;5930.229070220887;7045.859082818366;7397.482176247611;7402.148752893432;7414.443916706268;7425.591592462412;4702.365180700596;4708.058388322315;4710.74090924999;4728.148933192024;4734.597559207437;7767.650455729449;7825.295723384866;7843.882341764878;7844.529328240267;7844.843103137962;4668.136394766979;4733.337332773414;4767.856964291077;4772.952270477251;4780.450248221499;4006.7996600169877;4849.2726091086615;4874.195757699939;4875.68308059975;4878.414590249193;4559;5853.5317174625925;5877.853053673607;5886.1465087562065;5909.527237820964;6038.5169186465855;7438.479306448497;7447.106347238366;7449.733545297312;7455.85088298231;1644.0793155832532;1707.240278076269;1707.5218938697185;1709.0173150438548;1711.4694444722177;1076.246627360835;1078.8327809189432;1083.9078678312433;1090.1061129873428;1095.46322302073;5719.742611582489;6873.621950792754;6923.861522769516;6962.338577835098;6989.860202796017;7692.846143077107;7703.57630330326;7715.768526944201;7719.84202369649;7755.922440775633;5759.510441612426;6836.794896153124;6918.654067296615;6937.271586483447;7066.328698773608;4001.6598589119667;4023.8189281482405;4083.5303940047274;4103.2409004334295;4171.687123465752;6703.731850725916;7947.4039447041705;7992.640331185111;8069;8083.555404452694;7874.976253087062;8031.518108913484;8034.196580341919;8038.638261278256;8079.4344395892895;8016.7194148204535;8060.556669383241;8065.4757440767335;8078.394120440873;8088.272055514914;7773.144954055162;7800.687972481264;7813.843723125392;7824.100228473799;7826.178251283533;7433.405327573673;7630.1606823248285;7634.541927484369;7637.961810190914;7653.349465295512;5748.712564371848;7467.655821952101;8020;8044.758657240292;8047.919520804951;4423.800928958269;4558.905862592887;4571.1543364477675;4617.145828021827;4994;5795.420457954171;7700.576468294297;7705.845883082195;7816.687332506864;7836.80407989782;7498.212687667717;7499.850003000019;7504.962475187589;7512;7528.284812942762;6453.064305675744;6868.759593414206;6939.201991770809;7466.25337466249;7521.811954701177;7306.525075870051;7309.5248808827255;7318.96340518294;7318.963405183153;7319.926800732138;6719;6868.313168683092;7435.996140520961;7445.702171913063;7491.587962662106;7091.1490621125795;7307.378872795659;7307.9634601828775;7313.085864266966;7331.816704582428 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.2189670930078;722.7795522365676;744.6611791634805;797.1430711984615;821.5317269156582;11848.585299514518;11900.583479578216;11991.340476273801;12010;12113.030957523399;10649.946750266257;14684.265786710648;14720.484783032596;14741.852581474182;14754.409823607042;732.9706811727525;748.988765168523;911.0934620053057;928.6981730937439;938.9483578403185;932.8367535681228;933.9579718912631;942.853857652065;947.5735918836517;948.0898337595917;975.5609975511048;980.103205566909;990.1435258501416;990.4601991914424;991.1080027974845;966.8356379415482;973.5424350555263;978.706388083572;981.2297346582969;982.1504398695113;709.8473828126978;709.8580283943232;711.4024219655514;713.5682911838367;718.0199028326349;15303.693926121416;15333.923330383277;15415;15545.844541554552;15574.532764017098;12617.936910315482;12715.427805748763;12812.935935320356;13088.018398620141;13090.738185236338;10067.395956242648;10211.897881021168;10330.811956624933;10587.84118238227;10902.672919812418;2999.8350090745002;3553.058439513531;3557.1107223194203;3584.13980644646;3601.8019008954498;78748.21251787466;80214.59892700499;80300.59849700773;82094.76857847137;82692;9414.246860251164;9539.236861051098;9586.66446674363;9652.22782177424;9893.950530247303;21416.036278367512;21711.240106596193;21842;22010.88994555017;22301.10795568159;7397.37122344596;7464.514806537558;7679.500832445873;7730.149683534807;7837.177096404909;3570.3573356795505;3935.740563019863;4065.918681626351;4156.56356082607;4237.533871274158;2998.445287621797;3471.3057388522398;3486.738494612914;3496.1084923344383;3498.8250587470525;470.2358667165856;538.4104405675779;542.9511343979061;551.831691334147;553.6346011632303;456.24035980092776;503.89898072710514;510.5864249957472;560.3248086056374;631.5515983651567;8525.616347264388;8626.266767324847;8964.238039766562;9304.72085837426;9577.712668619952;523.7878659143054;595.7110801261384;598.4255115089476;604.1813342920368;609.1259043272918;4076.7146299759324;4106.199291138199;4120.835166593302;4197.664186865043;4220.620144187038;96693.51653241689;97594;97984;98985.5152172718;100245;73715;76512;79981.80118292292;86116.70824937632;86806.56596717102;64934.675326623066;66254.66872665606;68504;72059;73844.63077684578;8307.833843322978;8312.16878312188;8418.242358187792;8518.3502498788;8539.188777066169;51256.48743512666;51433.714157144874;51480.74259628678;52257.47742522678;52644.736776315876;69674;74696.62651686707;75282.6235868839;76149;76422.23577764152;7831.608419579112;8246.422750407413;8271.83456330858;8309.210624990616;8314.085450600309;11978.70053248641;12264.75470490603;12521.499140034297;12584.18202816814;12870.16343937641;11428.314301141625;12022.338771367658;12155.574554890536;12189;12343.69140771452;11407.543698251977;12006.75986480283;12119.939400303294;12142.514299427923;12378.257304561756;11601.477933493183;11617.941910290394;11989.40052997364;12006.099542534519;12380.938095309466;9855.704328870146;9861.457619830979;9950.203983681144;10216.897831021595;10335.328203666737;9425.245980321695;9463.290253231173;9634.229261659191;10310.278280520291;10311.845322320321 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: __startTimestamp1447890818881__endTimestamp 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:38 INFO - 2015-11-18 15:53:38,896 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:53:38 INFO - 2015-11-18 15:53:38,897 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,897 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5722.61 Median:5908.44 stddev:659.29 (11.2%) stddev-sans-first:636.43 15:53:38 INFO - 2015-11-18 15:53:38,898 DEBUG : BROWSER_OUTPUT: Values: 3435.6 3517.9 3523.8 3542.6 3552.7 5616.5 5711.1 5721.5 5722.1 5742.9 5516.0 5646.1 5670.4 5713.7 5772.3 5210.7 5217.6 5264.7 5322.8 5327.3 5300.3 5328.2 5358.7 5362.1 5382.4 5071.5 5077.8 5174.3 5260.6 5289.2 5250.4 5266.7 5282.8 5286.7 5318.9 5216.0 5261.9 5301.3 5317.1 5372.2 3992.5 4388.8 5464.0 5662.7 5686.5 6202.9 6231.7 6231.7 6236.5 6250.3 6286.2 6330.8 6331.9 6351.9 6374.5 5800.2 5828.7 5908.4 5969.4 6017.5 6285.1 6364.8 6403.7 6418.3 6423.7 5944.6 6205.8 6214.8 6218.0 6226.4 4959.7 6201.8 6228.8 6292.1 6310.3 5794.1 5798.6 6206.4 6230.4 6272.9 6025.9 6127.7 6250.8 6273.6 6292.0 4875.8 4981.9 4984.9 4994.0 5000.2 3833.0 4455.2 4456.0 4477.2 4477.3 5627.4 5629.2 5683.6 5835.9 5845.5 6251.5 6265.8 6269.8 6273.2 6287.8 5050.3 5854.4 5894.2 5926.7 5966.5 5221.6 5359.7 5362.5 5467.4 5495.2 6415.5 6422.7 6466.0 6468.4 6473.3 6256.7 6260.2 6278.7 6281.9 6291.7 5526.6 5805.7 6337.8 6338.7 6433.6 6190.1 6212.5 6217.5 6243.9 6255.2 6080.3 6256.6 6264.4 6265.8 6266.0 5505.2 5785.3 6013.2 6070.7 6119.1 6074.4 6078.9 6086.4 6093.2 6096.8 4931.5 5762.7 5827.7 5996.6 6056.1 5319.8 5867.5 6101.4 6127.8 6129.6 5951.5 5970.6 6006.2 6047.8 6052.8 15:53:38 INFO - 2015-11-18 15:53:38,898 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,898 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:70724.91 Median:42306.00 stddev:147620.40 (348.9%) stddev-sans-first:147940.47 15:53:38 INFO - 2015-11-18 15:53:38,898 DEBUG : BROWSER_OUTPUT: Values: 542.5 564.1 584.0 610.9 622.9 42290.0 42322.0 42377.6 42380.6 42562.7 36964.3 45543.3 46180.5 46235.8 46323.8 9894.3 9938.8 10063.9 10071.4 10091.6 9861.2 9922.4 9984.5 9993.4 10000.9 8932.7 9324.4 9811.3 9836.7 9887.7 9970.0 9998.2 10012.3 10030.7 10051.4 8344.7 9048.7 9770.0 9860.8 9902.7 41653.4 42188.6 42387.4 42397.2 42588.6 3075.2 3249.7 3449.4 3622.9 4048.8 24380.2 29971.4 30052.4 30097.4 30098.7 2528.5 2547.9 2556.2 2673.2 2705.8 424733.0 511112.0 511138.0 511376.0 511563.0 51295.0 60762.8 71269.3 71879.6 75867.0 74178.8 75006.0 75053.0 75699.6 76073.6 17133.8 17177.9 17232.1 17364.3 17374.3 12591.2 12806.9 12882.2 12915.6 13008.1 22324.6 22373.9 22531.4 22640.2 22646.5 9483.9 9628.5 9634.5 9709.2 9719.8 950.9 987.5 1010.8 1073.7 1110.7 31083.7 32545.9 33630.8 33675.5 34543.7 921.3 1060.6 1085.4 1142.3 1202.5 12284.8 15365.6 15672.7 15785.0 17758.5 667140.0 675697.0 677292.0 677889.0 678756.0 64088.0 64906.1 65322.0 65349.0 65508.3 1449.0 1450.6 1452.0 1457.7 1598.5 29718.0 31933.0 31969.5 32169.7 32559.5 54611.0 54834.7 54918.0 55167.2 55357.2 461827.0 466489.0 469925.0 470799.0 471609.0 34327.7 45547.8 47089.5 47180.5 47219.0 48912.8 49148.5 49553.8 50743.2 51107.0 33961.7 36808.8 39967.6 40820.6 41176.8 39429.4 39887.0 40584.8 40610.6 40968.0 40457.8 41929.0 42524.4 42746.1 43050.6 38018.4 40203.6 41050.4 41134.8 41469.4 31890.6 32018.5 32174.9 32667.0 32800.7 15:53:38 INFO - 2015-11-18 15:53:38,898 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,900 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36539.22 Median:4313.32 stddev:125583.64 (2911.5%) stddev-sans-first:125906.54 15:53:38 INFO - 2015-11-18 15:53:38,900 DEBUG : BROWSER_OUTPUT: Values: 353.8 361.1 361.9 362.6 363.2 16077.6 19385.9 20023.7 20570.9 21364.6 19459.6 19972.4 20073.3 20703.7 20840.9 5458.9 5554.4 5670.6 5713.9 5865.0 4938.9 5010.5 5076.0 5077.6 5754.1 4483.5 4909.3 4990.2 5000.0 5015.9 5076.6 5083.8 5093.3 5103.2 5110.7 4274.6 4299.9 4311.2 4315.4 4330.7 13858.7 14192.9 14212.3 14398.9 14403.1 1660.3 1897.3 1967.5 2012.2 2142.1 10123.5 10124.7 10315.8 10333.7 10427.8 1596.6 1613.3 1647.5 1686.7 1689.3 94601.1 97358.0 97756.0 99354.5 100090.0 6832.5 6835.9 6878.9 6884.7 6915.7 6883.9 7456.9 7655.7 7706.1 7733.3 5715.3 5719.5 5767.5 5781.5 5802.7 6167.0 6201.4 6272.4 6272.7 6293.0 2807.2 2955.0 3011.1 3065.6 3100.2 1096.7 1098.2 1102.9 1103.6 1152.2 385.8 386.1 431.6 448.4 460.6 10855.6 10860.9 11116.1 11409.7 11716.6 424.0 439.5 453.5 468.6 487.5 6346.3 6395.9 6457.3 6460.5 6516.1 718854.0 748452.0 758255.0 787418.0 792477.0 98821.5 115006.4 116519.0 118170.0 119080.0 472.7 516.8 538.6 542.9 545.7 11542.3 11817.8 11914.6 11953.6 12056.2 38191.0 48735.8 49670.8 50078.2 50495.2 69353.0 72165.6 75887.6 76223.0 77033.2 6267.4 6278.1 6299.0 6323.7 6392.0 10321.0 10551.8 11756.9 12283.8 12377.2 10370.3 10562.4 10769.5 10779.0 10898.7 9885.7 10413.2 10682.6 10815.2 10833.9 8740.8 10771.9 10773.9 11053.9 11236.7 6290.8 6366.8 6369.0 6441.0 6459.4 10834.8 10846.8 11015.9 11074.7 11087.9 15:53:38 INFO - 2015-11-18 15:53:38,900 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,900 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5503.75 Median:6601.02 stddev:2747.34 (41.6%) stddev-sans-first:2738.82 15:53:38 INFO - 2015-11-18 15:53:38,902 DEBUG : BROWSER_OUTPUT: Values: 1532.1 1566.9 1680.9 1824.7 1931.4 7280.8 7374.5 7558.4 7964.4 7966.6 7507.4 7625.5 7666.4 7737.3 7744.5 2341.5 2370.9 2377.5 2380.3 2382.0 2364.9 2395.5 2421.4 2424.2 2430.6 2344.5 2362.7 2392.2 2396.6 2403.0 2301.8 2325.3 2338.3 2345.4 2375.0 2291.5 2316.9 2329.0 2336.2 2339.8 7909.8 7975.4 7975.9 7985.4 7995.6 4430.3 5033.4 5104.7 5136.8 5153.1 3115.6 3418.4 3441.3 3493.9 3514.4 1022.6 1039.1 1043.0 1065.9 1071.3 8523.7 8753.6 8888.0 8964.8 10340.8 4558.5 4630.0 4673.5 4678.8 4681.5 7803.8 8951.6 9005.7 9064.2 9087.7 4284.9 5062.8 5098.0 5123.0 5143.3 4005.6 4014.6 4530.3 4604.2 4665.7 3791.4 3820.8 3821.7 3834.2 3856.9 1256.2 1277.6 1278.6 1281.5 1286.5 1339.7 1354.1 1354.8 1360.1 1395.9 7366.9 7526.3 7538.4 7542.1 7553.4 484.9 492.9 495.7 497.9 500.8 5583.8 5940.3 5952.3 5954.3 5966.2 8141.5 9368.7 9414.1 9496.4 9534.8 9170.5 9320.5 9324.9 9373.4 9420.7 7484.5 7524.6 7565.4 7566.1 7599.9 7253.8 7355.3 7364.4 7372.4 7406.6 8252.5 8444.8 8520.9 8550.8 8628.5 8514.7 8769.3 8814.6 8824.8 8942.3 6948.5 6960.7 6971.2 6976.6 7007.0 7547.8 7629.3 7667.2 7668.7 7675.0 7088.5 7094.9 7119.8 7217.2 7299.1 6901.4 6951.0 6983.3 6991.0 7205.7 7156.2 7169.0 7197.3 7202.0 7210.9 6362.7 6440.5 6461.6 6549.9 6569.7 6632.3 6642.7 6653.7 6674.4 6706.2 15:53:38 INFO - 2015-11-18 15:53:38,902 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,902 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5986.64 Median:6800.99 stddev:1970.60 (29.0%) stddev-sans-first:1928.87 15:53:38 INFO - 2015-11-18 15:53:38,903 DEBUG : BROWSER_OUTPUT: Values: 271.5 318.3 325.1 328.3 331.4 6785.2 6816.8 6944.4 7058.9 7123.8 6744.1 6779.3 6844.3 6927.2 6941.5 5025.5 5082.4 5084.9 5092.8 5114.7 4885.5 5058.4 5067.9 5086.6 5105.5 4115.4 4118.7 5002.8 5017.7 5068.5 5009.9 5015.8 5016.9 5019.0 5020.0 4023.6 4081.8 4177.2 4246.8 4261.9 6578.5 6659.7 6668.5 6674.1 6687.9 5209.5 5530.8 5830.2 5884.1 5930.2 7045.9 7397.5 7402.1 7414.4 7425.6 4702.4 4708.1 4710.7 4728.1 4734.6 7767.7 7825.3 7843.9 7844.5 7844.8 4668.1 4733.3 4767.9 4773.0 4780.5 4006.8 4849.3 4874.2 4875.7 4878.4 4559.0 5853.5 5877.9 5886.1 5909.5 6038.5 7438.5 7447.1 7449.7 7455.9 1644.1 1707.2 1707.5 1709.0 1711.5 1076.2 1078.8 1083.9 1090.1 1095.5 5719.7 6873.6 6923.9 6962.3 6989.9 7692.8 7703.6 7715.8 7719.8 7755.9 5759.5 6836.8 6918.7 6937.3 7066.3 4001.7 4023.8 4083.5 4103.2 4171.7 6703.7 7947.4 7992.6 8069.0 8083.6 7875.0 8031.5 8034.2 8038.6 8079.4 8016.7 8060.6 8065.5 8078.4 8088.3 7773.1 7800.7 7813.8 7824.1 7826.2 7433.4 7630.2 7634.5 7638.0 7653.3 5748.7 7467.7 8020.0 8044.8 8047.9 4423.8 4558.9 4571.2 4617.1 4994.0 5795.4 7700.6 7705.8 7816.7 7836.8 7498.2 7499.9 7505.0 7512.0 7528.3 6453.1 6868.8 6939.2 7466.3 7521.8 7306.5 7309.5 7319.0 7319.0 7319.9 6719.0 6868.3 7436.0 7445.7 7491.6 7091.1 7307.4 7308.0 7313.1 7331.8 15:53:38 INFO - 2015-11-18 15:53:38,903 DEBUG : BROWSER_OUTPUT: 15:53:38 INFO - 2015-11-18 15:53:38,903 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18737.76 Median:597.07 stddev:26768.28 (4483.3%) stddev-sans-first:26809.02 15:53:38 INFO - 2015-11-18 15:53:38,904 DEBUG : BROWSER_OUTPUT: Values: 676.2 722.8 744.7 797.1 821.5 11848.6 11900.6 11991.3 12010.0 12113.0 10649.9 14684.3 14720.5 14741.9 14754.4 733.0 749.0 911.1 928.7 938.9 932.8 934.0 942.9 947.6 948.1 975.6 980.1 990.1 990.5 991.1 966.8 973.5 978.7 981.2 982.2 709.8 709.9 711.4 713.6 718.0 15303.7 15333.9 15415.0 15545.8 15574.5 12617.9 12715.4 12812.9 13088.0 13090.7 10067.4 10211.9 10330.8 10587.8 10902.7 2999.8 3553.1 3557.1 3584.1 3601.8 78748.2 80214.6 80300.6 82094.8 82692.0 9414.2 9539.2 9586.7 9652.2 9894.0 21416.0 21711.2 21842.0 22010.9 22301.1 7397.4 7464.5 7679.5 7730.1 7837.2 3570.4 3935.7 4065.9 4156.6 4237.5 2998.4 3471.3 3486.7 3496.1 3498.8 470.2 538.4 543.0 551.8 553.6 456.2 503.9 510.6 560.3 631.6 8525.6 8626.3 8964.2 9304.7 9577.7 523.8 595.7 598.4 604.2 609.1 4076.7 4106.2 4120.8 4197.7 4220.6 96693.5 97594.0 97984.0 98985.5 100245.0 73715.0 76512.0 79981.8 86116.7 86806.6 64934.7 66254.7 68504.0 72059.0 73844.6 8307.8 8312.2 8418.2 8518.4 8539.2 51256.5 51433.7 51480.7 52257.5 52644.7 69674.0 74696.6 75282.6 76149.0 76422.2 7831.6 8246.4 8271.8 8309.2 8314.1 11978.7 12264.8 12521.5 12584.2 12870.2 11428.3 12022.3 12155.6 12189.0 12343.7 11407.5 12006.8 12119.9 12142.5 12378.3 11601.5 11617.9 11989.4 12006.1 12380.9 9855.7 9861.5 9950.2 10216.9 10335.3 9425.2 9463.3 9634.2 10310.3 10311.8 15:53:38 INFO - 2015-11-18 15:53:38,905 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:38 INFO - 2015-11-18 15:53:38,905 DEBUG : BROWSER_OUTPUT: 15:53:39 INFO - 2015-11-18 15:53:39,362 INFO : Browser exited with error code: 0 15:53:39 INFO - 2015-11-18 15:53:39,386 INFO : Completed test dromaeo_css (00:18:29) 15:53:39 INFO - 2015-11-18 15:53:39,386 INFO : Starting test kraken 15:53:39 INFO - 2015-11-18 15:53:39,386 DEBUG : operating with platform_type : mac_ 15:53:39 INFO - 2015-11-18 15:53:39,386 INFO : Initialising browser for kraken test... 15:53:39 INFO - 2015-11-18 15:53:39,399 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpl8waOj/profile http://localhost:49264/getInfo.html 15:53:41 INFO - 2015-11-18 15:53:41,987 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:53:41 INFO - 2015-11-18 15:53:41,987 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:53:41 INFO - 2015-11-18 15:53:41,987 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:53:41 INFO - 2015-11-18 15:53:41,987 DEBUG : BROWSER_OUTPUT: __metrics 15:53:42 INFO - 2015-11-18 15:53:42,584 INFO : Browser initialized. 15:53:42 INFO - 2015-11-18 15:53:42,584 INFO : Running cycle 1/1 for kraken test... 15:53:42 INFO - 2015-11-18 15:53:42,585 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpl8waOj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:53:54 INFO - 2015-11-18 15:53:54,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 235950080 15:53:54 INFO - 2015-11-18 15:53:54,583 DEBUG : BROWSER_OUTPUT: 15:53:57 INFO - 2015-11-18 15:53:57,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:57 INFO - 2015-11-18 15:53:57,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 248553472 15:53:57 INFO - 2015-11-18 15:53:57,763 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-11-18 15:54:00,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 15:54:00 INFO - 2015-11-18 15:54:00,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 258596864 15:54:00 INFO - 2015-11-18 15:54:00,913 DEBUG : BROWSER_OUTPUT: 15:54:04 INFO - 2015-11-18 15:54:04,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 15:54:04 INFO - 2015-11-18 15:54:04,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 262610944 15:54:04 INFO - 2015-11-18 15:54:04,901 DEBUG : BROWSER_OUTPUT: 15:54:06 INFO - 2015-11-18 15:54:06,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 15:54:07 INFO - 2015-11-18 15:54:07,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 263565312 15:54:07 INFO - 2015-11-18 15:54:07,511 DEBUG : BROWSER_OUTPUT: 15:54:09 INFO - 2015-11-18 15:54:09,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:10 INFO - 2015-11-18 15:54:10,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 265265152 15:54:10 INFO - 2015-11-18 15:54:10,154 DEBUG : BROWSER_OUTPUT: 15:54:12 INFO - 2015-11-18 15:54:12,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:13 INFO - 2015-11-18 15:54:13,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 265027584 15:54:13 INFO - 2015-11-18 15:54:13,469 DEBUG : BROWSER_OUTPUT: 15:54:16 INFO - 2015-11-18 15:54:16,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:17 INFO - 2015-11-18 15:54:17,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 265097216 15:54:17 INFO - 2015-11-18 15:54:17,184 DEBUG : BROWSER_OUTPUT: 15:54:20 INFO - 2015-11-18 15:54:20,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 15:54:20 INFO - 2015-11-18 15:54:20,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 265625600 15:54:20 INFO - 2015-11-18 15:54:20,667 DEBUG : BROWSER_OUTPUT: 15:54:22 INFO - 2015-11-18 15:54:22,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:22 INFO - 2015-11-18 15:54:22,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 263254016 15:54:22 INFO - 2015-11-18 15:54:22,787 DEBUG : BROWSER_OUTPUT: 15:54:24 INFO - 2015-11-18 15:54:24,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:25 INFO - 2015-11-18 15:54:25,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 264658944 15:54:25 INFO - 2015-11-18 15:54:25,218 DEBUG : BROWSER_OUTPUT: 15:54:27 INFO - 2015-11-18 15:54:27,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:27 INFO - 2015-11-18 15:54:27,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 264777728 15:54:27 INFO - 2015-11-18 15:54:27,949 DEBUG : BROWSER_OUTPUT: 15:54:30 INFO - 2015-11-18 15:54:30,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:31 INFO - 2015-11-18 15:54:31,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 264597504 15:54:31 INFO - 2015-11-18 15:54:31,157 DEBUG : BROWSER_OUTPUT: 15:54:33 INFO - 2015-11-18 15:54:33,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:34 INFO - 2015-11-18 15:54:34,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 264658944 15:54:34 INFO - 2015-11-18 15:54:34,274 DEBUG : BROWSER_OUTPUT: 15:54:35 INFO - 2015-11-18 15:54:35,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 15:54:36 INFO - 2015-11-18 15:54:36,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 265023488 15:54:36 INFO - 2015-11-18 15:54:36,137 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;110;114;114;114;129;121;115;115;116 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;140;124;139;153;120;138;140;140;181;119 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |2;audio-dft;194;196;196;218;229;210;206;220;278;206 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |3;audio-fft;65;68;79;80;86;59;105;57;55;58 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;78;106;74;76;78;100;96;109;140 15:54:36 INFO - 2015-11-18 15:54:36,139 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;91;91;90;90;92;92;92;91;90;91 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;98;98;102;98;113;149;149;105;151;149 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;93;128;146;143;102;90;90;90;94 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;61;60;60;61;61;60;67;60;59 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;63;65;65;66;69;67;86;100 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;77;86;85;86;83;97;113;110;85 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;133;139;101;133;128;129;138;148;135 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;139;139;140;138;140;137;153;179;169 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;65;66;65;68;68;66;65;67 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:36 INFO - 2015-11-18 15:54:36,140 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:54:36 INFO - 2015-11-18 15:54:36,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,811 15:54:36 INFO - 2015-11-18 15:54:36,142 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:54:36 INFO - 2015-11-18 15:54:36,142 DEBUG : BROWSER_OUTPUT: __startTimestamp1447890876138__endTimestamp 15:54:36 INFO - 2015-11-18 15:54:36,142 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,143 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:36 INFO - 2015-11-18 15:54:36,143 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:54:36 INFO - 2015-11-18 15:54:36,143 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,143 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.40 Median:115.50 stddev:5.19 (4.5%) stddev-sans-first:5.50 15:54:36 INFO - 2015-11-18 15:54:36,143 DEBUG : BROWSER_OUTPUT: Values: 116.0 110.0 114.0 114.0 114.0 129.0 121.0 115.0 115.0 116.0 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.40 Median:140.00 stddev:18.10 (12.9%) stddev-sans-first:19.20 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: Values: 140.0 124.0 139.0 153.0 120.0 138.0 140.0 140.0 181.0 119.0 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:215.30 Median:214.00 stddev:24.83 (11.6%) stddev-sans-first:25.11 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: Values: 194.0 196.0 196.0 218.0 229.0 210.0 206.0 220.0 278.0 206.0 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.20 Median:66.50 stddev:16.11 (24.2%) stddev-sans-first:16.93 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: Values: 65.0 68.0 79.0 80.0 86.0 59.0 105.0 57.0 55.0 58.0 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:93.40 Median:76.50 stddev:21.20 (27.7%) stddev-sans-first:21.64 15:54:36 INFO - 2015-11-18 15:54:36,144 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 106.0 74.0 76.0 78.0 100.0 96.0 109.0 140.0 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:91.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 90.0 90.0 92.0 92.0 92.0 91.0 90.0 91.0 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:121.20 Median:150.00 stddev:24.76 (16.5%) stddev-sans-first:24.80 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: Values: 98.0 98.0 102.0 98.0 113.0 149.0 149.0 105.0 151.0 149.0 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:107.00 Median:90.00 stddev:22.81 (25.3%) stddev-sans-first:23.71 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 128.0 146.0 143.0 102.0 90.0 90.0 90.0 94.0 15:54:36 INFO - 2015-11-18 15:54:36,145 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,146 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.50 stddev:2.23 (3.7%) stddev-sans-first:2.35 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 60.0 60.0 61.0 61.0 60.0 67.0 60.0 59.0 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:66.00 stddev:12.05 (18.3%) stddev-sans-first:12.57 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 63.0 65.0 65.0 66.0 69.0 67.0 86.0 100.0 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:85.50 stddev:11.98 (14.0%) stddev-sans-first:12.56 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: Values: 97.0 77.0 86.0 85.0 86.0 83.0 97.0 113.0 110.0 85.0 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:134.00 stddev:12.72 (9.5%) stddev-sans-first:12.92 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: Values: 120.0 133.0 139.0 101.0 133.0 128.0 129.0 138.0 148.0 135.0 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,147 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:141.50 stddev:14.77 (10.4%) stddev-sans-first:15.56 15:54:36 INFO - 2015-11-18 15:54:36,148 DEBUG : BROWSER_OUTPUT: Values: 143.0 139.0 139.0 140.0 138.0 140.0 137.0 153.0 179.0 169.0 15:54:36 INFO - 2015-11-18 15:54:36,148 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,148 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 15:54:36 INFO - 2015-11-18 15:54:36,148 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 65.0 66.0 65.0 68.0 68.0 66.0 65.0 67.0 15:54:36 INFO - 2015-11-18 15:54:36,148 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:36 INFO - 2015-11-18 15:54:36,148 DEBUG : BROWSER_OUTPUT: 15:54:36 INFO - 2015-11-18 15:54:36,964 INFO : Browser exited with error code: 0 15:54:37 INFO - 2015-11-18 15:54:37,008 INFO : Completed test kraken (00:00:57) 15:54:37 INFO - 2015-11-18 15:54:37,008 INFO : Starting test v8_7 15:54:37 INFO - 2015-11-18 15:54:37,008 DEBUG : operating with platform_type : mac_ 15:54:37 INFO - 2015-11-18 15:54:37,008 INFO : Initialising browser for v8_7 test... 15:54:37 INFO - 2015-11-18 15:54:37,021 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpklzH7L/profile http://localhost:49264/getInfo.html 15:54:39 INFO - 2015-11-18 15:54:39,567 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:54:39 INFO - 2015-11-18 15:54:39,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:54:39 INFO - 2015-11-18 15:54:39,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:54:39 INFO - 2015-11-18 15:54:39,568 DEBUG : BROWSER_OUTPUT: __metrics 15:54:40 INFO - 2015-11-18 15:54:40,260 INFO : Browser initialized. 15:54:40 INFO - 2015-11-18 15:54:40,260 INFO : Running cycle 1/1 for v8_7 test... 15:54:40 INFO - 2015-11-18 15:54:40,260 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpklzH7L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:52 INFO - 2015-11-18 15:54:52,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 237252608 15:54:52 INFO - 2015-11-18 15:54:52,140 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 15:55:13 INFO - 2015-11-18 15:55:13,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 248598528 15:55:13 INFO - 2015-11-18 15:55:13,789 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:55:13 INFO - 2015-11-18 15:55:13,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:55:13 INFO - 2015-11-18 15:55:13,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:55:13 INFO - 2015-11-18 15:55:13,789 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |0;Richards;148.85382554331647 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.60441292356185 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.28611898017 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4916.666666666667 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |4;RayTrace;967.1179883945841 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |5;Earley;722.0216606498195 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |6;Boyer;12961.538461538461 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |7;RegExp;27405.405405405407 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |8;Splay;678.763440860215 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4545.454545454545 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: __startTimestamp1447890913782__endTimestamp 15:55:13 INFO - 2015-11-18 15:55:13,790 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.85 Median:148.85 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: Values: 148.9 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.60 Median:157.60 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: Values: 157.6 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.29 Median:283.29 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: Values: 283.3 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4916.67 Median:4916.67 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,791 DEBUG : BROWSER_OUTPUT: Values: 4916.7 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:967.12 Median:967.12 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: Values: 967.1 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: Values: 722.0 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12961.54 Median:12961.54 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: Values: 12961.5 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27405.41 Median:27405.41 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: Values: 27405.4 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:678.76 Median:678.76 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,792 DEBUG : BROWSER_OUTPUT: Values: 678.8 15:55:13 INFO - 2015-11-18 15:55:13,793 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-11-18 15:55:13,793 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4545.45 Median:4545.45 stddev:0.00 (0.0%) 15:55:13 INFO - 2015-11-18 15:55:13,793 DEBUG : BROWSER_OUTPUT: Values: 4545.5 15:55:13 INFO - 2015-11-18 15:55:13,793 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:55:13 INFO - 2015-11-18 15:55:13,793 DEBUG : BROWSER_OUTPUT: 15:55:14 INFO - 2015-11-18 15:55:14,586 INFO : Browser exited with error code: 0 15:55:14 INFO - 2015-11-18 15:55:14,603 INFO : Completed test v8_7 (00:00:37) 15:55:14 INFO - 2015-11-18 15:55:14,886 INFO : Completed test suite (00:20:04) 15:55:14 INFO - 2015-11-18 15:55:14,886 DEBUG : Working with test: dromaeo_css 15:55:14 INFO - 2015-11-18 15:55:14,886 DEBUG : Generating results file: dromaeo_css 15:55:14 INFO - 2015-11-18 15:55:14,887 DEBUG : Working with test: kraken 15:55:14 INFO - 2015-11-18 15:55:14,887 DEBUG : Generating results file: kraken 15:55:14 INFO - 2015-11-18 15:55:14,887 INFO : javascript benchmark 15:55:14 INFO - 2015-11-18 15:55:14,887 DEBUG : Working with test: v8_7 15:55:14 INFO - 2015-11-18 15:55:14,887 DEBUG : Generating results file: v8_7 15:55:14 INFO - 2015-11-18 15:55:14,887 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:15 INFO - 2015-11-18 15:55:15,378 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:55:15 INFO - 2015-11-18 15:55:15,378 DEBUG : process_Request line: dromaeo_css 7280.72 graph.html#tests=[[72,64,61]] 15:55:15 INFO - 2015-11-18 15:55:15,379 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:15 INFO - 2015-11-18 15:55:15,505 DEBUG : process_Request line: kraken 1523.30 graph.html#tests=[[232,64,61]] 15:55:15 INFO - 2015-11-18 15:55:15,505 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:15 INFO - 2015-11-18 15:55:15,538 DEBUG : process_Request line: v8_7 21867.17 graph.html#tests=[[230,64,61]] 15:55:15 INFO - 2015-11-18 15:55:15,539 INFO : javascript benchmark 15:55:15 INFO - 2015-11-18 15:55:15,541 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3435.57055368079, 3517.929641407172, 3523.823808809559, 3542.557180352456, 3552.7157827373812, 5616.466435688608, 5711.086226203808, 5721.513671337931, 5722.141678748189, 5742.9138562921535, 5515.972420137894, 5646.096624540074, 5670.37625861156, 5713.742881570329, 5772.307323121221, 5210.713410762407, 5217.608679349045, 5264.684118952875, 5322.8137015204475, 5327.254184414185, 5300.337457817773, 5328.17413300939, 5358.678479291255, 5362.061639213122, 5382.434844341346, 5071.46749591295, 5077.771500282496, 5174.275601415805, 5260.605454590902, 5289.233061206123, 5250.448702886219, 5266.735983364003, 5282.815101471469, 5286.735663216862, 5318.893622127574, 5215.973920130413, 5261.894762104736, 5301.257823904656, 5317.096093664087, 5372.2210279509645, 3992.500937382827, 4388.802503887333, 5463.989162005002, 5662.745176467069, 5686.459786320334, 6202.915858088281, 6231.688415579203, 6231.719572619198, 6236.469900058501, 6250.312465628777, 6286.245650521967, 6330.828796672584, 6331.905021424683, 6351.904721429182, 6374.490040796772, 5800.187973683687, 5828.679422631753, 5908.438698323653, 5969.432903874125, 6017.548683848641, 6285.057241413733, 6364.809055728336, 6403.711832967528, 6418.293987661354, 6423.678816059271, 5944.613600115978, 6205.81382558524, 6214.782482613087, 6218.0, 6226.439620434183, 4959.702417854868, 6201.7519299228425, 6228.781992630236, 6292.119103325538, 6310.274318453345, 5794.130880367894, 5798.565107616945, 6206.410391012847, 6230.439693304349, 6272.905906411407, 6025.9096113558335, 6127.7393367763425, 6250.812475625738, 6273.560850740404, 6291.9685401573615, 4875.780589873464, 4981.850544483671, 4984.850454486371, 4993.975030124826, 5000.224965130411, 3832.9616703833162, 4455.198064348384, 4455.977720111378, 4477.216487114807, 4477.261251893467, 5627.409122042127, 5629.211910332557, 5683.630564013326, 5835.854103647358, 5845.503132233723, 6251.531135164881, 6265.843353916098, 6269.780557680459, 6273.247210334789, 6287.779927702509, 5050.292958985745, 5854.385289544622, 5894.233749612523, 5926.703664816742, 5966.463018328372, 5221.582273418117, 5359.705216213068, 5362.463753624606, 5467.425920278393, 5495.203195536705, 6415.518836087312, 6422.678866056678, 6466.030095485715, 6468.353164683494, 6473.287938326875, 6256.687165641791, 6260.186175797117, 6278.717457714322, 6281.874362512633, 6291.685415729104, 5526.557875370041, 5805.651660900359, 6337.809865704036, 6338.714757835816, 6433.646149461637, 6190.14587065764, 6212.471939884979, 6217.4715149212825, 6243.906341404973, 6255.218097737783, 6080.300765412034, 6256.593321434092, 6264.404881536247, 6265.843353916189, 6266.0, 5505.174223866452, 5785.334686510937, 6013.158157857816, 6070.666113363807, 6119.07606531266, 6074.3925607438905, 6078.878422431439, 6086.360932102066, 6093.177421048102, 6096.78661246872, 4931.5315045070665, 5762.740676669476, 5827.6794776286015, 5996.580239383201, 6056.121862329849, 5319.787208511616, 5867.471927526372, 6101.420365065312, 6127.816165515042, 6129.601575897553, 5951.494122999594, 5970.611910225822, 6006.159137720635, 6047.848803779764, 6052.848678783065], "unit": "ms", "name": "dojo.html", "value": 5683.492426871866}, {"lowerIsBetter": false, "replicates": [542.5252903709252, 564.1058921609249, 584.0450862839259, 610.8992016317308, 622.9159063526423, 42290.0, 42322.0, 42377.576224237746, 42380.57619423805, 42562.723118306465, 36964.26071478569, 45543.316850247276, 46180.53819461804, 46235.76882115593, 46323.76838115805, 9894.307398482128, 9938.751531211705, 10063.949680251626, 10071.446070466121, 10091.596336146546, 9861.211103111735, 9922.404655720644, 9984.50077496126, 9993.400395976229, 10000.899991000106, 8932.732018039469, 9324.440533568008, 9811.313208075437, 9836.704898853046, 9887.653932112378, 9969.950150249275, 9998.2001439885, 10012.349197302225, 10030.749231269203, 10051.396916185016, 8344.707935222237, 9048.728538143867, 9769.951150244275, 9860.753481162956, 9902.702918912444, 41653.375199372036, 42188.57811421877, 42387.36418953687, 42397.244179128254, 42588.57411425877, 3075.199635179422, 3249.675032496755, 3449.448088305884, 3622.855085796565, 4048.7773172475504, 24380.171487138534, 29971.400571988655, 30052.398952020838, 30097.398052038836, 30098.69901300981, 2528.4816612594373, 2547.872606369674, 2556.2459074573044, 2673.1980405878157, 2705.8105932584726, 424733.0, 511112.0, 511138.0, 511376.0, 511562.9999999963, 51295.0, 60762.8351590111, 71269.2873071273, 71879.64060179665, 75867.0, 74178.77463676098, 75006.0, 75053.0, 75699.62150189214, 76073.61963190149, 17133.828661713473, 17177.88343757652, 17232.138393080295, 17364.305427782747, 17374.305027799, 12591.24452532851, 12806.871931280753, 12882.162659427107, 12915.612531624067, 13008.089433739548, 22324.55350892973, 22373.888130559244, 22531.436714081952, 22640.207592734503, 22646.547069058855, 9483.857742133874, 9628.47043412619, 9634.470104144339, 9709.223262139154, 9719.757006074904, 950.9476978766096, 987.4914419074182, 1010.7978404319166, 1073.6671631794168, 1110.6667999600088, 31083.68916310853, 32545.860894868565, 33630.831845840614, 33675.49486757701, 34543.654563454045, 921.2952091649893, 1060.6022741471947, 1085.3921803789904, 1142.3146112332533, 1202.4949521201117, 12284.754304913851, 15365.617094461551, 15672.686546269011, 15784.973976691479, 17758.535452652406, 667140.0, 675697.0, 677292.0, 677889.0, 678756.0, 64088.0, 64906.05281841553, 65322.0, 65349.0, 65508.344916550224, 1448.9927550362393, 1450.579331993731, 1452.012631410651, 1457.7084583083213, 1598.5124537016088, 29718.0, 31933.042008739776, 31969.520457193626, 32169.678303216668, 32559.511607325436, 54611.0, 54834.72582637061, 54918.0, 55167.17249241345, 55357.16964245459, 461827.0, 466489.0, 469925.0, 470799.0, 471609.0, 34327.65672343245, 45547.772261139806, 47089.52910470989, 47180.52819471761, 47219.0, 48912.77718057077, 49148.50851491439, 49553.75223123861, 50743.238851418, 51107.0, 33961.66038339585, 36808.81595592005, 39967.60032399639, 40820.59179408168, 41176.794116029225, 39429.408558871066, 39887.0, 40584.79707601443, 40610.59389406068, 40968.0, 40457.797711012434, 41929.0, 42524.362134568626, 42746.1450770989, 43050.569494305906, 38018.42972355472, 40203.59796401999, 41050.38424423576, 41134.794326028175, 41469.37795933003, 31890.628952969364, 32018.51972220465, 32174.873879414106, 32667.0, 32800.671993279764], "unit": "ms", "name": "ext.html", "value": 21358.02162679346}, {"lowerIsBetter": false, "replicates": [353.7935639469408, 361.10806308418216, 361.8787706118449, 362.62106099126413, 363.17559140750495, 16077.633401160887, 19385.903070484645, 20023.699644505345, 20570.89714551427, 21364.57270854582, 19459.610807783873, 19972.400827975183, 20073.297434589793, 20703.689444658343, 20840.89579552104, 5458.85364073545, 5554.361248456439, 5670.631408958425, 5713.885722285552, 5864.970675146618, 4938.925916111243, 5010.549050585447, 5075.9746201268945, 5077.619178561604, 5754.079347304432, 4483.529229430912, 4909.3126962225315, 4990.176620857555, 5000.049990501811, 5015.949840501585, 5076.568491678212, 5083.84748457545, 5093.337866077386, 5103.15797893349, 5110.66780659256, 4274.572542745701, 4299.935500967488, 4311.223979683656, 4315.417418648505, 4330.653547716175, 13858.722825543533, 14192.929035354757, 14212.289385530683, 14398.928005359907, 14403.135811851218, 1660.3192690996755, 1897.3359324236544, 1967.4982879365814, 2012.164951545107, 2142.1217300906555, 10123.493825308778, 10124.746881327952, 10315.79368412635, 10333.689989300334, 10427.843582346271, 1596.5609457399191, 1613.3224045900633, 1647.472808701216, 1686.7216909209965, 1689.2567270401107, 94601.0539894599, 97357.99999999929, 97756.0, 99354.5032274834, 100090.0, 6832.45340372769, 6835.931640683629, 6878.8624227515165, 6884.724611015503, 6915.723371065101, 6883.89857622778, 7456.888146677804, 7655.732049378245, 7706.07527096752, 7733.265339792711, 5715.31416230055, 5719.513841323451, 5767.452092051249, 5781.508571771363, 5802.65184088956, 6166.969165154145, 6201.379862013853, 6272.372762723691, 6272.686365681698, 6293.0, 2807.171884294138, 2954.985225073861, 3011.141824580028, 3065.6474505431715, 3100.162956001912, 1096.6764804382567, 1098.1983152298867, 1102.9448527573588, 1103.6358001859367, 1152.2395219155317, 385.78781670081906, 386.08690447092425, 431.5598089948235, 448.3634733223759, 460.5624656576266, 10855.620053298097, 10860.859609740863, 11116.110711143088, 11409.657710268706, 11716.589919352782, 423.9576042395736, 439.47702234341034, 453.4603821452527, 468.6157350972238, 487.4613552025032, 6346.27017892939, 6395.912694841888, 6457.2896981332015, 6460.483161347081, 6516.055172000033, 718854.0, 748452.0, 758255.0, 787418.0, 792477.0, 98821.5176772349, 115006.42496787463, 116519.0, 118170.0, 119080.0, 472.6974736168855, 516.8010316028356, 538.5530010091614, 542.9484199001089, 545.7162275616657, 11542.307461552333, 11817.763644726885, 11914.642560723192, 11953.641390758292, 12056.156069075081, 38191.04522386852, 48735.75632121817, 49670.758231043066, 50078.24882626836, 50495.24257136219, 69353.0, 72165.6391718038, 75887.62056189684, 76223.0, 77033.2296677026, 6267.4045965633195, 6278.121063051268, 6298.968505157445, 6323.747050117944, 6391.96804015977, 10321.0, 10551.841722374016, 11756.94187523127, 12283.75432491363, 12377.195482293622, 10370.27408081427, 10562.366258024544, 10769.515371808444, 10779.02988731018, 10898.673039808818, 9885.703428897144, 10413.166946644402, 10682.57269709234, 10815.24293299493, 10833.86244444322, 8740.781480462785, 10771.946140269249, 10773.946130269298, 11053.944730276296, 11236.66290011301, 6290.779822706183, 6366.77716279928, 6369.0, 6440.967795160994, 6459.386358295955, 10834.837477438003, 10846.783064338511, 11015.889841101487, 11074.723131921766, 11087.889121109009], "unit": "ms", "name": "jquery.html", "value": 7399.3872751585595}, {"lowerIsBetter": false, "replicates": [1532.1420004797308, 1566.8589826915575, 1680.8907421017634, 1824.6624374490711, 1931.4109196695003, 7280.781576552698, 7374.520656157346, 7558.395328373731, 7964.362850971923, 7966.641501132442, 7507.4369422293275, 7625.504342217766, 7666.425018123635, 7737.264959828807, 7744.535327880331, 2341.5316936612703, 2370.9407264818346, 2377.465070359164, 2380.3097101840444, 2382.03527571333, 2364.9408764780846, 2395.5089206712582, 2421.443068094339, 2424.224248240555, 2430.635404689302, 2344.5193735284224, 2362.6574146748712, 2392.234484964812, 2396.6405039244078, 2403.0267741564694, 2301.8043466305385, 2325.3140323604493, 2338.251759436981, 2345.355027367479, 2375.0143690368477, 2291.5073259249343, 2316.872572008539, 2328.9650655240184, 2336.19401306549, 2339.812814974798, 7909.802254943615, 7975.361971042303, 7975.920240797575, 7985.401094917905, 7995.640196191185, 4430.26900561407, 5033.421156566968, 5104.719240441774, 5136.845894623168, 5153.072446959546, 3115.641701204368, 3418.4017796885446, 3441.2601290722614, 3493.9301213975577, 3514.4376899695926, 1022.6062965758163, 1039.0648416425202, 1042.95828166874, 1065.8667666541683, 1071.2715353559577, 8523.701670441505, 8753.562321883881, 8888.02231754513, 8964.820703585958, 10340.793184136275, 4558.544145585415, 4630.0, 4673.462551806518, 4678.7660616969015, 4681.461631912373, 7803.765887023398, 8951.597178127, 9005.729828105168, 9064.184223419923, 9087.727368178834, 4284.892877678083, 5062.848114556496, 5097.974510127426, 5122.974385128051, 5143.331366922351, 4005.619466150711, 4014.598540145962, 4530.275155975029, 4604.1712491751805, 4665.6967297125575, 3791.3554695701796, 3820.8089595520114, 3821.6942644588366, 3834.1948190880225, 3856.8842934712, 1256.2211428914131, 1277.6137890388845, 1278.5525066226746, 1281.4874050379922, 1286.5432771366031, 1339.6516905604612, 1354.1130559483554, 1354.7561438941086, 1360.081944687332, 1395.9022868399318, 7366.926330736731, 7526.32263096313, 7538.434617403716, 7542.057242844645, 7553.395728341719, 484.88847565060235, 492.9186684197139, 495.6951474842946, 497.86308765089166, 500.8096923169172, 5583.832485025456, 5940.34656187819, 5952.345242023374, 5954.285485741739, 5966.224390829165, 8141.51150930946, 9368.718938431857, 9414.105659962293, 9496.43021418717, 9534.809303813885, 9170.541472926327, 9320.487373194404, 9324.90675093254, 9373.437593744397, 9420.670276540426, 7484.513506622052, 7524.623768811647, 7565.394768418513, 7566.092068951761, 7599.924000759922, 7253.8186545336785, 7355.264473552816, 7364.447666424932, 7372.373348265243, 7406.629668516445, 8252.46358986664, 8444.831103378021, 8520.872186917077, 8550.82898342042, 8628.52543110135, 8514.74455766328, 8769.254613357936, 8814.5592720365, 8824.823503530022, 8942.284617230736, 6948.478864085315, 6960.721571137098, 6971.2331643518155, 6976.616286104313, 7007.0, 7547.811304717426, 7629.3133617974645, 7667.194944530744, 7668.731594394169, 7675.04061992251, 7088.503804733619, 7094.9290507094265, 7119.786406407816, 7217.206107328295, 7299.124105107421, 6901.413379862768, 6951.0, 6983.336583024605, 6990.965045174741, 7205.71177152908, 7156.1770396403, 7168.996340512437, 7197.316254955771, 7201.991721158937, 7210.927890721236, 6362.6818659067785, 6440.5491615588335, 6461.57999730016, 6549.901751473636, 6569.737210511526, 6632.303608121078, 6642.701078451578, 6653.733850646114, 6674.365935236145, 6706.195256569243], "unit": "ms", "name": "mootools.html", "value": 4509.492863338313}, {"lowerIsBetter": false, "replicates": [271.4841800578899, 318.3410340594968, 325.1156853358863, 328.3203768199826, 331.36543519160807, 6785.1518560179975, 6816.829579260515, 6944.444444444445, 7058.858822823547, 7123.821904452385, 6744.08954791103, 6779.2542820289855, 6844.315568443153, 6927.203371612266, 6941.54879932804, 5025.472325405825, 5082.364704411949, 5084.898302033957, 5092.79628814847, 5114.721319670082, 4885.5114488551035, 5058.392992840846, 5067.898642027158, 5086.593072554206, 5105.463926287742, 4115.382692596119, 4118.670506359484, 5002.849914502571, 5017.749112544377, 5068.5438310552045, 5009.874753131183, 5015.84952451427, 5016.924746128811, 5019.046381187581, 5019.996000799854, 4023.5574086850424, 4081.755094694328, 4177.248095342837, 4246.830126794925, 4261.893452663678, 6578.473722102221, 6659.6670166491485, 6668.499862510283, 6674.132362792854, 6687.933120668779, 5209.505097015777, 5530.834074977757, 5830.2420685310635, 5884.058550631921, 5930.229070220887, 7045.859082818366, 7397.482176247611, 7402.148752893432, 7414.443916706268, 7425.591592462412, 4702.365180700596, 4708.058388322315, 4710.74090924999, 4728.148933192024, 4734.597559207437, 7767.650455729449, 7825.295723384866, 7843.882341764878, 7844.529328240267, 7844.843103137962, 4668.136394766979, 4733.337332773414, 4767.856964291077, 4772.952270477251, 4780.450248221499, 4006.7996600169877, 4849.2726091086615, 4874.195757699939, 4875.68308059975, 4878.414590249193, 4559.0, 5853.5317174625925, 5877.853053673607, 5886.1465087562065, 5909.527237820964, 6038.5169186465855, 7438.479306448497, 7447.106347238366, 7449.733545297312, 7455.85088298231, 1644.0793155832532, 1707.240278076269, 1707.5218938697185, 1709.0173150438548, 1711.4694444722177, 1076.246627360835, 1078.8327809189432, 1083.9078678312433, 1090.1061129873428, 1095.46322302073, 5719.742611582489, 6873.621950792754, 6923.861522769516, 6962.338577835098, 6989.860202796017, 7692.846143077107, 7703.57630330326, 7715.768526944201, 7719.84202369649, 7755.922440775633, 5759.510441612426, 6836.794896153124, 6918.654067296615, 6937.271586483447, 7066.328698773608, 4001.6598589119667, 4023.8189281482405, 4083.5303940047274, 4103.2409004334295, 4171.687123465752, 6703.731850725916, 7947.4039447041705, 7992.640331185111, 8069.0, 8083.555404452694, 7874.976253087062, 8031.518108913484, 8034.196580341919, 8038.638261278256, 8079.4344395892895, 8016.7194148204535, 8060.556669383241, 8065.4757440767335, 8078.394120440873, 8088.272055514914, 7773.144954055162, 7800.687972481264, 7813.843723125392, 7824.100228473799, 7826.178251283533, 7433.405327573673, 7630.1606823248285, 7634.541927484369, 7637.961810190914, 7653.349465295512, 5748.712564371848, 7467.655821952101, 8020.0, 8044.758657240292, 8047.919520804951, 4423.800928958269, 4558.905862592887, 4571.1543364477675, 4617.145828021827, 4994.0, 5795.420457954171, 7700.576468294297, 7705.845883082195, 7816.687332506864, 7836.80407989782, 7498.212687667717, 7499.850003000019, 7504.962475187589, 7512.0, 7528.284812942762, 6453.064305675744, 6868.759593414206, 6939.201991770809, 7466.25337466249, 7521.811954701177, 7306.525075870051, 7309.5248808827255, 7318.96340518294, 7318.963405183153, 7319.926800732138, 6719.0, 6868.313168683092, 7435.996140520961, 7445.702171913063, 7491.587962662106, 7091.1490621125795, 7307.378872795659, 7307.9634601828775, 7313.085864266966, 7331.816704582428], "unit": "ms", "name": "prototype.html", "value": 5321.286211579075}, {"lowerIsBetter": false, "replicates": [676.2189670930078, 722.7795522365676, 744.6611791634805, 797.1430711984615, 821.5317269156582, 11848.585299514518, 11900.583479578216, 11991.340476273801, 12010.0, 12113.030957523399, 10649.946750266257, 14684.265786710648, 14720.484783032596, 14741.852581474182, 14754.409823607042, 732.9706811727525, 748.988765168523, 911.0934620053057, 928.6981730937439, 938.9483578403185, 932.8367535681228, 933.9579718912631, 942.853857652065, 947.5735918836517, 948.0898337595917, 975.5609975511048, 980.103205566909, 990.1435258501416, 990.4601991914424, 991.1080027974845, 966.8356379415482, 973.5424350555263, 978.706388083572, 981.2297346582969, 982.1504398695113, 709.8473828126978, 709.8580283943232, 711.4024219655514, 713.5682911838367, 718.0199028326349, 15303.693926121416, 15333.923330383277, 15415.0, 15545.844541554552, 15574.532764017098, 12617.936910315482, 12715.427805748763, 12812.935935320356, 13088.018398620141, 13090.738185236338, 10067.395956242648, 10211.897881021168, 10330.811956624933, 10587.84118238227, 10902.672919812418, 2999.8350090745002, 3553.058439513531, 3557.1107223194203, 3584.13980644646, 3601.8019008954498, 78748.21251787466, 80214.59892700499, 80300.59849700773, 82094.76857847137, 82692.0, 9414.246860251164, 9539.236861051098, 9586.66446674363, 9652.22782177424, 9893.950530247303, 21416.036278367512, 21711.240106596193, 21842.0, 22010.88994555017, 22301.10795568159, 7397.37122344596, 7464.514806537558, 7679.500832445873, 7730.149683534807, 7837.177096404909, 3570.3573356795505, 3935.740563019863, 4065.918681626351, 4156.56356082607, 4237.533871274158, 2998.445287621797, 3471.3057388522398, 3486.738494612914, 3496.1084923344383, 3498.8250587470525, 470.2358667165856, 538.4104405675779, 542.9511343979061, 551.831691334147, 553.6346011632303, 456.24035980092776, 503.89898072710514, 510.5864249957472, 560.3248086056374, 631.5515983651567, 8525.616347264388, 8626.266767324847, 8964.238039766562, 9304.72085837426, 9577.712668619952, 523.7878659143054, 595.7110801261384, 598.4255115089476, 604.1813342920368, 609.1259043272918, 4076.7146299759324, 4106.199291138199, 4120.835166593302, 4197.664186865043, 4220.620144187038, 96693.51653241689, 97594.0, 97984.0, 98985.5152172718, 100245.0, 73715.0, 76512.0, 79981.80118292292, 86116.70824937632, 86806.56596717102, 64934.675326623066, 66254.66872665606, 68504.0, 72059.0, 73844.63077684578, 8307.833843322978, 8312.16878312188, 8418.242358187792, 8518.3502498788, 8539.188777066169, 51256.48743512666, 51433.714157144874, 51480.74259628678, 52257.47742522678, 52644.736776315876, 69674.0, 74696.62651686707, 75282.6235868839, 76149.0, 76422.23577764152, 7831.608419579112, 8246.422750407413, 8271.83456330858, 8309.210624990616, 8314.085450600309, 11978.70053248641, 12264.75470490603, 12521.499140034297, 12584.18202816814, 12870.16343937641, 11428.314301141625, 12022.338771367658, 12155.574554890536, 12189.0, 12343.69140771452, 11407.543698251977, 12006.75986480283, 12119.939400303294, 12142.514299427923, 12378.257304561756, 11601.477933493183, 11617.941910290394, 11989.40052997364, 12006.099542534519, 12380.938095309466, 9855.704328870146, 9861.457619830979, 9950.203983681144, 10216.897831021595, 10335.328203666737, 9425.245980321695, 9463.290253231173, 9634.229261659191, 10310.278280520291, 10311.845322320321], "unit": "ms", "name": "yui.html", "value": 6910.212414048888}], "name": "dromaeo_css", "value": 7280.720309121215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 114.0, 114.0, 114.0, 129.0, 121.0, 115.0, 115.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [140.0, 124.0, 139.0, 153.0, 120.0, 138.0, 140.0, 140.0, 181.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.4}, {"lowerIsBetter": true, "replicates": [194.0, 196.0, 196.0, 218.0, 229.0, 210.0, 206.0, 220.0, 278.0, 206.0], "unit": "ms", "name": "audio-dft", "value": 215.3}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 79.0, 80.0, 86.0, 59.0, 105.0, 57.0, 55.0, 58.0], "unit": "ms", "name": "audio-fft", "value": 71.2}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 106.0, 74.0, 76.0, 78.0, 100.0, 96.0, 109.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 90.0, 90.0, 92.0, 92.0, 92.0, 91.0, 90.0, 91.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 91.0}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 102.0, 98.0, 113.0, 149.0, 149.0, 105.0, 151.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 121.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 128.0, 146.0, 143.0, 102.0, 90.0, 90.0, 90.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 107.0}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 67.0, 60.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 63.0, 65.0, 65.0, 66.0, 69.0, 67.0, 86.0, 100.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [97.0, 77.0, 86.0, 85.0, 86.0, 83.0, 97.0, 113.0, 110.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 91.9}, {"lowerIsBetter": true, "replicates": [120.0, 133.0, 139.0, 101.0, 133.0, 128.0, 129.0, 138.0, 148.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.4}, {"lowerIsBetter": true, "replicates": [143.0, 139.0, 139.0, 140.0, 138.0, 140.0, 137.0, 153.0, 179.0, 169.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 65.0, 68.0, 68.0, 66.0, 65.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1523.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.85382554331647], "unit": "score", "name": "Richards", "value": 237.15883599999992}, {"lowerIsBetter": false, "replicates": [157.60441292356185], "unit": "score", "name": "DeltaBlue", "value": 419.5187100000001}, {"lowerIsBetter": false, "replicates": [283.28611898017], "unit": "score", "name": "Encrypt", "value": 939.6189299999998}, {"lowerIsBetter": false, "replicates": [4916.666666666667], "unit": "score", "name": "Decrypt", "value": 54.13850847457623}, {"lowerIsBetter": false, "replicates": [967.1179883945841], "unit": "score", "name": "RayTrace", "value": 765.1486259999999}, {"lowerIsBetter": false, "replicates": [722.0216606498195], "unit": "score", "name": "Earley", "value": 923.0512549999999}, {"lowerIsBetter": false, "replicates": [12961.538461538461], "unit": "score", "name": "Boyer", "value": 51.41851038575665}, {"lowerIsBetter": false, "replicates": [27405.405405405407], "unit": "score", "name": "RegExp", "value": 33.241070019723885}, {"lowerIsBetter": false, "replicates": [678.763440860215], "unit": "score", "name": "Splay", "value": 120.05802772277224}, {"lowerIsBetter": false, "replicates": [4545.454545454545], "unit": "score", "name": "NavierStokes", "value": 326.4799999999998}], "name": "v8_7", "value": 21867.165490799314}]} 15:55:15 INFO - RETURN: dromaeo_css: 7280.72 15:55:15 INFO - RETURN: kraken: 1523.30 15:55:15 INFO - RETURN: v8_7: 21867.17 15:55:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21867.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1523.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7280.72"}}} 15:55:15 INFO - Return code: 0 15:55:15 INFO - # TBPL SUCCESS # 15:55:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:55:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:55:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:55:15 INFO - 2015-11-18 15:55:15.622 screenresolution[1676:11029] starting screenresolution argv=screenresolution get 15:55:15 INFO - 2015-11-18 15:55:15.625 screenresolution[1676:11029] Display 0: 1600x1200x32@60 15:55:15 INFO - 2015-11-18 15:55:15.631 screenresolution[1677:11032] starting screenresolution argv=screenresolution list 15:55:15 INFO - Available Modes on Display 0 15:55:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:55:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:55:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:55:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:55:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:55:15 INFO - Intel Iris: 15:55:15 INFO - Chipset Model: Intel Iris 15:55:15 INFO - Type: GPU 15:55:15 INFO - Bus: Built-In 15:55:15 INFO - VRAM (Dynamic, Max): 1536 MB 15:55:15 INFO - Vendor: Intel (0x8086) 15:55:15 INFO - Device ID: 0x0a2e 15:55:15 INFO - Revision ID: 0x0009 15:55:15 INFO - Displays: 15:55:15 INFO - Display: 15:55:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:55:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:55:15 INFO - Display Serial Number: 1600x1200 60 15:55:15 INFO - Main Display: Yes 15:55:15 INFO - Mirror: Off 15:55:15 INFO - Online: Yes 15:55:15 INFO - Rotation: Supported 15:55:15 INFO - Return code: 0 15:55:15 INFO - Running post-action listener: _resource_record_post_action 15:55:15 INFO - Running post-run listener: _resource_record_post_run 15:55:16 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 38987264; Write bytes: 690361856; Read time: 469; Write time: 2078 15:55:16 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 337369600; Write bytes: 333870592; Read time: 26961; Write time: 581 15:55:16 INFO - run-tests - Wall time: 1206s; CPU: 53.0%; Read bytes: 37086720; Write bytes: 345280512; Read time: 441; Write time: 1459 15:55:16 INFO - Running post-run listener: _upload_blobber_files 15:55:16 INFO - Blob upload gear active. 15:55:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:55:16 INFO - Copying logs to upload dir... 15:55:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.181464 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-18 15:55:17.002058) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:55:17.007272) ========= 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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009565 build_url: 'https://queue.taskcluster.net/v1/task/T73OpfkgRsKsYRgDEL7eeA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:55:17.030556) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:55:17.030916) ========= 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.hN2wWOycyK/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.odX65tGspG/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005049 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:55:17.079438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:55:17.079763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:55:17.080168) ========= ========= Total master_lag: 0.20 =========