builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0084 starttime: 1447759561.11 results: success (0) buildid: 20151117013304 builduid: 52511697da2748108ccd7cfdea092d45 revision: ab82ff5156bc1bd4281936310439f69e07073622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.107180) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.107705) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.108191) ========= 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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006653 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.165147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.165522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.189831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.190235) ========= 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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.028575 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.240839) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.241255) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.241723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:01.242039) ========= 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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 03:26:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-17 03:26:01 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168715 ========= master_lag: 0.69 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:02.105128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:02.108583) ========= 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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.126175 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:02.256804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 03:26:02.260443) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab82ff5156bc1bd4281936310439f69e07073622 --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 ab82ff5156bc1bd4281936310439f69e07073622 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 03:26:02,359 truncating revision to first 12 chars 2015-11-17 03:26:02,359 Setting DEBUG logging. 2015-11-17 03:26:02,359 attempt 1/10 2015-11-17 03:26:02,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab82ff5156bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 03:26:03,515 unpacking tar archive at: fx-team-ab82ff5156bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 03:26:03.770074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:03.770708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:03.788285) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:03.788726) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 03:26:03.789403) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-11-17 03:26:03.789844) ========= /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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 03:26:04 INFO - MultiFileLogger online at 20151117 03:26:04 in /builds/slave/test 03:26:04 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 03:26:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:04 INFO - {'append_to_log': False, 03:26:04 INFO - 'base_work_dir': '/builds/slave/test', 03:26:04 INFO - 'blob_upload_branch': 'Fx-Team', 03:26:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:04 INFO - 'branch': 'Fx-Team', 03:26:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:04 INFO - 'config_files': ('talos/mac_config.py',), 03:26:04 INFO - 'default_actions': ('clobber', 03:26:04 INFO - 'read-buildbot-config', 03:26:04 INFO - 'download-and-extract', 03:26:04 INFO - 'populate-webroot', 03:26:04 INFO - 'create-virtualenv', 03:26:04 INFO - 'install', 03:26:04 INFO - 'run-tests'), 03:26:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:04 INFO - 'download_minidump_stackwalk': True, 03:26:04 INFO - 'download_symbols': 'ondemand', 03:26:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:04 INFO - 'installer_path': 'installer.exe', 03:26:04 INFO - 'log_level': 'info', 03:26:04 INFO - 'log_name': 'talos', 03:26:04 INFO - 'log_to_console': True, 03:26:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:26:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:26:04 INFO - 'opt_config_files': (), 03:26:04 INFO - 'pip_index': False, 03:26:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:04 INFO - 'cmd': ('bash', 03:26:04 INFO - '-c', 03:26:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:04 INFO - 'enabled': True, 03:26:04 INFO - 'halt_on_failure': False, 03:26:04 INFO - 'name': 'check_screen_resolution'},), 03:26:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:04 INFO - 'cmd': ('bash', 03:26:04 INFO - '-c', 03:26:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:04 INFO - 'enabled': True, 03:26:04 INFO - 'halt_on_failure': False, 03:26:04 INFO - 'name': 'check_screen_resolution'},), 03:26:04 INFO - 'run_cmd_checks_enabled': True, 03:26:04 INFO - 'sps_profile': False, 03:26:04 INFO - 'sps_profile_interval': 0, 03:26:04 INFO - 'suite': 'dromaeojs-e10s', 03:26:04 INFO - 'system_bits': '64', 03:26:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:04 INFO - 'title': 't-yosemite-r5-0084', 03:26:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:04 INFO - 'use_talos_json': True, 03:26:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:04 INFO - 'work_dir': 'build'} 03:26:04 INFO - ##### 03:26:04 INFO - ##### Running clobber step. 03:26:04 INFO - ##### 03:26:04 INFO - Running pre-action listener: _resource_record_pre_action 03:26:04 INFO - Running main action method: clobber 03:26:04 INFO - rmtree: /builds/slave/test/build 03:26:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:08 INFO - Running post-action listener: _resource_record_post_action 03:26:08 INFO - ##### 03:26:08 INFO - ##### Running read-buildbot-config step. 03:26:08 INFO - ##### 03:26:08 INFO - Running pre-action listener: _resource_record_pre_action 03:26:08 INFO - Running main action method: read_buildbot_config 03:26:08 INFO - Using buildbot properties: 03:26:08 INFO - { 03:26:08 INFO - "properties": { 03:26:08 INFO - "buildnumber": 52, 03:26:08 INFO - "product": "firefox", 03:26:08 INFO - "script_repo_revision": "production", 03:26:08 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 03:26:08 INFO - "repository": "", 03:26:08 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 03:26:08 INFO - "buildid": "20151117013304", 03:26:08 INFO - "slavename": "t-yosemite-r5-0084", 03:26:08 INFO - "pgo_build": "False", 03:26:08 INFO - "basedir": "/builds/slave/test", 03:26:08 INFO - "project": "", 03:26:08 INFO - "platform": "yosemite", 03:26:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:26:08 INFO - "slavebuilddir": "test", 03:26:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:26:08 INFO - "branch": "fx-team", 03:26:08 INFO - "repo_path": "integration/fx-team", 03:26:08 INFO - "stage_platform": "macosx64", 03:26:08 INFO - "builduid": "52511697da2748108ccd7cfdea092d45", 03:26:08 INFO - "revision": "ab82ff5156bc1bd4281936310439f69e07073622" 03:26:08 INFO - }, 03:26:08 INFO - "sourcestamp": { 03:26:08 INFO - "repository": "", 03:26:08 INFO - "hasPatch": false, 03:26:08 INFO - "project": "", 03:26:08 INFO - "branch": "fx-team-macosx64-talos", 03:26:08 INFO - "changes": [ 03:26:08 INFO - { 03:26:08 INFO - "category": null, 03:26:08 INFO - "files": [ 03:26:08 INFO - { 03:26:08 INFO - "url": null, 03:26:08 INFO - "name": "https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 03:26:08 INFO - } 03:26:08 INFO - ], 03:26:08 INFO - "repository": "", 03:26:08 INFO - "rev": "ab82ff5156bc1bd4281936310439f69e07073622", 03:26:08 INFO - "who": "cbook@mozilla.com", 03:26:08 INFO - "when": 1447758652, 03:26:08 INFO - "number": 6671183, 03:26:08 INFO - "comments": "Bug 1224958 - Update animation-fast-track.svg to be thinner. r=pbro", 03:26:08 INFO - "project": "", 03:26:08 INFO - "at": "Tue 17 Nov 2015 03:10:52", 03:26:08 INFO - "branch": "fx-team-macosx64-talos", 03:26:08 INFO - "revlink": "", 03:26:08 INFO - "properties": [ 03:26:08 INFO - [ 03:26:08 INFO - "buildid", 03:26:08 INFO - "20151117013304", 03:26:08 INFO - "Change" 03:26:08 INFO - ], 03:26:08 INFO - [ 03:26:08 INFO - "builduid", 03:26:08 INFO - "52511697da2748108ccd7cfdea092d45", 03:26:08 INFO - "Change" 03:26:08 INFO - ], 03:26:08 INFO - [ 03:26:08 INFO - "pgo_build", 03:26:08 INFO - "False", 03:26:08 INFO - "Change" 03:26:08 INFO - ] 03:26:08 INFO - ], 03:26:08 INFO - "revision": "ab82ff5156bc1bd4281936310439f69e07073622" 03:26:08 INFO - } 03:26:08 INFO - ], 03:26:08 INFO - "revision": "ab82ff5156bc1bd4281936310439f69e07073622" 03:26:08 INFO - } 03:26:08 INFO - } 03:26:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 03:26:08 INFO - Running post-action listener: _resource_record_post_action 03:26:08 INFO - ##### 03:26:08 INFO - ##### Running download-and-extract step. 03:26:08 INFO - ##### 03:26:08 INFO - Running pre-action listener: _resource_record_pre_action 03:26:08 INFO - Running main action method: download_and_extract 03:26:08 INFO - mkdir: /builds/slave/test/build/tests 03:26:08 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')]} 03:26:08 INFO - https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:26:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/test_packages.json 03:26:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/test_packages.json 03:26:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:26:08 INFO - Downloaded 1149 bytes. 03:26:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:26:08 INFO - Using the following test package requirements: 03:26:08 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:26:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 03:26:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'jsshell-mac.zip'], 03:26:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 03:26:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:26:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 03:26:08 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 03:26:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 03:26:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:26:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:26:08 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 03:26:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:26:08 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')]} 03:26:08 INFO - https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:26:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:26:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:26:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:10 INFO - Downloaded 17460764 bytes. 03:26:10 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 03:26:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:26:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:26:16 INFO - Return code: 0 03:26:16 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 03:26:16 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')]} 03:26:16 INFO - https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:17 INFO - Downloaded 17460764 bytes. 03:26:17 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 03:26:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:26:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:26:24 INFO - Return code: 0 03:26:24 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')]} 03:26:24 INFO - https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:25 INFO - Downloaded 11131693 bytes. 03:26:25 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 03:26:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:26:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 03:26:26 INFO - Return code: 0 03:26: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')]} 03:26:26 INFO - https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 03:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0eZLFXQRQeHEp2kZxzfcA/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 03:26:31 INFO - Downloaded 108759809 bytes. 03:26:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:26:31 INFO - mkdir: /builds/slave/test/properties 03:26:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:31 INFO - Contents: 03:26:31 INFO - build_url:https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:26:31 INFO - Running post-action listener: _resource_record_post_action 03:26:31 INFO - Running post-action listener: set_extra_try_arguments 03:26:31 INFO - ##### 03:26:31 INFO - ##### Running populate-webroot step. 03:26:31 INFO - ##### 03:26:31 INFO - Running pre-action listener: _resource_record_pre_action 03:26:31 INFO - Running main action method: populate_webroot 03:26:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:31 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:26:31 INFO - '../fennec_ids.txt'], 03:26:31 INFO - 'tests': ['tcheck2']}, 03:26:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:31 INFO - '--tppagecycles', 03:26:31 INFO - '7'], 03:26:31 INFO - 'tests': ['tsvgm']}}, 03:26:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:26:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:26:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:26:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'tests': ['damp', 'tps']}, 03:26:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['damp', 'tps']}, 03:26:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:26:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:31 INFO - 'other': {'tests': ['a11yr', 03:26:31 INFO - 'ts_paint', 03:26:31 INFO - 'tpaint', 03:26:31 INFO - 'sessionrestore', 03:26:31 INFO - 'sessionrestore_no_auto_restore']}, 03:26:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['a11yr', 03:26:31 INFO - 'ts_paint', 03:26:31 INFO - 'tpaint', 03:26:31 INFO - 'sessionrestore', 03:26:31 INFO - 'sessionrestore_no_auto_restore']}, 03:26:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['a11yr', 03:26:31 INFO - 'ts_paint', 03:26:31 INFO - 'tpaint', 03:26:31 INFO - 'sessionrestore', 03:26:31 INFO - 'sessionrestore_no_auto_restore']}, 03:26:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['a11yr', 03:26:31 INFO - 'ts_paint', 03:26:31 INFO - 'tpaint', 03:26:31 INFO - 'sessionrestore', 03:26:31 INFO - 'sessionrestore_no_auto_restore']}, 03:26:31 INFO - 'other_l64': {'tests': ['a11yr', 03:26:31 INFO - 'ts_paint', 03:26:31 INFO - 'tpaint', 03:26:31 INFO - 'sessionrestore', 03:26:31 INFO - 'sessionrestore_no_auto_restore']}, 03:26:31 INFO - 'other_nol64': {'tests': ['a11yr', 03:26:31 INFO - 'ts_paint', 03:26:31 INFO - 'tpaint', 03:26:31 INFO - 'sessionrestore', 03:26:31 INFO - 'sessionrestore_no_auto_restore']}, 03:26:31 INFO - 'svgr': {'tests': ['tsvgx', 03:26:31 INFO - 'tsvgr_opacity', 03:26:31 INFO - 'tart', 03:26:31 INFO - 'tscrollx', 03:26:31 INFO - 'cart']}, 03:26:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['tsvgx', 03:26:31 INFO - 'tsvgr_opacity', 03:26:31 INFO - 'tart', 03:26:31 INFO - 'tscrollx', 03:26:31 INFO - 'cart']}, 03:26:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'tests': ['tp5o']}, 03:26:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'talos_options': ['--e10s'], 03:26:31 INFO - 'tests': ['tp5o']}, 03:26:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'talos_options': ['--xperf_path', 03:26:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:31 INFO - 'tests': ['tp5n']}, 03:26:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:31 INFO - 'talos_options': ['--e10s', 03:26:31 INFO - '--xperf_path', 03:26:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:31 INFO - 'tests': ['tp5n']}}, 03:26:31 INFO - 'talos.zip': {'path': '', 03:26:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:31 INFO - Running post-action listener: _resource_record_post_action 03:26:31 INFO - ##### 03:26:31 INFO - ##### Running create-virtualenv step. 03:26:31 INFO - ##### 03:26:31 INFO - Running pre-action listener: _resource_record_pre_action 03:26:31 INFO - Running main action method: create_virtualenv 03:26:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:31 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 03:26:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:31 INFO - Using real prefix '/tools/python27' 03:26:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:37 INFO - Installing pip.................done. 03:26:37 INFO - Return code: 0 03:26:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:26:37 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 03:26:37 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 03:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:37 INFO - 'HOME': '/Users/cltbld', 03:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:37 INFO - 'LOGNAME': 'cltbld', 03:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:37 INFO - 'MOZ_NO_REMOTE': '1', 03:26:37 INFO - 'NO_EM_RESTART': '1', 03:26:37 INFO - 'PAGER': '/bin/cat', 03:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:37 INFO - 'PWD': '/builds/slave/test', 03:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:37 INFO - 'SHELL': '/bin/bash', 03:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:26:37 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:37 INFO - 'USER': 'cltbld', 03:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:37 INFO - 'XPC_FLAGS': '0x0', 03:26:37 INFO - 'XPC_SERVICE_NAME': '0', 03:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:38 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 03:26:38 INFO - Cleaning up... 03:26:38 INFO - Return code: 0 03:26:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:26:38 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')]} 03:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:38 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')]} 03:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:38 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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:26:38 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 03:26:38 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 03:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:38 INFO - 'HOME': '/Users/cltbld', 03:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:38 INFO - 'LOGNAME': 'cltbld', 03:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:38 INFO - 'MOZ_NO_REMOTE': '1', 03:26:38 INFO - 'NO_EM_RESTART': '1', 03:26:38 INFO - 'PAGER': '/bin/cat', 03:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:38 INFO - 'PWD': '/builds/slave/test', 03:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:38 INFO - 'SHELL': '/bin/bash', 03:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:26:38 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:38 INFO - 'USER': 'cltbld', 03:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:38 INFO - 'XPC_FLAGS': '0x0', 03:26:38 INFO - 'XPC_SERVICE_NAME': '0', 03:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:38 INFO - Downloading/unpacking psutil>=0.7.1 03:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:26:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:42 INFO - Installing collected packages: psutil 03:26:42 INFO - Running setup.py install for psutil 03:26:42 INFO - building 'psutil._psutil_osx' extension 03:26:42 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 03:26:44 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 03:26:44 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 03:26:44 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 03:26:44 INFO - building 'psutil._psutil_posix' extension 03:26:44 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 03:26:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:44 INFO - ^ 03:26:44 INFO - 1 warning generated. 03:26:44 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 03:26:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:45 INFO - Successfully installed psutil 03:26:45 INFO - Cleaning up... 03:26:45 INFO - Return code: 0 03:26:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:45 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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:26:45 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 03:26:45 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 03:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:45 INFO - 'HOME': '/Users/cltbld', 03:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:45 INFO - 'LOGNAME': 'cltbld', 03:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:45 INFO - 'MOZ_NO_REMOTE': '1', 03:26:45 INFO - 'NO_EM_RESTART': '1', 03:26:45 INFO - 'PAGER': '/bin/cat', 03:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:45 INFO - 'PWD': '/builds/slave/test', 03:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:45 INFO - 'SHELL': '/bin/bash', 03:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:26:45 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:45 INFO - 'USER': 'cltbld', 03:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:45 INFO - 'XPC_FLAGS': '0x0', 03:26:45 INFO - 'XPC_SERVICE_NAME': '0', 03:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:48 INFO - Installing collected packages: mozsystemmonitor 03:26:48 INFO - Running setup.py install for mozsystemmonitor 03:26:48 INFO - Successfully installed mozsystemmonitor 03:26:48 INFO - Cleaning up... 03:26:48 INFO - Return code: 0 03:26:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:26:48 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 03:26:48 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 03:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:48 INFO - 'HOME': '/Users/cltbld', 03:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:48 INFO - 'LOGNAME': 'cltbld', 03:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:48 INFO - 'MOZ_NO_REMOTE': '1', 03:26:48 INFO - 'NO_EM_RESTART': '1', 03:26:48 INFO - 'PAGER': '/bin/cat', 03:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:48 INFO - 'PWD': '/builds/slave/test', 03:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:48 INFO - 'SHELL': '/bin/bash', 03:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:26:48 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:48 INFO - 'USER': 'cltbld', 03:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:48 INFO - 'XPC_FLAGS': '0x0', 03:26:48 INFO - 'XPC_SERVICE_NAME': '0', 03:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 INFO - Downloading docopt-0.6.1.tar.gz 03:26:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:53 INFO - Running setup.py install for blobuploader 03:26:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:53 INFO - Running setup.py install for requests 03:26:54 INFO - Running setup.py install for docopt 03:26:54 INFO - Successfully installed blobuploader requests docopt 03:26:54 INFO - Cleaning up... 03:26:54 INFO - Return code: 0 03:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:54 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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:26:54 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 03:26:54 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 03:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:54 INFO - 'HOME': '/Users/cltbld', 03:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:54 INFO - 'LOGNAME': 'cltbld', 03:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:54 INFO - 'MOZ_NO_REMOTE': '1', 03:26:54 INFO - 'NO_EM_RESTART': '1', 03:26:54 INFO - 'PAGER': '/bin/cat', 03:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:54 INFO - 'PWD': '/builds/slave/test', 03:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:54 INFO - 'SHELL': '/bin/bash', 03:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:26:54 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:54 INFO - 'USER': 'cltbld', 03:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:54 INFO - 'XPC_FLAGS': '0x0', 03:26:54 INFO - 'XPC_SERVICE_NAME': '0', 03:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:55 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-qrssmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:55 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-O6rDLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:55 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-48Vud7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:55 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-QYIXpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:55 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-BFoBrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-HNkPlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-mflVqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-49N9Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-0JfCZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-M0p4SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-wXsJh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:56 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-FzlYSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:57 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-0QlqDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:57 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-nDnsip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:57 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-zUFoK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:57 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-ooofEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:57 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-EGJlpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:57 INFO - Running setup.py install for manifestparser 03:26:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozcrash 03:26:58 INFO - Running setup.py install for mozdebug 03:26:58 INFO - Running setup.py install for mozdevice 03:26:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozfile 03:26:58 INFO - Running setup.py install for mozhttpd 03:26:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Running setup.py install for mozinfo 03:26:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Running setup.py install for mozInstall 03:26:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Running setup.py install for mozleak 03:26:59 INFO - Running setup.py install for mozlog 03:26:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Running setup.py install for moznetwork 03:27:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozprocess 03:27:00 INFO - Running setup.py install for mozprofile 03:27:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozrunner 03:27:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozscreenshot 03:27:00 INFO - Running setup.py install for moztest 03:27:01 INFO - Running setup.py install for mozversion 03:27:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:01 INFO - Cleaning up... 03:27:01 INFO - Return code: 0 03:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:01 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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:27:01 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 03:27:01 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 03:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:01 INFO - 'HOME': '/Users/cltbld', 03:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:01 INFO - 'LOGNAME': 'cltbld', 03:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:01 INFO - 'MOZ_NO_REMOTE': '1', 03:27:01 INFO - 'NO_EM_RESTART': '1', 03:27:01 INFO - 'PAGER': '/bin/cat', 03:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:01 INFO - 'PWD': '/builds/slave/test', 03:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:01 INFO - 'SHELL': '/bin/bash', 03:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:27:01 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:01 INFO - 'USER': 'cltbld', 03:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:01 INFO - 'XPC_FLAGS': '0x0', 03:27:01 INFO - 'XPC_SERVICE_NAME': '0', 03:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:01 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-ceV1wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:01 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)) 03:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:01 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-ccuMZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-NjLH1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-EEio0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:02 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-aZPhGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-TpBXuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-EcxY5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-VxH7w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:03 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)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-SYGlZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:03 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)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-3vbXPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-abeKrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:03 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)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-5Wtd4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:03 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)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-tupa2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:03 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)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-tt4iw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:03 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)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:03 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-3FOjER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:04 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)) 03:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:04 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-GiCCjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:04 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)) 03:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:04 INFO - Running setup.py (path:/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/pip-GxBQRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:04 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 03:27:04 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 03:27:04 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 03:27:04 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 03:27:04 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 03:27:04 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 03:27:07 INFO - Downloading blessings-1.5.1.tar.gz 03:27:07 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 03:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:07 INFO - Installing collected packages: blessings 03:27:07 INFO - Running setup.py install for blessings 03:27:07 INFO - Successfully installed blessings 03:27:07 INFO - Cleaning up... 03:27:07 INFO - Return code: 0 03:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:08 INFO - Reading from file tmpfile_stdout 03:27:08 INFO - Current package versions: 03:27:08 INFO - blessings == 1.5.1 03:27:08 INFO - blobuploader == 1.2.4 03:27:08 INFO - docopt == 0.6.1 03:27:08 INFO - manifestparser == 1.1 03:27:08 INFO - mozInstall == 1.12 03:27:08 INFO - mozcrash == 0.16 03:27:08 INFO - mozdebug == 0.1 03:27:08 INFO - mozdevice == 0.47 03:27:08 INFO - mozfile == 1.2 03:27:08 INFO - mozhttpd == 0.7 03:27:08 INFO - mozinfo == 0.9 03:27:08 INFO - mozleak == 0.1 03:27:08 INFO - mozlog == 3.0 03:27:08 INFO - moznetwork == 0.27 03:27:08 INFO - mozprocess == 0.22 03:27:08 INFO - mozprofile == 0.27 03:27:08 INFO - mozrunner == 6.11 03:27:08 INFO - mozscreenshot == 0.1 03:27:08 INFO - mozsystemmonitor == 0.0 03:27:08 INFO - moztest == 0.7 03:27:08 INFO - mozversion == 1.4 03:27:08 INFO - psutil == 3.1.1 03:27:08 INFO - requests == 1.2.3 03:27:08 INFO - wsgiref == 0.1.2 03:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:08 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')]} 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:08 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')]} 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:08 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 0x1022c8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd93cdbf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/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.UdAr6jI327/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:27:08 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 03:27:08 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 03:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:08 INFO - 'HOME': '/Users/cltbld', 03:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:08 INFO - 'LOGNAME': 'cltbld', 03:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:08 INFO - 'MOZ_NO_REMOTE': '1', 03:27:08 INFO - 'NO_EM_RESTART': '1', 03:27:08 INFO - 'PAGER': '/bin/cat', 03:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:08 INFO - 'PWD': '/builds/slave/test', 03:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:08 INFO - 'SHELL': '/bin/bash', 03:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:27:08 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:08 INFO - 'USER': 'cltbld', 03:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:08 INFO - 'XPC_FLAGS': '0x0', 03:27:08 INFO - 'XPC_SERVICE_NAME': '0', 03:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 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)) 03:27:08 INFO - Cleaning up... 03:27:08 INFO - Return code: 0 03:27:08 INFO - Running post-action listener: _resource_record_post_action 03:27:08 INFO - Running post-action listener: _start_resource_monitoring 03:27:08 INFO - Starting resource monitoring. 03:27:08 INFO - ##### 03:27:08 INFO - ##### Running install step. 03:27:08 INFO - ##### 03:27:08 INFO - Running pre-action listener: _resource_record_pre_action 03:27:08 INFO - Running main action method: install 03:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:08 INFO - Reading from file tmpfile_stdout 03:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:09 INFO - Reading from file tmpfile_stdout 03:27:09 INFO - Output received: 03:27:09 INFO - Usage: mozinstall [options] installer 03:27:09 INFO - Options: 03:27:09 INFO - -h, --help show this help message and exit 03:27:09 INFO - -d DEST, --destination=DEST 03:27:09 INFO - Directory to install application into. [default: 03:27:09 INFO - "/builds/slave/test"] 03:27:09 INFO - --app=APP Application being installed. [default: firefox] 03:27:09 INFO - mkdir: /builds/slave/test/build/application 03:27:09 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'] 03:27:09 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 03:27:54 INFO - Reading from file tmpfile_stdout 03:27:54 INFO - Output received: 03:27:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:27:54 INFO - Running post-action listener: _resource_record_post_action 03:27:54 INFO - ##### 03:27:54 INFO - ##### Running run-tests step. 03:27:54 INFO - ##### 03:27:54 INFO - Running pre-action listener: _resource_record_pre_action 03:27:54 INFO - Running main action method: run_tests 03:27:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:54 INFO - 2015-11-17 03:27:54.032 screenresolution[1630:7543] starting screenresolution argv=screenresolution get 03:27:54 INFO - 2015-11-17 03:27:54.036 screenresolution[1630:7543] Display 0: 1600x1200x32@60 03:27:54 INFO - 2015-11-17 03:27:54.044 screenresolution[1631:7545] starting screenresolution argv=screenresolution list 03:27:54 INFO - Available Modes on Display 0 03:27:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:54 INFO - Intel HD Graphics 3000: 03:27:54 INFO - Chipset Model: Intel HD Graphics 3000 03:27:54 INFO - Type: GPU 03:27:54 INFO - Bus: Built-In 03:27:54 INFO - VRAM (Total): 512 MB 03:27:54 INFO - VRAM (Dynamic, Max): 10 03:27:54 INFO - Vendor: Intel (0x8086) 03:27:54 INFO - Device ID: 0x0116 03:27:54 INFO - Revision ID: 0x0009 03:27:54 INFO - Displays: 03:27:54 INFO - Display: 03:27:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:54 INFO - Display Serial Number: 1600x1200 60 03:27:54 INFO - Main Display: Yes 03:27:54 INFO - Mirror: Off 03:27:54 INFO - Online: Yes 03:27:54 INFO - Rotation: Supported 03:27:54 INFO - Return code: 0 03:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:54 INFO - Python 2.7.3 03:27:54 INFO - Return code: 0 03:27:54 INFO - grabbing minidump binary from tooltool 03:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:54 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 0x1021eb9f0>, '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 0x101f4bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021df8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:54 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 03:27:54 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 03:27:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:54 INFO - Return code: 0 03:27:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:27:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:27:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:54 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/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0084', '--webServer', 'localhost'] in /builds/slave/test/build 03:27:54 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/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0084 --webServer localhost 03:27:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p6k5vrs5YT/Render', 03:27:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:54 INFO - 'HOME': '/Users/cltbld', 03:27:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:54 INFO - 'LOGNAME': 'cltbld', 03:27:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:54 INFO - 'MOZ_NO_REMOTE': '1', 03:27:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:54 INFO - 'NO_EM_RESTART': '1', 03:27:54 INFO - 'PAGER': '/bin/cat', 03:27:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:54 INFO - 'PWD': '/builds/slave/test', 03:27:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:54 INFO - 'SHELL': '/bin/bash', 03:27:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdAr6jI327/Listeners', 03:27:54 INFO - 'TMPDIR': '/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/', 03:27:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:54 INFO - 'USER': 'cltbld', 03:27:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:54 INFO - 'XPC_FLAGS': '0x0', 03:27:54 INFO - 'XPC_SERVICE_NAME': '0', 03:27:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:27:54 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/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0084', '--webServer', 'localhost'] with output_timeout 3600 03:27:54 INFO - mozversion INFO | application_buildid: 20151117013304 03:27:54 INFO - mozversion INFO | application_changeset: ab82ff5156bc1bd4281936310439f69e07073622 03:27:54 INFO - mozversion INFO | application_display_name: Nightly 03:27:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:54 INFO - mozversion INFO | application_name: Firefox 03:27:54 INFO - mozversion INFO | application_remotingname: firefox 03:27:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:27:54 INFO - mozversion INFO | application_vendor: Mozilla 03:27:54 INFO - mozversion INFO | application_version: 45.0a1 03:27:54 INFO - mozversion INFO | platform_buildid: 20151117013304 03:27:54 INFO - mozversion INFO | platform_changeset: ab82ff5156bc1bd4281936310439f69e07073622 03:27:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:27:54 INFO - mozversion INFO | platform_version: 45.0a1 03:27:54 INFO - 2015-11-17 03:27:54,828 DEBUG : using testdate: 1447759674 03:27:54 INFO - 2015-11-17 03:27:54,828 DEBUG : actual date: 1447759674 03:27:54 INFO - 2015-11-17 03:27:54,877 INFO : starting webserver on 'localhost:49273' 03:27:54 INFO - 2015-11-17 03:27:54,879 INFO : Starting test suite t-yosemite-r5-0084.e 03:27:54 INFO - 2015-11-17 03:27:54,879 INFO : Starting test dromaeo_css 03:27:54 INFO - 2015-11-17 03:27:54,879 DEBUG : operating with platform_type : mac_ 03:27:54 INFO - 2015-11-17 03:27:54,880 INFO : Initialising browser for dromaeo_css test... 03:27:54 INFO - 2015-11-17 03:27:54,910 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/tmpmvu4o7/profile http://localhost:49273/getInfo.html 03:27:59 INFO - 2015-11-17 03:27:59,717 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:27:59 INFO - 2015-11-17 03:27:59,718 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:27:59 INFO - 2015-11-17 03:27:59,718 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:27:59 INFO - 2015-11-17 03:27:59,718 DEBUG : BROWSER_OUTPUT: __metrics 03:28:00 INFO - 2015-11-17 03:28:00,496 INFO : Browser initialized. 03:28:00 INFO - 2015-11-17 03:28:00,497 INFO : Running cycle 1/1 for dromaeo_css test... 03:28:00 INFO - 2015-11-17 03:28:00,497 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/tmpmvu4o7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:28:12 INFO - 2015-11-17 03:28:12,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 241725440 03:28:12 INFO - 2015-11-17 03:28:12,872 DEBUG : BROWSER_OUTPUT: 03:29:02 INFO - 2015-11-17 03:29:02,763 DEBUG : BROWSER_OUTPUT: 1447759742761 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] 03:31:13 INFO - 2015-11-17 03:31:13,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 03:31:14 INFO - 2015-11-17 03:31:14,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 268394496 03:31:14 INFO - 2015-11-17 03:31:14,417 DEBUG : BROWSER_OUTPUT: 03:34:16 INFO - 2015-11-17 03:34:16,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 03:34:17 INFO - 2015-11-17 03:34:17,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 274141184 03:34:17 INFO - 2015-11-17 03:34:17,173 DEBUG : BROWSER_OUTPUT: 03:37:19 INFO - 2015-11-17 03:37:19,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 03:37:19 INFO - 2015-11-17 03:37:19,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 278306816 03:37:19 INFO - 2015-11-17 03:37:19,628 DEBUG : BROWSER_OUTPUT: 03:40:21 INFO - 2015-11-17 03:40:21,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 03:40:22 INFO - 2015-11-17 03:40:22,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 281112576 03:40:22 INFO - 2015-11-17 03:40:22,031 DEBUG : BROWSER_OUTPUT: 03:43:24 INFO - 2015-11-17 03:43:24,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 03:43:25 INFO - 2015-11-17 03:43:25,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 287023104 03:43:25 INFO - 2015-11-17 03:43:25,482 DEBUG : BROWSER_OUTPUT: 03:46:27 INFO - 2015-11-17 03:46:27,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 03:46:28 INFO - 2015-11-17 03:46:28,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 291934208 03:46:28 INFO - 2015-11-17 03:46:28,011 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,011 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:46:28 INFO - 2015-11-17 03:46:28,011 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:46:28 INFO - 2015-11-17 03:46:28,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:46:28 INFO - 2015-11-17 03:46:28,012 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:46:28 INFO - 2015-11-17 03:46:28,015 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2390.6294524348727;2454.6563481112644;2473.270385236355;2503.2490252924117;2530.6077557978497;4107.137501124764;4148.937765933513;4155.937660935088;4159.313713237316;4162.791860406979;4034.6368826805583;4063.67490600752;4103.630673239415;4116.814743336549;4171.436856024436;3719.25614877025;3812.4281357796276;3834.0798208430056;3850.191459793447;3904.5900180481067;617.6562921395155;3776.660100590946;3850.210706805098;3879.2047630235734;3958.4656071430277;3893.201893611803;3894.6300101490597;3898.8245528951265;3925.2934471795065;3928.273269445162;3819.4079917612817;3845.480860083881;3923.8234279457492;3938.960610393888;3959.9010024749614;3709.0541911812584;3722.32998060349;3794.4687743715626;3809.2952803731123;3850.4994350734223;3893.7469064511;4127.030147915238;4156.916861662749;4178.6448151907125;4211.7472951623;4311.805968731414;4459.264221403465;4462.419885414875;4468.575485328888;4530.954690453119;4352.39066530686;4437.090396468749;4438.178936896652;4445.666575006888;4482.686211965164;4165.604267594574;4175.62419382257;4182.247195504778;4196.244675958295;4277.679174061957;4343.804528796211;4471.754053527087;4517.480489743656;4549.40857688505;4575.633949284049;4205.36919462077;4263.76549289792;4289.892752681146;4312.719673221231;4369.126174764996;4467.955320446754;4469.843555475542;4476.328550717419;4489.73061616304;4537.568930951555;4217.683673724483;4252.425922500484;4309.719868208556;4421.049474362963;4467.039586488921;4400.823967041347;4457.197704413236;4457.621102206284;4458.977705111519;4469.374287599739;3434.1242983039665;3439.7420193485586;3442.208292092783;3476.42638964568;3529.6293889141784;3032.9848350758107;3069.355435358555;3141.387429451235;3158.210447388153;3177.269228077555;4218.472690913636;4244.978775106105;4246.278132717445;4257.765822879709;4292.59220374064;4456.264716321771;4478.305862591304;4486.057927835126;4494.955050449519;4523.570260825282;4083.9387409188885;4134.131832315187;4193.748375097504;4205.705600607928;4243.575642435731;3935.2326296372507;3938.960610393917;3984.1234928315725;3991.1219531702977;4000.299947509174;4415.624671902796;4592.678512504092;4616.238320677051;4620.099080679235;4695.741734204583;4410.625096866674;4467.754273514988;4474.328850672425;4475.351074094173;4526.683132180848;4622.930656040095;4628.606568441585;4641.234196357564;4681.742504162167;4740.099381117577;4176.373543968308;4316.438862947797;4473.306637471197;4476.462824461086;4529.8641040768825;4410.867673969786;4486.910261794811;4513.277875539898;4528.954710452985;4538.29656403258;4363.912721745483;4402.273624851863;4406.184855801559;4477;4496.348029535634;4195.1609678065115;4281.700280980302;4320.93518597215;4392.275274579659;4449.644028477779;4266.616004559604;4297.183535128315;4331.328644060176;4349.499807522176;4403.339499075164;4294.055307832272;4366.323219900921;4382.342648602735;4427.114577084661;4437.245668236343;4109.075458021921;4118.691098167589;4161.3549899765585;4276.31578947367;4401.493828209796 03:46:28 INFO - 2015-11-17 03:46:28,017 DEBUG : BROWSER_OUTPUT: |1;ext.html;420.1030799243614;441.1375760388439;445.9987328447635;453.81166815771456;480.57709215890014;29689.55465668014;30964.84517577409;31147.532787008186;31408;31703.84148079259;33023.83488082556;33069.173270668245;33466.66533334666;33602.327953440916;33746;7016.438684905195;7202.927970720304;7220.855582888339;7304.634768261566;7323.011393461894;7074.717011319541;7196.208417074144;7235.095613048369;7321.926780732204;7323.523970941872;7094.680739366715;7173.784786456415;7194.1726701429225;7195.928040719605;7321.707131714725;7118.537295075829;7176.820579485502;7178.318059784312;7253.891191632103;7294.562326260441;7031;7161.462890283197;7171.856562868766;7186.748463803794;7190.101237345332;30491.23771905698;30980.845095774603;31064.378712425852;31131.688683113105;31238.21904452384;2036.7046778217223;2145.3778404262744;2154.4721543221854;2272.749997500274;2423.7212720537186;20877.895610522002;21333.893330533403;21712.022958966885;21970;22063.66904496434;1863.506170864722;1868.2807119259048;1885.811418858117;1892.4322703188989;1911.44568075258;202854;203757;207611;207710;208522.9999999985;42178;45074.09851802946;46341.768291158325;46490;46926.296105558446;42011.78994105071;43397;43810;43810.342844857354;43838.34242486365;12662.873371266169;12915.741685166244;13113.737725245632;13122.409491572711;13133.60599182026;9510.524473776284;9529.57116929726;9776;9861.654842080492;9872.901270987342;14858.925705371621;15262.771058434133;15416.845831541765;15426;15483.458078967182;6510.511711621647;6801.149856267966;6970.616616086062;7018.964905175441;7023.192332881682;676.1784431915247;835.143977423134;861.2722249698994;863.0247819963402;884.0717246890739;21097.578048438947;21312;21780.891095544423;21841.890790545945;21884.343469695934;748.2405358561065;799.4403917257943;841.9980223533975;842.3724325377633;923.3674932671141;10440.216983726252;10993.340399576051;11032.613858514913;11147.888521114684;11153.498092585853;313027;318800;324481;324569;324754;41125.588744112174;41807;42537.36193957093;42542.57457425448;42578.36132458015;1093.3549205968516;1096.9341839489657;1100.3342977498658;1103.0623969625753;1107.1032463704425;20759.481012974193;20766.480837979172;21159.57680846405;21301.6804747932;21328.36014919555;34553.654463455045;35330;35416;35656.286874262885;35718.107047324025;230246;230311;231304;233318;233843;24090;33830.830845845616;35033.29933401369;35168.12079698028;35730.53368328959;32461.350772983937;32565.511517326784;32830;33238.5014224782;33341.83329083339;27428.177154685392;27631.30921726973;27825.93057005716;27949.580756288266;28012;27485.725142748317;27512.862435687694;27625.75684094261;27803.30491737642;28020.29949251285;28010.719892801626;28044.29889252785;28199.89801121916;28446.288842779097;28456.288592785346;23381.53236935218;24168.51662966766;25262.621060684472;25360.239192824243;25661.486770264117;18500.537486562942;18900.716489252398;19173;19196.520086997938;19299.51751206231 03:46:28 INFO - 2015-11-17 03:46:28,020 DEBUG : BROWSER_OUTPUT: |2;jquery.html;261.56057822857593;263.209056784363;263.65461245768046;264.96952850422196;270.77255105711197;10864.185186111034;12353;12914.354282285884;13372.264525451097;13569.592912212636;13818.65453363664;13854.722905541908;14238.430462781476;14379.78430323546;14397.784033239484;4058.2289365020624;4104.1381309924955;4175.707700460969;4247.193033323674;4275.0594869128745;2950.468915595192;3140.3876244132402;4222.408862759216;4417.293233082707;4629.421322334708;4513.548645135493;4530.365748795171;4574.61115805157;4580.954190458103;4593.586577208051;3445.758796884219;3631.5460567429072;4522.864314070566;4587.839425620104;4600.309953506967;2995.3859458810894;3033.9848300758576;3035.969640303591;3074.6771588983283;3090.6754790746872;9586.233101351874;9799.608015679365;10018.899811001942;10227.181825453947;10241.334313269614;1185.6857932647856;1255.5480027190204;1349.5546469664987;1456.694094240211;1507.464849978253;6962.1297337832775;7088.468364872655;7290.45321600882;7325.633718314063;7394.149672787591;1137.1187329819375;1167.1596450555587;1169.3860723120345;1216.0332535634193;1241.5840693367643;43214.35178472326;44242.115157696986;45023;45575.77212113918;45697;4986.90026199474;4999.925001124986;5009.198528235464;5020.447750747415;5064.290999260106;5659.377468478464;5668.914966275509;5671.347795003545;5679;5744.971275143681;4107.486564179478;4181.560936101666;4205.137946720976;4208.684348673862;4231.724937879089;4300.720453170534;4303.935440968388;4467.441569803775;4526.637868970474;4540.160070386923;2232.3079845248026;2252.8310376721483;2258.706368172127;2274.715660542432;2276.3057267533563;788.4993029426356;802.3741481644327;818.108261994429;819.2626636027504;877.8727084572829;320.5736370627107;342.1480513521314;343.0668581458429;343.4076218523078;353.33925559204454;8080.4243172581955;8805.339599530062;9056.909430905738;9121.771955701028;9255.490947997925;340.8909149072323;342.1207496733371;345.87202734988216;360.5187075254565;370.7738279649412;4828.903421931542;4955.5044495550155;4956.603471722254;5004.574611158092;5042.495750424928;443538;457538;459771;472095;476980;30963.535546966814;31100.68899311023;46716.532834671896;52251.73874130681;56200;336.51709796441696;342.0985702673473;342.7857589006871;342.8919890234568;348.0081766964183;7569.280918312751;7671.501352412075;7931.325837303663;7938.841223175619;8000.879986800086;27004;27526.862365688845;27656;28131.43737125287;28205.71794282113;37054;37641;37804.2439151221;37984;38036.04909877275;5740.741666625096;5942.227510423617;5945.524358051259;5984.521238300838;5987.700614969322;8611.31109511225;8846.203841654282;9053.004169541213;9061.184493395625;9211.953940230256;6441.838954026187;6785.389314961677;7490.325870671666;7784.84430311402;7824.256695613907;7395.18652948186;7430.294122058396;7524.962375188089;7655.655495502827;7760.107587627495;7727.884081738666;7842.333401660922;7928.920710792819;7995.440319177602;8046.436749427484;5783.94216057834;5813.883722325445;5878.29460464747;5893.970530147321;5933.762649493972;6831.69257383409;7316.1952185258515;7886.960565197137;7995.720149794729;8129 03:46:28 INFO - 2015-11-17 03:46:28,022 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1339.9933000334997;1406.9788953165705;1415.0165634883754;1432.4127107885763;1453.2007395932235;5658.8019419320335;5910.527157827374;6070.635761854292;6431.774887878919;6469.935300646992;5974.551908606861;6010.12853136295;6116.296625888024;6138.140660307549;6144.8463788405315;1733.072806048764;1739.7564340992271;1741.2599645150824;1741.3992172700398;1761.4099276742243;1699.745038244267;1737.5742942978989;1743.015196414022;1744.7557341972133;1746.8165842586536;1697.8047524534652;1722.4918648998512;1725.1374312843577;1747.3971479839436;1766.311138655925;1702.7190513565247;1707.9658406831857;1709.9230534625972;1721.3286818140934;1751.6321572469797;1743.8953662780148;1766.3729376071437;1768.8054314025446;1769.8141695121956;1786.9195886185153;6239.126522286883;6293.527985401113;6310;6349.904751428732;6379.8405039873915;3703.814809259526;3774.358359078936;3792.9620703792884;3844.615538446161;3848.9807550962064;2003.7395138631884;2048.016951863114;2181.073043956312;2223.2774348336857;2290.358699564125;646.2213033294869;659.8251463362213;665.7503436211421;679.6771533521587;679.9286074962157;7620.80947976305;7719.459637825355;7739.729109481141;7826.960865195638;7858.5284882906635;3353;3362.075429256925;3363.764536482423;3388.1698983748647;3397.11674964511;7262.782116536512;7278.818029549304;7344.632768361561;7370.742024029133;7375.963120184365;3867.1298957734284;3875.1668391295443;3896.376579747227;3924.9018774530864;3926.7447615904875;3502.562179727534;3511.227529943408;3524.577050753926;3555.413356796151;3568.678818906311;2819.266990582463;2825.872835722397;2853.486372452937;2858.585505101749;2894.0594306850357;946.9905300946903;965.9178969787506;971.1502435369052;972.3096601413076;974.0940924939874;1014.1531820929459;1023.5803320638503;1023.7696518283327;1051.2431049644244;1055.604148444318;5801.9419805802245;5852.970735146382;5853.473187413153;5906.940930590639;5952.226210592596;340.44507452851695;342.44011041946595;344.6140322838437;348.67573156964266;348.8848679935615;4446.510883802779;4617.515160908057;4623.9075218495445;4626.676132670681;4628.190066738307;6894.655267236618;7002.159740831031;7346.1551921528635;7395.963020184865;7525.36034437079;7257.92742072583;7355.963220183865;7360;7421.0723659542555;7459.291367320096;5480.780768769284;5547.639403438763;5563.693996830213;5568.805091821767;5669.262995810601;5260.868478288074;5359.598030147832;5367.382750983531;5369.812056578001;5381.784728610968;6100.969495152496;6129.509639228761;6163.660998645118;6182.227221597301;6201.0388389799655;6358.904616430665;6419.8395040122505;6421.036844473367;6436.13112229843;6446.4520515756685;5140.074786538459;5185.585153187812;5203.609729270395;5213.374395072616;5281.630285879952;5579.553635709052;5636.2954630671165;5640.379558248672;5643.633163844337;5723.914141287801;5263.6578622389425;5292.497212764782;5369.973150134224;5371.382291036581;5418.674879507084;5193.818216362409;5207.140821764367;5248.08158572256;5302.787888484418;5354.196870469305;5349.625526213128;5369.758360873692;5387.434319396407;5398.514133727826;5461.1262198048125;4843.806247750051;4878.195097808822;4882.462929077869;4899.412070551557;4924.162892308244;4963.578095861748;4973.52751488608;4976.2038073908;5005.149124648746;5039.748012599282 03:46:28 INFO - 2015-11-17 03:46:28,025 DEBUG : BROWSER_OUTPUT: |4;prototype.html;244.96937882764655;249.48979337255312;254.89883702405604;254.90058877037958;256.2389702583327;4830.058138662962;4934.703917764937;4992.500749925006;5002.649814512981;5059.721715305656;4699.412573428322;4823.083614113325;4858.416989961201;4899.706017638944;4926.088673595387;3708.1100535871333;3714.4614030965495;3738.1589142442867;3756.530433695788;3772.2455508898192;3733.1227161617135;3733.216024634816;3751.8499260029566;3763.0592351912023;3799.3920972644382;3680.613535578766;3701.3152566775234;3701.5743189533146;3753.8498460061564;3763.41667041609;3430.4562946673846;3582.8566857325677;3608.711303095746;3756.887293381203;3781.470594116826;3194.265318976625;3194.6006749156354;3202.1034110449114;3237.109794806447;3254.576905002358;4728.881777955544;4743.786529606142;4769.928451073237;4830.9371938173545;4853.878653033667;4192.4549808525;4211.936820947688;4221.24017676818;4224.704270701052;4286.099919016979;5004.424491183524;5087.364079490064;5115.820946266863;5126;5188.818391356284;3410.6930376266255;3411.5394421752994;3415.077928959192;3419.059758566414;3425.640307767673;5319.867003324909;5376.91934620981;5388.649737767033;5402.000629883484;5473.01485732568;3288.704016638514;3374.4094783412806;3397.864085436555;3459.08334291413;3465.5841299043773;3490.441529355291;3528.9117772055392;3564.500969864221;3575.0883524701035;3598.7480876338927;4142.482189726285;4142.502899652061;4146.983988922673;4147.564505726855;4188.392683061;5144.61415393847;5145.922811157836;5178;5194.662346947436;5216.113260745682;1165.8600967883738;1190.3750530971136;1221.7556488702116;1224.2960297828783;1273.8853503184573;795.3915254830059;795.6857041468587;802.6548584108889;812.8902598149292;812.9553523722107;4939.259111133359;4964.453910069889;4996.600271978233;5021.422536408287;5064.088464076502;5349.117395629678;5355.116405793078;5357.08929481989;5397.433269506724;5445.809396671098;4976.178930476431;4992.8002879885125;5039.672421292605;5067.822626208065;5068.189089745697;2731.126039667327;2872.0952899836484;2883.9711602883704;2887.97112028877;2909.1418031680705;5503.036968530491;5523.7238138092935;5536.031194540939;5585.441455854382;5585.692786896679;5446.2647542582035;5453.045716999589;5519.420460851633;5534.861628459321;5540.750666220029;5433.9184912225555;5501.697406642593;5507.03626865297;5594.776208951596;5596.132599447093;5416.350037995466;5419.945800541944;5448.727563621724;5514.503694667499;5515.751791169327;5306.893862122659;5314.335708036496;5398.1093119634825;5404.8108316208745;5410.215518749838;5636.774529018958;5647.661140331593;5654.3497497788285;5699.544036477155;5707.429257074259;3407.5399821023843;3487.424574945207;3548.4677298405445;3552.1652411682717;3557.911052223715;5403.351597808131;5426.511613954763;5470.56235501151;5490.396056433869;5498.395176530498;5238.5023422774775;5255.710935898409;5311.7609707564025;5350.785968561214;5352.625316227826;5266.210068489757;5266.473352664703;5298.258243845942;5304.9469505306;5312.990531798946;5022.372203474566;5131.127708289525;5171.3277273954145;5202.8959420812125;5246.081935661167;5077.466865979019;5078.898422031612;5196.662216955886;5235.424103348705;5239.842804715865;5059.747012649279;5137.126688462896;5142.871428214325;5152.4847515248175;5218.608604354613 03:46:28 INFO - 2015-11-17 03:46:28,028 DEBUG : BROWSER_OUTPUT: |5;yui.html;488.311480812055;539.854239355374;567.5062695454952;576.6914700635161;603.8339456649421;8790.340724445668;8929.732108036762;8971.102889711026;9033.593488293027;9066.682666106688;8263.214994575506;8352.290055345304;8483.236508714215;8488.44825086369;8515.95742021289;530.400647268586;539.2854467830122;647.6081970407906;649.6556824882808;658.5883822610868;670.7853486884198;675.4056430341293;675.587891386254;676.2628734679199;676.3101636330939;680.877442060429;686.7733647896182;687.5771400588627;689.7792706333975;693.7606525748633;680.4624346766049;681.6455443169574;681.7511608262998;688.6419062087712;690.7962151165418;502.0060280644345;503.5669324381029;503.58705861193835;504.0448350376017;504.47282589693856;8653.221210091122;8657.22085012352;8657.740267791976;8664.523451210182;8765;6794.76218332356;6960.582365058112;7118.28817118284;7553.093628764584;7681.884771728429;6708.123776726181;6725.914258798702;6859.2454829968665;7147.964260178718;7283.562986220791;2241.7197850268717;2293.7018187635667;2308.1459859851793;2356;2397.2328854766483;36452.63547364545;37005.195938442164;37053;37323.81338093292;37703.43444848357;5045.520675535819;5318.601104917147;5345.278387417727;5457.645253058538;5478.260434841325;9366;9374.062593740571;9394.67118650844;9398.342116051948;9529.332946693803;4515.503294637587;4590.734070301826;4686.625069994392;4705.717656940595;4743.66794324394;2820.863216063363;2866.1974647098846;2927.5608658701367;2939.6472423309338;3007.9398412032074;1896.781870084958;1909.8185672361103;1916.377177417345;1916.6933290673426;1931.169597073244;312.89048832908753;313.5109229601828;315.8389221497007;316.82099613718174;317.2322978392296;310.813511892867;339.2637975592969;357.63878482732105;419.7083027296061;498.6484528407464;5024.748762561857;5441.401445841034;5491.28613280271;5767.68277744728;5857.970710146422;427.2181907109981;446.3973635591925;457.0721435485969;465.4663576762311;466.80160931603933;2669.3460102275067;2767.114523352548;2785.512535306313;2811.592319113717;2822.8729707163225;46947;47308.5269147311;47430;47499.525004749514;47642.5235747645;41226.1754764903;41858.58141418547;42110.36834447486;42178.789106054275;42281;34972.928925305685;35807.4628880567;35918.281634367166;37236;37280.44079338758;5642.351129619982;6049.51603871698;6061.818145455643;6315.494760419064;6514;27899.860500697367;27911.581326279716;28621.570676439453;28735.71264287414;29036.27409314784;35468.645313546534;37506;37551;37616.2476750458;38349.2330153401;5048.268001139741;5068.670536415121;5423.620346575702;5516.80691175823;5663.773449061991;8628.956855215683;8632.654693812177;8660.17728315809;8690.913090869264;8695.478271303742;8039.1156972734125;8084.231997960184;8100.432969692065;8323.625436855235;8817.603207855791;7873.212678732081;7898.170692077479;7993.400494963017;8016.599170041592;8328.167183281623;7329.963350183215;7725.652345644347;7775.105862825621;7894.407919406182;7906.446548741533;6757.93242067573;6774;6973.79078627642;7025.402840758593;7433.479656423999;6758.357955994173;7145.785626431215;7147.928520714726;7248.637568121679;7292.817679558054 03:46:28 INFO - 2015-11-17 03:46:28,029 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:46:28 INFO - 2015-11-17 03:46:28,029 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:46:28 INFO - 2015-11-17 03:46:28,029 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,316 03:46:28 INFO - 2015-11-17 03:46:28,029 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: __startTimestamp1447760788010__endTimestamp 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4131.39 Median:4276.32 stddev:525.12 (12.3%) stddev-sans-first:508.66 03:46:28 INFO - 2015-11-17 03:46:28,030 DEBUG : BROWSER_OUTPUT: Values: 2390.6 2454.7 2473.3 2503.2 2530.6 4107.1 4148.9 4155.9 4159.3 4162.8 4034.6 4063.7 4103.6 4116.8 4171.4 3719.3 3812.4 3834.1 3850.2 3904.6 617.7 3776.7 3850.2 3879.2 3958.5 3893.2 3894.6 3898.8 3925.3 3928.3 3819.4 3845.5 3923.8 3939.0 3959.9 3709.1 3722.3 3794.5 3809.3 3850.5 3893.7 4127.0 4156.9 4178.6 4211.7 4311.8 4459.3 4462.4 4468.6 4531.0 4352.4 4437.1 4438.2 4445.7 4482.7 4165.6 4175.6 4182.2 4196.2 4277.7 4343.8 4471.8 4517.5 4549.4 4575.6 4205.4 4263.8 4289.9 4312.7 4369.1 4468.0 4469.8 4476.3 4489.7 4537.6 4217.7 4252.4 4309.7 4421.0 4467.0 4400.8 4457.2 4457.6 4459.0 4469.4 3434.1 3439.7 3442.2 3476.4 3529.6 3033.0 3069.4 3141.4 3158.2 3177.3 4218.5 4245.0 4246.3 4257.8 4292.6 4456.3 4478.3 4486.1 4495.0 4523.6 4083.9 4134.1 4193.7 4205.7 4243.6 3935.2 3939.0 3984.1 3991.1 4000.3 4415.6 4592.7 4616.2 4620.1 4695.7 4410.6 4467.8 4474.3 4475.4 4526.7 4622.9 4628.6 4641.2 4681.7 4740.1 4176.4 4316.4 4473.3 4476.5 4529.9 4410.9 4486.9 4513.3 4529.0 4538.3 4363.9 4402.3 4406.2 4477.0 4496.3 4195.2 4281.7 4320.9 4392.3 4449.6 4266.6 4297.2 4331.3 4349.5 4403.3 4294.1 4366.3 4382.3 4427.1 4437.2 4109.1 4118.7 4161.4 4276.3 4401.5 03:46:28 INFO - 2015-11-17 03:46:28,031 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,031 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38251.61 Median:31555.92 stddev:67782.74 (214.8%) stddev-sans-first:67913.38 03:46:28 INFO - 2015-11-17 03:46:28,032 DEBUG : BROWSER_OUTPUT: Values: 420.1 441.1 446.0 453.8 480.6 29689.6 30964.8 31147.5 31408.0 31703.8 33023.8 33069.2 33466.7 33602.3 33746.0 7016.4 7202.9 7220.9 7304.6 7323.0 7074.7 7196.2 7235.1 7321.9 7323.5 7094.7 7173.8 7194.2 7195.9 7321.7 7118.5 7176.8 7178.3 7253.9 7294.6 7031.0 7161.5 7171.9 7186.7 7190.1 30491.2 30980.8 31064.4 31131.7 31238.2 2036.7 2145.4 2154.5 2272.7 2423.7 20877.9 21333.9 21712.0 21970.0 22063.7 1863.5 1868.3 1885.8 1892.4 1911.4 202854.0 203757.0 207611.0 207710.0 208523.0 42178.0 45074.1 46341.8 46490.0 46926.3 42011.8 43397.0 43810.0 43810.3 43838.3 12662.9 12915.7 13113.7 13122.4 13133.6 9510.5 9529.6 9776.0 9861.7 9872.9 14858.9 15262.8 15416.8 15426.0 15483.5 6510.5 6801.1 6970.6 7019.0 7023.2 676.2 835.1 861.3 863.0 884.1 21097.6 21312.0 21780.9 21841.9 21884.3 748.2 799.4 842.0 842.4 923.4 10440.2 10993.3 11032.6 11147.9 11153.5 313027.0 318800.0 324481.0 324569.0 324754.0 41125.6 41807.0 42537.4 42542.6 42578.4 1093.4 1096.9 1100.3 1103.1 1107.1 20759.5 20766.5 21159.6 21301.7 21328.4 34553.7 35330.0 35416.0 35656.3 35718.1 230246.0 230311.0 231304.0 233318.0 233843.0 24090.0 33830.8 35033.3 35168.1 35730.5 32461.4 32565.5 32830.0 33238.5 33341.8 27428.2 27631.3 27825.9 27949.6 28012.0 27485.7 27512.9 27625.8 27803.3 28020.3 28010.7 28044.3 28199.9 28446.3 28456.3 23381.5 24168.5 25262.6 25360.2 25661.5 18500.5 18900.7 19173.0 19196.5 19299.5 03:46:28 INFO - 2015-11-17 03:46:28,032 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,033 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21619.69 Median:4528.50 stddev:75519.64 (1667.7%) stddev-sans-first:75714.46 03:46:28 INFO - 2015-11-17 03:46:28,034 DEBUG : BROWSER_OUTPUT: Values: 261.6 263.2 263.7 265.0 270.8 10864.2 12353.0 12914.4 13372.3 13569.6 13818.7 13854.7 14238.4 14379.8 14397.8 4058.2 4104.1 4175.7 4247.2 4275.1 2950.5 3140.4 4222.4 4417.3 4629.4 4513.5 4530.4 4574.6 4581.0 4593.6 3445.8 3631.5 4522.9 4587.8 4600.3 2995.4 3034.0 3036.0 3074.7 3090.7 9586.2 9799.6 10018.9 10227.2 10241.3 1185.7 1255.5 1349.6 1456.7 1507.5 6962.1 7088.5 7290.5 7325.6 7394.1 1137.1 1167.2 1169.4 1216.0 1241.6 43214.4 44242.1 45023.0 45575.8 45697.0 4986.9 4999.9 5009.2 5020.4 5064.3 5659.4 5668.9 5671.3 5679.0 5745.0 4107.5 4181.6 4205.1 4208.7 4231.7 4300.7 4303.9 4467.4 4526.6 4540.2 2232.3 2252.8 2258.7 2274.7 2276.3 788.5 802.4 818.1 819.3 877.9 320.6 342.1 343.1 343.4 353.3 8080.4 8805.3 9056.9 9121.8 9255.5 340.9 342.1 345.9 360.5 370.8 4828.9 4955.5 4956.6 5004.6 5042.5 443538.0 457538.0 459771.0 472095.0 476980.0 30963.5 31100.7 46716.5 52251.7 56200.0 336.5 342.1 342.8 342.9 348.0 7569.3 7671.5 7931.3 7938.8 8000.9 27004.0 27526.9 27656.0 28131.4 28205.7 37054.0 37641.0 37804.2 37984.0 38036.0 5740.7 5942.2 5945.5 5984.5 5987.7 8611.3 8846.2 9053.0 9061.2 9212.0 6441.8 6785.4 7490.3 7784.8 7824.3 7395.2 7430.3 7525.0 7655.7 7760.1 7727.9 7842.3 7928.9 7995.4 8046.4 5783.9 5813.9 5878.3 5894.0 5933.8 6831.7 7316.2 7887.0 7995.7 8129.0 03:46:28 INFO - 2015-11-17 03:46:28,034 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,034 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4210.21 Median:5230.73 stddev:2177.50 (41.6%) stddev-sans-first:2172.93 03:46:28 INFO - 2015-11-17 03:46:28,036 DEBUG : BROWSER_OUTPUT: Values: 1340.0 1407.0 1415.0 1432.4 1453.2 5658.8 5910.5 6070.6 6431.8 6469.9 5974.6 6010.1 6116.3 6138.1 6144.8 1733.1 1739.8 1741.3 1741.4 1761.4 1699.7 1737.6 1743.0 1744.8 1746.8 1697.8 1722.5 1725.1 1747.4 1766.3 1702.7 1708.0 1709.9 1721.3 1751.6 1743.9 1766.4 1768.8 1769.8 1786.9 6239.1 6293.5 6310.0 6349.9 6379.8 3703.8 3774.4 3793.0 3844.6 3849.0 2003.7 2048.0 2181.1 2223.3 2290.4 646.2 659.8 665.8 679.7 679.9 7620.8 7719.5 7739.7 7827.0 7858.5 3353.0 3362.1 3363.8 3388.2 3397.1 7262.8 7278.8 7344.6 7370.7 7376.0 3867.1 3875.2 3896.4 3924.9 3926.7 3502.6 3511.2 3524.6 3555.4 3568.7 2819.3 2825.9 2853.5 2858.6 2894.1 947.0 965.9 971.2 972.3 974.1 1014.2 1023.6 1023.8 1051.2 1055.6 5801.9 5853.0 5853.5 5906.9 5952.2 340.4 342.4 344.6 348.7 348.9 4446.5 4617.5 4623.9 4626.7 4628.2 6894.7 7002.2 7346.2 7396.0 7525.4 7257.9 7356.0 7360.0 7421.1 7459.3 5480.8 5547.6 5563.7 5568.8 5669.3 5260.9 5359.6 5367.4 5369.8 5381.8 6101.0 6129.5 6163.7 6182.2 6201.0 6358.9 6419.8 6421.0 6436.1 6446.5 5140.1 5185.6 5203.6 5213.4 5281.6 5579.6 5636.3 5640.4 5643.6 5723.9 5263.7 5292.5 5370.0 5371.4 5418.7 5193.8 5207.1 5248.1 5302.8 5354.2 5349.6 5369.8 5387.4 5398.5 5461.1 4843.8 4878.2 4882.5 4899.4 4924.2 4963.6 4973.5 4976.2 5005.1 5039.7 03:46:28 INFO - 2015-11-17 03:46:28,036 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,036 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4325.04 Median:5021.90 stddev:1355.58 (27.0%) stddev-sans-first:1324.34 03:46:28 INFO - 2015-11-17 03:46:28,038 DEBUG : BROWSER_OUTPUT: Values: 245.0 249.5 254.9 254.9 256.2 4830.1 4934.7 4992.5 5002.6 5059.7 4699.4 4823.1 4858.4 4899.7 4926.1 3708.1 3714.5 3738.2 3756.5 3772.2 3733.1 3733.2 3751.8 3763.1 3799.4 3680.6 3701.3 3701.6 3753.8 3763.4 3430.5 3582.9 3608.7 3756.9 3781.5 3194.3 3194.6 3202.1 3237.1 3254.6 4728.9 4743.8 4769.9 4830.9 4853.9 4192.5 4211.9 4221.2 4224.7 4286.1 5004.4 5087.4 5115.8 5126.0 5188.8 3410.7 3411.5 3415.1 3419.1 3425.6 5319.9 5376.9 5388.6 5402.0 5473.0 3288.7 3374.4 3397.9 3459.1 3465.6 3490.4 3528.9 3564.5 3575.1 3598.7 4142.5 4142.5 4147.0 4147.6 4188.4 5144.6 5145.9 5178.0 5194.7 5216.1 1165.9 1190.4 1221.8 1224.3 1273.9 795.4 795.7 802.7 812.9 813.0 4939.3 4964.5 4996.6 5021.4 5064.1 5349.1 5355.1 5357.1 5397.4 5445.8 4976.2 4992.8 5039.7 5067.8 5068.2 2731.1 2872.1 2884.0 2888.0 2909.1 5503.0 5523.7 5536.0 5585.4 5585.7 5446.3 5453.0 5519.4 5534.9 5540.8 5433.9 5501.7 5507.0 5594.8 5596.1 5416.4 5419.9 5448.7 5514.5 5515.8 5306.9 5314.3 5398.1 5404.8 5410.2 5636.8 5647.7 5654.3 5699.5 5707.4 3407.5 3487.4 3548.5 3552.2 3557.9 5403.4 5426.5 5470.6 5490.4 5498.4 5238.5 5255.7 5311.8 5350.8 5352.6 5266.2 5266.5 5298.3 5304.9 5313.0 5022.4 5131.1 5171.3 5202.9 5246.1 5077.5 5078.9 5196.7 5235.4 5239.8 5059.7 5137.1 5142.9 5152.5 5218.6 03:46:28 INFO - 2015-11-17 03:46:28,038 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,038 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10182.08 Median:5579.58 stddev:13074.75 (234.3%) stddev-sans-first:13091.17 03:46:28 INFO - 2015-11-17 03:46:28,038 DEBUG : BROWSER_OUTPUT: Values: 488.3 539.9 567.5 576.7 603.8 8790.3 8929.7 8971.1 9033.6 9066.7 8263.2 8352.3 8483.2 8488.4 8516.0 530.4 539.3 647.6 649.7 658.6 670.8 675.4 675.6 676.3 676.3 680.9 686.8 687.6 689.8 693.8 680.5 681.6 681.8 688.6 690.8 502.0 503.6 503.6 504.0 504.5 8653.2 8657.2 8657.7 8664.5 8765.0 6794.8 6960.6 7118.3 7553.1 7681.9 6708.1 6725.9 6859.2 7148.0 7283.6 2241.7 2293.7 2308.1 2356.0 2397.2 36452.6 37005.2 37053.0 37323.8 37703.4 5045.5 5318.6 5345.3 5457.6 5478.3 9366.0 9374.1 9394.7 9398.3 9529.3 4515.5 4590.7 4686.6 4705.7 4743.7 2820.9 2866.2 2927.6 2939.6 3007.9 1896.8 1909.8 1916.4 1916.7 1931.2 312.9 313.5 315.8 316.8 317.2 310.8 339.3 357.6 419.7 498.6 5024.7 5441.4 5491.3 5767.7 5858.0 427.2 446.4 457.1 465.5 466.8 2669.3 2767.1 2785.5 2811.6 2822.9 46947.0 47308.5 47430.0 47499.5 47642.5 41226.2 41858.6 42110.4 42178.8 42281.0 34972.9 35807.5 35918.3 37236.0 37280.4 5642.4 6049.5 6061.8 6315.5 6514.0 27899.9 27911.6 28621.6 28735.7 29036.3 35468.6 37506.0 37551.0 37616.2 38349.2 5048.3 5068.7 5423.6 5516.8 5663.8 8629.0 8632.7 8660.2 8690.9 8695.5 8039.1 8084.2 8100.4 8323.6 8817.6 7873.2 7898.2 7993.4 8016.6 8328.2 7330.0 7725.7 7775.1 7894.4 7906.4 6757.9 6774.0 6973.8 7025.4 7433.5 6758.4 7145.8 7147.9 7248.6 7292.8 03:46:28 INFO - 2015-11-17 03:46:28,039 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:46:28 INFO - 2015-11-17 03:46:28,039 DEBUG : BROWSER_OUTPUT: 03:46:28 INFO - 2015-11-17 03:46:28,739 INFO : Browser exited with error code: 0 03:46:28 INFO - 2015-11-17 03:46:28,775 INFO : Completed test dromaeo_css (00:18:33) 03:46:28 INFO - 2015-11-17 03:46:28,775 INFO : Starting test kraken 03:46:28 INFO - 2015-11-17 03:46:28,775 DEBUG : operating with platform_type : mac_ 03:46:28 INFO - 2015-11-17 03:46:28,775 INFO : Initialising browser for kraken test... 03:46:28 INFO - 2015-11-17 03:46:28,792 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/tmpq9kwJl/profile http://localhost:49273/getInfo.html 03:46:32 INFO - 2015-11-17 03:46:32,384 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:46:32 INFO - 2015-11-17 03:46:32,385 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:46:32 INFO - 2015-11-17 03:46:32,385 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:46:32 INFO - 2015-11-17 03:46:32,385 DEBUG : BROWSER_OUTPUT: __metrics 03:46:33 INFO - 2015-11-17 03:46:33,145 INFO : Browser initialized. 03:46:33 INFO - 2015-11-17 03:46:33,145 INFO : Running cycle 1/1 for kraken test... 03:46:33 INFO - 2015-11-17 03:46:33,146 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/tmpq9kwJl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:46:45 INFO - 2015-11-17 03:46:45,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 242204672 03:46:45 INFO - 2015-11-17 03:46:45,501 DEBUG : BROWSER_OUTPUT: 03:46:48 INFO - 2015-11-17 03:46:48,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:49 INFO - 2015-11-17 03:46:49,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 259936256 03:46:49 INFO - 2015-11-17 03:46:49,201 DEBUG : BROWSER_OUTPUT: 03:46:52 INFO - 2015-11-17 03:46:52,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 03:46:53 INFO - 2015-11-17 03:46:53,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 267722752 03:46:53 INFO - 2015-11-17 03:46:53,115 DEBUG : BROWSER_OUTPUT: 03:46:56 INFO - 2015-11-17 03:46:56,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 03:46:57 INFO - 2015-11-17 03:46:57,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 268443648 03:46:57 INFO - 2015-11-17 03:46:57,295 DEBUG : BROWSER_OUTPUT: 03:46:59 INFO - 2015-11-17 03:46:59,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 03:47:00 INFO - 2015-11-17 03:47:00,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 268038144 03:47:00 INFO - 2015-11-17 03:47:00,276 DEBUG : BROWSER_OUTPUT: 03:47:02 INFO - 2015-11-17 03:47:02,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:03 INFO - 2015-11-17 03:47:03,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 268775424 03:47:03 INFO - 2015-11-17 03:47:03,396 DEBUG : BROWSER_OUTPUT: 03:47:07 INFO - 2015-11-17 03:47:07,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:07 INFO - 2015-11-17 03:47:07,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 267927552 03:47:07 INFO - 2015-11-17 03:47:07,783 DEBUG : BROWSER_OUTPUT: 03:47:11 INFO - 2015-11-17 03:47:11,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:12 INFO - 2015-11-17 03:47:12,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 267907072 03:47:12 INFO - 2015-11-17 03:47:12,303 DEBUG : BROWSER_OUTPUT: 03:47:15 INFO - 2015-11-17 03:47:15,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 03:47:16 INFO - 2015-11-17 03:47:16,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 268034048 03:47:16 INFO - 2015-11-17 03:47:16,478 DEBUG : BROWSER_OUTPUT: 03:47:18 INFO - 2015-11-17 03:47:18,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:18 INFO - 2015-11-17 03:47:18,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 267956224 03:47:18 INFO - 2015-11-17 03:47:18,928 DEBUG : BROWSER_OUTPUT: 03:47:21 INFO - 2015-11-17 03:47:21,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:21 INFO - 2015-11-17 03:47:21,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 267837440 03:47:21 INFO - 2015-11-17 03:47:21,754 DEBUG : BROWSER_OUTPUT: 03:47:24 INFO - 2015-11-17 03:47:24,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:24 INFO - 2015-11-17 03:47:24,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 267579392 03:47:24 INFO - 2015-11-17 03:47:24,903 DEBUG : BROWSER_OUTPUT: 03:47:28 INFO - 2015-11-17 03:47:28,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:28 INFO - 2015-11-17 03:47:28,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 268738560 03:47:28 INFO - 2015-11-17 03:47:28,734 DEBUG : BROWSER_OUTPUT: 03:47:31 INFO - 2015-11-17 03:47:31,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:32 INFO - 2015-11-17 03:47:32,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 269099008 03:47:32 INFO - 2015-11-17 03:47:32,587 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 03:47:34 INFO - 2015-11-17 03:47:34,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 275128320 03:47:34 INFO - 2015-11-17 03:47:34,874 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,874 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:47:34 INFO - 2015-11-17 03:47:34,874 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:47:34 INFO - 2015-11-17 03:47:34,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:47:34 INFO - 2015-11-17 03:47:34,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:47:34 INFO - 2015-11-17 03:47:34,875 DEBUG : BROWSER_OUTPUT: |0;ai-astar;140;128;147;146;146;161;146;147;147;145 03:47:34 INFO - 2015-11-17 03:47:34,876 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;193;178;202;219;185;208;209;179;218;173 03:47:34 INFO - 2015-11-17 03:47:34,876 DEBUG : BROWSER_OUTPUT: |2;audio-dft;207;212;218;218;222;222;221;218;220;222 03:47:34 INFO - 2015-11-17 03:47:34,876 DEBUG : BROWSER_OUTPUT: |3;audio-fft;89;97;105;154;89;93;93;96;139;94 03:47:34 INFO - 2015-11-17 03:47:34,876 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;115;115;157;116;120;122;161;119;121;162 03:47:34 INFO - 2015-11-17 03:47:34,877 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;157;165;165;157;157;158;157;157;166;166 03:47:34 INFO - 2015-11-17 03:47:34,877 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;165;173;173;173;173;174;173;172;182;184 03:47:34 INFO - 2015-11-17 03:47:34,877 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;133;130;131;147;136;138;137;150;151;150 03:47:34 INFO - 2015-11-17 03:47:34,877 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;79;80;81;82;86;87;85;92;87;85 03:47:34 INFO - 2015-11-17 03:47:34,878 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;88;90;89;95;95;94;95;96;97;96 03:47:34 INFO - 2015-11-17 03:47:34,878 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;112;111;119;117;120;117;118;117;125;125 03:47:34 INFO - 2015-11-17 03:47:34,880 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;162;173;168;171;188;192;181;195;181;176 03:47:34 INFO - 2015-11-17 03:47:34,880 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;201;209;211;214;211;208;213;211;209;208 03:47:34 INFO - 2015-11-17 03:47:34,880 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;94;95;106;99;94;97;97;96;96;98 03:47:34 INFO - 2015-11-17 03:47:34,880 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:47:34 INFO - 2015-11-17 03:47:34,880 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:47:34 INFO - 2015-11-17 03:47:34,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,839 03:47:34 INFO - 2015-11-17 03:47:34,881 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:47:34 INFO - 2015-11-17 03:47:34,881 DEBUG : BROWSER_OUTPUT: __startTimestamp1447760854873__endTimestamp 03:47:34 INFO - 2015-11-17 03:47:34,881 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,882 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:47:34 INFO - 2015-11-17 03:47:34,883 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:47:34 INFO - 2015-11-17 03:47:34,883 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,883 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:145.30 Median:146.50 stddev:8.06 (5.5%) stddev-sans-first:8.31 03:47:34 INFO - 2015-11-17 03:47:34,883 DEBUG : BROWSER_OUTPUT: Values: 140.0 128.0 147.0 146.0 146.0 161.0 146.0 147.0 147.0 145.0 03:47:34 INFO - 2015-11-17 03:47:34,883 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,884 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:196.40 Median:205.00 stddev:17.10 (8.3%) stddev-sans-first:18.10 03:47:34 INFO - 2015-11-17 03:47:34,884 DEBUG : BROWSER_OUTPUT: Values: 193.0 178.0 202.0 219.0 185.0 208.0 209.0 179.0 218.0 173.0 03:47:34 INFO - 2015-11-17 03:47:34,884 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,884 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:218.00 Median:220.50 stddev:4.92 (2.2%) stddev-sans-first:3.23 03:47:34 INFO - 2015-11-17 03:47:34,885 DEBUG : BROWSER_OUTPUT: Values: 207.0 212.0 218.0 218.0 222.0 222.0 221.0 218.0 220.0 222.0 03:47:34 INFO - 2015-11-17 03:47:34,885 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,885 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:104.90 Median:93.00 stddev:22.66 (24.4%) stddev-sans-first:23.30 03:47:34 INFO - 2015-11-17 03:47:34,885 DEBUG : BROWSER_OUTPUT: Values: 89.0 97.0 105.0 154.0 89.0 93.0 93.0 96.0 139.0 94.0 03:47:34 INFO - 2015-11-17 03:47:34,885 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,886 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:130.80 Median:121.50 stddev:20.33 (16.7%) stddev-sans-first:20.74 03:47:34 INFO - 2015-11-17 03:47:34,886 DEBUG : BROWSER_OUTPUT: Values: 115.0 115.0 157.0 116.0 120.0 122.0 161.0 119.0 121.0 162.0 03:47:34 INFO - 2015-11-17 03:47:34,886 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,886 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:160.50 Median:161.50 stddev:4.33 (2.7%) stddev-sans-first:4.40 03:47:34 INFO - 2015-11-17 03:47:34,887 DEBUG : BROWSER_OUTPUT: Values: 157.0 165.0 165.0 157.0 157.0 158.0 157.0 157.0 166.0 166.0 03:47:34 INFO - 2015-11-17 03:47:34,887 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,887 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:174.20 Median:173.00 stddev:5.31 (3.1%) stddev-sans-first:4.47 03:47:34 INFO - 2015-11-17 03:47:34,888 DEBUG : BROWSER_OUTPUT: Values: 165.0 173.0 173.0 173.0 173.0 174.0 173.0 172.0 182.0 184.0 03:47:34 INFO - 2015-11-17 03:47:34,889 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,889 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:140.30 Median:142.50 stddev:8.35 (5.9%) stddev-sans-first:8.43 03:47:34 INFO - 2015-11-17 03:47:34,889 DEBUG : BROWSER_OUTPUT: Values: 133.0 130.0 131.0 147.0 136.0 138.0 137.0 150.0 151.0 150.0 03:47:34 INFO - 2015-11-17 03:47:34,889 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,889 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:84.40 Median:85.50 stddev:3.95 (4.6%) stddev-sans-first:3.67 03:47:34 INFO - 2015-11-17 03:47:34,890 DEBUG : BROWSER_OUTPUT: Values: 79.0 80.0 81.0 82.0 86.0 87.0 85.0 92.0 87.0 85.0 03:47:34 INFO - 2015-11-17 03:47:34,890 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,890 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:93.50 Median:95.00 stddev:3.24 (3.4%) stddev-sans-first:2.76 03:47:34 INFO - 2015-11-17 03:47:34,890 DEBUG : BROWSER_OUTPUT: Values: 88.0 90.0 89.0 95.0 95.0 94.0 95.0 96.0 97.0 96.0 03:47:34 INFO - 2015-11-17 03:47:34,890 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,890 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:118.10 Median:118.50 stddev:4.61 (3.9%) stddev-sans-first:4.32 03:47:34 INFO - 2015-11-17 03:47:34,891 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 119.0 117.0 120.0 117.0 118.0 117.0 125.0 125.0 03:47:34 INFO - 2015-11-17 03:47:34,891 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,891 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:178.70 Median:181.00 stddev:10.71 (5.9%) stddev-sans-first:9.50 03:47:34 INFO - 2015-11-17 03:47:34,891 DEBUG : BROWSER_OUTPUT: Values: 162.0 173.0 168.0 171.0 188.0 192.0 181.0 195.0 181.0 176.0 03:47:34 INFO - 2015-11-17 03:47:34,891 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,893 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:209.50 Median:211.00 stddev:3.60 (1.7%) stddev-sans-first:2.13 03:47:34 INFO - 2015-11-17 03:47:34,893 DEBUG : BROWSER_OUTPUT: Values: 201.0 209.0 211.0 214.0 211.0 208.0 213.0 211.0 209.0 208.0 03:47:34 INFO - 2015-11-17 03:47:34,893 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2015-11-17 03:47:34,893 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:97.20 Median:96.50 stddev:3.49 (3.6%) stddev-sans-first:3.50 03:47:34 INFO - 2015-11-17 03:47:34,893 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 106.0 99.0 94.0 97.0 97.0 96.0 96.0 98.0 03:47:34 INFO - 2015-11-17 03:47:34,894 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:47:34 INFO - 2015-11-17 03:47:34,894 DEBUG : BROWSER_OUTPUT: 03:47:35 INFO - 2015-11-17 03:47:35,509 INFO : Browser exited with error code: 0 03:47:35 INFO - 2015-11-17 03:47:35,569 INFO : Completed test kraken (00:01:06) 03:47:35 INFO - 2015-11-17 03:47:35,569 INFO : Starting test v8_7 03:47:35 INFO - 2015-11-17 03:47:35,569 DEBUG : operating with platform_type : mac_ 03:47:35 INFO - 2015-11-17 03:47:35,570 INFO : Initialising browser for v8_7 test... 03:47:35 INFO - 2015-11-17 03:47:35,587 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/tmpl5PxsR/profile http://localhost:49273/getInfo.html 03:47:39 INFO - 2015-11-17 03:47:39,113 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:39 INFO - 2015-11-17 03:47:39,113 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:39 INFO - 2015-11-17 03:47:39,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:47:39 INFO - 2015-11-17 03:47:39,113 DEBUG : BROWSER_OUTPUT: __metrics 03:47:40 INFO - 2015-11-17 03:47:40,035 INFO : Browser initialized. 03:47:40 INFO - 2015-11-17 03:47:40,035 INFO : Running cycle 1/1 for v8_7 test... 03:47:40 INFO - 2015-11-17 03:47:40,035 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/tmpl5PxsR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:52 INFO - 2015-11-17 03:47:52,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 241184768 03:47:52 INFO - 2015-11-17 03:47:52,355 DEBUG : BROWSER_OUTPUT: 03:48:14 INFO - 2015-11-17 03:48:14,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/v8_7/run.html (next: http://localhost:49273/tests/v8_7/run.html) 03:48:15 INFO - 2015-11-17 03:48:15,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 260898816 03:48:15 INFO - 2015-11-17 03:48:15,257 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,257 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:48:15 INFO - 2015-11-17 03:48:15,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:48:15 INFO - 2015-11-17 03:48:15,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:48:15 INFO - 2015-11-17 03:48:15,258 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:48:15 INFO - 2015-11-17 03:48:15,258 DEBUG : BROWSER_OUTPUT: |0;Richards;211.72983273343215 03:48:15 INFO - 2015-11-17 03:48:15,258 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;257.7319587628866 03:48:15 INFO - 2015-11-17 03:48:15,258 DEBUG : BROWSER_OUTPUT: |2;Encrypt;415.11000415110004 03:48:15 INFO - 2015-11-17 03:48:15,258 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7563.909774436091 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1443.001443001443 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: |5;Earley;1040.5827263267429 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: |6;Boyer;17169.491525423728 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: |7;RegExp;38603.77358490566 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: |8;Splay;804.5052292839904 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7367.64705882353 03:48:15 INFO - 2015-11-17 03:48:15,259 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1447760895250__endTimestamp 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:211.73 Median:211.73 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: Values: 211.7 03:48:15 INFO - 2015-11-17 03:48:15,260 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,261 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:257.73 Median:257.73 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,261 DEBUG : BROWSER_OUTPUT: Values: 257.7 03:48:15 INFO - 2015-11-17 03:48:15,261 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,261 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:415.11 Median:415.11 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,261 DEBUG : BROWSER_OUTPUT: Values: 415.1 03:48:15 INFO - 2015-11-17 03:48:15,261 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7563.91 Median:7563.91 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: Values: 7563.9 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1443.00 Median:1443.00 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: Values: 1443.0 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1040.58 Median:1040.58 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,262 DEBUG : BROWSER_OUTPUT: Values: 1040.6 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:17169.49 Median:17169.49 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: Values: 17169.5 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:38603.77 Median:38603.77 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: Values: 38603.8 03:48:15 INFO - 2015-11-17 03:48:15,263 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: Values: 804.5 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7367.65 Median:7367.65 stddev:0.00 (0.0%) 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: Values: 7367.6 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:48:15 INFO - 2015-11-17 03:48:15,264 DEBUG : BROWSER_OUTPUT: 03:48:16 INFO - 2015-11-17 03:48:16,029 INFO : Browser exited with error code: 0 03:48:16 INFO - 2015-11-17 03:48:16,054 INFO : Completed test v8_7 (00:00:40) 03:48:16 INFO - 2015-11-17 03:48:16,205 INFO : Completed test suite (00:20:21) 03:48:16 INFO - 2015-11-17 03:48:16,205 DEBUG : Working with test: dromaeo_css 03:48:16 INFO - 2015-11-17 03:48:16,205 DEBUG : Generating results file: dromaeo_css 03:48:16 INFO - 2015-11-17 03:48:16,206 DEBUG : Working with test: kraken 03:48:16 INFO - 2015-11-17 03:48:16,206 DEBUG : Generating results file: kraken 03:48:16 INFO - 2015-11-17 03:48:16,206 INFO : javascript benchmark 03:48:16 INFO - 2015-11-17 03:48:16,206 DEBUG : Working with test: v8_7 03:48:16 INFO - 2015-11-17 03:48:16,206 DEBUG : Generating results file: v8_7 03:48:16 INFO - 2015-11-17 03:48:16,206 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:48:16 INFO - 2015-11-17 03:48:16,254 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 03:48:16 INFO - 2015-11-17 03:48:16,254 DEBUG : process_Request line: dromaeo_css 5105.98 graph.html#tests=[[72,64,57]] 03:48:16 INFO - 2015-11-17 03:48:16,254 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:48:16 INFO - 2015-11-17 03:48:16,281 DEBUG : process_Request line: kraken 2051.80 graph.html#tests=[[232,64,57]] 03:48:16 INFO - 2015-11-17 03:48:16,281 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:48:16 INFO - 2015-11-17 03:48:16,308 DEBUG : process_Request line: v8_7 15129.31 graph.html#tests=[[230,64,57]] 03:48:16 INFO - 2015-11-17 03:48:16,309 INFO : javascript benchmark 03:48:16 INFO - 2015-11-17 03:48:16,311 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [261.56057822857593, 263.209056784363, 263.65461245768046, 264.96952850422196, 270.77255105711197, 10864.185186111034, 12353.0, 12914.354282285884, 13372.264525451097, 13569.592912212636, 13818.65453363664, 13854.722905541908, 14238.430462781476, 14379.78430323546, 14397.784033239484, 4058.2289365020624, 4104.1381309924955, 4175.707700460969, 4247.193033323674, 4275.0594869128745, 2950.468915595192, 3140.3876244132402, 4222.408862759216, 4417.293233082707, 4629.421322334708, 4513.548645135493, 4530.365748795171, 4574.61115805157, 4580.954190458103, 4593.586577208051, 3445.758796884219, 3631.5460567429072, 4522.864314070566, 4587.839425620104, 4600.309953506967, 2995.3859458810894, 3033.9848300758576, 3035.969640303591, 3074.6771588983283, 3090.6754790746872, 9586.233101351874, 9799.608015679365, 10018.899811001942, 10227.181825453947, 10241.334313269614, 1185.6857932647856, 1255.5480027190204, 1349.5546469664987, 1456.694094240211, 1507.464849978253, 6962.1297337832775, 7088.468364872655, 7290.45321600882, 7325.633718314063, 7394.149672787591, 1137.1187329819375, 1167.1596450555587, 1169.3860723120345, 1216.0332535634193, 1241.5840693367643, 43214.35178472326, 44242.115157696986, 45023.0, 45575.77212113918, 45697.0, 4986.90026199474, 4999.925001124986, 5009.198528235464, 5020.447750747415, 5064.290999260106, 5659.377468478464, 5668.914966275509, 5671.347795003545, 5679.0, 5744.971275143681, 4107.486564179478, 4181.560936101666, 4205.137946720976, 4208.684348673862, 4231.724937879089, 4300.720453170534, 4303.935440968388, 4467.441569803775, 4526.637868970474, 4540.160070386923, 2232.3079845248026, 2252.8310376721483, 2258.706368172127, 2274.715660542432, 2276.3057267533563, 788.4993029426356, 802.3741481644327, 818.108261994429, 819.2626636027504, 877.8727084572829, 320.5736370627107, 342.1480513521314, 343.0668581458429, 343.4076218523078, 353.33925559204454, 8080.4243172581955, 8805.339599530062, 9056.909430905738, 9121.771955701028, 9255.490947997925, 340.8909149072323, 342.1207496733371, 345.87202734988216, 360.5187075254565, 370.7738279649412, 4828.903421931542, 4955.5044495550155, 4956.603471722254, 5004.574611158092, 5042.495750424928, 443538.0, 457538.0, 459771.0, 472095.0, 476980.0, 30963.535546966814, 31100.68899311023, 46716.532834671896, 52251.73874130681, 56200.0, 336.51709796441696, 342.0985702673473, 342.7857589006871, 342.8919890234568, 348.0081766964183, 7569.280918312751, 7671.501352412075, 7931.325837303663, 7938.841223175619, 8000.879986800086, 27004.0, 27526.862365688845, 27656.0, 28131.43737125287, 28205.71794282113, 37054.0, 37641.0, 37804.2439151221, 37984.0, 38036.04909877275, 5740.741666625096, 5942.227510423617, 5945.524358051259, 5984.521238300838, 5987.700614969322, 8611.31109511225, 8846.203841654282, 9053.004169541213, 9061.184493395625, 9211.953940230256, 6441.838954026187, 6785.389314961677, 7490.325870671666, 7784.84430311402, 7824.256695613907, 7395.18652948186, 7430.294122058396, 7524.962375188089, 7655.655495502827, 7760.107587627495, 7727.884081738666, 7842.333401660922, 7928.920710792819, 7995.440319177602, 8046.436749427484, 5783.94216057834, 5813.883722325445, 5878.29460464747, 5893.970530147321, 5933.762649493972, 6831.69257383409, 7316.1952185258515, 7886.960565197137, 7995.720149794729, 8129.0], "dojo.html": [2390.6294524348727, 2454.6563481112644, 2473.270385236355, 2503.2490252924117, 2530.6077557978497, 4107.137501124764, 4148.937765933513, 4155.937660935088, 4159.313713237316, 4162.791860406979, 4034.6368826805583, 4063.67490600752, 4103.630673239415, 4116.814743336549, 4171.436856024436, 3719.25614877025, 3812.4281357796276, 3834.0798208430056, 3850.191459793447, 3904.5900180481067, 617.6562921395155, 3776.660100590946, 3850.210706805098, 3879.2047630235734, 3958.4656071430277, 3893.201893611803, 3894.6300101490597, 3898.8245528951265, 3925.2934471795065, 3928.273269445162, 3819.4079917612817, 3845.480860083881, 3923.8234279457492, 3938.960610393888, 3959.9010024749614, 3709.0541911812584, 3722.32998060349, 3794.4687743715626, 3809.2952803731123, 3850.4994350734223, 3893.7469064511, 4127.030147915238, 4156.916861662749, 4178.6448151907125, 4211.7472951623, 4311.805968731414, 4459.264221403465, 4462.419885414875, 4468.575485328888, 4530.954690453119, 4352.39066530686, 4437.090396468749, 4438.178936896652, 4445.666575006888, 4482.686211965164, 4165.604267594574, 4175.62419382257, 4182.247195504778, 4196.244675958295, 4277.679174061957, 4343.804528796211, 4471.754053527087, 4517.480489743656, 4549.40857688505, 4575.633949284049, 4205.36919462077, 4263.76549289792, 4289.892752681146, 4312.719673221231, 4369.126174764996, 4467.955320446754, 4469.843555475542, 4476.328550717419, 4489.73061616304, 4537.568930951555, 4217.683673724483, 4252.425922500484, 4309.719868208556, 4421.049474362963, 4467.039586488921, 4400.823967041347, 4457.197704413236, 4457.621102206284, 4458.977705111519, 4469.374287599739, 3434.1242983039665, 3439.7420193485586, 3442.208292092783, 3476.42638964568, 3529.6293889141784, 3032.9848350758107, 3069.355435358555, 3141.387429451235, 3158.210447388153, 3177.269228077555, 4218.472690913636, 4244.978775106105, 4246.278132717445, 4257.765822879709, 4292.59220374064, 4456.264716321771, 4478.305862591304, 4486.057927835126, 4494.955050449519, 4523.570260825282, 4083.9387409188885, 4134.131832315187, 4193.748375097504, 4205.705600607928, 4243.575642435731, 3935.2326296372507, 3938.960610393917, 3984.1234928315725, 3991.1219531702977, 4000.299947509174, 4415.624671902796, 4592.678512504092, 4616.238320677051, 4620.099080679235, 4695.741734204583, 4410.625096866674, 4467.754273514988, 4474.328850672425, 4475.351074094173, 4526.683132180848, 4622.930656040095, 4628.606568441585, 4641.234196357564, 4681.742504162167, 4740.099381117577, 4176.373543968308, 4316.438862947797, 4473.306637471197, 4476.462824461086, 4529.8641040768825, 4410.867673969786, 4486.910261794811, 4513.277875539898, 4528.954710452985, 4538.29656403258, 4363.912721745483, 4402.273624851863, 4406.184855801559, 4477.0, 4496.348029535634, 4195.1609678065115, 4281.700280980302, 4320.93518597215, 4392.275274579659, 4449.644028477779, 4266.616004559604, 4297.183535128315, 4331.328644060176, 4349.499807522176, 4403.339499075164, 4294.055307832272, 4366.323219900921, 4382.342648602735, 4427.114577084661, 4437.245668236343, 4109.075458021921, 4118.691098167589, 4161.3549899765585, 4276.31578947367, 4401.493828209796], "mootools.html": [1339.9933000334997, 1406.9788953165705, 1415.0165634883754, 1432.4127107885763, 1453.2007395932235, 5658.8019419320335, 5910.527157827374, 6070.635761854292, 6431.774887878919, 6469.935300646992, 5974.551908606861, 6010.12853136295, 6116.296625888024, 6138.140660307549, 6144.8463788405315, 1733.072806048764, 1739.7564340992271, 1741.2599645150824, 1741.3992172700398, 1761.4099276742243, 1699.745038244267, 1737.5742942978989, 1743.015196414022, 1744.7557341972133, 1746.8165842586536, 1697.8047524534652, 1722.4918648998512, 1725.1374312843577, 1747.3971479839436, 1766.311138655925, 1702.7190513565247, 1707.9658406831857, 1709.9230534625972, 1721.3286818140934, 1751.6321572469797, 1743.8953662780148, 1766.3729376071437, 1768.8054314025446, 1769.8141695121956, 1786.9195886185153, 6239.126522286883, 6293.527985401113, 6310.0, 6349.904751428732, 6379.8405039873915, 3703.814809259526, 3774.358359078936, 3792.9620703792884, 3844.615538446161, 3848.9807550962064, 2003.7395138631884, 2048.016951863114, 2181.073043956312, 2223.2774348336857, 2290.358699564125, 646.2213033294869, 659.8251463362213, 665.7503436211421, 679.6771533521587, 679.9286074962157, 7620.80947976305, 7719.459637825355, 7739.729109481141, 7826.960865195638, 7858.5284882906635, 3353.0, 3362.075429256925, 3363.764536482423, 3388.1698983748647, 3397.11674964511, 7262.782116536512, 7278.818029549304, 7344.632768361561, 7370.742024029133, 7375.963120184365, 3867.1298957734284, 3875.1668391295443, 3896.376579747227, 3924.9018774530864, 3926.7447615904875, 3502.562179727534, 3511.227529943408, 3524.577050753926, 3555.413356796151, 3568.678818906311, 2819.266990582463, 2825.872835722397, 2853.486372452937, 2858.585505101749, 2894.0594306850357, 946.9905300946903, 965.9178969787506, 971.1502435369052, 972.3096601413076, 974.0940924939874, 1014.1531820929459, 1023.5803320638503, 1023.7696518283327, 1051.2431049644244, 1055.604148444318, 5801.9419805802245, 5852.970735146382, 5853.473187413153, 5906.940930590639, 5952.226210592596, 340.44507452851695, 342.44011041946595, 344.6140322838437, 348.67573156964266, 348.8848679935615, 4446.510883802779, 4617.515160908057, 4623.9075218495445, 4626.676132670681, 4628.190066738307, 6894.655267236618, 7002.159740831031, 7346.1551921528635, 7395.963020184865, 7525.36034437079, 7257.92742072583, 7355.963220183865, 7360.0, 7421.0723659542555, 7459.291367320096, 5480.780768769284, 5547.639403438763, 5563.693996830213, 5568.805091821767, 5669.262995810601, 5260.868478288074, 5359.598030147832, 5367.382750983531, 5369.812056578001, 5381.784728610968, 6100.969495152496, 6129.509639228761, 6163.660998645118, 6182.227221597301, 6201.0388389799655, 6358.904616430665, 6419.8395040122505, 6421.036844473367, 6436.13112229843, 6446.4520515756685, 5140.074786538459, 5185.585153187812, 5203.609729270395, 5213.374395072616, 5281.630285879952, 5579.553635709052, 5636.2954630671165, 5640.379558248672, 5643.633163844337, 5723.914141287801, 5263.6578622389425, 5292.497212764782, 5369.973150134224, 5371.382291036581, 5418.674879507084, 5193.818216362409, 5207.140821764367, 5248.08158572256, 5302.787888484418, 5354.196870469305, 5349.625526213128, 5369.758360873692, 5387.434319396407, 5398.514133727826, 5461.1262198048125, 4843.806247750051, 4878.195097808822, 4882.462929077869, 4899.412070551557, 4924.162892308244, 4963.578095861748, 4973.52751488608, 4976.2038073908, 5005.149124648746, 5039.748012599282], "ext.html": [420.1030799243614, 441.1375760388439, 445.9987328447635, 453.81166815771456, 480.57709215890014, 29689.55465668014, 30964.84517577409, 31147.532787008186, 31408.0, 31703.84148079259, 33023.83488082556, 33069.173270668245, 33466.66533334666, 33602.327953440916, 33746.0, 7016.438684905195, 7202.927970720304, 7220.855582888339, 7304.634768261566, 7323.011393461894, 7074.717011319541, 7196.208417074144, 7235.095613048369, 7321.926780732204, 7323.523970941872, 7094.680739366715, 7173.784786456415, 7194.1726701429225, 7195.928040719605, 7321.707131714725, 7118.537295075829, 7176.820579485502, 7178.318059784312, 7253.891191632103, 7294.562326260441, 7031.0, 7161.462890283197, 7171.856562868766, 7186.748463803794, 7190.101237345332, 30491.23771905698, 30980.845095774603, 31064.378712425852, 31131.688683113105, 31238.21904452384, 2036.7046778217223, 2145.3778404262744, 2154.4721543221854, 2272.749997500274, 2423.7212720537186, 20877.895610522002, 21333.893330533403, 21712.022958966885, 21970.0, 22063.66904496434, 1863.506170864722, 1868.2807119259048, 1885.811418858117, 1892.4322703188989, 1911.44568075258, 202854.0, 203757.0, 207611.0, 207710.0, 208522.9999999985, 42178.0, 45074.09851802946, 46341.768291158325, 46490.0, 46926.296105558446, 42011.78994105071, 43397.0, 43810.0, 43810.342844857354, 43838.34242486365, 12662.873371266169, 12915.741685166244, 13113.737725245632, 13122.409491572711, 13133.60599182026, 9510.524473776284, 9529.57116929726, 9776.0, 9861.654842080492, 9872.901270987342, 14858.925705371621, 15262.771058434133, 15416.845831541765, 15426.0, 15483.458078967182, 6510.511711621647, 6801.149856267966, 6970.616616086062, 7018.964905175441, 7023.192332881682, 676.1784431915247, 835.143977423134, 861.2722249698994, 863.0247819963402, 884.0717246890739, 21097.578048438947, 21312.0, 21780.891095544423, 21841.890790545945, 21884.343469695934, 748.2405358561065, 799.4403917257943, 841.9980223533975, 842.3724325377633, 923.3674932671141, 10440.216983726252, 10993.340399576051, 11032.613858514913, 11147.888521114684, 11153.498092585853, 313027.0, 318800.0, 324481.0, 324569.0, 324754.0, 41125.588744112174, 41807.0, 42537.36193957093, 42542.57457425448, 42578.36132458015, 1093.3549205968516, 1096.9341839489657, 1100.3342977498658, 1103.0623969625753, 1107.1032463704425, 20759.481012974193, 20766.480837979172, 21159.57680846405, 21301.6804747932, 21328.36014919555, 34553.654463455045, 35330.0, 35416.0, 35656.286874262885, 35718.107047324025, 230246.0, 230311.0, 231304.0, 233318.0, 233843.0, 24090.0, 33830.830845845616, 35033.29933401369, 35168.12079698028, 35730.53368328959, 32461.350772983937, 32565.511517326784, 32830.0, 33238.5014224782, 33341.83329083339, 27428.177154685392, 27631.30921726973, 27825.93057005716, 27949.580756288266, 28012.0, 27485.725142748317, 27512.862435687694, 27625.75684094261, 27803.30491737642, 28020.29949251285, 28010.719892801626, 28044.29889252785, 28199.89801121916, 28446.288842779097, 28456.288592785346, 23381.53236935218, 24168.51662966766, 25262.621060684472, 25360.239192824243, 25661.486770264117, 18500.537486562942, 18900.716489252398, 19173.0, 19196.520086997938, 19299.51751206231], "prototype.html": [244.96937882764655, 249.48979337255312, 254.89883702405604, 254.90058877037958, 256.2389702583327, 4830.058138662962, 4934.703917764937, 4992.500749925006, 5002.649814512981, 5059.721715305656, 4699.412573428322, 4823.083614113325, 4858.416989961201, 4899.706017638944, 4926.088673595387, 3708.1100535871333, 3714.4614030965495, 3738.1589142442867, 3756.530433695788, 3772.2455508898192, 3733.1227161617135, 3733.216024634816, 3751.8499260029566, 3763.0592351912023, 3799.3920972644382, 3680.613535578766, 3701.3152566775234, 3701.5743189533146, 3753.8498460061564, 3763.41667041609, 3430.4562946673846, 3582.8566857325677, 3608.711303095746, 3756.887293381203, 3781.470594116826, 3194.265318976625, 3194.6006749156354, 3202.1034110449114, 3237.109794806447, 3254.576905002358, 4728.881777955544, 4743.786529606142, 4769.928451073237, 4830.9371938173545, 4853.878653033667, 4192.4549808525, 4211.936820947688, 4221.24017676818, 4224.704270701052, 4286.099919016979, 5004.424491183524, 5087.364079490064, 5115.820946266863, 5126.0, 5188.818391356284, 3410.6930376266255, 3411.5394421752994, 3415.077928959192, 3419.059758566414, 3425.640307767673, 5319.867003324909, 5376.91934620981, 5388.649737767033, 5402.000629883484, 5473.01485732568, 3288.704016638514, 3374.4094783412806, 3397.864085436555, 3459.08334291413, 3465.5841299043773, 3490.441529355291, 3528.9117772055392, 3564.500969864221, 3575.0883524701035, 3598.7480876338927, 4142.482189726285, 4142.502899652061, 4146.983988922673, 4147.564505726855, 4188.392683061, 5144.61415393847, 5145.922811157836, 5178.0, 5194.662346947436, 5216.113260745682, 1165.8600967883738, 1190.3750530971136, 1221.7556488702116, 1224.2960297828783, 1273.8853503184573, 795.3915254830059, 795.6857041468587, 802.6548584108889, 812.8902598149292, 812.9553523722107, 4939.259111133359, 4964.453910069889, 4996.600271978233, 5021.422536408287, 5064.088464076502, 5349.117395629678, 5355.116405793078, 5357.08929481989, 5397.433269506724, 5445.809396671098, 4976.178930476431, 4992.8002879885125, 5039.672421292605, 5067.822626208065, 5068.189089745697, 2731.126039667327, 2872.0952899836484, 2883.9711602883704, 2887.97112028877, 2909.1418031680705, 5503.036968530491, 5523.7238138092935, 5536.031194540939, 5585.441455854382, 5585.692786896679, 5446.2647542582035, 5453.045716999589, 5519.420460851633, 5534.861628459321, 5540.750666220029, 5433.9184912225555, 5501.697406642593, 5507.03626865297, 5594.776208951596, 5596.132599447093, 5416.350037995466, 5419.945800541944, 5448.727563621724, 5514.503694667499, 5515.751791169327, 5306.893862122659, 5314.335708036496, 5398.1093119634825, 5404.8108316208745, 5410.215518749838, 5636.774529018958, 5647.661140331593, 5654.3497497788285, 5699.544036477155, 5707.429257074259, 3407.5399821023843, 3487.424574945207, 3548.4677298405445, 3552.1652411682717, 3557.911052223715, 5403.351597808131, 5426.511613954763, 5470.56235501151, 5490.396056433869, 5498.395176530498, 5238.5023422774775, 5255.710935898409, 5311.7609707564025, 5350.785968561214, 5352.625316227826, 5266.210068489757, 5266.473352664703, 5298.258243845942, 5304.9469505306, 5312.990531798946, 5022.372203474566, 5131.127708289525, 5171.3277273954145, 5202.8959420812125, 5246.081935661167, 5077.466865979019, 5078.898422031612, 5196.662216955886, 5235.424103348705, 5239.842804715865, 5059.747012649279, 5137.126688462896, 5142.871428214325, 5152.4847515248175, 5218.608604354613], "yui.html": [488.311480812055, 539.854239355374, 567.5062695454952, 576.6914700635161, 603.8339456649421, 8790.340724445668, 8929.732108036762, 8971.102889711026, 9033.593488293027, 9066.682666106688, 8263.214994575506, 8352.290055345304, 8483.236508714215, 8488.44825086369, 8515.95742021289, 530.400647268586, 539.2854467830122, 647.6081970407906, 649.6556824882808, 658.5883822610868, 670.7853486884198, 675.4056430341293, 675.587891386254, 676.2628734679199, 676.3101636330939, 680.877442060429, 686.7733647896182, 687.5771400588627, 689.7792706333975, 693.7606525748633, 680.4624346766049, 681.6455443169574, 681.7511608262998, 688.6419062087712, 690.7962151165418, 502.0060280644345, 503.5669324381029, 503.58705861193835, 504.0448350376017, 504.47282589693856, 8653.221210091122, 8657.22085012352, 8657.740267791976, 8664.523451210182, 8765.0, 6794.76218332356, 6960.582365058112, 7118.28817118284, 7553.093628764584, 7681.884771728429, 6708.123776726181, 6725.914258798702, 6859.2454829968665, 7147.964260178718, 7283.562986220791, 2241.7197850268717, 2293.7018187635667, 2308.1459859851793, 2356.0, 2397.2328854766483, 36452.63547364545, 37005.195938442164, 37053.0, 37323.81338093292, 37703.43444848357, 5045.520675535819, 5318.601104917147, 5345.278387417727, 5457.645253058538, 5478.260434841325, 9366.0, 9374.062593740571, 9394.67118650844, 9398.342116051948, 9529.332946693803, 4515.503294637587, 4590.734070301826, 4686.625069994392, 4705.717656940595, 4743.66794324394, 2820.863216063363, 2866.1974647098846, 2927.5608658701367, 2939.6472423309338, 3007.9398412032074, 1896.781870084958, 1909.8185672361103, 1916.377177417345, 1916.6933290673426, 1931.169597073244, 312.89048832908753, 313.5109229601828, 315.8389221497007, 316.82099613718174, 317.2322978392296, 310.813511892867, 339.2637975592969, 357.63878482732105, 419.7083027296061, 498.6484528407464, 5024.748762561857, 5441.401445841034, 5491.28613280271, 5767.68277744728, 5857.970710146422, 427.2181907109981, 446.3973635591925, 457.0721435485969, 465.4663576762311, 466.80160931603933, 2669.3460102275067, 2767.114523352548, 2785.512535306313, 2811.592319113717, 2822.8729707163225, 46947.0, 47308.5269147311, 47430.0, 47499.525004749514, 47642.5235747645, 41226.1754764903, 41858.58141418547, 42110.36834447486, 42178.789106054275, 42281.0, 34972.928925305685, 35807.4628880567, 35918.281634367166, 37236.0, 37280.44079338758, 5642.351129619982, 6049.51603871698, 6061.818145455643, 6315.494760419064, 6514.0, 27899.860500697367, 27911.581326279716, 28621.570676439453, 28735.71264287414, 29036.27409314784, 35468.645313546534, 37506.0, 37551.0, 37616.2476750458, 38349.2330153401, 5048.268001139741, 5068.670536415121, 5423.620346575702, 5516.80691175823, 5663.773449061991, 8628.956855215683, 8632.654693812177, 8660.17728315809, 8690.913090869264, 8695.478271303742, 8039.1156972734125, 8084.231997960184, 8100.432969692065, 8323.625436855235, 8817.603207855791, 7873.212678732081, 7898.170692077479, 7993.400494963017, 8016.599170041592, 8328.167183281623, 7329.963350183215, 7725.652345644347, 7775.105862825621, 7894.407919406182, 7906.446548741533, 6757.93242067573, 6774.0, 6973.79078627642, 7025.402840758593, 7433.479656423999, 6758.357955994173, 7145.785626431215, 7147.928520714726, 7248.637568121679, 7292.817679558054]}, "summary": {"lowerIsBetter": false, "suite": 5105.983672711734, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5220.38001401086, "unit": "ms", "value": 5220.38001401086}, "dojo.html": {"lowerIsBetter": false, "filtered": 4099.8694113393585, "unit": "ms", "value": 4099.8694113393585}, "mootools.html": {"lowerIsBetter": false, "filtered": 3400.2922530939086, "unit": "ms", "value": 3400.2922530939086}, "ext.html": {"lowerIsBetter": false, "filtered": 14482.30392996201, "unit": "ms", "value": 14482.30392996201}, "prototype.html": {"lowerIsBetter": false, "filtered": 3869.072896666594, "unit": "ms", "value": 3869.072896666594}, "yui.html": {"lowerIsBetter": false, "filtered": 4345.051160099927, "unit": "ms", "value": 4345.051160099927}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0084.e"}, "testrun": {"date": 1447759674, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117013304", "branch": "Fx-Team", "revision": "ab82ff5156bc1bd4281936310439f69e07073622"}}, {"talos_counters": {}, "results": {"audio-dft": [207.0, 212.0, 218.0, 218.0, 222.0, 222.0, 221.0, 218.0, 220.0, 222.0], "ai-astar": [140.0, 128.0, 147.0, 146.0, 146.0, 161.0, 146.0, 147.0, 147.0, 145.0], "imaging-gaussian-blur": [157.0, 165.0, 165.0, 157.0, 157.0, 158.0, 157.0, 157.0, 166.0, 166.0], "audio-beat-detection": [193.0, 178.0, 202.0, 219.0, 185.0, 208.0, 209.0, 179.0, 218.0, 173.0], "json-stringify-tinderbox": [88.0, 90.0, 89.0, 95.0, 95.0, 94.0, 95.0, 96.0, 97.0, 96.0], "stanford-crypto-pbkdf2": [201.0, 209.0, 211.0, 214.0, 211.0, 208.0, 213.0, 211.0, 209.0, 208.0], "json-parse-financial": [79.0, 80.0, 81.0, 82.0, 86.0, 87.0, 85.0, 92.0, 87.0, 85.0], "stanford-crypto-sha256-iterative": [94.0, 95.0, 106.0, 99.0, 94.0, 97.0, 97.0, 96.0, 96.0, 98.0], "audio-fft": [89.0, 97.0, 105.0, 154.0, 89.0, 93.0, 93.0, 96.0, 139.0, 94.0], "imaging-darkroom": [165.0, 173.0, 173.0, 173.0, 173.0, 174.0, 173.0, 172.0, 182.0, 184.0], "stanford-crypto-ccm": [162.0, 173.0, 168.0, 171.0, 188.0, 192.0, 181.0, 195.0, 181.0, 176.0], "audio-oscillator": [115.0, 115.0, 157.0, 116.0, 120.0, 122.0, 161.0, 119.0, 121.0, 162.0], "stanford-crypto-aes": [112.0, 111.0, 119.0, 117.0, 120.0, 117.0, 118.0, 117.0, 125.0, 125.0], "imaging-desaturate": [133.0, 130.0, 131.0, 147.0, 136.0, 138.0, 137.0, 150.0, 151.0, 150.0]}, "summary": {"lowerIsBetter": true, "suite": 2051.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 104.9, "unit": "ms", "value": 104.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 209.5, "unit": "ms", "value": 209.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 196.4, "unit": "ms", "value": 196.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 178.7, "unit": "ms", "value": 178.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 174.2, "unit": "ms", "value": 174.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 84.4, "unit": "ms", "value": 84.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 130.8, "unit": "ms", "value": 130.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 218.0, "unit": "ms", "value": 218.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 97.2, "unit": "ms", "value": 97.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 93.5, "unit": "ms", "value": 93.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 160.5, "unit": "ms", "value": 160.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 118.1, "unit": "ms", "value": 118.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 140.3, "unit": "ms", "value": 140.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0084.e"}, "testrun": {"date": 1447759674, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117013304", "branch": "Fx-Team", "revision": "ab82ff5156bc1bd4281936310439f69e07073622"}}, {"talos_counters": {}, "results": {"DeltaBlue": [257.7319587628866], "Encrypt": [415.11000415110004], "NavierStokes": [7367.64705882353], "Decrypt": [7563.909774436091], "Splay": [804.5052292839904], "Richards": [211.72983273343215], "RegExp": [38603.77358490566], "Earley": [1040.5827263267429], "Boyer": [17169.491525423728], "RayTrace": [1443.001443001443]}, "summary": {"lowerIsBetter": false, "suite": 15129.306858313268, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 256.5378400000001, "unit": "score", "value": 256.5378400000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 641.2300290000002, "unit": "score", "value": 641.2300290000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 201.4211576846308, "unit": "score", "value": 201.4211576846308}, "Decrypt": {"lowerIsBetter": false, "filtered": 35.19092743538764, "unit": "score", "value": 35.19092743538764}, "Splay": {"lowerIsBetter": false, "filtered": 101.29331299999996, "unit": "score", "value": 101.29331299999996}, "RegExp": {"lowerIsBetter": false, "filtered": 23.598340664711646, "unit": "score", "value": 23.598340664711646}, "Richards": {"lowerIsBetter": false, "filtered": 166.731346, "unit": "score", "value": 166.731346}, "Earley": {"lowerIsBetter": false, "filtered": 640.4709429999998, "unit": "score", "value": 640.4709429999998}, "Boyer": {"lowerIsBetter": false, "filtered": 38.81669990128329, "unit": "score", "value": 38.81669990128329}, "RayTrace": {"lowerIsBetter": false, "filtered": 512.812377, "unit": "score", "value": 512.812377}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0084.e"}, "testrun": {"date": 1447759674, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117013304", "branch": "Fx-Team", "revision": "ab82ff5156bc1bd4281936310439f69e07073622"}}] 03:48:16 INFO - RETURN: dromaeo_css: 5105.98 03:48:16 INFO - RETURN: kraken: 2051.80 03:48:16 INFO - RETURN: v8_7: 15129.31 03:48:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "15129.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "2051.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5105.98"}}} 03:48:16 INFO - Return code: 0 03:48:16 INFO - # TBPL SUCCESS # 03:48:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:48:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:48:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:48:16 INFO - 2015-11-17 03:48:16.404 screenresolution[1687:10557] starting screenresolution argv=screenresolution get 03:48:16 INFO - 2015-11-17 03:48:16.407 screenresolution[1687:10557] Display 0: 1600x1200x32@60 03:48:16 INFO - 2015-11-17 03:48:16.415 screenresolution[1688:10560] starting screenresolution argv=screenresolution list 03:48:16 INFO - Available Modes on Display 0 03:48:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:48:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:48:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:48:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:48:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:48:16 INFO - Intel HD Graphics 3000: 03:48:16 INFO - Chipset Model: Intel HD Graphics 3000 03:48:16 INFO - Type: GPU 03:48:16 INFO - Bus: Built-In 03:48:16 INFO - VRAM (Total): 512 MB 03:48:16 INFO - VRAM (Dynamic, Max): 10 03:48:16 INFO - Vendor: Intel (0x8086) 03:48:16 INFO - Device ID: 0x0116 03:48:16 INFO - Revision ID: 0x0009 03:48:16 INFO - Displays: 03:48:16 INFO - Display: 03:48:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:48:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:48:16 INFO - Display Serial Number: 1600x1200 60 03:48:16 INFO - Main Display: Yes 03:48:16 INFO - Mirror: Off 03:48:16 INFO - Online: Yes 03:48:16 INFO - Rotation: Supported 03:48:16 INFO - Return code: 0 03:48:16 INFO - Running post-action listener: _resource_record_post_action 03:48:16 INFO - Running post-run listener: _resource_record_post_run 03:48:17 INFO - Total resource usage - Wall time: 1268s; CPU: 30.0%; Read bytes: 40817664; Write bytes: 690293760; Read time: 5241; Write time: 47734 03:48:17 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 340038144; Write bytes: 335929344; Read time: 39804; Write time: 6695 03:48:17 INFO - run-tests - Wall time: 1223s; CPU: 30.0%; Read bytes: 38753280; Write bytes: 343165952; Read time: 4807; Write time: 40185 03:48:17 INFO - Running post-run listener: _upload_blobber_files 03:48:17 INFO - Blob upload gear active. 03:48:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:48:17 INFO - Copying logs to upload dir... 03:48:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1334.052633 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-11-17 03:48:17.882088) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:48:17.887757) ========= 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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011571 build_url: 'https://queue.taskcluster.net/v1/task/R0eZLFXQRQeHEp2kZxzfcA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:48:17.917801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:48:17.918182) ========= 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.p6k5vrs5YT/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.UdAr6jI327/Listeners TMPDIR=/var/folders/r4/6frw7rbj4sndx0m4qs9lmrth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.006102 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:48:17.969572) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 03:48:17.969953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 03:48:17.970454) ========= ========= Total master_lag: 0.91 =========