builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0056 starttime: 1448334945.46 results: success (0) buildid: 20151123180231 builduid: 2bb2bf33cb334e6e8a902aacffaca018 revision: 0ed0b39c35419af45b20bf9b1df70104be2f7914 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.458091) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.458514) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.458811) ========= 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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005679 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.479207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.479529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.494248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.494682) ========= 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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.543201) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.543515) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.543891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.544158) ========= 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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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-23 19:15:45-- 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-23 19:15:45 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.750459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.750792) ========= 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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.019891 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:45.799623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:15:45.799965) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ed0b39c35419af45b20bf9b1df70104be2f7914 --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 0ed0b39c35419af45b20bf9b1df70104be2f7914 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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-23 19:15:45,880 truncating revision to first 12 chars 2015-11-23 19:15:45,880 Setting DEBUG logging. 2015-11-23 19:15:45,880 attempt 1/10 2015-11-23 19:15:45,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ed0b39c3541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 19:15:46,917 unpacking tar archive at: fx-team-0ed0b39c3541/testing/mozharness/ program finished with exit code 0 elapsedTime=1.284027 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:15:47.101222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:47.101599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:47.116147) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:47.116454) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:15:47.116893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 19:15:47.117191) ========= /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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:15:47 INFO - MultiFileLogger online at 20151123 19:15:47 in /builds/slave/test 19:15:47 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 19:15:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:15:47 INFO - {'append_to_log': False, 19:15:47 INFO - 'base_work_dir': '/builds/slave/test', 19:15:47 INFO - 'blob_upload_branch': 'Fx-Team', 19:15:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:15:47 INFO - 'branch': 'Fx-Team', 19:15:47 INFO - 'buildbot_json_path': 'buildprops.json', 19:15:47 INFO - 'config_files': ('talos/mac_config.py',), 19:15:47 INFO - 'default_actions': ('clobber', 19:15:47 INFO - 'read-buildbot-config', 19:15:47 INFO - 'download-and-extract', 19:15:47 INFO - 'populate-webroot', 19:15:47 INFO - 'create-virtualenv', 19:15:47 INFO - 'install', 19:15:47 INFO - 'run-tests'), 19:15:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:15:47 INFO - 'download_minidump_stackwalk': True, 19:15:47 INFO - 'download_symbols': 'ondemand', 19:15:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:15:47 INFO - 'tooltool.py': '/tools/tooltool.py', 19:15:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:15:47 INFO - '/tools/misc-python/virtualenv.py')}, 19:15:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:15:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:15:47 INFO - 'installer_path': 'installer.exe', 19:15:47 INFO - 'log_level': 'info', 19:15:47 INFO - 'log_name': 'talos', 19:15:47 INFO - 'log_to_console': True, 19:15:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:15:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:15:47 INFO - 'opt_config_files': (), 19:15:47 INFO - 'pip_index': False, 19:15:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:15:47 INFO - 'cmd': ('bash', 19:15:47 INFO - '-c', 19:15:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:15:47 INFO - 'enabled': True, 19:15:47 INFO - 'halt_on_failure': False, 19:15:47 INFO - 'name': 'check_screen_resolution'},), 19:15:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:15:47 INFO - 'cmd': ('bash', 19:15:47 INFO - '-c', 19:15:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:15:47 INFO - 'enabled': True, 19:15:47 INFO - 'halt_on_failure': False, 19:15:47 INFO - 'name': 'check_screen_resolution'},), 19:15:47 INFO - 'run_cmd_checks_enabled': True, 19:15:47 INFO - 'sps_profile': False, 19:15:47 INFO - 'sps_profile_interval': 0, 19:15:47 INFO - 'suite': 'dromaeojs-e10s', 19:15:47 INFO - 'system_bits': '64', 19:15:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:15:47 INFO - 'title': 't-yosemite-r7-0056', 19:15:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:15:47 INFO - 'use_talos_json': True, 19:15:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:15:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:15:47 INFO - 'work_dir': 'build'} 19:15:47 INFO - ##### 19:15:47 INFO - ##### Running clobber step. 19:15:47 INFO - ##### 19:15:47 INFO - Running pre-action listener: _resource_record_pre_action 19:15:47 INFO - Running main action method: clobber 19:15:47 INFO - rmtree: /builds/slave/test/build 19:15:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:15:48 INFO - Running post-action listener: _resource_record_post_action 19:15:48 INFO - ##### 19:15:48 INFO - ##### Running read-buildbot-config step. 19:15:48 INFO - ##### 19:15:48 INFO - Running pre-action listener: _resource_record_pre_action 19:15:48 INFO - Running main action method: read_buildbot_config 19:15:48 INFO - Using buildbot properties: 19:15:48 INFO - { 19:15:48 INFO - "properties": { 19:15:48 INFO - "buildnumber": 22, 19:15:48 INFO - "product": "firefox", 19:15:48 INFO - "script_repo_revision": "production", 19:15:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:15:48 INFO - "repository": "", 19:15:48 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:15:48 INFO - "buildid": "20151123180231", 19:15:48 INFO - "slavename": "t-yosemite-r7-0056", 19:15:48 INFO - "pgo_build": "False", 19:15:48 INFO - "basedir": "/builds/slave/test", 19:15:48 INFO - "project": "", 19:15:48 INFO - "platform": "yosemite_r7", 19:15:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:15:48 INFO - "slavebuilddir": "test", 19:15:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:15:48 INFO - "branch": "fx-team", 19:15:48 INFO - "repo_path": "integration/fx-team", 19:15:48 INFO - "stage_platform": "macosx64", 19:15:48 INFO - "builduid": "2bb2bf33cb334e6e8a902aacffaca018", 19:15:48 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 19:15:48 INFO - }, 19:15:48 INFO - "sourcestamp": { 19:15:48 INFO - "repository": "", 19:15:48 INFO - "hasPatch": false, 19:15:48 INFO - "project": "", 19:15:48 INFO - "branch": "fx-team-macosx64-talos", 19:15:48 INFO - "changes": [ 19:15:48 INFO - { 19:15:48 INFO - "category": null, 19:15:48 INFO - "files": [ 19:15:48 INFO - { 19:15:48 INFO - "url": null, 19:15:48 INFO - "name": "https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:15:48 INFO - } 19:15:48 INFO - ], 19:15:48 INFO - "repository": "", 19:15:48 INFO - "rev": "0ed0b39c35419af45b20bf9b1df70104be2f7914", 19:15:48 INFO - "who": "felipc@gmail.com", 19:15:48 INFO - "when": 1448334566, 19:15:48 INFO - "number": 6698678, 19:15:48 INFO - "comments": "Bug 1226487 - Enable e10s checks for accessibility on Beta. r=mconley", 19:15:48 INFO - "project": "", 19:15:48 INFO - "at": "Mon 23 Nov 2015 19:09:26", 19:15:48 INFO - "branch": "fx-team-macosx64-talos", 19:15:48 INFO - "revlink": "", 19:15:48 INFO - "properties": [ 19:15:48 INFO - [ 19:15:48 INFO - "buildid", 19:15:48 INFO - "20151123180231", 19:15:48 INFO - "Change" 19:15:48 INFO - ], 19:15:48 INFO - [ 19:15:48 INFO - "builduid", 19:15:48 INFO - "2bb2bf33cb334e6e8a902aacffaca018", 19:15:48 INFO - "Change" 19:15:48 INFO - ], 19:15:48 INFO - [ 19:15:48 INFO - "pgo_build", 19:15:48 INFO - "False", 19:15:48 INFO - "Change" 19:15:48 INFO - ] 19:15:48 INFO - ], 19:15:48 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 19:15:48 INFO - } 19:15:48 INFO - ], 19:15:48 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 19:15:48 INFO - } 19:15:48 INFO - } 19:15:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:15:48 INFO - Running post-action listener: _resource_record_post_action 19:15:48 INFO - ##### 19:15:48 INFO - ##### Running download-and-extract step. 19:15:48 INFO - ##### 19:15:48 INFO - Running pre-action listener: _resource_record_pre_action 19:15:48 INFO - Running main action method: download_and_extract 19:15:48 INFO - mkdir: /builds/slave/test/build/tests 19:15:48 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')]} 19:15:48 INFO - https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/test_packages.json 19:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/test_packages.json 19:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:15:49 INFO - Downloaded 1149 bytes. 19:15:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:15:49 INFO - Using the following test package requirements: 19:15:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:15:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:15:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'jsshell-mac.zip'], 19:15:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:15:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:15:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:15:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:15:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:15:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:15:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:15:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:15:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:49 INFO - https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:15:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:15:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:15:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:15:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:15:50 INFO - Downloaded 17526977 bytes. 19:15:50 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 19:15:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:15:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:15:53 INFO - Return code: 0 19:15:53 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 19:15:53 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')]} 19:15:53 INFO - https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:15:54 INFO - Downloaded 17526977 bytes. 19:15:54 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 19:15:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:15:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:15:57 INFO - Return code: 0 19:15:57 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')]} 19:15:57 INFO - https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:15:58 INFO - Downloaded 11130997 bytes. 19:15:58 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 19:15:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:15:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:15:59 INFO - Return code: 0 19:15:59 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')]} 19:15:59 INFO - https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5YY72RVRcWyJ8FoqazD4g/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 19:16:01 INFO - Downloaded 109907061 bytes. 19:16:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:16:01 INFO - mkdir: /builds/slave/test/properties 19:16:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:16:01 INFO - Writing to file /builds/slave/test/properties/build_url 19:16:01 INFO - Contents: 19:16:01 INFO - build_url:https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:16:01 INFO - Running post-action listener: _resource_record_post_action 19:16:01 INFO - Running post-action listener: set_extra_try_arguments 19:16:01 INFO - ##### 19:16:01 INFO - ##### Running populate-webroot step. 19:16:01 INFO - ##### 19:16:01 INFO - Running pre-action listener: _resource_record_pre_action 19:16:01 INFO - Running main action method: populate_webroot 19:16:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:16:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:16:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:16:01 INFO - '../fennec_ids.txt'], 19:16:01 INFO - 'tests': ['tcheck2']}, 19:16:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:16:01 INFO - '--tppagecycles', 19:16:01 INFO - '7'], 19:16:01 INFO - 'tests': ['tsvgm']}}, 19:16:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:16:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:16:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:16:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:16:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:16:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:16:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'tests': ['damp', 'tps']}, 19:16:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['damp', 'tps']}, 19:16:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:16:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:16:01 INFO - 'other': {'tests': ['a11yr', 19:16:01 INFO - 'ts_paint', 19:16:01 INFO - 'tpaint', 19:16:01 INFO - 'sessionrestore', 19:16:01 INFO - 'sessionrestore_no_auto_restore']}, 19:16:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['a11yr', 19:16:01 INFO - 'ts_paint', 19:16:01 INFO - 'tpaint', 19:16:01 INFO - 'sessionrestore', 19:16:01 INFO - 'sessionrestore_no_auto_restore']}, 19:16:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['a11yr', 19:16:01 INFO - 'ts_paint', 19:16:01 INFO - 'tpaint', 19:16:01 INFO - 'sessionrestore', 19:16:01 INFO - 'sessionrestore_no_auto_restore']}, 19:16:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['a11yr', 19:16:01 INFO - 'ts_paint', 19:16:01 INFO - 'tpaint', 19:16:01 INFO - 'sessionrestore', 19:16:01 INFO - 'sessionrestore_no_auto_restore']}, 19:16:01 INFO - 'other_l64': {'tests': ['a11yr', 19:16:01 INFO - 'ts_paint', 19:16:01 INFO - 'tpaint', 19:16:01 INFO - 'sessionrestore', 19:16:01 INFO - 'sessionrestore_no_auto_restore']}, 19:16:01 INFO - 'other_nol64': {'tests': ['a11yr', 19:16:01 INFO - 'ts_paint', 19:16:01 INFO - 'tpaint', 19:16:01 INFO - 'sessionrestore', 19:16:01 INFO - 'sessionrestore_no_auto_restore']}, 19:16:01 INFO - 'svgr': {'tests': ['tsvgx', 19:16:01 INFO - 'tsvgr_opacity', 19:16:01 INFO - 'tart', 19:16:01 INFO - 'tscrollx', 19:16:01 INFO - 'cart']}, 19:16:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['tsvgx', 19:16:01 INFO - 'tsvgr_opacity', 19:16:01 INFO - 'tart', 19:16:01 INFO - 'tscrollx', 19:16:01 INFO - 'cart']}, 19:16:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'tests': ['tp5o']}, 19:16:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'talos_options': ['--e10s'], 19:16:01 INFO - 'tests': ['tp5o']}, 19:16:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'talos_options': ['--xperf_path', 19:16:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:01 INFO - 'tests': ['tp5n']}, 19:16:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:01 INFO - 'talos_options': ['--e10s', 19:16:01 INFO - '--xperf_path', 19:16:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:01 INFO - 'tests': ['tp5n']}}, 19:16:01 INFO - 'talos.zip': {'path': '', 19:16:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:16:01 INFO - Running post-action listener: _resource_record_post_action 19:16:01 INFO - ##### 19:16:01 INFO - ##### Running create-virtualenv step. 19:16:01 INFO - ##### 19:16:01 INFO - Running pre-action listener: _resource_record_pre_action 19:16:01 INFO - Running main action method: create_virtualenv 19:16:01 INFO - Creating virtualenv /builds/slave/test/build/venv 19:16:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:16:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:16:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:16:02 INFO - Using real prefix '/tools/python27' 19:16:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:16:02 INFO - Installing distribute.............................................................................................................................................................................................done. 19:16:05 INFO - Installing pip.................done. 19:16:05 INFO - Return code: 0 19:16:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:16:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:05 INFO - 'HOME': '/Users/cltbld', 19:16:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:05 INFO - 'LOGNAME': 'cltbld', 19:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:05 INFO - 'MOZ_NO_REMOTE': '1', 19:16:05 INFO - 'NO_EM_RESTART': '1', 19:16:05 INFO - 'PAGER': '/bin/cat', 19:16:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:05 INFO - 'PWD': '/builds/slave/test', 19:16:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:05 INFO - 'SHELL': '/bin/bash', 19:16:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:05 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:05 INFO - 'USER': 'cltbld', 19:16:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:05 INFO - 'XPC_FLAGS': '0x0', 19:16:05 INFO - 'XPC_SERVICE_NAME': '0', 19:16:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:05 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 19:16:05 INFO - Cleaning up... 19:16:05 INFO - Return code: 0 19:16:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:16:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:05 INFO - 'HOME': '/Users/cltbld', 19:16:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:05 INFO - 'LOGNAME': 'cltbld', 19:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:05 INFO - 'MOZ_NO_REMOTE': '1', 19:16:05 INFO - 'NO_EM_RESTART': '1', 19:16:05 INFO - 'PAGER': '/bin/cat', 19:16:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:05 INFO - 'PWD': '/builds/slave/test', 19:16:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:05 INFO - 'SHELL': '/bin/bash', 19:16:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:05 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:05 INFO - 'USER': 'cltbld', 19:16:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:05 INFO - 'XPC_FLAGS': '0x0', 19:16:05 INFO - 'XPC_SERVICE_NAME': '0', 19:16:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:06 INFO - Downloading/unpacking psutil>=0.7.1 19:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:16:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:16:08 INFO - Installing collected packages: psutil 19:16:08 INFO - Running setup.py install for psutil 19:16:08 INFO - building 'psutil._psutil_osx' extension 19:16:08 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 19:16:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:16:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:16:09 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 19:16:09 INFO - building 'psutil._psutil_posix' extension 19:16:09 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 19:16:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:16:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:16:09 INFO - ^ 19:16:09 INFO - 1 warning generated. 19:16:09 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 19:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:16:09 INFO - Successfully installed psutil 19:16:09 INFO - Cleaning up... 19:16:09 INFO - Return code: 0 19:16:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:09 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 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:09 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 19:16:09 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 19:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:09 INFO - 'HOME': '/Users/cltbld', 19:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:09 INFO - 'LOGNAME': 'cltbld', 19:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:09 INFO - 'MOZ_NO_REMOTE': '1', 19:16:09 INFO - 'NO_EM_RESTART': '1', 19:16:09 INFO - 'PAGER': '/bin/cat', 19:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:09 INFO - 'PWD': '/builds/slave/test', 19:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:09 INFO - 'SHELL': '/bin/bash', 19:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:09 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:09 INFO - 'USER': 'cltbld', 19:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:09 INFO - 'XPC_FLAGS': '0x0', 19:16:09 INFO - 'XPC_SERVICE_NAME': '0', 19:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:16:10 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 19:16:10 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 19:16:10 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 19:16:10 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 19:16:10 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 19:16:10 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 19:16:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:16:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:16:12 INFO - Installing collected packages: mozsystemmonitor 19:16:12 INFO - Running setup.py install for mozsystemmonitor 19:16:12 INFO - Successfully installed mozsystemmonitor 19:16:12 INFO - Cleaning up... 19:16:12 INFO - Return code: 0 19:16:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:12 INFO - 'HOME': '/Users/cltbld', 19:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:12 INFO - 'LOGNAME': 'cltbld', 19:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:12 INFO - 'MOZ_NO_REMOTE': '1', 19:16:12 INFO - 'NO_EM_RESTART': '1', 19:16:12 INFO - 'PAGER': '/bin/cat', 19:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:12 INFO - 'PWD': '/builds/slave/test', 19:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:12 INFO - 'SHELL': '/bin/bash', 19:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:12 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:12 INFO - 'USER': 'cltbld', 19:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:12 INFO - 'XPC_FLAGS': '0x0', 19:16:12 INFO - 'XPC_SERVICE_NAME': '0', 19:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:12 INFO - Downloading/unpacking blobuploader==1.2.4 19:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:16:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:16:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:16:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:16 INFO - Downloading docopt-0.6.1.tar.gz 19:16:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:16:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:16:16 INFO - Running setup.py install for blobuploader 19:16:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:16:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:16:16 INFO - Running setup.py install for requests 19:16:16 INFO - Running setup.py install for docopt 19:16:17 INFO - Successfully installed blobuploader requests docopt 19:16:17 INFO - Cleaning up... 19:16:17 INFO - Return code: 0 19:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:17 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 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:17 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 19:16:17 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 19:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:17 INFO - 'HOME': '/Users/cltbld', 19:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:17 INFO - 'LOGNAME': 'cltbld', 19:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:17 INFO - 'MOZ_NO_REMOTE': '1', 19:16:17 INFO - 'NO_EM_RESTART': '1', 19:16:17 INFO - 'PAGER': '/bin/cat', 19:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:17 INFO - 'PWD': '/builds/slave/test', 19:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:17 INFO - 'SHELL': '/bin/bash', 19:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:17 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:17 INFO - 'USER': 'cltbld', 19:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:17 INFO - 'XPC_FLAGS': '0x0', 19:16:17 INFO - 'XPC_SERVICE_NAME': '0', 19:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:16:17 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-1GRKwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:16:17 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-OcVlRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:16:17 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-J7qeQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:16:17 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-GUHL9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:16:17 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-xR2V2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:16:17 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-TyJUoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-CDGUbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-eD9dyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ucQ4lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-lBMJCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-LeA2im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-DwBXG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-dj3Ats-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-P1znwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-zVR18v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:16:18 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-xyoRiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:16:19 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-IpbLWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:16:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:16:19 INFO - Running setup.py install for manifestparser 19:16:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:16:19 INFO - Running setup.py install for mozcrash 19:16:19 INFO - Running setup.py install for mozdebug 19:16:19 INFO - Running setup.py install for mozdevice 19:16:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:16:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:16:19 INFO - Running setup.py install for mozfile 19:16:19 INFO - Running setup.py install for mozhttpd 19:16:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Running setup.py install for mozinfo 19:16:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Running setup.py install for mozInstall 19:16:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Running setup.py install for mozleak 19:16:20 INFO - Running setup.py install for mozlog 19:16:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Running setup.py install for moznetwork 19:16:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:16:20 INFO - Running setup.py install for mozprocess 19:16:20 INFO - Running setup.py install for mozprofile 19:16:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:16:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:16:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:16:21 INFO - Running setup.py install for mozrunner 19:16:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:16:21 INFO - Running setup.py install for mozscreenshot 19:16:21 INFO - Running setup.py install for moztest 19:16:21 INFO - Running setup.py install for mozversion 19:16:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:16:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:16:21 INFO - Cleaning up... 19:16:21 INFO - Return code: 0 19:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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', '-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 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:21 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 19:16:21 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 19:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:21 INFO - 'HOME': '/Users/cltbld', 19:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:21 INFO - 'LOGNAME': 'cltbld', 19:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:21 INFO - 'MOZ_NO_REMOTE': '1', 19:16:21 INFO - 'NO_EM_RESTART': '1', 19:16:21 INFO - 'PAGER': '/bin/cat', 19:16:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:21 INFO - 'PWD': '/builds/slave/test', 19:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:21 INFO - 'SHELL': '/bin/bash', 19:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:21 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:21 INFO - 'USER': 'cltbld', 19:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:21 INFO - 'XPC_FLAGS': '0x0', 19:16:21 INFO - 'XPC_SERVICE_NAME': '0', 19:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-jJJ_pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-rCrlLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-d4Fa9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-1t7Pi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-Xt95CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-gSzMrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-9OtLCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-UkR733-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-BrJpUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:16:22 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)) 19:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:16:22 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-HLt9i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-BWfZWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:16:23 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-Hhqxm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:16:23 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-P39KHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:16:23 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-rwleCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:16:23 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-bAcBHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:23 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-qI4bVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:16:23 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)) 19:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:16:23 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-sRzSsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:16:23 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)) 19:16:23 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)) 19:16:23 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)) 19:16:23 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)) 19:16:23 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)) 19:16:23 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)) 19:16:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:25 INFO - Downloading blessings-1.5.1.tar.gz 19:16:25 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 19:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:16:26 INFO - Installing collected packages: blessings 19:16:26 INFO - Running setup.py install for blessings 19:16:26 INFO - Successfully installed blessings 19:16:26 INFO - Cleaning up... 19:16:26 INFO - Return code: 0 19:16:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:16:26 INFO - Reading from file tmpfile_stdout 19:16:26 INFO - Current package versions: 19:16:26 INFO - blessings == 1.5.1 19:16:26 INFO - blobuploader == 1.2.4 19:16:26 INFO - docopt == 0.6.1 19:16:26 INFO - manifestparser == 1.1 19:16:26 INFO - mozInstall == 1.12 19:16:26 INFO - mozcrash == 0.16 19:16:26 INFO - mozdebug == 0.1 19:16:26 INFO - mozdevice == 0.47 19:16:26 INFO - mozfile == 1.2 19:16:26 INFO - mozhttpd == 0.7 19:16:26 INFO - mozinfo == 0.9 19:16:26 INFO - mozleak == 0.1 19:16:26 INFO - mozlog == 3.1 19:16:26 INFO - moznetwork == 0.27 19:16:26 INFO - mozprocess == 0.22 19:16:26 INFO - mozprofile == 0.27 19:16:26 INFO - mozrunner == 6.11 19:16:26 INFO - mozscreenshot == 0.1 19:16:26 INFO - mozsystemmonitor == 0.0 19:16:26 INFO - moztest == 0.7 19:16:26 INFO - mozversion == 1.4 19:16:26 INFO - psutil == 3.1.1 19:16:26 INFO - requests == 1.2.3 19:16:26 INFO - wsgiref == 0.1.2 19:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x104de9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee50ca9d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, '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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 19:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 19:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:26 INFO - 'HOME': '/Users/cltbld', 19:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:26 INFO - 'LOGNAME': 'cltbld', 19:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:26 INFO - 'MOZ_NO_REMOTE': '1', 19:16:26 INFO - 'NO_EM_RESTART': '1', 19:16:26 INFO - 'PAGER': '/bin/cat', 19:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:26 INFO - 'PWD': '/builds/slave/test', 19:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:26 INFO - 'SHELL': '/bin/bash', 19:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:26 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:26 INFO - 'USER': 'cltbld', 19:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:26 INFO - 'XPC_FLAGS': '0x0', 19:16:26 INFO - 'XPC_SERVICE_NAME': '0', 19:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 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)) 19:16:26 INFO - Cleaning up... 19:16:26 INFO - Return code: 0 19:16:26 INFO - Running post-action listener: _resource_record_post_action 19:16:26 INFO - Running post-action listener: _start_resource_monitoring 19:16:26 INFO - Starting resource monitoring. 19:16:26 INFO - ##### 19:16:26 INFO - ##### Running install step. 19:16:26 INFO - ##### 19:16:26 INFO - Running pre-action listener: _resource_record_pre_action 19:16:26 INFO - Running main action method: install 19:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:16:27 INFO - Reading from file tmpfile_stdout 19:16:27 INFO - Detecting whether we're running mozinstall >=1.0... 19:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:16:27 INFO - Reading from file tmpfile_stdout 19:16:27 INFO - Output received: 19:16:27 INFO - Usage: mozinstall [options] installer 19:16:27 INFO - Options: 19:16:27 INFO - -h, --help show this help message and exit 19:16:27 INFO - -d DEST, --destination=DEST 19:16:27 INFO - Directory to install application into. [default: 19:16:27 INFO - "/builds/slave/test"] 19:16:27 INFO - --app=APP Application being installed. [default: firefox] 19:16:27 INFO - mkdir: /builds/slave/test/build/application 19:16:27 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'] 19:16:27 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 19:16:58 INFO - Reading from file tmpfile_stdout 19:16:58 INFO - Output received: 19:16:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:16:58 INFO - Running post-action listener: _resource_record_post_action 19:16:58 INFO - ##### 19:16:58 INFO - ##### Running run-tests step. 19:16:58 INFO - ##### 19:16:58 INFO - Running pre-action listener: _resource_record_pre_action 19:16:58 INFO - Running main action method: run_tests 19:16:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:16:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:16:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:16:58 INFO - 2015-11-23 19:16:58.223 screenresolution[2551:25186] starting screenresolution argv=screenresolution get 19:16:58 INFO - 2015-11-23 19:16:58.225 screenresolution[2551:25186] Display 0: 1600x1200x32@60 19:16:58 INFO - 2015-11-23 19:16:58.231 screenresolution[2552:25188] starting screenresolution argv=screenresolution list 19:16:58 INFO - Available Modes on Display 0 19:16:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:16:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:16:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:16:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:16:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:16:58 INFO - Intel Iris: 19:16:58 INFO - Chipset Model: Intel Iris 19:16:58 INFO - Type: GPU 19:16:58 INFO - Bus: Built-In 19:16:58 INFO - VRAM (Dynamic, Max): 1536 MB 19:16:58 INFO - Vendor: Intel (0x8086) 19:16:58 INFO - Device ID: 0x0a2e 19:16:58 INFO - Revision ID: 0x0009 19:16:58 INFO - Displays: 19:16:58 INFO - Display: 19:16:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:16:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:16:58 INFO - Display Serial Number: 1600x1200 60 19:16:58 INFO - Main Display: Yes 19:16:58 INFO - Mirror: Off 19:16:58 INFO - Online: Yes 19:16:58 INFO - Rotation: Supported 19:16:58 INFO - Return code: 0 19:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:16:58 INFO - Python 2.7.3 19:16:58 INFO - Return code: 0 19:16:58 INFO - grabbing minidump binary from tooltool 19:16:58 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')]} 19:16:58 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 0x104d0d9f0>, '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 0x104a6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d008c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:16:58 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 19:16:58 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 19:16:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:16:58 INFO - Return code: 0 19:16:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:16:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:16:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:16:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:16:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:16:58 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/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--webServer', 'localhost'] in /builds/slave/test/build 19:16:58 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/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0056 --webServer localhost 19:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F5t9a7Szzy/Render', 19:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:58 INFO - 'HOME': '/Users/cltbld', 19:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:58 INFO - 'LOGNAME': 'cltbld', 19:16:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:16:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:58 INFO - 'MOZ_NO_REMOTE': '1', 19:16:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:16:58 INFO - 'NO_EM_RESTART': '1', 19:16:58 INFO - 'PAGER': '/bin/cat', 19:16:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:58 INFO - 'PWD': '/builds/slave/test', 19:16:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:58 INFO - 'SHELL': '/bin/bash', 19:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVsQiGrIDb/Listeners', 19:16:58 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:58 INFO - 'USER': 'cltbld', 19:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:58 INFO - 'XPC_FLAGS': '0x0', 19:16:58 INFO - 'XPC_SERVICE_NAME': '0', 19:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:16:58 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/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--webServer', 'localhost'] with output_timeout 3600 19:16:58 INFO - mozversion INFO | application_buildid: 20151123180231 19:16:58 INFO - mozversion INFO | application_changeset: 0ed0b39c35419af45b20bf9b1df70104be2f7914 19:16:58 INFO - mozversion INFO | application_display_name: Nightly 19:16:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:16:58 INFO - mozversion INFO | application_name: Firefox 19:16:58 INFO - mozversion INFO | application_remotingname: firefox 19:16:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:16:58 INFO - mozversion INFO | application_vendor: Mozilla 19:16:58 INFO - mozversion INFO | application_version: 45.0a1 19:16:58 INFO - mozversion INFO | platform_buildid: 20151123180231 19:16:58 INFO - mozversion INFO | platform_changeset: 0ed0b39c35419af45b20bf9b1df70104be2f7914 19:16:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:16:58 INFO - mozversion INFO | platform_version: 45.0a1 19:16:58 INFO - 2015-11-23 19:16:58,779 DEBUG : using testdate: 1448335018 19:16:58 INFO - 2015-11-23 19:16:58,779 DEBUG : actual date: 1448335018 19:16:58 INFO - 2015-11-23 19:16:58,787 INFO : starting webserver on 'localhost:51816' 19:16:58 INFO - 2015-11-23 19:16:58,788 INFO : Starting test suite t-yosemite-r7-0056.e 19:16:58 INFO - 2015-11-23 19:16:58,788 INFO : Starting test dromaeo_css 19:16:58 INFO - 2015-11-23 19:16:58,788 DEBUG : operating with platform_type : mac_ 19:16:58 INFO - 2015-11-23 19:16:58,789 INFO : Initialising browser for dromaeo_css test... 19:16:58 INFO - 2015-11-23 19:16:58,801 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpzC4YE9/profile http://localhost:51816/getInfo.html 19:17:01 INFO - 2015-11-23 19:17:01,472 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:17:01 INFO - 2015-11-23 19:17:01,472 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:17:01 INFO - 2015-11-23 19:17:01,472 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:17:01 INFO - 2015-11-23 19:17:01,473 DEBUG : BROWSER_OUTPUT: __metrics 19:17:02 INFO - 2015-11-23 19:17:02,231 INFO : Browser initialized. 19:17:02 INFO - 2015-11-23 19:17:02,231 INFO : Running cycle 1/1 for dromaeo_css test... 19:17:02 INFO - 2015-11-23 19:17:02,232 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpzC4YE9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:17:14 INFO - 2015-11-23 19:17:14,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 236396544 19:17:14 INFO - 2015-11-23 19:17:14,082 DEBUG : BROWSER_OUTPUT: 19:18:03 INFO - 2015-11-23 19:18:03,751 DEBUG : BROWSER_OUTPUT: 1448335083750 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] 19:20:14 INFO - 2015-11-23 19:20:14,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51816/tests/dromaeo/cssquery-ext.html) 19:20:16 INFO - 2015-11-23 19:20:16,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 252862464 19:20:16 INFO - 2015-11-23 19:20:16,390 DEBUG : BROWSER_OUTPUT: 19:23:18 INFO - 2015-11-23 19:23:18,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/dromaeo/cssquery-ext.html (next: http://localhost:51816/tests/dromaeo/cssquery-jquery.html) 19:23:19 INFO - 2015-11-23 19:23:19,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 263258112 19:23:19 INFO - 2015-11-23 19:23:19,113 DEBUG : BROWSER_OUTPUT: 19:26:20 INFO - 2015-11-23 19:26:20,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51816/tests/dromaeo/cssquery-mootools.html) 19:26:21 INFO - 2015-11-23 19:26:21,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 263364608 19:26:21 INFO - 2015-11-23 19:26:21,327 DEBUG : BROWSER_OUTPUT: 19:29:22 INFO - 2015-11-23 19:29:22,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51816/tests/dromaeo/cssquery-prototype.html) 19:29:23 INFO - 2015-11-23 19:29:23,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 266514432 19:29:23 INFO - 2015-11-23 19:29:23,540 DEBUG : BROWSER_OUTPUT: 19:32:25 INFO - 2015-11-23 19:32:25,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51816/tests/dromaeo/cssquery-yui.html) 19:32:26 INFO - 2015-11-23 19:32:26,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 269496320 19:32:26 INFO - 2015-11-23 19:32:26,562 DEBUG : BROWSER_OUTPUT: 19:35:28 INFO - 2015-11-23 19:35:28,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/dromaeo/cssquery-yui.html (next: http://localhost:51816/tests/dromaeo/cssquery-dojo.html) 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 272388096 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3412.2834204816986;3531.4173161428366;3569.6965757910584;3573.982130089349;3579.409397449421;5977.40225977402;5992.670403127831;5996.400359964013;6022.728977196026;6035.18524999125;5774.595778295521;5922.822315330547;5954.434328738763;5968.67172305523;5971.671558064305;4463.5313292104265;5280.656757310781;5299.894002119955;5371.355437347524;5437.510624043835;4449.777511124447;5400.459954004587;5420.376656684492;5437.864053398657;5487.75305111271;5337.638902079964;5409.918851217235;5448.400675925645;5466.234727138204;5471.917921231185;5183.2743415921805;5373.220882971987;5378.220158077057;5391.245225668409;5397.109476936301;4406.5593440656;5361.651492652965;5407.405185429599;5419.647722897999;5431.076716958127;4799.992001679617;5612.214289999403;5677.432256774331;5797.826065218051;5965.164876917235;6221.595596286227;6260.467860231885;6303.842403939892;6305.180326557564;6321.589096708699;6440.806775796734;6442.710078046499;6446.097546343469;6454.19322584677;6460.773872914472;6027.306859711101;6133.754649814002;6151.108089327112;6156.168917196211;6169.105479705418;5378.865528361744;6523;6534.640594767238;6557.2131344239;6565;6274.2784579773;6296.244450665949;6297.244330680256;6302.716377763011;6315.400036996478;6282.591631543935;6386.233651961701;6396.456301214356;6397;6422.165118534561;6239.438450539473;6274.466670333073;6281.685915704196;6285.9057114143325;6293.622382657055;6262.499000079983;6274.6548939808745;6275.937240627535;6280.842978925472;6286.277078136073;4973.229149481836;5050.318207042076;5066.493350664978;5115.258287548285;5157.690538567698;4565.863024109282;4573.725576465423;4605.539446055368;4609;4609.331646911246;6014.849628759229;6040.033594624839;6058.182145410401;6064;6065.848353791191;5479;6301.810945671546;6351.809445716636;6395.136656551399;6478.740850366027;6091.116788065794;6098.847528811726;6104.267487901391;6113.8471538211015;6114.816555503342;5503.944960550343;5634.74643641029;5642.689652069093;5653.943460565424;5659.26429564154;6449.548531602836;6512.479001679854;6576.309487503743;6591.670416479253;6614.437772789367;6384.93615063862;6387.329330420424;6395.712192951235;6396;6400;6355.777547785805;6412.454941329853;6634.535582509178;6636.13730215069;6644.269130395556;6209.348018458178;6245.469135123383;6264.968675156595;6277.748890044347;6298.02380631003;6327;6422.100905873275;6439.227292724903;6467.741290348334;6471.320511346429;6114.174586430775;6141.700809433504;6201.317855036033;6268;6283.465905398092;6117.370705100174;6201.720922558586;6204.472619827366;6228.439440450381;6236.906446403398;6055.000924847527;6182.536309776875;6190.628562286277;6209.689515524296;6244.344343844013;6108.633481991094;6126.724297406717;6314.747410103728;6316.557840951089;6318.178636777189;6137.447629713347;6190.845228869314;6200.193974783249;6202.255729312511;6209.5032397409 19:35:29 INFO - 2015-11-23 19:35:29,226 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.1828139509342;555.1118210862622;563.6843367714082;567.8810337359836;630.9810705678829;37297.440538391944;41347.79326103365;41426.79286603571;41430.58569414309;41527.37708934368;42074;43759.34360984588;44143.11713765731;44290.11419771603;44650.33024504627;9744.805103897917;9889.40663560185;9909.504524773733;9915.553800079013;9955.153811925995;9709.61161553537;9801.166900813403;9808.46053467059;9818.312718109735;9865.358751681119;9808.754781130494;9810.068043535854;9842.60629574816;9846.852297215511;9887.752806179831;9792.314537982344;9877.753056173617;9894.257930655229;9910.851337229948;9912.950435247778;9675.274354423447;9745;9771.951140244324;9807;9823.459709715962;40245.79877100625;41075.589244107774;41317;41528.58471415278;41554.1689166215;3178.9682103179134;3461.671141241603;3774.565924918642;3797.791121488317;4035.5762644922156;28768.993085241917;29496;29851.10446686603;30298.84850575755;30326.241843953856;2764.1292992707436;2770.224337185591;2788.7908406869565;2895.5656651502445;2903.462859371023;478398;481691;481960;483161;483174;59247;60737.088943664996;65100.674496627216;65728.34271657318;70327.64836175786;68687.65656171787;68981;69020.3097969024;69296.96054559185;69299;16016.199190040452;16237;16245.944013639075;16271.267792949346;16498.58753531171;12269.815952760715;12271.815922761165;12325.075619328587;12424.192427492184;12489.562865299671;20905.268315609184;20915.37253882386;20985.475363116046;21015.633983791005;21022.2642207522;7701.268379503938;8155.714549990722;8282.674772036446;8913.643454261757;9100.362974591848;959.2278216036018;1017.8880323164447;1057.7132774242166;1063.4788953412772;1129.2377645089532;29952.251193719894;30045.94839180618;30505.08484745461;30699.693003069682;31435;1083.1930211992117;1111;1160.9825852612219;1176.1825531255695;1206.3968015992004;14136;14807.259637018105;14906.776398354034;15276.541703748906;15497;458528;532799;538333;540613;541506;47172;56612;57448.71275643595;57532.71233643889;57631.13553296704;1244.813278008306;1424.1312799192485;1461.671123997092;1468.955931322062;1610.3236640610971;27501.587476187473;29512;29911;30153.849230753705;30312;51263.487365125875;51296;51732.96534069373;51841.740791297314;51943;482923;489635;490592;492584;498284;31463;33363.49954750632;33993.320133596695;34091;34347.28263586861;43379.566204337556;43479.34780978351;43539.56460435355;43608.34587481254;44391.556084438744;37684.62315376811;38045.048873778374;38202.617973819906;38203.23593528169;38653.806730966164;36420.62952445618;36982.63017369792;37160.81419592885;37312.44031339478;37612.2477550442;37112.25775484529;37325.81337093297;37634.24731505409;37669.24661506809;37942.67200647964;32233.033009009767;33185;33286.83356583298;33521.66478335185;33531.66468335286;22656.320310390714;24949.50100998006;25293.747062529874;25302;25491.745082548936 19:35:29 INFO - 2015-11-23 19:35:29,228 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.2619803205395;364.9854005839766;366.63886072218867;368.022899202617;368.48412222887936;14468.782968255484;16096.919515402407;19299.517512062204;19327;20432.8978355108;13566.321683915814;16205.432809851658;16261.349546018146;19204.271615554597;20582.794172058275;5193.5066168714;5282.867928301804;5309.283246761695;5319.760610772524;5339.5728341732565;5117.923231151536;5246.239295302179;5254.133068043788;5263.578913686915;5814.622049566765;5734.111212762028;5735.885282294352;5737.3688894221605;5740.5981581289325;5769.653820770767;5667.987864308173;5719.399463056381;5739.655620662774;5745.511631511326;5750.338711048241;5035.924461133086;5051.848444546669;5059.494050594948;5080.872978175576;5081.898362032775;23985.52028959411;24217.757822421725;24454.510909781882;24699.753002470105;24752.009919603195;1815.4916623345484;1853.212384736495;1958.3243780895568;1974.7235387045826;1996.8502362322738;9503.192228660571;9574.664886729;9701.611935522571;9885.555150018194;10047.095761381437;1683.192067807447;1697.4228762220905;1715.5368050626387;1723.818999005099;1737.7654016707836;94528;95376.52311738467;97182;98293.01706982982;98344.50827745887;8636.747671587586;10452.581896724198;10565.418901960313;10644.467776611138;10646.307989980627;12325.445354959049;12638.557650482373;12688.619341419771;12694.49222031127;12720.745585088247;7872.212778722082;8017.879731804028;8080.4343695940715;8126.349892008625;8152.8777068344025;6756.2568117507035;6831.87274099768;7979.960100199578;8009.519428834172;8182.83634327322;4228.281192197333;4243.915121697549;4251;4265.509466411402;4291.9785401072795;1829.4420201838568;1831.2583403721515;1840.5766673664864;1849.5838436351714;1862.3574866670976;831.8128421105203;884.3014018924977;894.6376717429451;946.2950102173787;1009.2178561614661;18284.634307314045;20278.49303767388;20465.260452861672;20573.69139462909;20653.17387304521;911.8404279251105;914.4741773480275;977.2133432586694;1011.4234886114991;1015.6082425887078;9376.390534615228;10594.417307048032;11079.446027698583;11273.154513411528;11302.095832333394;701490;717547;721646;722446;737070;124470.75529244772;127967.08049379267;129257;129771;130394.34802825925;1154.7517283784027;1156.1617827075304;1170.455738081796;1174.3130268792852;1184.265755231762;17176;17887.73168402449;18051.819481805014;18086.82435641679;18299.085045747925;42801.571984279755;49081.75459122682;49099;50994.49005509898;52744;69957.30042699711;71558;72922.63538682273;73149.63425182841;73324;9584.185344245538;9598.9040109598;9825.919148893474;9828.705138845846;9925.10674039311;19206.61586768285;19437.611247775247;19542.804571954097;19800.405987820388;19979.400617981482;15508.147051912254;15544.222788860738;15851.365945362057;16016.359345626044;16065.437709680105;12277;13313.33433328349;13942.512012079529;14975.1014939104;15406.768898466307;15905.363785448453;15976.20118994069;16151.353945842035;16213.837861621232;16214.837851621332;7899.368050556057;9707.88359338685;9763.463009534544;9786;9797.412155270422;14148.009639325148;14655.706885862437;15862.365505379656;15895.284712187748;16016.958897671613 19:35:29 INFO - 2015-11-23 19:35:29,229 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.015524831236;1534.5396381085673;1836.7520384748073;1894.9388342528182;1928.4311128217175;6956.443484521233;7111.964440177799;7129.322714342135;7775.30022297993;7909.604519774017;7578.658960346784;7732.574708391036;8307.543085130315;8408.537530435824;8433;2355.2698663414353;2370.6799582056374;2382.19005538117;2395.688560487134;2396.1733202045352;2380.8452450590744;2388.5819981503255;2418.3107814272935;2429.4898071405028;2436.500517393939;1986.45372522556;2344.19125401737;2375.444084124901;2389.354874183969;2399.5800734871414;2328.557574060923;2337.0885354711677;2349.119080344871;2359.09174967637;2373.7863592276776;2324.8721320327377;2328.068772491017;2343.8945247463735;2353.5410594933996;2359.2096647623066;8394.8321033579;8481.982162140583;8485.236328730382;8509.361797865186;8542.57287135647;5176.7929282828645;5259.947400525984;5283.101872681654;5318.494742999409;5346.572274218053;3428.211511352403;3438.638942910983;3453.4647129694936;3503.351879902201;3548.8935331940083;1037.5745944162857;1040.3601784902307;1045.2213101239624;1047.7852040331713;1054.4411461925192;11223.989840914275;11305.095592352593;11311.981921627012;11329.716757081056;11351.489182986703;4636.049609830045;4668.439787225487;4693.577578017995;4694.014257006067;4718.773118989019;7778.22217778229;9739.97730238329;9775.951120244496;9783.168430683329;9788.461634610023;5183.637145399785;5198.558122559549;5243.187305967581;5248.921266181011;5256.894862102737;4264.808083636244;4339.7830108494445;4630.884227894329;4714.38712967312;4753.928691069567;3879.0690234343556;3897.18159186574;3922.7254092213843;3938.6652134568308;3958.6041395860184;1290.283892439705;1292.095533126815;1292.8060790881254;1292.9030322725832;1301.4013553765374;1060.3743791163251;1143.9428028598536;1283.3519072868141;1381.4543255414055;1386.3414877933103;6703.296153903867;7823.921760782433;7950.363970882316;7981.042274927046;7981.640826162837;501.1005245584185;510.3594988289673;513.2275924733327;513.9820106296337;516.1638146203175;6096.786612468631;6110.725017374229;6111;6114.694265286718;6120.204373431515;10019.79960400788;10209.693709188736;10257.58969641206;10325.948370258251;10365.533550990223;9938;10123;10145.797084058277;10186.03232692893;10286.177105831515;7940.801479963047;7970.721024764105;8041.597920103972;8049.51702897828;8085.474444161111;6472.449841763503;6628.767993120217;7913.287804097658;7937.047554293522;7963.721269755531;8921.509316987627;9153.084691530794;9199.724008279762;9203.171714545722;9286.767830804283;9400.717978460658;9536.713898583053;9566.282528810229;9608.75978100553;9620.278479113955;6747.089142965833;6836.418904393182;7177.641117943977;7376.373008294355;7395.445341599509;8012.559309238048;8022.438429309892;8037.557934313435;8056.355491560544;8098.5545794981845;7427.25727427253;7431.851362972819;7678.731244406419;7694.307512323918;7706.845863082594;7390.187079421152;7436.702531898663;7445.62771861394;7506.8498630026;7557.924420755722;7565.2812982766545;7575.734849280248;7598.392128629807;7610.657520411484;7628.8474230516185;6759.121314229119;6786.117804685359;6790.354916282945;6927.3419025192525;6930.965345173242;6937.791866244021;6947.444204463732;6967.581945083311;6983.079653095439;7036.190838053484 19:35:29 INFO - 2015-11-23 19:35:29,233 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.8455795265438;328.2712378519685;331.7661048960483;334.8543383628122;337.8868079193472;6846.589204647725;6859.554128981613;6940.340667636573;7022;7040.943858421239;6775.525713200078;6845.589264644125;6881.759138430143;6900.309969003097;6945.930540694591;4905.386826646669;4953.876153096166;4960.107180707471;4969.652124351297;4981.5018498150075;4837.250226214942;4966.9751651241695;4967.726775027372;4973.676711013791;4985.102681517325;4718.4809670936165;4876.878078048059;4886.193778026622;4886.34034405356;4895.11887860185;4875.804967801284;4879.39007624047;4881.731504767236;4893.8287159949405;4902.166631672624;4061.8220715992325;4130.215259100762;4136.048708796963;4139.79301034947;4152.1072969311745;5069.366329208849;5284.735763211863;5303.655262407931;5429.918551221735;6580.86838263232;5585.050541407971;5832.300123985106;5838.503727183194;5848.181254624356;5851;6231.3145553989025;6255.374462553754;7360.889586656204;7373.8156546086775;7379.59412232327;3940.0543869471408;4481.327800829869;4565.155446242423;4649.465311489188;4679.181143299943;7461.067366579177;7682.270184332479;7784.455088143832;7802.453828232026;7831.177726338709;4720.362751028636;4738.123447162286;4742.430908291027;4749.216379297446;4759.9524004759505;3959.6238357356006;4804.615630749532;4813.181759100961;4833.685810422311;4834.492378300298;5622.91565626516;5748.770049197985;5798.971005144947;5818.5345172386105;5830.562707796932;6970.5710329382355;7404.37062849653;7405.592692401862;7437.702491900372;7470.925290747023;1385.4458216713194;1624.7644091606887;1626.4226199699174;1673.0045622854382;1677.1614192903548;1042.4370839746603;1057.7153348766626;1067.893210678926;1071.3197119828808;1076.531708706715;6725.327467253333;6741.797746067626;6747.460203183831;6775.695093720795;6778.084958530634;7524.097108347033;7530.28462296081;7541.170471248159;7544.698212071456;7561.432892533082;6445.291017988017;6686.297938716462;6703.798886033427;6705.497087718343;6767.796966091025;3514.945516345086;3924.862629807943;3978.5026871641044;4004.2592120457807;4019.8191081401405;7784.805379865548;7785.649645765954;7794.22057794216;7801;7819.765407037798;7485;7781.727639532703;7821.452498325063;7836.608169591612;7846.803829904298;7759.30166285037;7762.41781866351;7768.7669369918995;7770;7780.260875216959;7475.43934204926;7500.36246919018;7501.474896757393;7502.887456688045;7530.472866899484;7393.223711510429;7669.118051424158;7673.6546855390525;7675.53946763196;7678.8080297993;8009.399295052778;8013;8020.759377218693;8022.077461092049;8056.83886322282;4634.679116451795;4738.8341408050555;4740.6681532292405;4754.952450475451;4761.023990082094;7305.452091093295;7428.517146385468;7524.774256772305;7709.7301594443925;7747.612619369122;7180.7845764627145;7269.563826170447;7303.087114110736;7312.122545294599;7326.084239470067;7318.560886346836;7327.780166595011;7357.153927298429;7375.557466552024;7399.038125043709;5853.853653658693;6956.469666498813;7182.461315401261;7208.495405321577;7211.6033618151505;7348;7365.668544915385;7366.594837284001;7366.7053317866685;7367.373773229336;6971.093757811452;7189.640517973976;7190.209077001421;7202.135743710788;7217.494775365884 19:35:29 INFO - 2015-11-23 19:35:29,233 DEBUG : BROWSER_OUTPUT: |5;yui.html;733.6991833348327;743.8995735575699;763.9847203055939;774.0788461730543;811.4157806379404;14673.633159171013;14949.252537373142;15071;15077.849221507782;15132.394704211833;12943.352832358369;13421.731565368687;14011.859881401182;14141.646458838508;14196.219207943559;862.7109918177387;945.3571571331508;959.1319855530755;962.9614815407375;963.7735132243918;929.1498279074673;942.8161508505844;945.8486642137259;946.7585765629755;949.4493193947528;975.6487664440796;989.6585677941099;990.3859607043607;996.2727209137335;996.4469719305782;720.7333286683908;971.116284181395;984.901509849013;986.1469828598247;1035.171862509989;721.4156533208118;734.5849594978873;737.3732327521617;739.737393225408;740.9110906691178;13390.263535505543;13390.330483475886;13459.798103028463;13462.124961877544;13512.189268643815;10966.287191332538;11104.833427498514;11168.218224724273;11547;11690.824637630443;9386.765330866714;9527.52362381885;9547.856782148274;9550.61797528098;9559.952200239024;3413.6927676509235;3458.1873259784184;3458.3774920514297;3466.7746596471147;3476.374252634525;64166.67916660387;64485.355146448404;71399.64300178518;78116.21883781147;79819.20180798176;9358.625654973861;9433.433993960385;9500.334976551714;9653.806923861483;9931.553080111413;20985.68521472179;20993.16027358919;21110.366688999355;21111.8944405277;21197.046132924057;6549.24683661385;7195.172555156119;7380.188179300273;7563.092428908566;7683.807904802425;4013.9397909031386;4091.1204091120553;4136.21411931732;4201.5717249082445;4206.369044643328;3337.399268131711;3390.355832391838;3391.7456190785297;3402.625711171769;3407.693307602328;598.1058317814808;606.8088552106072;611.5169016477022;621.4593303825701;626.943575078236;509.76041260607457;557.6707058858608;601.6540489218717;602.9207718184489;631.4916492223804;8216.849641050258;8326.209010144026;8495.915040849635;8562.871556926526;8672.089430609822;498.4765995704496;586.2291087220292;600.5525883217032;614;619.7211254935207;3811.5616704079384;3933.3903244997073;4074.103697186614;4140;4163.10493243954;96085.5195724017;97640;97824.53263201058;97828;98441.031179376;64900.02649960254;70077.8976630702;74561;85241.57379213064;86794.56602716947;64470;68441;73051;77057;79249;8843.204111629984;8911.910880891368;9008.41445306053;9013.594388252675;9049.411788233743;47748.2837757427;48209.75895120502;48663.27005094997;48745.268820967;49481;64056.03915941172;67976.66011670108;75202.62398687971;77842;78253.04367390633;10932.344059356465;11133.165012623924;11204.88795112071;11272.718182045515;11380.032697220498;12007.339596321937;12360.245967097793;12490.063245256824;12519.248845069325;12746.553870614483;11633.59282425111;11668.94165529167;11841.407929603658;11904.702382440508;11938;10138.391696498235;11450.255733377304;11939.641810745692;11955.521779128738;11968.940155299168;11539.615246170513;11555.191136620691;11560.595379162025;11741.47163377633;11830.11274154459;9619.711408657751;9761.951190244003;9925.674898908946;9975.700728978143;9987.350822196535;9938.751531211778;10074;10085.991400859855;10087.394756314645;10105.141063009727 19:35:29 INFO - 2015-11-23 19:35:29,233 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:35:29 INFO - 2015-11-23 19:35:29,233 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:35:29 INFO - 2015-11-23 19:35:29,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,335 19:35:29 INFO - 2015-11-23 19:35:29,233 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:35:29 INFO - 2015-11-23 19:35:29,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1448336129220__endTimestamp 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5897.34 Median:6156.17 stddev:667.90 (10.8%) stddev-sans-first:640.87 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: Values: 3412.3 3531.4 3569.7 3574.0 3579.4 5977.4 5992.7 5996.4 6022.7 6035.2 5774.6 5922.8 5954.4 5968.7 5971.7 4463.5 5280.7 5299.9 5371.4 5437.5 4449.8 5400.5 5420.4 5437.9 5487.8 5337.6 5409.9 5448.4 5466.2 5471.9 5183.3 5373.2 5378.2 5391.2 5397.1 4406.6 5361.7 5407.4 5419.6 5431.1 4800.0 5612.2 5677.4 5797.8 5965.2 6221.6 6260.5 6303.8 6305.2 6321.6 6440.8 6442.7 6446.1 6454.2 6460.8 6027.3 6133.8 6151.1 6156.2 6169.1 5378.9 6523.0 6534.6 6557.2 6565.0 6274.3 6296.2 6297.2 6302.7 6315.4 6282.6 6386.2 6396.5 6397.0 6422.2 6239.4 6274.5 6281.7 6285.9 6293.6 6262.5 6274.7 6275.9 6280.8 6286.3 4973.2 5050.3 5066.5 5115.3 5157.7 4565.9 4573.7 4605.5 4609.0 4609.3 6014.8 6040.0 6058.2 6064.0 6065.8 5479.0 6301.8 6351.8 6395.1 6478.7 6091.1 6098.8 6104.3 6113.8 6114.8 5503.9 5634.7 5642.7 5653.9 5659.3 6449.5 6512.5 6576.3 6591.7 6614.4 6384.9 6387.3 6395.7 6396.0 6400.0 6355.8 6412.5 6634.5 6636.1 6644.3 6209.3 6245.5 6265.0 6277.7 6298.0 6327.0 6422.1 6439.2 6467.7 6471.3 6114.2 6141.7 6201.3 6268.0 6283.5 6117.4 6201.7 6204.5 6228.4 6236.9 6055.0 6182.5 6190.6 6209.7 6244.3 6108.6 6126.7 6314.7 6316.6 6318.2 6137.4 6190.8 6200.2 6202.3 6209.5 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,235 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64747.16 Median:22555.58 stddev:132565.10 (587.7%) stddev-sans-first:132849.33 19:35:29 INFO - 2015-11-23 19:35:29,236 DEBUG : BROWSER_OUTPUT: Values: 541.2 555.1 563.7 567.9 631.0 37297.4 41347.8 41426.8 41430.6 41527.4 42074.0 43759.3 44143.1 44290.1 44650.3 9744.8 9889.4 9909.5 9915.6 9955.2 9709.6 9801.2 9808.5 9818.3 9865.4 9808.8 9810.1 9842.6 9846.9 9887.8 9792.3 9877.8 9894.3 9910.9 9913.0 9675.3 9745.0 9772.0 9807.0 9823.5 40245.8 41075.6 41317.0 41528.6 41554.2 3179.0 3461.7 3774.6 3797.8 4035.6 28769.0 29496.0 29851.1 30298.8 30326.2 2764.1 2770.2 2788.8 2895.6 2903.5 478398.0 481691.0 481960.0 483161.0 483174.0 59247.0 60737.1 65100.7 65728.3 70327.6 68687.7 68981.0 69020.3 69297.0 69299.0 16016.2 16237.0 16245.9 16271.3 16498.6 12269.8 12271.8 12325.1 12424.2 12489.6 20905.3 20915.4 20985.5 21015.6 21022.3 7701.3 8155.7 8282.7 8913.6 9100.4 959.2 1017.9 1057.7 1063.5 1129.2 29952.3 30045.9 30505.1 30699.7 31435.0 1083.2 1111.0 1161.0 1176.2 1206.4 14136.0 14807.3 14906.8 15276.5 15497.0 458528.0 532799.0 538333.0 540613.0 541506.0 47172.0 56612.0 57448.7 57532.7 57631.1 1244.8 1424.1 1461.7 1469.0 1610.3 27501.6 29512.0 29911.0 30153.8 30312.0 51263.5 51296.0 51733.0 51841.7 51943.0 482923.0 489635.0 490592.0 492584.0 498284.0 31463.0 33363.5 33993.3 34091.0 34347.3 43379.6 43479.3 43539.6 43608.3 44391.6 37684.6 38045.0 38202.6 38203.2 38653.8 36420.6 36982.6 37160.8 37312.4 37612.2 37112.3 37325.8 37634.2 37669.2 37942.7 32233.0 33185.0 33286.8 33521.7 33531.7 22656.3 24949.5 25293.7 25302.0 25491.7 19:35:29 INFO - 2015-11-23 19:35:29,237 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,237 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37856.77 Median:24725.88 stddev:118732.80 (480.2%) stddev-sans-first:119032.49 19:35:29 INFO - 2015-11-23 19:35:29,238 DEBUG : BROWSER_OUTPUT: Values: 358.3 365.0 366.6 368.0 368.5 14468.8 16096.9 19299.5 19327.0 20432.9 13566.3 16205.4 16261.3 19204.3 20582.8 5193.5 5282.9 5309.3 5319.8 5339.6 5117.9 5246.2 5254.1 5263.6 5814.6 5734.1 5735.9 5737.4 5740.6 5769.7 5668.0 5719.4 5739.7 5745.5 5750.3 5035.9 5051.8 5059.5 5080.9 5081.9 23985.5 24217.8 24454.5 24699.8 24752.0 1815.5 1853.2 1958.3 1974.7 1996.9 9503.2 9574.7 9701.6 9885.6 10047.1 1683.2 1697.4 1715.5 1723.8 1737.8 94528.0 95376.5 97182.0 98293.0 98344.5 8636.7 10452.6 10565.4 10644.5 10646.3 12325.4 12638.6 12688.6 12694.5 12720.7 7872.2 8017.9 8080.4 8126.3 8152.9 6756.3 6831.9 7980.0 8009.5 8182.8 4228.3 4243.9 4251.0 4265.5 4292.0 1829.4 1831.3 1840.6 1849.6 1862.4 831.8 884.3 894.6 946.3 1009.2 18284.6 20278.5 20465.3 20573.7 20653.2 911.8 914.5 977.2 1011.4 1015.6 9376.4 10594.4 11079.4 11273.2 11302.1 701490.0 717547.0 721646.0 722446.0 737070.0 124470.8 127967.1 129257.0 129771.0 130394.3 1154.8 1156.2 1170.5 1174.3 1184.3 17176.0 17887.7 18051.8 18086.8 18299.1 42801.6 49081.8 49099.0 50994.5 52744.0 69957.3 71558.0 72922.6 73149.6 73324.0 9584.2 9598.9 9825.9 9828.7 9925.1 19206.6 19437.6 19542.8 19800.4 19979.4 15508.1 15544.2 15851.4 16016.4 16065.4 12277.0 13313.3 13942.5 14975.1 15406.8 15905.4 15976.2 16151.4 16213.8 16214.8 7899.4 9707.9 9763.5 9786.0 9797.4 14148.0 14655.7 15862.4 15895.3 16017.0 19:35:29 INFO - 2015-11-23 19:35:29,238 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,238 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5812.70 Median:5271.52 stddev:3049.45 (57.8%) stddev-sans-first:3040.80 19:35:29 INFO - 2015-11-23 19:35:29,240 DEBUG : BROWSER_OUTPUT: Values: 1503.0 1534.5 1836.8 1894.9 1928.4 6956.4 7112.0 7129.3 7775.3 7909.6 7578.7 7732.6 8307.5 8408.5 8433.0 2355.3 2370.7 2382.2 2395.7 2396.2 2380.8 2388.6 2418.3 2429.5 2436.5 1986.5 2344.2 2375.4 2389.4 2399.6 2328.6 2337.1 2349.1 2359.1 2373.8 2324.9 2328.1 2343.9 2353.5 2359.2 8394.8 8482.0 8485.2 8509.4 8542.6 5176.8 5259.9 5283.1 5318.5 5346.6 3428.2 3438.6 3453.5 3503.4 3548.9 1037.6 1040.4 1045.2 1047.8 1054.4 11224.0 11305.1 11312.0 11329.7 11351.5 4636.0 4668.4 4693.6 4694.0 4718.8 7778.2 9740.0 9776.0 9783.2 9788.5 5183.6 5198.6 5243.2 5248.9 5256.9 4264.8 4339.8 4630.9 4714.4 4753.9 3879.1 3897.2 3922.7 3938.7 3958.6 1290.3 1292.1 1292.8 1292.9 1301.4 1060.4 1143.9 1283.4 1381.5 1386.3 6703.3 7823.9 7950.4 7981.0 7981.6 501.1 510.4 513.2 514.0 516.2 6096.8 6110.7 6111.0 6114.7 6120.2 10019.8 10209.7 10257.6 10325.9 10365.5 9938.0 10123.0 10145.8 10186.0 10286.2 7940.8 7970.7 8041.6 8049.5 8085.5 6472.4 6628.8 7913.3 7937.0 7963.7 8921.5 9153.1 9199.7 9203.2 9286.8 9400.7 9536.7 9566.3 9608.8 9620.3 6747.1 6836.4 7177.6 7376.4 7395.4 8012.6 8022.4 8037.6 8056.4 8098.6 7427.3 7431.9 7678.7 7694.3 7706.8 7390.2 7436.7 7445.6 7506.8 7557.9 7565.3 7575.7 7598.4 7610.7 7628.8 6759.1 6786.1 6790.4 6927.3 6931.0 6937.8 6947.4 6967.6 6983.1 7036.2 19:35:29 INFO - 2015-11-23 19:35:29,240 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,240 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5919.07 Median:6771.66 stddev:1950.91 (28.8%) stddev-sans-first:1910.25 19:35:29 INFO - 2015-11-23 19:35:29,241 DEBUG : BROWSER_OUTPUT: Values: 299.8 328.3 331.8 334.9 337.9 6846.6 6859.6 6940.3 7022.0 7040.9 6775.5 6845.6 6881.8 6900.3 6945.9 4905.4 4953.9 4960.1 4969.7 4981.5 4837.3 4967.0 4967.7 4973.7 4985.1 4718.5 4876.9 4886.2 4886.3 4895.1 4875.8 4879.4 4881.7 4893.8 4902.2 4061.8 4130.2 4136.0 4139.8 4152.1 5069.4 5284.7 5303.7 5429.9 6580.9 5585.1 5832.3 5838.5 5848.2 5851.0 6231.3 6255.4 7360.9 7373.8 7379.6 3940.1 4481.3 4565.2 4649.5 4679.2 7461.1 7682.3 7784.5 7802.5 7831.2 4720.4 4738.1 4742.4 4749.2 4760.0 3959.6 4804.6 4813.2 4833.7 4834.5 5622.9 5748.8 5799.0 5818.5 5830.6 6970.6 7404.4 7405.6 7437.7 7470.9 1385.4 1624.8 1626.4 1673.0 1677.2 1042.4 1057.7 1067.9 1071.3 1076.5 6725.3 6741.8 6747.5 6775.7 6778.1 7524.1 7530.3 7541.2 7544.7 7561.4 6445.3 6686.3 6703.8 6705.5 6767.8 3514.9 3924.9 3978.5 4004.3 4019.8 7784.8 7785.6 7794.2 7801.0 7819.8 7485.0 7781.7 7821.5 7836.6 7846.8 7759.3 7762.4 7768.8 7770.0 7780.3 7475.4 7500.4 7501.5 7502.9 7530.5 7393.2 7669.1 7673.7 7675.5 7678.8 8009.4 8013.0 8020.8 8022.1 8056.8 4634.7 4738.8 4740.7 4755.0 4761.0 7305.5 7428.5 7524.8 7709.7 7747.6 7180.8 7269.6 7303.1 7312.1 7326.1 7318.6 7327.8 7357.2 7375.6 7399.0 5853.9 6956.5 7182.5 7208.5 7211.6 7348.0 7365.7 7366.6 7366.7 7367.4 6971.1 7189.6 7190.2 7202.1 7217.5 19:35:29 INFO - 2015-11-23 19:35:29,241 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,241 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18278.62 Median:616.86 stddev:25896.88 (4198.2%) stddev-sans-first:25936.02 19:35:29 INFO - 2015-11-23 19:35:29,243 DEBUG : BROWSER_OUTPUT: Values: 733.7 743.9 764.0 774.1 811.4 14673.6 14949.3 15071.0 15077.8 15132.4 12943.4 13421.7 14011.9 14141.6 14196.2 862.7 945.4 959.1 963.0 963.8 929.1 942.8 945.8 946.8 949.4 975.6 989.7 990.4 996.3 996.4 720.7 971.1 984.9 986.1 1035.2 721.4 734.6 737.4 739.7 740.9 13390.3 13390.3 13459.8 13462.1 13512.2 10966.3 11104.8 11168.2 11547.0 11690.8 9386.8 9527.5 9547.9 9550.6 9560.0 3413.7 3458.2 3458.4 3466.8 3476.4 64166.7 64485.4 71399.6 78116.2 79819.2 9358.6 9433.4 9500.3 9653.8 9931.6 20985.7 20993.2 21110.4 21111.9 21197.0 6549.2 7195.2 7380.2 7563.1 7683.8 4013.9 4091.1 4136.2 4201.6 4206.4 3337.4 3390.4 3391.7 3402.6 3407.7 598.1 606.8 611.5 621.5 626.9 509.8 557.7 601.7 602.9 631.5 8216.8 8326.2 8495.9 8562.9 8672.1 498.5 586.2 600.6 614.0 619.7 3811.6 3933.4 4074.1 4140.0 4163.1 96085.5 97640.0 97824.5 97828.0 98441.0 64900.0 70077.9 74561.0 85241.6 86794.6 64470.0 68441.0 73051.0 77057.0 79249.0 8843.2 8911.9 9008.4 9013.6 9049.4 47748.3 48209.8 48663.3 48745.3 49481.0 64056.0 67976.7 75202.6 77842.0 78253.0 10932.3 11133.2 11204.9 11272.7 11380.0 12007.3 12360.2 12490.1 12519.2 12746.6 11633.6 11668.9 11841.4 11904.7 11938.0 10138.4 11450.3 11939.6 11955.5 11968.9 11539.6 11555.2 11560.6 11741.5 11830.1 9619.7 9762.0 9925.7 9975.7 9987.4 9938.8 10074.0 10086.0 10087.4 10105.1 19:35:29 INFO - 2015-11-23 19:35:29,243 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:35:29 INFO - 2015-11-23 19:35:29,243 DEBUG : BROWSER_OUTPUT: 19:35:29 INFO - 2015-11-23 19:35:29,629 INFO : Browser exited with error code: 0 19:35:29 INFO - 2015-11-23 19:35:29,653 INFO : Completed test dromaeo_css (00:18:30) 19:35:29 INFO - 2015-11-23 19:35:29,653 INFO : Starting test kraken 19:35:29 INFO - 2015-11-23 19:35:29,653 DEBUG : operating with platform_type : mac_ 19:35:29 INFO - 2015-11-23 19:35:29,653 INFO : Initialising browser for kraken test... 19:35:29 INFO - 2015-11-23 19:35:29,665 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpFfLQT1/profile http://localhost:51816/getInfo.html 19:35:32 INFO - 2015-11-23 19:35:32,421 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:35:32 INFO - 2015-11-23 19:35:32,422 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:35:32 INFO - 2015-11-23 19:35:32,422 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:35:32 INFO - 2015-11-23 19:35:32,422 DEBUG : BROWSER_OUTPUT: __metrics 19:35:33 INFO - 2015-11-23 19:35:33,046 INFO : Browser initialized. 19:35:33 INFO - 2015-11-23 19:35:33,046 INFO : Running cycle 1/1 for kraken test... 19:35:33 INFO - 2015-11-23 19:35:33,046 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpFfLQT1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:35:44 INFO - 2015-11-23 19:35:44,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 237019136 19:35:44 INFO - 2015-11-23 19:35:44,892 DEBUG : BROWSER_OUTPUT: 19:35:47 INFO - 2015-11-23 19:35:47,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51816/tests/kraken/driver.html?testName=audio-beat-detection) 19:35:48 INFO - 2015-11-23 19:35:48,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 250118144 19:35:48 INFO - 2015-11-23 19:35:48,136 DEBUG : BROWSER_OUTPUT: 19:35:50 INFO - 2015-11-23 19:35:50,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51816/tests/kraken/driver.html?testName=audio-dft) 19:35:51 INFO - 2015-11-23 19:35:51,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 259297280 19:35:51 INFO - 2015-11-23 19:35:51,267 DEBUG : BROWSER_OUTPUT: 19:35:54 INFO - 2015-11-23 19:35:54,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51816/tests/kraken/driver.html?testName=audio-fft) 19:35:55 INFO - 2015-11-23 19:35:55,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 261578752 19:35:55 INFO - 2015-11-23 19:35:55,038 DEBUG : BROWSER_OUTPUT: 19:35:57 INFO - 2015-11-23 19:35:57,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51816/tests/kraken/driver.html?testName=audio-oscillator) 19:35:57 INFO - 2015-11-23 19:35:57,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 262623232 19:35:57 INFO - 2015-11-23 19:35:57,792 DEBUG : BROWSER_OUTPUT: 19:35:59 INFO - 2015-11-23 19:35:59,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51816/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:36:00 INFO - 2015-11-23 19:36:00,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 264749056 19:36:00 INFO - 2015-11-23 19:36:00,329 DEBUG : BROWSER_OUTPUT: 19:36:03 INFO - 2015-11-23 19:36:03,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51816/tests/kraken/driver.html?testName=imaging-darkroom) 19:36:03 INFO - 2015-11-23 19:36:03,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 265543680 19:36:03 INFO - 2015-11-23 19:36:03,710 DEBUG : BROWSER_OUTPUT: 19:36:06 INFO - 2015-11-23 19:36:06,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51816/tests/kraken/driver.html?testName=imaging-desaturate) 19:36:07 INFO - 2015-11-23 19:36:07,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 263569408 19:36:07 INFO - 2015-11-23 19:36:07,273 DEBUG : BROWSER_OUTPUT: 19:36:10 INFO - 2015-11-23 19:36:10,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51816/tests/kraken/driver.html?testName=json-parse-financial) 19:36:10 INFO - 2015-11-23 19:36:10,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 264589312 19:36:10 INFO - 2015-11-23 19:36:10,861 DEBUG : BROWSER_OUTPUT: 19:36:12 INFO - 2015-11-23 19:36:12,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51816/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:36:13 INFO - 2015-11-23 19:36:13,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 264933376 19:36:13 INFO - 2015-11-23 19:36:13,098 DEBUG : BROWSER_OUTPUT: 19:36:14 INFO - 2015-11-23 19:36:14,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:36:15 INFO - 2015-11-23 19:36:15,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 265465856 19:36:15 INFO - 2015-11-23 19:36:15,551 DEBUG : BROWSER_OUTPUT: 19:36:17 INFO - 2015-11-23 19:36:17,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:36:18 INFO - 2015-11-23 19:36:18,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 265469952 19:36:18 INFO - 2015-11-23 19:36:18,288 DEBUG : BROWSER_OUTPUT: 19:36:20 INFO - 2015-11-23 19:36:20,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:36:21 INFO - 2015-11-23 19:36:21,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 265084928 19:36:21 INFO - 2015-11-23 19:36:21,532 DEBUG : BROWSER_OUTPUT: 19:36:23 INFO - 2015-11-23 19:36:23,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:36:24 INFO - 2015-11-23 19:36:24,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 264617984 19:36:24 INFO - 2015-11-23 19:36:24,545 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51816/tests/kraken/driver.html?testName=ai-astar) 19:36:26 INFO - 2015-11-23 19:36:26,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 264404992 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;108;114;112;113;125;115;125;166;107 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;124;144;155;121;144;143;124;158;125 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;195;192;198;197;201;215;195;199;196 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |3;audio-fft;59;81;92;92;142;78;58;61;74;115 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;78;78;109;79;77;76;112;79;79;106 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;79;133;132;90;86;86;87;88;87;87 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;117;151;94;94;95;94;95;95;121;150 19:36:26 INFO - 2015-11-23 19:36:26,583 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;140;77;87;144;154;139;99;92;91;92 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;61;60;60;61;78;96;91;92 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;65;66;65;67;69;61;78;104 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;68;103;108;110;85;84;86;82;87;110 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;128;131;132;114;123;148;122;149;141 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;142;135;140;142;138;140;143;127;142 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;57;94;93;74;63;70;91;67;94;100 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,821 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: __startTimestamp1448336186578__endTimestamp 19:36:26 INFO - 2015-11-23 19:36:26,584 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.20 Median:116.00 stddev:17.20 (14.8%) stddev-sans-first:18.20 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: Values: 117.0 108.0 114.0 112.0 113.0 125.0 115.0 125.0 166.0 107.0 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.60 Median:144.00 stddev:13.87 (9.6%) stddev-sans-first:14.29 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: Values: 148.0 124.0 144.0 155.0 121.0 144.0 143.0 124.0 158.0 125.0 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:197.80 Median:197.50 stddev:6.84 (3.5%) stddev-sans-first:6.65 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: Values: 190.0 195.0 192.0 198.0 197.0 201.0 215.0 195.0 199.0 196.0 19:36:26 INFO - 2015-11-23 19:36:26,585 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.20 Median:76.00 stddev:26.69 (35.1%) stddev-sans-first:26.58 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: Values: 59.0 81.0 92.0 92.0 142.0 78.0 58.0 61.0 74.0 115.0 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.30 Median:78.00 stddev:15.07 (19.3%) stddev-sans-first:15.60 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: Values: 78.0 78.0 109.0 79.0 77.0 76.0 112.0 79.0 79.0 106.0 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:87.00 stddev:19.70 (22.6%) stddev-sans-first:19.97 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: Values: 79.0 133.0 132.0 90.0 86.0 86.0 87.0 88.0 87.0 87.0 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:110.60 Median:94.00 stddev:23.31 (24.8%) stddev-sans-first:24.61 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: Values: 117.0 151.0 94.0 94.0 95.0 94.0 95.0 95.0 121.0 150.0 19:36:26 INFO - 2015-11-23 19:36:26,586 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:111.50 Median:89.00 stddev:28.98 (32.6%) stddev-sans-first:28.84 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: Values: 140.0 77.0 87.0 144.0 154.0 139.0 99.0 92.0 91.0 92.0 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:69.50 stddev:15.60 (22.4%) stddev-sans-first:15.94 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 61.0 60.0 60.0 61.0 78.0 96.0 91.0 92.0 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:65.50 stddev:12.68 (19.4%) stddev-sans-first:13.25 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 65.0 66.0 65.0 67.0 69.0 61.0 78.0 104.0 19:36:26 INFO - 2015-11-23 19:36:26,587 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,588 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:83.00 stddev:14.43 (17.4%) stddev-sans-first:12.34 19:36:26 INFO - 2015-11-23 19:36:26,588 DEBUG : BROWSER_OUTPUT: Values: 68.0 103.0 108.0 110.0 85.0 84.0 86.0 82.0 87.0 110.0 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.50 stddev:11.30 (8.6%) stddev-sans-first:11.98 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: Values: 131.0 128.0 131.0 132.0 114.0 123.0 148.0 122.0 149.0 141.0 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.70 Median:141.00 stddev:4.79 (3.4%) stddev-sans-first:5.07 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: Values: 138.0 142.0 135.0 140.0 142.0 138.0 140.0 143.0 127.0 142.0 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:82.50 stddev:15.65 (19.0%) stddev-sans-first:14.15 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: Values: 57.0 94.0 93.0 74.0 63.0 70.0 91.0 67.0 94.0 100.0 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:36:26 INFO - 2015-11-23 19:36:26,589 DEBUG : BROWSER_OUTPUT: 19:36:27 INFO - 2015-11-23 19:36:27,226 INFO : Browser exited with error code: 0 19:36:27 INFO - 2015-11-23 19:36:27,273 INFO : Completed test kraken (00:00:57) 19:36:27 INFO - 2015-11-23 19:36:27,273 INFO : Starting test v8_7 19:36:27 INFO - 2015-11-23 19:36:27,273 DEBUG : operating with platform_type : mac_ 19:36:27 INFO - 2015-11-23 19:36:27,274 INFO : Initialising browser for v8_7 test... 19:36:27 INFO - 2015-11-23 19:36:27,287 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpzZSVxX/profile http://localhost:51816/getInfo.html 19:36:29 INFO - 2015-11-23 19:36:29,708 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:36:29 INFO - 2015-11-23 19:36:29,708 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:36:29 INFO - 2015-11-23 19:36:29,709 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:36:29 INFO - 2015-11-23 19:36:29,709 DEBUG : BROWSER_OUTPUT: __metrics 19:36:30 INFO - 2015-11-23 19:36:30,293 INFO : Browser initialized. 19:36:30 INFO - 2015-11-23 19:36:30,293 INFO : Running cycle 1/1 for v8_7 test... 19:36:30 INFO - 2015-11-23 19:36:30,293 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpzZSVxX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:36:42 INFO - 2015-11-23 19:36:42,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 236232704 19:36:42 INFO - 2015-11-23 19:36:42,148 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51816/tests/v8_7/run.html (next: http://localhost:51816/tests/v8_7/run.html) 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 247832576 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: |0;Richards;177.33640716439086 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;159.03307888040712 19:37:03 INFO - 2015-11-23 19:37:03,913 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.6901408450704 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4739.336492890995 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |4;RayTrace;948.7666034155598 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |5;Earley;727.4709302325581 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |6;Boyer;13116.883116883117 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |7;RegExp;31500 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |8;Splay;789.3152746425884 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4771.428571428572 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: __startTimestamp1448336223906__endTimestamp 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:37:03 INFO - 2015-11-23 19:37:03,914 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:177.34 Median:177.34 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: Values: 177.3 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:159.03 Median:159.03 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: Values: 159.0 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.69 Median:281.69 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: Values: 281.7 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4739.34 Median:4739.34 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: Values: 4739.3 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,915 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: Values: 948.8 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:727.47 Median:727.47 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: Values: 727.5 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13116.88 Median:13116.88 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: Values: 13116.9 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31500.00 Median:31500.00 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: Values: 31500.0 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:789.32 Median:789.32 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,916 DEBUG : BROWSER_OUTPUT: Values: 789.3 19:37:03 INFO - 2015-11-23 19:37:03,917 DEBUG : BROWSER_OUTPUT: 19:37:03 INFO - 2015-11-23 19:37:03,917 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4771.43 Median:4771.43 stddev:0.00 (0.0%) 19:37:03 INFO - 2015-11-23 19:37:03,917 DEBUG : BROWSER_OUTPUT: Values: 4771.4 19:37:03 INFO - 2015-11-23 19:37:03,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:37:03 INFO - 2015-11-23 19:37:03,917 DEBUG : BROWSER_OUTPUT: 19:37:04 INFO - 2015-11-23 19:37:04,619 INFO : Browser exited with error code: 0 19:37:04 INFO - 2015-11-23 19:37:04,635 INFO : Completed test v8_7 (00:00:37) 19:37:04 INFO - 2015-11-23 19:37:04,916 INFO : Completed test suite (00:20:06) 19:37:04 INFO - 2015-11-23 19:37:04,916 DEBUG : Working with test: dromaeo_css 19:37:04 INFO - 2015-11-23 19:37:04,916 DEBUG : Generating results file: dromaeo_css 19:37:04 INFO - 2015-11-23 19:37:04,917 DEBUG : Working with test: kraken 19:37:04 INFO - 2015-11-23 19:37:04,917 DEBUG : Generating results file: kraken 19:37:04 INFO - 2015-11-23 19:37:04,918 INFO : javascript benchmark 19:37:04 INFO - 2015-11-23 19:37:04,918 DEBUG : Working with test: v8_7 19:37:04 INFO - 2015-11-23 19:37:04,918 DEBUG : Generating results file: v8_7 19:37:04 INFO - 2015-11-23 19:37:04,918 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:37:05 INFO - 2015-11-23 19:37:05,351 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 19:37:05 INFO - 2015-11-23 19:37:05,351 DEBUG : process_Request line: dromaeo_css 7617.87 graph.html#tests=[[72,64,61]] 19:37:05 INFO - 2015-11-23 19:37:05,351 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:37:05 INFO - 2015-11-23 19:37:05,377 DEBUG : process_Request line: kraken 1532.10 graph.html#tests=[[232,64,61]] 19:37:05 INFO - 2015-11-23 19:37:05,377 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:37:05 INFO - 2015-11-23 19:37:05,407 DEBUG : process_Request line: v8_7 20849.31 graph.html#tests=[[230,64,61]] 19:37:05 INFO - 2015-11-23 19:37:05,408 INFO : javascript benchmark 19:37:05 INFO - 2015-11-23 19:37:05,410 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3412.2834204816986, 3531.4173161428366, 3569.6965757910584, 3573.982130089349, 3579.409397449421, 5977.40225977402, 5992.670403127831, 5996.400359964013, 6022.728977196026, 6035.18524999125, 5774.595778295521, 5922.822315330547, 5954.434328738763, 5968.67172305523, 5971.671558064305, 4463.5313292104265, 5280.656757310781, 5299.894002119955, 5371.355437347524, 5437.510624043835, 4449.777511124447, 5400.459954004587, 5420.376656684492, 5437.864053398657, 5487.75305111271, 5337.638902079964, 5409.918851217235, 5448.400675925645, 5466.234727138204, 5471.917921231185, 5183.2743415921805, 5373.220882971987, 5378.220158077057, 5391.245225668409, 5397.109476936301, 4406.5593440656, 5361.651492652965, 5407.405185429599, 5419.647722897999, 5431.076716958127, 4799.992001679617, 5612.214289999403, 5677.432256774331, 5797.826065218051, 5965.164876917235, 6221.595596286227, 6260.467860231885, 6303.842403939892, 6305.180326557564, 6321.589096708699, 6440.806775796734, 6442.710078046499, 6446.097546343469, 6454.19322584677, 6460.773872914472, 6027.306859711101, 6133.754649814002, 6151.108089327112, 6156.168917196211, 6169.105479705418, 5378.865528361744, 6523.0, 6534.640594767238, 6557.2131344239, 6565.0, 6274.2784579773, 6296.244450665949, 6297.244330680256, 6302.716377763011, 6315.400036996478, 6282.591631543935, 6386.233651961701, 6396.456301214356, 6397.0, 6422.165118534561, 6239.438450539473, 6274.466670333073, 6281.685915704196, 6285.9057114143325, 6293.622382657055, 6262.499000079983, 6274.6548939808745, 6275.937240627535, 6280.842978925472, 6286.277078136073, 4973.229149481836, 5050.318207042076, 5066.493350664978, 5115.258287548285, 5157.690538567698, 4565.863024109282, 4573.725576465423, 4605.539446055368, 4609.0, 4609.331646911246, 6014.849628759229, 6040.033594624839, 6058.182145410401, 6064.0, 6065.848353791191, 5479.0, 6301.810945671546, 6351.809445716636, 6395.136656551399, 6478.740850366027, 6091.116788065794, 6098.847528811726, 6104.267487901391, 6113.8471538211015, 6114.816555503342, 5503.944960550343, 5634.74643641029, 5642.689652069093, 5653.943460565424, 5659.26429564154, 6449.548531602836, 6512.479001679854, 6576.309487503743, 6591.670416479253, 6614.437772789367, 6384.93615063862, 6387.329330420424, 6395.712192951235, 6396.0, 6400.0, 6355.777547785805, 6412.454941329853, 6634.535582509178, 6636.13730215069, 6644.269130395556, 6209.348018458178, 6245.469135123383, 6264.968675156595, 6277.748890044347, 6298.02380631003, 6327.0, 6422.100905873275, 6439.227292724903, 6467.741290348334, 6471.320511346429, 6114.174586430775, 6141.700809433504, 6201.317855036033, 6268.0, 6283.465905398092, 6117.370705100174, 6201.720922558586, 6204.472619827366, 6228.439440450381, 6236.906446403398, 6055.000924847527, 6182.536309776875, 6190.628562286277, 6209.689515524296, 6244.344343844013, 6108.633481991094, 6126.724297406717, 6314.747410103728, 6316.557840951089, 6318.178636777189, 6137.447629713347, 6190.845228869314, 6200.193974783249, 6202.255729312511, 6209.5032397409], "unit": "ms", "name": "dojo.html", "value": 5856.07858181366}, {"lowerIsBetter": false, "replicates": [541.1828139509342, 555.1118210862622, 563.6843367714082, 567.8810337359836, 630.9810705678829, 37297.440538391944, 41347.79326103365, 41426.79286603571, 41430.58569414309, 41527.37708934368, 42074.0, 43759.34360984588, 44143.11713765731, 44290.11419771603, 44650.33024504627, 9744.805103897917, 9889.40663560185, 9909.504524773733, 9915.553800079013, 9955.153811925995, 9709.61161553537, 9801.166900813403, 9808.46053467059, 9818.312718109735, 9865.358751681119, 9808.754781130494, 9810.068043535854, 9842.60629574816, 9846.852297215511, 9887.752806179831, 9792.314537982344, 9877.753056173617, 9894.257930655229, 9910.851337229948, 9912.950435247778, 9675.274354423447, 9745.0, 9771.951140244324, 9807.0, 9823.459709715962, 40245.79877100625, 41075.589244107774, 41317.0, 41528.58471415278, 41554.1689166215, 3178.9682103179134, 3461.671141241603, 3774.565924918642, 3797.791121488317, 4035.5762644922156, 28768.993085241917, 29496.0, 29851.10446686603, 30298.84850575755, 30326.241843953856, 2764.1292992707436, 2770.224337185591, 2788.7908406869565, 2895.5656651502445, 2903.462859371023, 478398.0, 481691.0, 481960.0, 483161.0, 483174.0, 59247.0, 60737.088943664996, 65100.674496627216, 65728.34271657318, 70327.64836175786, 68687.65656171787, 68981.0, 69020.3097969024, 69296.96054559185, 69299.0, 16016.199190040452, 16237.0, 16245.944013639075, 16271.267792949346, 16498.58753531171, 12269.815952760715, 12271.815922761165, 12325.075619328587, 12424.192427492184, 12489.562865299671, 20905.268315609184, 20915.37253882386, 20985.475363116046, 21015.633983791005, 21022.2642207522, 7701.268379503938, 8155.714549990722, 8282.674772036446, 8913.643454261757, 9100.362974591848, 959.2278216036018, 1017.8880323164447, 1057.7132774242166, 1063.4788953412772, 1129.2377645089532, 29952.251193719894, 30045.94839180618, 30505.08484745461, 30699.693003069682, 31435.0, 1083.1930211992117, 1111.0, 1160.9825852612219, 1176.1825531255695, 1206.3968015992004, 14136.0, 14807.259637018105, 14906.776398354034, 15276.541703748906, 15497.0, 458528.0, 532799.0, 538333.0, 540613.0, 541506.0, 47172.0, 56612.0, 57448.71275643595, 57532.71233643889, 57631.13553296704, 1244.813278008306, 1424.1312799192485, 1461.671123997092, 1468.955931322062, 1610.3236640610971, 27501.587476187473, 29512.0, 29911.0, 30153.849230753705, 30312.0, 51263.487365125875, 51296.0, 51732.96534069373, 51841.740791297314, 51943.0, 482923.0, 489635.0, 490592.0, 492584.0, 498284.0, 31463.0, 33363.49954750632, 33993.320133596695, 34091.0, 34347.28263586861, 43379.566204337556, 43479.34780978351, 43539.56460435355, 43608.34587481254, 44391.556084438744, 37684.62315376811, 38045.048873778374, 38202.617973819906, 38203.23593528169, 38653.806730966164, 36420.62952445618, 36982.63017369792, 37160.81419592885, 37312.44031339478, 37612.2477550442, 37112.25775484529, 37325.81337093297, 37634.24731505409, 37669.24661506809, 37942.67200647964, 32233.033009009767, 33185.0, 33286.83356583298, 33521.66478335185, 33531.66468335286, 22656.320310390714, 24949.50100998006, 25293.747062529874, 25302.0, 25491.745082548936], "unit": "ms", "name": "ext.html", "value": 20193.625955691277}, {"lowerIsBetter": false, "replicates": [358.2619803205395, 364.9854005839766, 366.63886072218867, 368.022899202617, 368.48412222887936, 14468.782968255484, 16096.919515402407, 19299.517512062204, 19327.0, 20432.8978355108, 13566.321683915814, 16205.432809851658, 16261.349546018146, 19204.271615554597, 20582.794172058275, 5193.5066168714, 5282.867928301804, 5309.283246761695, 5319.760610772524, 5339.5728341732565, 5117.923231151536, 5246.239295302179, 5254.133068043788, 5263.578913686915, 5814.622049566765, 5734.111212762028, 5735.885282294352, 5737.3688894221605, 5740.5981581289325, 5769.653820770767, 5667.987864308173, 5719.399463056381, 5739.655620662774, 5745.511631511326, 5750.338711048241, 5035.924461133086, 5051.848444546669, 5059.494050594948, 5080.872978175576, 5081.898362032775, 23985.52028959411, 24217.757822421725, 24454.510909781882, 24699.753002470105, 24752.009919603195, 1815.4916623345484, 1853.212384736495, 1958.3243780895568, 1974.7235387045826, 1996.8502362322738, 9503.192228660571, 9574.664886729, 9701.611935522571, 9885.555150018194, 10047.095761381437, 1683.192067807447, 1697.4228762220905, 1715.5368050626387, 1723.818999005099, 1737.7654016707836, 94528.0, 95376.52311738467, 97182.0, 98293.01706982982, 98344.50827745887, 8636.747671587586, 10452.581896724198, 10565.418901960313, 10644.467776611138, 10646.307989980627, 12325.445354959049, 12638.557650482373, 12688.619341419771, 12694.49222031127, 12720.745585088247, 7872.212778722082, 8017.879731804028, 8080.4343695940715, 8126.349892008625, 8152.8777068344025, 6756.2568117507035, 6831.87274099768, 7979.960100199578, 8009.519428834172, 8182.83634327322, 4228.281192197333, 4243.915121697549, 4251.0, 4265.509466411402, 4291.9785401072795, 1829.4420201838568, 1831.2583403721515, 1840.5766673664864, 1849.5838436351714, 1862.3574866670976, 831.8128421105203, 884.3014018924977, 894.6376717429451, 946.2950102173787, 1009.2178561614661, 18284.634307314045, 20278.49303767388, 20465.260452861672, 20573.69139462909, 20653.17387304521, 911.8404279251105, 914.4741773480275, 977.2133432586694, 1011.4234886114991, 1015.6082425887078, 9376.390534615228, 10594.417307048032, 11079.446027698583, 11273.154513411528, 11302.095832333394, 701490.0, 717547.0, 721646.0, 722446.0, 737070.0, 124470.75529244772, 127967.08049379267, 129257.0, 129771.0, 130394.34802825925, 1154.7517283784027, 1156.1617827075304, 1170.455738081796, 1174.3130268792852, 1184.265755231762, 17176.0, 17887.73168402449, 18051.819481805014, 18086.82435641679, 18299.085045747925, 42801.571984279755, 49081.75459122682, 49099.0, 50994.49005509898, 52744.0, 69957.30042699711, 71558.0, 72922.63538682273, 73149.63425182841, 73324.0, 9584.185344245538, 9598.9040109598, 9825.919148893474, 9828.705138845846, 9925.10674039311, 19206.61586768285, 19437.611247775247, 19542.804571954097, 19800.405987820388, 19979.400617981482, 15508.147051912254, 15544.222788860738, 15851.365945362057, 16016.359345626044, 16065.437709680105, 12277.0, 13313.33433328349, 13942.512012079529, 14975.1014939104, 15406.768898466307, 15905.363785448453, 15976.20118994069, 16151.353945842035, 16213.837861621232, 16214.837851621332, 7899.368050556057, 9707.88359338685, 9763.463009534544, 9786.0, 9797.412155270422, 14148.009639325148, 14655.706885862437, 15862.365505379656, 15895.284712187748, 16016.958897671613], "unit": "ms", "name": "jquery.html", "value": 9681.415813424524}, {"lowerIsBetter": false, "replicates": [1503.015524831236, 1534.5396381085673, 1836.7520384748073, 1894.9388342528182, 1928.4311128217175, 6956.443484521233, 7111.964440177799, 7129.322714342135, 7775.30022297993, 7909.604519774017, 7578.658960346784, 7732.574708391036, 8307.543085130315, 8408.537530435824, 8433.0, 2355.2698663414353, 2370.6799582056374, 2382.19005538117, 2395.688560487134, 2396.1733202045352, 2380.8452450590744, 2388.5819981503255, 2418.3107814272935, 2429.4898071405028, 2436.500517393939, 1986.45372522556, 2344.19125401737, 2375.444084124901, 2389.354874183969, 2399.5800734871414, 2328.557574060923, 2337.0885354711677, 2349.119080344871, 2359.09174967637, 2373.7863592276776, 2324.8721320327377, 2328.068772491017, 2343.8945247463735, 2353.5410594933996, 2359.2096647623066, 8394.8321033579, 8481.982162140583, 8485.236328730382, 8509.361797865186, 8542.57287135647, 5176.7929282828645, 5259.947400525984, 5283.101872681654, 5318.494742999409, 5346.572274218053, 3428.211511352403, 3438.638942910983, 3453.4647129694936, 3503.351879902201, 3548.8935331940083, 1037.5745944162857, 1040.3601784902307, 1045.2213101239624, 1047.7852040331713, 1054.4411461925192, 11223.989840914275, 11305.095592352593, 11311.981921627012, 11329.716757081056, 11351.489182986703, 4636.049609830045, 4668.439787225487, 4693.577578017995, 4694.014257006067, 4718.773118989019, 7778.22217778229, 9739.97730238329, 9775.951120244496, 9783.168430683329, 9788.461634610023, 5183.637145399785, 5198.558122559549, 5243.187305967581, 5248.921266181011, 5256.894862102737, 4264.808083636244, 4339.7830108494445, 4630.884227894329, 4714.38712967312, 4753.928691069567, 3879.0690234343556, 3897.18159186574, 3922.7254092213843, 3938.6652134568308, 3958.6041395860184, 1290.283892439705, 1292.095533126815, 1292.8060790881254, 1292.9030322725832, 1301.4013553765374, 1060.3743791163251, 1143.9428028598536, 1283.3519072868141, 1381.4543255414055, 1386.3414877933103, 6703.296153903867, 7823.921760782433, 7950.363970882316, 7981.042274927046, 7981.640826162837, 501.1005245584185, 510.3594988289673, 513.2275924733327, 513.9820106296337, 516.1638146203175, 6096.786612468631, 6110.725017374229, 6111.0, 6114.694265286718, 6120.204373431515, 10019.79960400788, 10209.693709188736, 10257.58969641206, 10325.948370258251, 10365.533550990223, 9938.0, 10123.0, 10145.797084058277, 10186.03232692893, 10286.177105831515, 7940.801479963047, 7970.721024764105, 8041.597920103972, 8049.51702897828, 8085.474444161111, 6472.449841763503, 6628.767993120217, 7913.287804097658, 7937.047554293522, 7963.721269755531, 8921.509316987627, 9153.084691530794, 9199.724008279762, 9203.171714545722, 9286.767830804283, 9400.717978460658, 9536.713898583053, 9566.282528810229, 9608.75978100553, 9620.278479113955, 6747.089142965833, 6836.418904393182, 7177.641117943977, 7376.373008294355, 7395.445341599509, 8012.559309238048, 8022.438429309892, 8037.557934313435, 8056.355491560544, 8098.5545794981845, 7427.25727427253, 7431.851362972819, 7678.731244406419, 7694.307512323918, 7706.845863082594, 7390.187079421152, 7436.702531898663, 7445.62771861394, 7506.8498630026, 7557.924420755722, 7565.2812982766545, 7575.734849280248, 7598.392128629807, 7610.657520411484, 7628.8474230516185, 6759.121314229119, 6786.117804685359, 6790.354916282945, 6927.3419025192525, 6930.965345173242, 6937.791866244021, 6947.444204463732, 6967.581945083311, 6983.079653095439, 7036.190838053484], "unit": "ms", "name": "mootools.html", "value": 4684.056573765442}, {"lowerIsBetter": false, "replicates": [299.8455795265438, 328.2712378519685, 331.7661048960483, 334.8543383628122, 337.8868079193472, 6846.589204647725, 6859.554128981613, 6940.340667636573, 7022.0, 7040.943858421239, 6775.525713200078, 6845.589264644125, 6881.759138430143, 6900.309969003097, 6945.930540694591, 4905.386826646669, 4953.876153096166, 4960.107180707471, 4969.652124351297, 4981.5018498150075, 4837.250226214942, 4966.9751651241695, 4967.726775027372, 4973.676711013791, 4985.102681517325, 4718.4809670936165, 4876.878078048059, 4886.193778026622, 4886.34034405356, 4895.11887860185, 4875.804967801284, 4879.39007624047, 4881.731504767236, 4893.8287159949405, 4902.166631672624, 4061.8220715992325, 4130.215259100762, 4136.048708796963, 4139.79301034947, 4152.1072969311745, 5069.366329208849, 5284.735763211863, 5303.655262407931, 5429.918551221735, 6580.86838263232, 5585.050541407971, 5832.300123985106, 5838.503727183194, 5848.181254624356, 5851.0, 6231.3145553989025, 6255.374462553754, 7360.889586656204, 7373.8156546086775, 7379.59412232327, 3940.0543869471408, 4481.327800829869, 4565.155446242423, 4649.465311489188, 4679.181143299943, 7461.067366579177, 7682.270184332479, 7784.455088143832, 7802.453828232026, 7831.177726338709, 4720.362751028636, 4738.123447162286, 4742.430908291027, 4749.216379297446, 4759.9524004759505, 3959.6238357356006, 4804.615630749532, 4813.181759100961, 4833.685810422311, 4834.492378300298, 5622.91565626516, 5748.770049197985, 5798.971005144947, 5818.5345172386105, 5830.562707796932, 6970.5710329382355, 7404.37062849653, 7405.592692401862, 7437.702491900372, 7470.925290747023, 1385.4458216713194, 1624.7644091606887, 1626.4226199699174, 1673.0045622854382, 1677.1614192903548, 1042.4370839746603, 1057.7153348766626, 1067.893210678926, 1071.3197119828808, 1076.531708706715, 6725.327467253333, 6741.797746067626, 6747.460203183831, 6775.695093720795, 6778.084958530634, 7524.097108347033, 7530.28462296081, 7541.170471248159, 7544.698212071456, 7561.432892533082, 6445.291017988017, 6686.297938716462, 6703.798886033427, 6705.497087718343, 6767.796966091025, 3514.945516345086, 3924.862629807943, 3978.5026871641044, 4004.2592120457807, 4019.8191081401405, 7784.805379865548, 7785.649645765954, 7794.22057794216, 7801.0, 7819.765407037798, 7485.0, 7781.727639532703, 7821.452498325063, 7836.608169591612, 7846.803829904298, 7759.30166285037, 7762.41781866351, 7768.7669369918995, 7770.0, 7780.260875216959, 7475.43934204926, 7500.36246919018, 7501.474896757393, 7502.887456688045, 7530.472866899484, 7393.223711510429, 7669.118051424158, 7673.6546855390525, 7675.53946763196, 7678.8080297993, 8009.399295052778, 8013.0, 8020.759377218693, 8022.077461092049, 8056.83886322282, 4634.679116451795, 4738.8341408050555, 4740.6681532292405, 4754.952450475451, 4761.023990082094, 7305.452091093295, 7428.517146385468, 7524.774256772305, 7709.7301594443925, 7747.612619369122, 7180.7845764627145, 7269.563826170447, 7303.087114110736, 7312.122545294599, 7326.084239470067, 7318.560886346836, 7327.780166595011, 7357.153927298429, 7375.557466552024, 7399.038125043709, 5853.853653658693, 6956.469666498813, 7182.461315401261, 7208.495405321577, 7211.6033618151505, 7348.0, 7365.668544915385, 7366.594837284001, 7366.7053317866685, 7367.373773229336, 6971.093757811452, 7189.640517973976, 7190.209077001421, 7202.135743710788, 7217.494775365884], "unit": "ms", "name": "prototype.html", "value": 5257.882336708833}, {"lowerIsBetter": false, "replicates": [733.6991833348327, 743.8995735575699, 763.9847203055939, 774.0788461730543, 811.4157806379404, 14673.633159171013, 14949.252537373142, 15071.0, 15077.849221507782, 15132.394704211833, 12943.352832358369, 13421.731565368687, 14011.859881401182, 14141.646458838508, 14196.219207943559, 862.7109918177387, 945.3571571331508, 959.1319855530755, 962.9614815407375, 963.7735132243918, 929.1498279074673, 942.8161508505844, 945.8486642137259, 946.7585765629755, 949.4493193947528, 975.6487664440796, 989.6585677941099, 990.3859607043607, 996.2727209137335, 996.4469719305782, 720.7333286683908, 971.116284181395, 984.901509849013, 986.1469828598247, 1035.171862509989, 721.4156533208118, 734.5849594978873, 737.3732327521617, 739.737393225408, 740.9110906691178, 13390.263535505543, 13390.330483475886, 13459.798103028463, 13462.124961877544, 13512.189268643815, 10966.287191332538, 11104.833427498514, 11168.218224724273, 11547.0, 11690.824637630443, 9386.765330866714, 9527.52362381885, 9547.856782148274, 9550.61797528098, 9559.952200239024, 3413.6927676509235, 3458.1873259784184, 3458.3774920514297, 3466.7746596471147, 3476.374252634525, 64166.67916660387, 64485.355146448404, 71399.64300178518, 78116.21883781147, 79819.20180798176, 9358.625654973861, 9433.433993960385, 9500.334976551714, 9653.806923861483, 9931.553080111413, 20985.68521472179, 20993.16027358919, 21110.366688999355, 21111.8944405277, 21197.046132924057, 6549.24683661385, 7195.172555156119, 7380.188179300273, 7563.092428908566, 7683.807904802425, 4013.9397909031386, 4091.1204091120553, 4136.21411931732, 4201.5717249082445, 4206.369044643328, 3337.399268131711, 3390.355832391838, 3391.7456190785297, 3402.625711171769, 3407.693307602328, 598.1058317814808, 606.8088552106072, 611.5169016477022, 621.4593303825701, 626.943575078236, 509.76041260607457, 557.6707058858608, 601.6540489218717, 602.9207718184489, 631.4916492223804, 8216.849641050258, 8326.209010144026, 8495.915040849635, 8562.871556926526, 8672.089430609822, 498.4765995704496, 586.2291087220292, 600.5525883217032, 614.0, 619.7211254935207, 3811.5616704079384, 3933.3903244997073, 4074.103697186614, 4140.0, 4163.10493243954, 96085.5195724017, 97640.0, 97824.53263201058, 97828.0, 98441.031179376, 64900.02649960254, 70077.8976630702, 74561.0, 85241.57379213064, 86794.56602716947, 64470.0, 68441.0, 73051.0, 77057.0, 79249.0, 8843.204111629984, 8911.910880891368, 9008.41445306053, 9013.594388252675, 9049.411788233743, 47748.2837757427, 48209.75895120502, 48663.27005094997, 48745.268820967, 49481.0, 64056.03915941172, 67976.66011670108, 75202.62398687971, 77842.0, 78253.04367390633, 10932.344059356465, 11133.165012623924, 11204.88795112071, 11272.718182045515, 11380.032697220498, 12007.339596321937, 12360.245967097793, 12490.063245256824, 12519.248845069325, 12746.553870614483, 11633.59282425111, 11668.94165529167, 11841.407929603658, 11904.702382440508, 11938.0, 10138.391696498235, 11450.255733377304, 11939.641810745692, 11955.521779128738, 11968.940155299168, 11539.615246170513, 11555.191136620691, 11560.595379162025, 11741.47163377633, 11830.11274154459, 9619.711408657751, 9761.951190244003, 9925.674898908946, 9975.700728978143, 9987.350822196535, 9938.751531211778, 10074.0, 10085.991400859855, 10087.394756314645, 10105.141063009727], "unit": "ms", "name": "yui.html", "value": 6930.599001672091}], "name": "dromaeo_css", "value": 7617.866894969587}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 108.0, 114.0, 112.0, 113.0, 125.0, 115.0, 125.0, 166.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 120.2}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 144.0, 155.0, 121.0, 144.0, 143.0, 124.0, 158.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.6}, {"lowerIsBetter": true, "replicates": [190.0, 195.0, 192.0, 198.0, 197.0, 201.0, 215.0, 195.0, 199.0, 196.0], "unit": "ms", "name": "audio-dft", "value": 197.8}, {"lowerIsBetter": true, "replicates": [59.0, 81.0, 92.0, 92.0, 142.0, 78.0, 58.0, 61.0, 74.0, 115.0], "unit": "ms", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 109.0, 79.0, 77.0, 76.0, 112.0, 79.0, 79.0, 106.0], "unit": "ms", "name": "audio-oscillator", "value": 87.3}, {"lowerIsBetter": true, "replicates": [79.0, 133.0, 132.0, 90.0, 86.0, 86.0, 87.0, 88.0, 87.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 95.5}, {"lowerIsBetter": true, "replicates": [117.0, 151.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 121.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 110.6}, {"lowerIsBetter": true, "replicates": [140.0, 77.0, 87.0, 144.0, 154.0, 139.0, 99.0, 92.0, 91.0, 92.0], "unit": "ms", "name": "imaging-desaturate", "value": 111.5}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 78.0, 96.0, 91.0, 92.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 66.0, 65.0, 67.0, 69.0, 61.0, 78.0, 104.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [68.0, 103.0, 108.0, 110.0, 85.0, 84.0, 86.0, 82.0, 87.0, 110.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 92.3}, {"lowerIsBetter": true, "replicates": [131.0, 128.0, 131.0, 132.0, 114.0, 123.0, 148.0, 122.0, 149.0, 141.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.9}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 135.0, 140.0, 142.0, 138.0, 140.0, 143.0, 127.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.7}, {"lowerIsBetter": true, "replicates": [57.0, 94.0, 93.0, 74.0, 63.0, 70.0, 91.0, 67.0, 94.0, 100.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 80.3}], "name": "kraken", "value": 1532.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [177.33640716439086], "unit": "score", "name": "Richards", "value": 199.06797799999995}, {"lowerIsBetter": false, "replicates": [159.03307888040712], "unit": "score", "name": "DeltaBlue", "value": 415.7499839999999}, {"lowerIsBetter": false, "replicates": [281.6901408450704], "unit": "score", "name": "Encrypt", "value": 944.9425500000004}, {"lowerIsBetter": false, "replicates": [4739.336492890995], "unit": "score", "name": "Decrypt", "value": 56.16419099999998}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [727.4709302325581], "unit": "score", "name": "Earley", "value": 916.1369510489512}, {"lowerIsBetter": false, "replicates": [13116.883116883117], "unit": "score", "name": "Boyer", "value": 50.809555445544575}, {"lowerIsBetter": false, "replicates": [31500.0], "unit": "score", "name": "RegExp", "value": 28.920158730158732}, {"lowerIsBetter": false, "replicates": [789.3152746425884], "unit": "score", "name": "Splay", "value": 103.24264918970451}, {"lowerIsBetter": false, "replicates": [4771.428571428572], "unit": "score", "name": "NavierStokes", "value": 311.01796407185606}], "name": "v8_7", "value": 20849.31046292291}]} 19:37:05 INFO - RETURN: dromaeo_css: 7617.87 19:37:05 INFO - RETURN: kraken: 1532.10 19:37:05 INFO - RETURN: v8_7: 20849.31 19:37:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "20849.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1532.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7617.87"}}} 19:37:05 INFO - Return code: 0 19:37:05 INFO - # TBPL SUCCESS # 19:37:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:37:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:37:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:37:05 INFO - 2015-11-23 19:37:05.516 screenresolution[2585:28231] starting screenresolution argv=screenresolution get 19:37:05 INFO - 2015-11-23 19:37:05.518 screenresolution[2585:28231] Display 0: 1600x1200x32@60 19:37:05 INFO - 2015-11-23 19:37:05.524 screenresolution[2586:28234] starting screenresolution argv=screenresolution list 19:37:05 INFO - Available Modes on Display 0 19:37:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:37:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:37:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:37:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:37:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:37:05 INFO - Intel Iris: 19:37:05 INFO - Chipset Model: Intel Iris 19:37:05 INFO - Type: GPU 19:37:05 INFO - Bus: Built-In 19:37:05 INFO - VRAM (Dynamic, Max): 1536 MB 19:37:05 INFO - Vendor: Intel (0x8086) 19:37:05 INFO - Device ID: 0x0a2e 19:37:05 INFO - Revision ID: 0x0009 19:37:05 INFO - Displays: 19:37:05 INFO - Display: 19:37:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:37:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:37:05 INFO - Display Serial Number: 1600x1200 60 19:37:05 INFO - Main Display: Yes 19:37:05 INFO - Mirror: Off 19:37:05 INFO - Online: Yes 19:37:05 INFO - Rotation: Supported 19:37:05 INFO - Return code: 0 19:37:05 INFO - Running post-action listener: _resource_record_post_action 19:37:05 INFO - Running post-run listener: _resource_record_post_run 19:37:06 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 5808128; Write bytes: 696637952; Read time: 220; Write time: 2301 19:37:06 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 343339520; Write bytes: 338187776; Read time: 27119; Write time: 627 19:37:06 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 5693440; Write bytes: 346821632; Read time: 214; Write time: 1634 19:37:06 INFO - Running post-run listener: _upload_blobber_files 19:37:06 INFO - Blob upload gear active. 19:37:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:37:06 INFO - Copying logs to upload dir... 19:37:06 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.735530 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 19:37:06.882289) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:37:06.886095) ========= 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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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/f5YY72RVRcWyJ8FoqazD4g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009570 build_url: 'https://queue.taskcluster.net/v1/task/f5YY72RVRcWyJ8FoqazD4g/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-23 19:37:06.909227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:37:06.909634) ========= 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.F5t9a7Szzy/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.HVsQiGrIDb/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005146 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:37:06.958708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:37:06.959068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:37:06.959510) ========= ========= Total master_lag: 0.20 =========