builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0242 starttime: 1468865107.26 results: success (0) buildid: 20160718021358 builduid: 9ea10ebdce4b46128745968a3732567e revision: e29236a2cb1019532749ae35f37266cbbba0c04c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.257046) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.257487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.257774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.285091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.285391) ========= 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.FcROANImyv/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.k9UeLswJwm/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-18 11:05:07-- 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% 236M=0s 2016-07-18 11:05:07 (236 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.533580 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.843110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.843423) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.039849 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:07.904856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-18 11:05:07.905374) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e29236a2cb1019532749ae35f37266cbbba0c04c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e29236a2cb1019532749ae35f37266cbbba0c04c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-18 11:05:07,985 truncating revision to first 12 chars 2016-07-18 11:05:07,985 Setting DEBUG logging. 2016-07-18 11:05:07,985 attempt 1/10 2016-07-18 11:05:07,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e29236a2cb10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 11:05:09,971 unpacking tar archive at: mozilla-beta-e29236a2cb10/testing/mozharness/ program finished with exit code 0 elapsedTime=2.251559 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-18 11:05:10.179048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:10.179372) ========= script_repo_revision: e29236a2cb1019532749ae35f37266cbbba0c04c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:10.179792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:10.180057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:05:10.198297) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-18 11:05:10.198662) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:05:10 INFO - MultiFileLogger online at 20160718 11:05:10 in /builds/slave/test 11:05:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:05:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:10 INFO - {'append_to_log': False, 11:05:10 INFO - 'base_work_dir': '/builds/slave/test', 11:05:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:05:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:10 INFO - 'branch': 'Mozilla-Beta', 11:05:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:10 INFO - 'config_files': ('talos/mac_config.py',), 11:05:10 INFO - 'default_actions': ('clobber', 11:05:10 INFO - 'read-buildbot-config', 11:05:10 INFO - 'download-and-extract', 11:05:10 INFO - 'populate-webroot', 11:05:10 INFO - 'create-virtualenv', 11:05:10 INFO - 'install', 11:05:10 INFO - 'run-tests'), 11:05:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:10 INFO - 'download_minidump_stackwalk': True, 11:05:10 INFO - 'download_symbols': 'ondemand', 11:05:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:10 INFO - 'installer_path': 'installer.exe', 11:05:10 INFO - 'log_level': 'info', 11:05:10 INFO - 'log_name': 'talos', 11:05:10 INFO - 'log_to_console': True, 11:05:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:05:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:05:10 INFO - 'opt_config_files': (), 11:05:10 INFO - 'pip_index': False, 11:05:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:10 INFO - 'cmd': ('bash', 11:05:10 INFO - '-c', 11:05:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:10 INFO - 'enabled': True, 11:05:10 INFO - 'halt_on_failure': False, 11:05:10 INFO - 'name': 'check_screen_resolution'},), 11:05:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:10 INFO - 'cmd': ('bash', 11:05:10 INFO - '-c', 11:05:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:10 INFO - 'enabled': True, 11:05:10 INFO - 'halt_on_failure': False, 11:05:10 INFO - 'name': 'check_screen_resolution'},), 11:05:10 INFO - 'run_cmd_checks_enabled': True, 11:05:10 INFO - 'sps_profile': False, 11:05:10 INFO - 'sps_profile_interval': 0, 11:05:10 INFO - 'suite': 'dromaeojs', 11:05:10 INFO - 'system_bits': '32', 11:05:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:10 INFO - 'title': 't-yosemite-r7-0242', 11:05:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:10 INFO - 'use_talos_json': True, 11:05:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:10 INFO - 'work_dir': 'build'} 11:05:10 INFO - ##### 11:05:10 INFO - ##### Running clobber step. 11:05:10 INFO - ##### 11:05:10 INFO - Running pre-action listener: _resource_record_pre_action 11:05:10 INFO - Running main action method: clobber 11:05:10 INFO - rmtree: /builds/slave/test/build 11:05:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:12 INFO - Running post-action listener: _resource_record_post_action 11:05:12 INFO - ##### 11:05:12 INFO - ##### Running read-buildbot-config step. 11:05:12 INFO - ##### 11:05:12 INFO - Running pre-action listener: _resource_record_pre_action 11:05:12 INFO - Running main action method: read_buildbot_config 11:05:12 INFO - Using buildbot properties: 11:05:12 INFO - { 11:05:12 INFO - "project": "", 11:05:12 INFO - "product": "firefox", 11:05:12 INFO - "script_repo_revision": "production", 11:05:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:05:12 INFO - "repository": "", 11:05:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:05:12 INFO - "buildid": "20160718021358", 11:05:12 INFO - "pgo_build": "False", 11:05:12 INFO - "basedir": "/builds/slave/test", 11:05:12 INFO - "buildnumber": 39, 11:05:12 INFO - "slavename": "t-yosemite-r7-0242", 11:05:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:05:12 INFO - "platform": "yosemite_r7", 11:05:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:05:12 INFO - "branch": "mozilla-beta", 11:05:12 INFO - "repo_path": "releases/mozilla-beta", 11:05:12 INFO - "revision": "e29236a2cb1019532749ae35f37266cbbba0c04c", 11:05:12 INFO - "stage_platform": "macosx64", 11:05:12 INFO - "builduid": "9ea10ebdce4b46128745968a3732567e", 11:05:12 INFO - "slavebuilddir": "test" 11:05:12 INFO - } 11:05:12 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg. 11:05:12 INFO - Running post-action listener: _resource_record_post_action 11:05:12 INFO - ##### 11:05:12 INFO - ##### Running download-and-extract step. 11:05:12 INFO - ##### 11:05:12 INFO - Running pre-action listener: _resource_record_pre_action 11:05:12 INFO - Running main action method: download_and_extract 11:05:12 INFO - mkdir: /builds/slave/test/build/tests 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.test_packages.json 11:05:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 11:05:12 INFO - Downloaded 1165 bytes. 11:05:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:05:12 INFO - Using the following test package requirements: 11:05:12 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:05:12 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 11:05:12 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 11:05:12 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:05:12 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 11:05:12 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:05:12 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 11:05:12 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 11:05:12 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 11:05:12 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:05:12 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 11:05:12 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.common.tests.zip 11:05:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:05:14 INFO - Downloaded 18314749 bytes. 11:05:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:05:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:05:17 INFO - Return code: 0 11:05:17 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.common.tests.zip 11:05:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:05:17 INFO - Downloaded 18314749 bytes. 11:05:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:05:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:05:21 INFO - Return code: 0 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.talos.tests.zip 11:05:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 11:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 11:05:26 INFO - Downloaded 10840145 bytes. 11:05:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:05:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:05:26 INFO - Return code: 0 11:05: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')]} 11:05:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg 11:05:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 11:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 11:05:40 INFO - Downloaded 86191951 bytes. 11:05:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg 11:05:40 INFO - mkdir: /builds/slave/test/properties 11:05:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:40 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:40 INFO - Contents: 11:05:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg 11:05:40 INFO - Running post-action listener: _resource_record_post_action 11:05:40 INFO - Running post-action listener: set_extra_try_arguments 11:05:40 INFO - ##### 11:05:40 INFO - ##### Running populate-webroot step. 11:05:40 INFO - ##### 11:05:40 INFO - Running pre-action listener: _resource_record_pre_action 11:05:40 INFO - Running main action method: populate_webroot 11:05:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:40 INFO - '--tppagecycles', 11:05:40 INFO - '7'], 11:05:40 INFO - 'tests': ['tsvgm']}}, 11:05:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['damp', 'tps']}, 11:05:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'tests': ['damp', 'tps']}, 11:05:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['dromaeo_dom']}, 11:05:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['a11yr', 11:05:40 INFO - 'ts_paint', 11:05:40 INFO - 'tpaint', 11:05:40 INFO - 'sessionrestore', 11:05:40 INFO - 'sessionrestore_no_auto_restore', 11:05:40 INFO - 'tabpaint']}, 11:05:40 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:40 INFO - 'ts_paint', 11:05:40 INFO - 'tpaint', 11:05:40 INFO - 'sessionrestore', 11:05:40 INFO - 'sessionrestore_no_auto_restore', 11:05:40 INFO - 'tabpaint']}, 11:05:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:05:40 INFO - 'ts_paint', 11:05:40 INFO - 'tpaint', 11:05:40 INFO - 'sessionrestore', 11:05:40 INFO - 'sessionrestore_no_auto_restore', 11:05:40 INFO - 'tabpaint']}, 11:05:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:05:40 INFO - 'ts_paint', 11:05:40 INFO - 'tpaint', 11:05:40 INFO - 'sessionrestore', 11:05:40 INFO - 'sessionrestore_no_auto_restore', 11:05:40 INFO - 'tabpaint']}, 11:05:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['a11yr', 11:05:40 INFO - 'ts_paint', 11:05:40 INFO - 'tpaint', 11:05:40 INFO - 'sessionrestore', 11:05:40 INFO - 'sessionrestore_no_auto_restore', 11:05:40 INFO - 'tabpaint']}, 11:05:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['a11yr', 11:05:40 INFO - 'ts_paint', 11:05:40 INFO - 'tpaint', 11:05:40 INFO - 'sessionrestore', 11:05:40 INFO - 'sessionrestore_no_auto_restore', 11:05:40 INFO - 'tabpaint']}, 11:05:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['tsvgx', 11:05:40 INFO - 'tsvgr_opacity', 11:05:40 INFO - 'tart', 11:05:40 INFO - 'tscrollx', 11:05:40 INFO - 'cart']}, 11:05:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:40 INFO - 'tsvgr_opacity', 11:05:40 INFO - 'tart', 11:05:40 INFO - 'tscrollx', 11:05:40 INFO - 'cart']}, 11:05:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'talos_options': ['--disable-e10s'], 11:05:40 INFO - 'tests': ['tp5o']}, 11:05:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'tests': ['tp5o']}, 11:05:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'talos_options': ['--disable-e10s', 11:05:40 INFO - '--xperf_path', 11:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:40 INFO - 'tests': ['tp5n']}, 11:05:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:40 INFO - 'talos_options': ['--xperf_path', 11:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:40 INFO - 'tests': ['tp5n']}}, 11:05:40 INFO - 'talos.zip': {'path': '', 11:05:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:40 INFO - Running post-action listener: _resource_record_post_action 11:05:40 INFO - ##### 11:05:40 INFO - ##### Running create-virtualenv step. 11:05:40 INFO - ##### 11:05:40 INFO - Running pre-action listener: _resource_record_pre_action 11:05:40 INFO - Running main action method: create_virtualenv 11:05:40 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:40 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 11:05:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:40 INFO - Using real prefix '/tools/python27' 11:05:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:41 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:44 INFO - Installing pip.................done. 11:05:44 INFO - Return code: 0 11:05:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 11:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:44 INFO - 'HOME': '/Users/cltbld', 11:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:44 INFO - 'LOGNAME': 'cltbld', 11:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:44 INFO - 'MOZ_NO_REMOTE': '1', 11:05:44 INFO - 'NO_EM_RESTART': '1', 11:05:44 INFO - 'PAGER': '/bin/cat', 11:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:44 INFO - 'PWD': '/builds/slave/test', 11:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:44 INFO - 'SHELL': '/bin/bash', 11:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:05:44 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:44 INFO - 'USER': 'cltbld', 11:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:44 INFO - 'XPC_FLAGS': '0x0', 11:05:44 INFO - 'XPC_SERVICE_NAME': '0', 11:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:44 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 11:05:44 INFO - Cleaning up... 11:05:44 INFO - Return code: 0 11:05:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 11:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:44 INFO - 'HOME': '/Users/cltbld', 11:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:44 INFO - 'LOGNAME': 'cltbld', 11:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:44 INFO - 'MOZ_NO_REMOTE': '1', 11:05:44 INFO - 'NO_EM_RESTART': '1', 11:05:44 INFO - 'PAGER': '/bin/cat', 11:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:44 INFO - 'PWD': '/builds/slave/test', 11:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:44 INFO - 'SHELL': '/bin/bash', 11:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:05:44 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:44 INFO - 'USER': 'cltbld', 11:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:44 INFO - 'XPC_FLAGS': '0x0', 11:05:44 INFO - 'XPC_SERVICE_NAME': '0', 11:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:44 INFO - Downloading/unpacking psutil>=0.7.1 11:05:44 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 11:05:44 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 11:05:44 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 11:05:44 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 11:05:44 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 11:05:44 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 11:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:48 INFO - Installing collected packages: psutil 11:05:48 INFO - Running setup.py install for psutil 11:05:48 INFO - building 'psutil._psutil_osx' extension 11:05:48 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 11:05:49 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 11:05:49 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 11:05:49 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 11:05:49 INFO - building 'psutil._psutil_posix' extension 11:05:49 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 11:05:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:05:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:05:49 INFO - ^ 11:05:49 INFO - 1 warning generated. 11:05:49 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 11:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:49 INFO - Successfully installed psutil 11:05:49 INFO - Cleaning up... 11:05:49 INFO - Return code: 0 11:05:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:05:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 11:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:49 INFO - 'HOME': '/Users/cltbld', 11:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:49 INFO - 'LOGNAME': 'cltbld', 11:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:49 INFO - 'MOZ_NO_REMOTE': '1', 11:05:49 INFO - 'NO_EM_RESTART': '1', 11:05:49 INFO - 'PAGER': '/bin/cat', 11:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:49 INFO - 'PWD': '/builds/slave/test', 11:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:49 INFO - 'SHELL': '/bin/bash', 11:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:05:49 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:49 INFO - 'USER': 'cltbld', 11:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:49 INFO - 'XPC_FLAGS': '0x0', 11:05:49 INFO - 'XPC_SERVICE_NAME': '0', 11:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:05:52 INFO - Installing collected packages: mozsystemmonitor 11:05:52 INFO - Running setup.py install for mozsystemmonitor 11:05:52 INFO - Successfully installed mozsystemmonitor 11:05:52 INFO - Cleaning up... 11:05:52 INFO - Return code: 0 11:05:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05:52 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')]} 11:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:52 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')]} 11:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 11:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:52 INFO - 'HOME': '/Users/cltbld', 11:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:52 INFO - 'LOGNAME': 'cltbld', 11:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:52 INFO - 'MOZ_NO_REMOTE': '1', 11:05:52 INFO - 'NO_EM_RESTART': '1', 11:05:52 INFO - 'PAGER': '/bin/cat', 11:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:52 INFO - 'PWD': '/builds/slave/test', 11:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:52 INFO - 'SHELL': '/bin/bash', 11:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:05:52 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:52 INFO - 'USER': 'cltbld', 11:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:52 INFO - 'XPC_FLAGS': '0x0', 11:05:52 INFO - 'XPC_SERVICE_NAME': '0', 11:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:55 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:55 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 11:05:55 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 11:05:55 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 11:05:55 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 11:05:55 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 11:05:55 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 11:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:56 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 11:05:56 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 11:05:56 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 11:05:56 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 11:05:56 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 11:05:56 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 11:05:56 INFO - Downloading docopt-0.6.1.tar.gz 11:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:56 INFO - Running setup.py install for blobuploader 11:05:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:56 INFO - Running setup.py install for requests 11:05:57 INFO - Running setup.py install for docopt 11:05:57 INFO - Successfully installed blobuploader requests docopt 11:05:57 INFO - Cleaning up... 11:05:57 INFO - Return code: 0 11:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 11:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 11:05:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:05:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:57 INFO - 'HOME': '/Users/cltbld', 11:05:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:57 INFO - 'LOGNAME': 'cltbld', 11:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:57 INFO - 'MOZ_NO_REMOTE': '1', 11:05:57 INFO - 'NO_EM_RESTART': '1', 11:05:57 INFO - 'PAGER': '/bin/cat', 11:05:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:57 INFO - 'PWD': '/builds/slave/test', 11:05:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:57 INFO - 'SHELL': '/bin/bash', 11:05:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:05:57 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:05:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:57 INFO - 'USER': 'cltbld', 11:05:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:57 INFO - 'XPC_FLAGS': '0x0', 11:05:57 INFO - 'XPC_SERVICE_NAME': '0', 11:05:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-xoN_JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Hu408m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-bZo5O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-F6bGJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-dc3fe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-au2zmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-jNZGLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-TBpYWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-T8H0PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-nNDwy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-xdOq74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-JJ8hg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:59 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-7gyH42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:59 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-JqTCH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:59 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-148vCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:59 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-30cOdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:59 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-fq8hhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:59 INFO - Running setup.py install for manifestparser 11:05:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:59 INFO - Running setup.py install for mozcrash 11:05:59 INFO - Running setup.py install for mozdebug 11:05:59 INFO - Running setup.py install for mozdevice 11:06:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Running setup.py install for mozfile 11:06:00 INFO - Running setup.py install for mozhttpd 11:06:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Running setup.py install for mozinfo 11:06:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Running setup.py install for mozInstall 11:06:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Running setup.py install for mozleak 11:06:00 INFO - Running setup.py install for mozlog 11:06:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:01 INFO - Running setup.py install for moznetwork 11:06:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:01 INFO - Running setup.py install for mozprocess 11:06:01 INFO - Running setup.py install for mozprofile 11:06:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:01 INFO - Running setup.py install for mozrunner 11:06:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:01 INFO - Running setup.py install for mozscreenshot 11:06:01 INFO - Running setup.py install for moztest 11:06:02 INFO - Running setup.py install for mozversion 11:06:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:02 INFO - Cleaning up... 11:06:02 INFO - Return code: 0 11:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:02 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')]} 11:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:02 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')]} 11:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 11:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:02 INFO - 'HOME': '/Users/cltbld', 11:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:02 INFO - 'LOGNAME': 'cltbld', 11:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:02 INFO - 'MOZ_NO_REMOTE': '1', 11:06:02 INFO - 'NO_EM_RESTART': '1', 11:06:02 INFO - 'PAGER': '/bin/cat', 11:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:02 INFO - 'PWD': '/builds/slave/test', 11:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:02 INFO - 'SHELL': '/bin/bash', 11:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:06:02 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:02 INFO - 'USER': 'cltbld', 11:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:02 INFO - 'XPC_FLAGS': '0x0', 11:06:02 INFO - 'XPC_SERVICE_NAME': '0', 11:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:02 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-zc4fPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:02 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)) 11:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:02 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-i9mBXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 11:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:02 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-sqLCX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06: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)) 11:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:02 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-SHgA_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 11:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:02 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-ZgtL1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06: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)) 11:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:02 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-qLEdJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:03 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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-0mWH1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:03 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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-lQqhHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06: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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-x4L8Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06: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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-tIcp5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-nvBtSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06: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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-IewhTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06: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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-8orPbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-m1nQWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06: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)) 11:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:03 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-bdkNOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06: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)) 11:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:04 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-I3OGKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06: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)) 11:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:04 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-HHrFg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06: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)) 11:06: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06: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)) 11:06: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06:06 INFO - Downloading blessings-1.6.tar.gz 11:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:06 INFO - Installing collected packages: blessings 11:06:06 INFO - Running setup.py install for blessings 11:06:06 INFO - Successfully installed blessings 11:06:06 INFO - Cleaning up... 11:06:07 INFO - Return code: 0 11:06:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:07 INFO - Reading from file tmpfile_stdout 11:06:07 INFO - Current package versions: 11:06:07 INFO - blessings == 1.6 11:06:07 INFO - blobuploader == 1.2.4 11:06:07 INFO - docopt == 0.6.1 11:06:07 INFO - manifestparser == 1.1 11:06:07 INFO - mozInstall == 1.12 11:06:07 INFO - mozcrash == 0.17 11:06:07 INFO - mozdebug == 0.1 11:06:07 INFO - mozdevice == 0.48 11:06:07 INFO - mozfile == 1.2 11:06:07 INFO - mozhttpd == 0.7 11:06:07 INFO - mozinfo == 0.9 11:06:07 INFO - mozleak == 0.1 11:06:07 INFO - mozlog == 3.1 11:06:07 INFO - moznetwork == 0.27 11:06:07 INFO - mozprocess == 0.22 11:06:07 INFO - mozprofile == 0.28 11:06:07 INFO - mozrunner == 6.11 11:06:07 INFO - mozscreenshot == 0.1 11:06:07 INFO - mozsystemmonitor == 0.0 11:06:07 INFO - moztest == 0.7 11:06:07 INFO - mozversion == 1.4 11:06:07 INFO - psutil == 3.1.1 11:06:07 INFO - requests == 1.2.3 11:06:07 INFO - wsgiref == 0.1.2 11:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:07 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')]} 11:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:07 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')]} 11:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 11:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:07 INFO - 'HOME': '/Users/cltbld', 11:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:07 INFO - 'LOGNAME': 'cltbld', 11:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:07 INFO - 'MOZ_NO_REMOTE': '1', 11:06:07 INFO - 'NO_EM_RESTART': '1', 11:06:07 INFO - 'PAGER': '/bin/cat', 11:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:07 INFO - 'PWD': '/builds/slave/test', 11:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:07 INFO - 'SHELL': '/bin/bash', 11:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:06:07 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:07 INFO - 'USER': 'cltbld', 11:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:07 INFO - 'XPC_FLAGS': '0x0', 11:06:07 INFO - 'XPC_SERVICE_NAME': '0', 11:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:07 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 2)) 11:06:07 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 3)) 11:06:07 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 4)) 11:06:07 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 5)) 11:06:07 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 6)) 11:06:07 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 7)) 11:06:07 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 8)) 11:06:07 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 9)) 11:06:07 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:07 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 4)) 11:06:07 INFO - Cleaning up... 11:06:07 INFO - Return code: 0 11:06:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:07 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')]} 11:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:07 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')]} 11:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 11:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 11:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:07 INFO - 'HOME': '/Users/cltbld', 11:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:07 INFO - 'LOGNAME': 'cltbld', 11:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:07 INFO - 'MOZ_NO_REMOTE': '1', 11:06:07 INFO - 'NO_EM_RESTART': '1', 11:06:07 INFO - 'PAGER': '/bin/cat', 11:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:07 INFO - 'PWD': '/builds/slave/test', 11:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:07 INFO - 'SHELL': '/bin/bash', 11:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:06:07 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:07 INFO - 'USER': 'cltbld', 11:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:07 INFO - 'XPC_FLAGS': '0x0', 11:06:07 INFO - 'XPC_SERVICE_NAME': '0', 11:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:07 INFO - Downloading/unpacking jsonschema 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 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 11:06:07 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 11:06:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:10 INFO - Downloading/unpacking functools32 (from jsonschema) 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:10 INFO - warning: no files found matching '*.txt' 11:06:10 INFO - no previously-included directories found matching 'build' 11:06:10 INFO - no previously-included directories found matching 'dist' 11:06:10 INFO - no previously-included directories found matching '.git*' 11:06:10 INFO - Installing collected packages: jsonschema, functools32 11:06:10 INFO - Running setup.py install for functools32 11:06:10 INFO - warning: no files found matching '*.txt' 11:06:10 INFO - no previously-included directories found matching 'build' 11:06:10 INFO - no previously-included directories found matching 'dist' 11:06:10 INFO - no previously-included directories found matching '.git*' 11:06:11 INFO - Successfully installed jsonschema functools32 11:06:11 INFO - Cleaning up... 11:06:11 INFO - Return code: 0 11:06:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:06:11 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')]} 11:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:11 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')]} 11:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108116420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc495b75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/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.k9UeLswJwm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 11:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 11:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:11 INFO - 'HOME': '/Users/cltbld', 11:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:11 INFO - 'LOGNAME': 'cltbld', 11:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:11 INFO - 'MOZ_NO_REMOTE': '1', 11:06:11 INFO - 'NO_EM_RESTART': '1', 11:06:11 INFO - 'PAGER': '/bin/cat', 11:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:11 INFO - 'PWD': '/builds/slave/test', 11:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:11 INFO - 'SHELL': '/bin/bash', 11:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:06:11 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:11 INFO - 'USER': 'cltbld', 11:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:11 INFO - 'XPC_FLAGS': '0x0', 11:06:11 INFO - 'XPC_SERVICE_NAME': '0', 11:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:11 INFO - Downloading/unpacking flake8 11:06:11 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 11:06:11 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 11:06:11 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 11:06:11 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 11:06:11 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 11:06:11 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 11:06:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:06:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:06:13 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 11:06:13 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 11:06:13 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 11:06:13 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 11:06:13 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 11:06:13 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 11:06:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:06:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:06:15 INFO - no previously-included directories found matching 'docs/_build' 11:06:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:06:15 INFO - Running setup.py install for pep8 11:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:06:15 INFO - no previously-included directories found matching 'docs/_build' 11:06:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:06:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:06:15 INFO - Cleaning up... 11:06:15 INFO - Return code: 0 11:06:15 INFO - Running post-action listener: _resource_record_post_action 11:06:15 INFO - Running post-action listener: _start_resource_monitoring 11:06:15 INFO - Starting resource monitoring. 11:06:15 INFO - ##### 11:06:15 INFO - ##### Running install step. 11:06:15 INFO - ##### 11:06:15 INFO - Running pre-action listener: _resource_record_pre_action 11:06:15 INFO - Running main action method: install 11:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:15 INFO - Reading from file tmpfile_stdout 11:06:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:15 INFO - Reading from file tmpfile_stdout 11:06:15 INFO - Output received: 11:06:15 INFO - Usage: mozinstall [options] installer 11:06:15 INFO - Options: 11:06:15 INFO - -h, --help show this help message and exit 11:06:15 INFO - -d DEST, --destination=DEST 11:06:15 INFO - Directory to install application into. [default: 11:06:15 INFO - "/builds/slave/test"] 11:06:15 INFO - --app=APP Application being installed. [default: firefox] 11:06:15 INFO - mkdir: /builds/slave/test/build/application 11:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:06:37 INFO - Reading from file tmpfile_stdout 11:06:37 INFO - Output received: 11:06:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:06:37 INFO - Running post-action listener: _resource_record_post_action 11:06:37 INFO - ##### 11:06:37 INFO - ##### Running run-tests step. 11:06:37 INFO - ##### 11:06:37 INFO - Running pre-action listener: _resource_record_pre_action 11:06:37 INFO - Running main action method: run_tests 11:06:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:37 INFO - 2016-07-18 11:06:37.490 screenresolution[1646:7763] starting screenresolution argv=screenresolution get 11:06:37 INFO - 2016-07-18 11:06:37.493 screenresolution[1646:7763] Display 0: 1600x1200x32@60 11:06:37 INFO - 2016-07-18 11:06:37.499 screenresolution[1647:7766] starting screenresolution argv=screenresolution list 11:06:37 INFO - Available Modes on Display 0 11:06:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:37 INFO - Intel Iris: 11:06:37 INFO - Chipset Model: Intel Iris 11:06:37 INFO - Type: GPU 11:06:37 INFO - Bus: Built-In 11:06:37 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:37 INFO - Vendor: Intel (0x8086) 11:06:37 INFO - Device ID: 0x0a2e 11:06:37 INFO - Revision ID: 0x0009 11:06:37 INFO - Displays: 11:06:37 INFO - Display: 11:06:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:37 INFO - Display Serial Number: 1600x1200 60 11:06:37 INFO - Main Display: Yes 11:06:37 INFO - Mirror: Off 11:06:37 INFO - Online: Yes 11:06:37 INFO - Rotation: Supported 11:06:37 INFO - Return code: 0 11:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:37 INFO - Python 2.7.3 11:06:37 INFO - Return code: 0 11:06:37 INFO - grabbing minidump binary from tooltool 11:06: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')]} 11:06:37 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 0x107fa5e00>, '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 0x107e0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fa0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:37 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 11:06:37 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 11:06:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:37 INFO - Return code: 0 11:06:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:06:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:06:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:06:38 INFO - Return code: 0 11:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcROANImyv/Render', 11:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:38 INFO - 'HOME': '/Users/cltbld', 11:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:38 INFO - 'LOGNAME': 'cltbld', 11:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:38 INFO - 'MOZ_NO_REMOTE': '1', 11:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:38 INFO - 'NO_EM_RESTART': '1', 11:06:38 INFO - 'PAGER': '/bin/cat', 11:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:38 INFO - 'PWD': '/builds/slave/test', 11:06:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:38 INFO - 'SHELL': '/bin/bash', 11:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k9UeLswJwm/Listeners', 11:06:38 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 11:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:38 INFO - 'USER': 'cltbld', 11:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:38 INFO - 'XPC_FLAGS': '0x0', 11:06:38 INFO - 'XPC_SERVICE_NAME': '0', 11:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:06:39 INFO - mozversion application_buildid: 20160718021358 11:06:39 INFO - mozversion application_changeset: e29236a2cb1019532749ae35f37266cbbba0c04c 11:06:39 INFO - mozversion application_display_name: Firefox 11:06:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:39 INFO - mozversion application_name: Firefox 11:06:39 INFO - mozversion application_remotingname: firefox 11:06:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:39 INFO - mozversion application_vendor: Mozilla 11:06:39 INFO - mozversion application_version: 48.0 11:06:39 INFO - mozversion platform_buildid: 20160718021358 11:06:39 INFO - mozversion platform_changeset: e29236a2cb1019532749ae35f37266cbbba0c04c 11:06:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:39 INFO - mozversion platform_version: 48.0 11:06:39 INFO - using testdate: 1468865199 11:06:39 INFO - actual date: 1468865199 11:06:39 INFO - starting webserver on 'localhost:49278' 11:06:39 INFO - SUITE-START | Running 2 tests 11:06:39 INFO - TEST-START | dromaeo_css 11:06:39 INFO - operating with platform_type : mac_ 11:06:39 INFO - Initialising browser for dromaeo_css test... 11:06:39 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpkOt5PU/profile http://localhost:49278/getInfo.html) 11:06:41 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 11:06:41 INFO - PROCESS | 1665 | colorDepth:24 11:06:41 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 11:06:41 INFO - PROCESS | 1665 | __metrics 11:06:41 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:06:41 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:06:42 INFO - TEST-INFO | 1665: exit 0 11:06:42 INFO - Browser initialized. 11:06:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:42 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpkOt5PU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:54 INFO - PROCESS | 1669 | RSS: Main: 160378880 11:06:54 INFO - PROCESS | 1669 | 11:07:45 INFO - PROCESS | 1669 | 1468865265770 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] 11:09:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 11:09:56 INFO - PROCESS | 1669 | RSS: Main: 251596800 11:09:56 INFO - PROCESS | 1669 | 11:12:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 11:13:00 INFO - PROCESS | 1669 | RSS: Main: 300322816 11:13:00 INFO - PROCESS | 1669 | 11:16:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 11:16:02 INFO - PROCESS | 1669 | RSS: Main: 310779904 11:16:02 INFO - PROCESS | 1669 | 11:19:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 11:19:05 INFO - PROCESS | 1669 | RSS: Main: 305643520 11:19:05 INFO - PROCESS | 1669 | 11:22:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 11:22:09 INFO - PROCESS | 1669 | RSS: Main: 269848576 11:22:09 INFO - PROCESS | 1669 | 11:25:11 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 11:25:12 INFO - PROCESS | 1669 | RSS: Main: 316944384 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | __start_tp_report 11:25:12 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 11:25:12 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 11:25:12 INFO - PROCESS | 1669 | |i|pagename|runs| 11:25:12 INFO - PROCESS | 1669 | |0;dojo.html;3516.507688923551;3629.364861149298;3638.054105932457;3638.6179451157627;3720.3861362875127;6027.156198132259;6028.216331876855;6033.517318614511;6046.637201767886;6088.969555152218;6027.089047403343;6076;6095.481884039862;6102.216595924237;6122;5342.332208473941;5407.5133238008575;5449.100898351767;5459.372172200208;5508.614396992212;5445.482679145475;5504.422035686255;5505.981393442206;5507.449255074501;5517.668939863601;5357.732113394334;5423.83728488146;5427.9185812212845;5465.043617366965;5483.232347471358;5459.808906688287;5503.889922201573;5509.118541033416;5518;5520.723963801834;5329.333833270841;5349.59878009147;5369.6509726867625;5424.105022671254;5481.12302031677;5873.471387575139;5910.67491287979;5939.2575928009;5945.851353716192;5961.225040744675;6271.641791044776;6302.1177035215105;6321.74713011479;6324.430801227912;6327.4938004959495;6207.596506227081;6255.906161407583;6280.78017269398;6385.457236134934;6407.967960160169;6111.197196826946;6115.6330620162935;6124.387561243884;6132.110843927606;6140.969295153585;5520.834374968757;6449.742010319628;6454.419102280724;6463.353664633499;6463.967680161663;6214.471769899519;6221.346758590374;6290;6298.559100862987;6301.7164227609865;6343.841403964845;6351.841203969845;6354.332795056545;6357.809265722036;6367.395097465826;6233.501319894398;6288.937110628835;6297.370262973666;6305.14880491137;6310.684465776692;6205.162303089025;6258.593191442542;6287.308396076428;6294.748210071637;6313.558050936482;5074.213496907985;5115.079285728604;5126.897462050738;5127.589792816566;5127.897442051138;4512.842050528281;4616.215243408628;4634.374359461497;4634.884127896829;4657.394538710014;5012.523810238022;5948.405159484017;6038.305594856648;6107.85643655375;6132.110769107974;6303.495720342362;6329.525285603599;6396.0725694774;6397.4562162216735;6415.518836087312;6085.17850090241;6088.391160883876;6107.480864126599;6134.386561343919;6140.8771824564155;5467.097928841697;5577.3028371453565;5579.38626751057;5626.381098079208;5659.151127330933;6565.770198043046;6579.80260592183;6608.900866486911;6623.602583844985;6640.0703901453835;6233.875322493615;6341.682915854281;6359.395857393541;6366.395192456709;6375.394337537927;6472.805815825533;6540.934590654223;6589.538732288694;6592.879210534316;6613.735450582115;6253.280872699515;6283.994560870239;6287.811365659038;6290.968545157245;6297.023961286008;6214.658193799203;6249.625022498664;6259.749610015549;6290.119383286435;6339.96830015847;6215.65813880241;6258.967270400515;6261.68691565429;6265.780697675559;6281.434670879643;6221.968890155701;6250.812475625738;6255.24937007562;6259;6275.090111933835;5099.337086178922;6131.590761709946;6251.843703907439;6276.403741644536;6292.653904035322;6187.257529096537;6215.9378406215355;6265.122882796321;6268.749250029948;6292.370762923671;6222.09779581949;6261.24865016201;6298.307186209605;6305.716242769178;6307.747690092345 11:25:12 INFO - PROCESS | 1669 | |1;ext.html;502.8843366025814;527.506781159616;585.8769658371742;611.4894063457015;632.5730132160791;32191.67808321919;38692;39411;39443.2111357773;39489.605103948954;42734.931626709345;43211.78394108033;43272.35091473631;43295;43345.56654433455;8991.190792828644;9654.71035868925;9853.753656158582;9858.309918305722;9864.506774661239;11833.7633247335;12070.336131512764;12081.939590302036;12112.636620901387;12120.212186207913;11752.23610465317;11815.7636847263;11829.940850295736;11830.7633847323;11850.3482308473;11719.941400292986;11813.763724725457;11820.172587918849;11825.11311651621;11826.822597661085;11644.359560224184;11733.882661173364;11734.295942243492;11736.941315293454;11740.412979350998;41721.79139104285;42213.577864221275;42322.57677423248;42347.36478952818;42420.78789606032;3295.8516866740815;3359.5968483781858;3366.091155388056;3410.778299410555;3931.5478719947287;27308.044218452458;27321.726782732316;28651.283717907012;28925.42149157026;30265.394692106256;2781.986090069557;2787.846668433235;2804.284907348613;2875.611792408019;2896.203544025389;537953;539935;541325;544482.999999996;544916;37334;37905.62094379076;37973.43039854404;37990;63532;37769.24461510754;37921.241575168344;37940.62059379371;37960.62039379571;37992.62007379946;16386.508404747878;16592.25334859934;16622.25199866009;16629.83370166283;16630;12832.422540985677;12984;14071.015028947875;14239.715205696035;14393.496227631982;7072.9646351767915;8342.833143337099;8366.45618034838;8393.874091888627;8471.322294216448;3542.4863394808126;3582.3193593217206;3596.3526565218513;3609.3683605368956;3630.419132938717;990.8860481044628;1081.7944590527932;1105.165599972032;1117.94969226385;1135.2393896089475;27656.47889366064;29679;30043;30689.079327620206;30852.845735771625;1136.4147464056018;1171.1392126786805;1181.3797756178076;1207.3057991654834;1254.6926003129292;15704.92147539255;15869.603259918364;16028.441745851811;16099.195040247942;16187.676246475241;642175;650325;651524;652184;652508;55757.88484230293;61994.76010479765;63174.36825631685;63909.72180556456;64069;1431.6277767780243;1470.1326217531707;1562.8280889102189;1581.1619841484032;1587.0874247307613;29315.413691726473;29717.554236686898;29739.10782676523;29897.402051959274;30497;47667.523324766305;48040.27939580839;48245.03509929852;48332.51667483421;48496.27255591098;447218;449317.75341123086;450228;454162;809384;27446.313842154104;28297.43405131927;28327.71672283333;28349.858250708614;28384;42429.5757042438;44361.669149925554;44427;44606.55393446024;44677.77661111674;36054.09864753297;36508.26983460263;37760.62239377571;38487.2302553953;38521.807390962866;37310;37351.813240933625;37571;37974.810125949196;38123.80938095292;34103.82948085244;38821.8058909715;40812;40940.79529602333;41241;28624.85687571549;31854.36291274115;33473.49789753204;34517.82741086279;34572.30855382929;25072.24783256505;25250.242492725247;25336.859841307552;25724.61413078768;25774.613380799678 11:25:12 INFO - PROCESS | 1669 | |2;jquery.html;348.33989589727463;414.749076808531;415.2898543490632;415.5242247626468;424.25331416706604;20058.59882802343;20281.290154844584;21032.369028929137;21047.894760526215;21095.789042109573;21059.47351316218;21206.10134897477;22318.665220021714;22388.10447582099;22390.776092239113;5620.5503559715125;5890.970545147279;5901;6180.443760061594;6184.783532576361;6044.788432404866;6125.601835880653;6140.385961403868;6151.8769624607485;6157.384261573851;5754.683492407916;6068.96965515174;6075.331713511532;6080.787172448965;6088.878222435548;5910.704464776765;5996.910046349309;6057.485113765335;6849.2465828758795;6869.7595584154815;6066;6072.240969878765;6088.66512341821;6094.207752992127;6098.72555734993;14242.92878535611;14248.21634810085;14256.643583910381;14258.572242832732;20736.792632073786;2172.837037222215;2173.579527177178;2193.2104442400723;2322.2452702871465;2331.219041621059;8428.32573394127;9969.401835889797;9983.550740216708;10331.01855323743;10644.41455719935;1583.6832633473352;1621.5702838747623;1844.041098628719;1876.1088482970615;1901.2965202875025;114901;116104.99999999916;117110.8288917117;117433.82566174315;117621;11722.472488738027;11735.354555499529;11879;12028.338441385808;12126.757464850654;15384.769228461582;15401.537953861402;15429.30568124437;15458.38166473351;15475.303611337516;8975.955120224487;9053.456792592466;9056.547172641342;9123.954380228057;9309.255259579217;9169.95415022934;9178.632854685871;9205.355625106178;9322;9330.113639204264;4661.883452913704;4738.881527961828;4747.691400058985;4761.833335833298;4828.010257897123;1963.106786412179;2023.898805059741;2024.673838635696;2029.1274751856843;2034.5148041929474;883.3992884838243;895.1317222294364;947.5877993073035;1023.8668973033458;1059.4014381874217;19641.901790490956;21080.262190823247;21263.574728505344;21373.239085570436;21447.820369879806;997.5610731278215;1007.6322142418111;1016.6746641074785;1044.4360045575304;1080.3895798873612;9161.95419022914;9752.853707194397;10683.679489615168;11350.545978160946;11366;649806;650641;660454;662833;664427;69686.65156674184;114855.42572287084;120288;121803;126422.42644680617;884.1600479544459;998.1615443027746;1024.2778840917135;1070.662741236508;1138.3454513654847;18776.15507302202;18808.623827523646;19354.419367419;19446.8055319445;19644.214231431153;54529;54610.26948652472;55405.168922467004;57370.713146434;58599.70700146643;75134.62432687801;77157.61421192858;77584;79476.4104717914;79692;8201.384896132695;8471.152884711479;8627.309815214894;8678.392512524062;8680.175383338572;11457.770844583229;12767.297798620793;12911.483540658644;13054.020948428715;13311.66720831987;10796.406197659204;11224.10207183407;11537.88462115368;11618.5352585899;11777.587784427504;6521.934780652133;9279.211267042378;11004.174686898354;11449;11540.653780386601;11384.430778460877;11389.259698119597;11551.480183391599;11721.355325457182;11839.82240266414;8183;8241.50550966944;8435.24082832548;8596.398252122292;8766.123387661182;10070.597176113166;11386.715332116763;11613.129015323715;11781.823272650745;11830.994365479031 11:25:12 INFO - PROCESS | 1669 | |3;mootools.html;1509.864112229899;1634.5913521619595;1671.8662506999442;1940.9611807763845;2007.8816848225135;8292.626831792568;8866.423682460636;9025.052369501207;9029.774255643595;9030.277577793777;8777.341699372557;9035.72892813215;9049.185573298402;9054.909450905488;9068.81862362754;2130.2650585547963;2542.7075886273083;2581.0708145067856;2587.4566341068303;2587.974120258792;2499.9750002500014;2562.0136247544738;2562.2313306008123;2564.1794625719685;2565.076572433922;2528.8229823912334;2557.3223095879607;2576.5491039068183;2577.5875859862426;2590.6502622146054;2528.3931856354434;2555.041859302752;2564.1025641025676;2570.820042597019;2572.858492782896;2517.7230504644476;2558.5650439425344;2568.614707793846;2572.498362819251;2576.9098081567245;8840.24857887074;9024.954875225647;9058.501782401965;9108.362414630978;9113.270938324918;4696.718196908197;5704.372519022904;5719;5738.913916291259;5756.222909907151;3555.964440355589;3557.911052223715;3622.2393297407575;3719.9070023249365;3755.906102347436;1052.168786658539;1063.1813503602184;1063.3299537575128;1079.0199983031148;1102.4377567440583;12257.203281786655;12406.81389779154;12415.006799456112;12438.378081095909;12445.564405245863;4787.3776409066595;4806.687565308313;4861.246506791453;4873.780679869415;4966.577840883493;9623.711288661352;9658.468784216935;9666.984966578408;9670.56482458291;9698.127168554864;5577.163425486209;5579;5586.888262234733;5600.915986260128;5618.213450116987;4608.493065762764;4766.737829419346;5039.395272567315;5165.096108181053;5191.377034755854;3496.7202623790035;4052.979735101306;4078.388241763759;4154.273002224599;4178.206140833232;1201.387292480841;1284.6683269865164;1298.298918583954;1306.3402981494476;1308.0778051473687;936.4708939449189;966.7438128895848;967.0474582536197;985.6747273399761;999.8450240212778;6006.849828754316;6013.0980352946535;6075.453209211104;6132.202813634288;6270.874582508415;1002.8896821349646;1003.7139415266614;1012.0688966151158;1037.0821822686976;1054.1040115901576;3924.5682974872743;3982.163745613396;4018.477597912311;4065.837366505307;4074.837006519706;10978.341299521895;11382.544698212145;11385.259958102697;11499;11527.654170374903;10124.392536447836;10478.056974872297;10722.624708135178;10876.075533579735;10878.72803179911;8482.448640838325;8562.357823163287;8700.869486957574;8872.556372181365;8885;6053.939460605514;6064.696765161636;6089.786857459968;6112.602680825732;6144.354842741626;9844.950775246078;10088.69733907984;10250.897491024994;10251.077403033763;10300.793984120126;9947.701568952943;10246.538905749409;10274.948625256826;10392.636257730943;10655.254132210981;7102.041224434635;7293.343599076109;7294.379977701742;7591.582462964369;7737.419693523121;7993.160718124514;8356;8542;8588.355873309401;8615.353848461265;7577.886331704918;7715.382769378324;7769.067711874612;7836.490628109154;7854.293113619801;7494.5503269803985;7536.585487798224;7546.094468663796;7690.846183076419;7694.153643099143;7166.570005799668;7213.567185968858;7222.34998850085;7255.383292420203;7282.817929551804;4980.750962451791;4995.950040499549;5134.666246693953;5165.276861239505;5191.273221749034;4455.353973673864;5121.9743901281745;5122.718250496258;5144.9742751286;5400.2439658447065 11:25:12 INFO - PROCESS | 1669 | |4;prototype.html;332.3419629134314;338.5970694873101;343.46076659644353;347.2880594780699;350.75447186969126;5993.041113421853;6387.137736405584;6695.363940425658;6713.865722685549;6783.55906866054;6324.3991820776955;6698.095757072793;6715.563488373265;6725.8991115133185;6771.966140169292;4787.880302992427;4911.975440122795;4920.188168952119;4982.476839931809;5006.924896126561;4915.852524424273;4968.180250258703;4995.700257984515;4997.950020499803;5013.949860501403;4230.57694230576;4909.901801963959;4940.60475161988;4943.036107958949;4987.650864439491;4377;4494.752788596626;4743.549362810545;4850.805967761303;4875.68308059975;4233.026403927083;4299.968007678166;4327.0913108247305;4336.804843782037;4346.043870348518;6340.619562826199;6423.100765892778;6437.83905402364;6459.83850403739;6471.091028146708;5838.511179649205;5841.6495010299095;5856.355800861902;5857.70711464425;5864.824055278348;6920.342567456084;7156.677949492286;7173.10336207974;7189.712411503534;7192.568445893263;4039.5758445363404;4873.122837889178;4887.633427492917;4894.583960363338;4906.184711656674;7514.361279291267;7643;7647.197044310378;7649.541027538366;7682.231776822273;4954.232094025432;4972.403311602631;4974.1543937530705;4982.60139188864;4986.227134794112;5063.443021267658;5064.848054558369;5064.974675126601;5065.986802639487;5069.721165335868;5144.305518754995;5691.772329106872;5834.912476312858;5950.9107363389585;5958.136070269873;7148.249433809479;7162.641867906584;7226.385757210591;7237.601931893796;7265.8546829063125;1358.952436664712;1743.572824657967;1765.479183640829;1770.4423106721342;1775.2277759174801;1122.180808010157;1122.859642544682;1152.0553146420023;1153.7692461507563;1156.439127023393;6574.76988305407;6819.181698196248;6831.4534837212905;6832.965835170792;6841.110655614738;7439.739609113763;7447.478676492594;7490.363319117827;7498.925010749932;7629.694812207561;6872.484563657746;6919.688614012382;6923.5499692519825;6928.272531384233;6933.5493192942295;3975.542812576533;4015.457913181683;4021.416894550274;4025.2352053109817;4031.4759081319826;7692.538447693157;7922.643481043367;7950.443468957117;7971.123176450586;8012.719554815553;7786.688532458638;7787.493812902143;7810.9845720057165;7842.568658723825;7844.882326765103;6353.714082866282;7403.185649578542;7914.406419518559;7918.960405197937;7931.048274207017;6253.3121356651645;7431.219721929119;7581.772546823604;7582.772516824504;7597.126330471845;7090.858182836418;7420.925790742023;7429.962850185714;7430.591317477591;7437.851242975002;7809.453338266267;7867.13461519221;7881;7890;7920.326772224425;4966.404031516241;4973.179425394769;4988.226824842155;4991.3511243538105;5000.6249531284575;7463.888041679488;7499.100107987077;7510.962445187739;7514.9624251878395;7515.39876809843;6921;7147.1780745214965;7162.104736907887;7210.387117095106;7271.381932535794;7158.677859496439;7210.783676489714;7214.2064372917885;7236.710531578678;7246.782596522113;6297.779577714758;6592.90110648331;7070.68181931804;7093;7094.432445404252;6962.651867406508;7254.528455650577;7256.310650488195;7257.818554536178;7262.9273707262255;6613.2394774601535;6815.182178138655;7091.468139889425;7140;7163.746344389815 11:25:12 INFO - PROCESS | 1669 | |5;yui.html;720.7837648705389;763.210077569715;779.1312686354717;782.4288269563219;811.1645005644185;15369.923150384246;15486.993345432538;15740.29168687409;15740.842591574095;15775.921120394396;14559.636009099779;14612.977091603592;14637.41450341985;14672.706545869076;14686.706265874676;801.8757092650649;812.3663542436909;961.9422834629927;970.9029097090305;993.9006099390075;997.7854761226334;1001.0490034467249;1005.0652892809684;1007.7782887764716;1009.7627057641448;1046.1839764983288;1048.5648455890796;1050.1808589300358;1050.616524968385;1052.6736711619385;823.5100115431309;1011.185995273808;1030.6135199300263;1034.6999370182639;1035.79801938622;773.0568706178509;773.2267732267733;775.4726785785664;775.4920527054732;775.6044417347138;14716;14770;14772.261386930719;14773.556793296219;14775.039622424509;12969.740605187844;13152.86847131526;13258.535951241756;13325.86674133256;13362.131461454974;10303.845442318372;10329.328593641465;10342.172626189888;10647.201459890539;11021.559137634486;3538.982305088458;3576.0523461282783;3611.656892595199;3672.816359182057;3831.597682243352;81283;81432.59283703603;81614.59192704057;81663.7750433738;87820.12179878248;10043.045910638477;10056.849147262797;10087.344322619007;10122.392656440637;10124.493775311352;22279.108835646715;22558.774412255996;22596.209132680277;22689;22734.431639209153;7017.087778588751;7487.315354045405;7709.267619576131;7733.7679869604;7745.10931242903;4205.3902184183125;4285.764282964405;4316.330968699856;4366.410534577792;4386.670999675037;3752.9437058444146;3816.3702989007056;3822.7132965027736;3825.4261860720558;3838.616138386195;607.4775692904099;668.1714673804545;681.8943063825116;691.7371398868398;714.2857142857143;588.5174157191062;610.3987572241339;613.984650383744;616.0451300484322;637.3912913167914;7106.2183159852375;8224.136465671138;8466.238038576557;8522.147785221428;8695.521746303888;597.6384287506083;605.2978544887909;609.1289456077762;624.3288464900251;627.6359711367396;3982.761034337949;4026.3356546169553;4068.5995262795095;4114.7119701621195;4132.132252227006;88032;89669.55165224263;95468.52265738627;96068;96332;78544;78760;79597.04029596994;80136.59931700304;80215;71597;71955;72185.27814721891;73285.80635169586;73386.8991965121;8647.697330593399;8719.607617657093;8964.861545775057;8965.237954773656;8991.865122023044;40418.98952526093;48289.51710482991;48772.2684159745;50714.49285507245;50906.727331817;54746.357609271785;63062;63556.68221658862;68489;68835.04314932607;11194.272372295774;11454.026407755435;11465.14011449128;11498.310101393943;11609.071274298205;11877.406129693654;11911.166218364631;12233.143679942319;12266.815997759863;12506;11549.942250288696;11780.293182409083;11853.288802671867;11911.52353905834;12217.938910305747;11367.54529818798;11893.048556115316;11952.043836493234;11965.05037004007;12055.81916271239;10220.335678180894;11620.360880151673;11638.6508404748;11853.051755859684;11960.401979900797;8994.820103598022;9311.72064838029;9699.321047526606;9738.610455581698;10136;8404.831903361775;9759.142641690096;9852.556634951588;9861.211103111877;9901.702948911545 11:25:12 INFO - PROCESS | 1669 | __end_tp_report 11:25:12 INFO - PROCESS | 1669 | __start_cc_report 11:25:12 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1250 11:25:12 INFO - PROCESS | 1669 | __end_cc_report 11:25:12 INFO - PROCESS | 1669 | __startTimestamp1468866312064__endTimestamp 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | ------- Summary: start ------- 11:25:12 INFO - PROCESS | 1669 | Number of tests: 6 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5935.26 Median:6214.66 stddev:617.30 (9.9%) stddev-sans-first:589.31 11:25:12 INFO - PROCESS | 1669 | Values: 3516.5 3629.4 3638.1 3638.6 3720.4 6027.2 6028.2 6033.5 6046.6 6089.0 6027.1 6076.0 6095.5 6102.2 6122.0 5342.3 5407.5 5449.1 5459.4 5508.6 5445.5 5504.4 5506.0 5507.4 5517.7 5357.7 5423.8 5427.9 5465.0 5483.2 5459.8 5503.9 5509.1 5518.0 5520.7 5329.3 5349.6 5369.7 5424.1 5481.1 5873.5 5910.7 5939.3 5945.9 5961.2 6271.6 6302.1 6321.7 6324.4 6327.5 6207.6 6255.9 6280.8 6385.5 6408.0 6111.2 6115.6 6124.4 6132.1 6141.0 5520.8 6449.7 6454.4 6463.4 6464.0 6214.5 6221.3 6290.0 6298.6 6301.7 6343.8 6351.8 6354.3 6357.8 6367.4 6233.5 6288.9 6297.4 6305.1 6310.7 6205.2 6258.6 6287.3 6294.7 6313.6 5074.2 5115.1 5126.9 5127.6 5127.9 4512.8 4616.2 4634.4 4634.9 4657.4 5012.5 5948.4 6038.3 6107.9 6132.1 6303.5 6329.5 6396.1 6397.5 6415.5 6085.2 6088.4 6107.5 6134.4 6140.9 5467.1 5577.3 5579.4 5626.4 5659.2 6565.8 6579.8 6608.9 6623.6 6640.1 6233.9 6341.7 6359.4 6366.4 6375.4 6472.8 6540.9 6589.5 6592.9 6613.7 6253.3 6284.0 6287.8 6291.0 6297.0 6214.7 6249.6 6259.7 6290.1 6340.0 6215.7 6259.0 6261.7 6265.8 6281.4 6222.0 6250.8 6255.2 6259.0 6275.1 5099.3 6131.6 6251.8 6276.4 6292.7 6187.3 6215.9 6265.1 6268.7 6292.4 6222.1 6261.2 6298.3 6305.7 6307.7 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:69054.39 Median:3562.40 stddev:155413.09 (4362.6%) stddev-sans-first:155763.84 11:25:12 INFO - PROCESS | 1669 | Values: 502.9 527.5 585.9 611.5 632.6 32191.7 38692.0 39411.0 39443.2 39489.6 42734.9 43211.8 43272.4 43295.0 43345.6 8991.2 9654.7 9853.8 9858.3 9864.5 11833.8 12070.3 12081.9 12112.6 12120.2 11752.2 11815.8 11829.9 11830.8 11850.3 11719.9 11813.8 11820.2 11825.1 11826.8 11644.4 11733.9 11734.3 11736.9 11740.4 41721.8 42213.6 42322.6 42347.4 42420.8 3295.9 3359.6 3366.1 3410.8 3931.5 27308.0 27321.7 28651.3 28925.4 30265.4 2782.0 2787.8 2804.3 2875.6 2896.2 537953.0 539935.0 541325.0 544483.0 544916.0 37334.0 37905.6 37973.4 37990.0 63532.0 37769.2 37921.2 37940.6 37960.6 37992.6 16386.5 16592.3 16622.3 16629.8 16630.0 12832.4 12984.0 14071.0 14239.7 14393.5 7073.0 8342.8 8366.5 8393.9 8471.3 3542.5 3582.3 3596.4 3609.4 3630.4 990.9 1081.8 1105.2 1117.9 1135.2 27656.5 29679.0 30043.0 30689.1 30852.8 1136.4 1171.1 1181.4 1207.3 1254.7 15704.9 15869.6 16028.4 16099.2 16187.7 642175.0 650325.0 651524.0 652184.0 652508.0 55757.9 61994.8 63174.4 63909.7 64069.0 1431.6 1470.1 1562.8 1581.2 1587.1 29315.4 29717.6 29739.1 29897.4 30497.0 47667.5 48040.3 48245.0 48332.5 48496.3 447218.0 449317.8 450228.0 454162.0 809384.0 27446.3 28297.4 28327.7 28349.9 28384.0 42429.6 44361.7 44427.0 44606.6 44677.8 36054.1 36508.3 37760.6 38487.2 38521.8 37310.0 37351.8 37571.0 37974.8 38123.8 34103.8 38821.8 40812.0 40940.8 41241.0 28624.9 31854.4 33473.5 34517.8 34572.3 25072.2 25250.2 25336.9 25724.6 25774.6 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:36159.12 Median:12255.94 stddev:108914.81 (888.7%) stddev-sans-first:109187.15 11:25:12 INFO - PROCESS | 1669 | Values: 348.3 414.7 415.3 415.5 424.3 20058.6 20281.3 21032.4 21047.9 21095.8 21059.5 21206.1 22318.7 22388.1 22390.8 5620.6 5891.0 5901.0 6180.4 6184.8 6044.8 6125.6 6140.4 6151.9 6157.4 5754.7 6069.0 6075.3 6080.8 6088.9 5910.7 5996.9 6057.5 6849.2 6869.8 6066.0 6072.2 6088.7 6094.2 6098.7 14242.9 14248.2 14256.6 14258.6 20736.8 2172.8 2173.6 2193.2 2322.2 2331.2 8428.3 9969.4 9983.6 10331.0 10644.4 1583.7 1621.6 1844.0 1876.1 1901.3 114901.0 116105.0 117110.8 117433.8 117621.0 11722.5 11735.4 11879.0 12028.3 12126.8 15384.8 15401.5 15429.3 15458.4 15475.3 8976.0 9053.5 9056.5 9124.0 9309.3 9170.0 9178.6 9205.4 9322.0 9330.1 4661.9 4738.9 4747.7 4761.8 4828.0 1963.1 2023.9 2024.7 2029.1 2034.5 883.4 895.1 947.6 1023.9 1059.4 19641.9 21080.3 21263.6 21373.2 21447.8 997.6 1007.6 1016.7 1044.4 1080.4 9162.0 9752.9 10683.7 11350.5 11366.0 649806.0 650641.0 660454.0 662833.0 664427.0 69686.7 114855.4 120288.0 121803.0 126422.4 884.2 998.2 1024.3 1070.7 1138.3 18776.2 18808.6 19354.4 19446.8 19644.2 54529.0 54610.3 55405.2 57370.7 58599.7 75134.6 77157.6 77584.0 79476.4 79692.0 8201.4 8471.2 8627.3 8678.4 8680.2 11457.8 12767.3 12911.5 13054.0 13311.7 10796.4 11224.1 11537.9 11618.5 11777.6 6521.9 9279.2 11004.2 11449.0 11540.7 11384.4 11389.3 11551.5 11721.4 11839.8 8183.0 8241.5 8435.2 8596.4 8766.1 10070.6 11386.7 11613.1 11781.8 11831.0 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5893.80 Median:4920.18 stddev:3264.40 (66.3%) stddev-sans-first:3256.93 11:25:12 INFO - PROCESS | 1669 | Values: 1509.9 1634.6 1671.9 1941.0 2007.9 8292.6 8866.4 9025.1 9029.8 9030.3 8777.3 9035.7 9049.2 9054.9 9068.8 2130.3 2542.7 2581.1 2587.5 2588.0 2500.0 2562.0 2562.2 2564.2 2565.1 2528.8 2557.3 2576.5 2577.6 2590.7 2528.4 2555.0 2564.1 2570.8 2572.9 2517.7 2558.6 2568.6 2572.5 2576.9 8840.2 9025.0 9058.5 9108.4 9113.3 4696.7 5704.4 5719.0 5738.9 5756.2 3556.0 3557.9 3622.2 3719.9 3755.9 1052.2 1063.2 1063.3 1079.0 1102.4 12257.2 12406.8 12415.0 12438.4 12445.6 4787.4 4806.7 4861.2 4873.8 4966.6 9623.7 9658.5 9667.0 9670.6 9698.1 5577.2 5579.0 5586.9 5600.9 5618.2 4608.5 4766.7 5039.4 5165.1 5191.4 3496.7 4053.0 4078.4 4154.3 4178.2 1201.4 1284.7 1298.3 1306.3 1308.1 936.5 966.7 967.0 985.7 999.8 6006.8 6013.1 6075.5 6132.2 6270.9 1002.9 1003.7 1012.1 1037.1 1054.1 3924.6 3982.2 4018.5 4065.8 4074.8 10978.3 11382.5 11385.3 11499.0 11527.7 10124.4 10478.1 10722.6 10876.1 10878.7 8482.4 8562.4 8700.9 8872.6 8885.0 6053.9 6064.7 6089.8 6112.6 6144.4 9845.0 10088.7 10250.9 10251.1 10300.8 9947.7 10246.5 10274.9 10392.6 10655.3 7102.0 7293.3 7294.4 7591.6 7737.4 7993.2 8356.0 8542.0 8588.4 8615.4 7577.9 7715.4 7769.1 7836.5 7854.3 7494.6 7536.6 7546.1 7690.8 7694.2 7166.6 7213.6 7222.3 7255.4 7282.8 4980.8 4996.0 5134.7 5165.3 5191.3 4455.4 5122.0 5122.7 5145.0 5400.2 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5931.17 Median:6705.98 stddev:1880.73 (28.0%) stddev-sans-first:1838.46 11:25:12 INFO - PROCESS | 1669 | Values: 332.3 338.6 343.5 347.3 350.8 5993.0 6387.1 6695.4 6713.9 6783.6 6324.4 6698.1 6715.6 6725.9 6772.0 4787.9 4912.0 4920.2 4982.5 5006.9 4915.9 4968.2 4995.7 4998.0 5013.9 4230.6 4909.9 4940.6 4943.0 4987.7 4377.0 4494.8 4743.5 4850.8 4875.7 4233.0 4300.0 4327.1 4336.8 4346.0 6340.6 6423.1 6437.8 6459.8 6471.1 5838.5 5841.6 5856.4 5857.7 5864.8 6920.3 7156.7 7173.1 7189.7 7192.6 4039.6 4873.1 4887.6 4894.6 4906.2 7514.4 7643.0 7647.2 7649.5 7682.2 4954.2 4972.4 4974.2 4982.6 4986.2 5063.4 5064.8 5065.0 5066.0 5069.7 5144.3 5691.8 5834.9 5950.9 5958.1 7148.2 7162.6 7226.4 7237.6 7265.9 1359.0 1743.6 1765.5 1770.4 1775.2 1122.2 1122.9 1152.1 1153.8 1156.4 6574.8 6819.2 6831.5 6833.0 6841.1 7439.7 7447.5 7490.4 7498.9 7629.7 6872.5 6919.7 6923.5 6928.3 6933.5 3975.5 4015.5 4021.4 4025.2 4031.5 7692.5 7922.6 7950.4 7971.1 8012.7 7786.7 7787.5 7811.0 7842.6 7844.9 6353.7 7403.2 7914.4 7919.0 7931.0 6253.3 7431.2 7581.8 7582.8 7597.1 7090.9 7420.9 7430.0 7430.6 7437.9 7809.5 7867.1 7881.0 7890.0 7920.3 4966.4 4973.2 4988.2 4991.4 5000.6 7463.9 7499.1 7511.0 7515.0 7515.4 6921.0 7147.2 7162.1 7210.4 7271.4 7158.7 7210.8 7214.2 7236.7 7246.8 6297.8 6592.9 7070.7 7093.0 7094.4 6962.7 7254.5 7256.3 7257.8 7262.9 6613.2 6815.2 7091.5 7140.0 7163.7 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18514.37 Median:4245.58 stddev:25825.04 (608.3%) stddev-sans-first:25862.92 11:25:12 INFO - PROCESS | 1669 | Values: 720.8 763.2 779.1 782.4 811.2 15369.9 15487.0 15740.3 15740.8 15775.9 14559.6 14613.0 14637.4 14672.7 14686.7 801.9 812.4 961.9 970.9 993.9 997.8 1001.0 1005.1 1007.8 1009.8 1046.2 1048.6 1050.2 1050.6 1052.7 823.5 1011.2 1030.6 1034.7 1035.8 773.1 773.2 775.5 775.5 775.6 14716.0 14770.0 14772.3 14773.6 14775.0 12969.7 13152.9 13258.5 13325.9 13362.1 10303.8 10329.3 10342.2 10647.2 11021.6 3539.0 3576.1 3611.7 3672.8 3831.6 81283.0 81432.6 81614.6 81663.8 87820.1 10043.0 10056.8 10087.3 10122.4 10124.5 22279.1 22558.8 22596.2 22689.0 22734.4 7017.1 7487.3 7709.3 7733.8 7745.1 4205.4 4285.8 4316.3 4366.4 4386.7 3752.9 3816.4 3822.7 3825.4 3838.6 607.5 668.2 681.9 691.7 714.3 588.5 610.4 614.0 616.0 637.4 7106.2 8224.1 8466.2 8522.1 8695.5 597.6 605.3 609.1 624.3 627.6 3982.8 4026.3 4068.6 4114.7 4132.1 88032.0 89669.6 95468.5 96068.0 96332.0 78544.0 78760.0 79597.0 80136.6 80215.0 71597.0 71955.0 72185.3 73285.8 73386.9 8647.7 8719.6 8964.9 8965.2 8991.9 40419.0 48289.5 48772.3 50714.5 50906.7 54746.4 63062.0 63556.7 68489.0 68835.0 11194.3 11454.0 11465.1 11498.3 11609.1 11877.4 11911.2 12233.1 12266.8 12506.0 11549.9 11780.3 11853.3 11911.5 12217.9 11367.5 11893.0 11952.0 11965.1 12055.8 10220.3 11620.4 11638.7 11853.1 11960.4 8994.8 9311.7 9699.3 9738.6 10136.0 8404.8 9759.1 9852.6 9861.2 9901.7 11:25:12 INFO - PROCESS | 1669 | -------- Summary: end -------- 11:25:12 INFO - PROCESS | 1669 | 11:25:12 INFO - TEST-INFO | 1669: exit 0 11:25:12 INFO - TEST-OK | dromaeo_css | took 1113484ms 11:25:12 INFO - TEST-START | kraken 11:25:12 INFO - operating with platform_type : mac_ 11:25:12 INFO - Initialising browser for kraken test... 11:25:12 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpSnlKBJ/profile http://localhost:49278/getInfo.html) 11:25:14 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 11:25:14 INFO - PROCESS | 1675 | colorDepth:24 11:25:14 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 11:25:14 INFO - PROCESS | 1675 | __metrics 11:25:14 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:14 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:25:15 INFO - TEST-INFO | 1675: exit 0 11:25:15 INFO - Browser initialized. 11:25:15 INFO - Running cycle 1/1 for kraken test... 11:25:15 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpSnlKBJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:27 INFO - PROCESS | 1678 | RSS: Main: 160280576 11:25:27 INFO - PROCESS | 1678 | 11:25:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:30 INFO - PROCESS | 1678 | RSS: Main: 223825920 11:25:30 INFO - PROCESS | 1678 | 11:25:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 11:25:34 INFO - PROCESS | 1678 | RSS: Main: 239665152 11:25:34 INFO - PROCESS | 1678 | 11:25:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 11:25:37 INFO - PROCESS | 1678 | RSS: Main: 324395008 11:25:37 INFO - PROCESS | 1678 | 11:25:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 11:25:40 INFO - PROCESS | 1678 | RSS: Main: 231727104 11:25:40 INFO - PROCESS | 1678 | 11:25:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:43 INFO - PROCESS | 1678 | RSS: Main: 232304640 11:25:43 INFO - PROCESS | 1678 | 11:25:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:46 INFO - PROCESS | 1678 | RSS: Main: 269119488 11:25:46 INFO - PROCESS | 1678 | 11:25:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:49 INFO - PROCESS | 1678 | RSS: Main: 271257600 11:25:49 INFO - PROCESS | 1678 | 11:25:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 11:25:53 INFO - PROCESS | 1678 | RSS: Main: 269959168 11:25:53 INFO - PROCESS | 1678 | 11:25:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:55 INFO - PROCESS | 1678 | RSS: Main: 261009408 11:25:55 INFO - PROCESS | 1678 | 11:25:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:57 INFO - PROCESS | 1678 | RSS: Main: 267767808 11:25:57 INFO - PROCESS | 1678 | 11:25:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:00 INFO - PROCESS | 1678 | RSS: Main: 271286272 11:26:00 INFO - PROCESS | 1678 | 11:26:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:03 INFO - PROCESS | 1678 | RSS: Main: 278458368 11:26:03 INFO - PROCESS | 1678 | 11:26:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:07 INFO - PROCESS | 1678 | RSS: Main: 275656704 11:26:07 INFO - PROCESS | 1678 | 11:26:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 11:26:09 INFO - PROCESS | 1678 | RSS: Main: 336691200 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | __start_tp_report 11:26:09 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 11:26:09 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 11:26:09 INFO - PROCESS | 1678 | |i|pagename|runs| 11:26:09 INFO - PROCESS | 1678 | |0;ai-astar;113;113;118;112;112;110;114;113;111;134 11:26:09 INFO - PROCESS | 1678 | |1;audio-beat-detection;174;102;173;195;147;139;136;113;165;114 11:26:09 INFO - PROCESS | 1678 | |2;audio-dft;184;183;186;182;184;182;184;183;185;185 11:26:09 INFO - PROCESS | 1678 | |3;audio-fft;70;77;73;154;55;56;54;57;134;57 11:26:09 INFO - PROCESS | 1678 | |4;audio-oscillator;92;94;144;78;77;84;126;78;76;125 11:26:09 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;83;86;85;87;82;88;84;86;87 11:26:09 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;97;93;92;92;92;92;93;92;93 11:26:09 INFO - PROCESS | 1678 | |7;imaging-desaturate;84;82;84;84;86;84;86;84;85;83 11:26:09 INFO - PROCESS | 1678 | |8;json-parse-financial;57;61;63;63;62;62;64;77;57;58 11:26:09 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;60;63;63;73;74;67;65;65;66;66 11:26:09 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;77;79;79;80;78;77;78;80;80;83 11:26:09 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;141;139;134;124;123;124;121;124;145;137 11:26:09 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;162;162;162;168;163;163;161;165;158;198 11:26:09 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;67;67;67;68;68;65;67;66;66 11:26:09 INFO - PROCESS | 1678 | __end_tp_report 11:26:09 INFO - PROCESS | 1678 | __start_cc_report 11:26:09 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1936 11:26:09 INFO - PROCESS | 1678 | __end_cc_report 11:26:09 INFO - PROCESS | 1678 | __startTimestamp1468866369148__endTimestamp 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | ------- Summary: start ------- 11:26:09 INFO - PROCESS | 1678 | Number of tests: 14 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:115.00 Median:113.00 stddev:7.01 (6.2%) stddev-sans-first:7.40 11:26:09 INFO - PROCESS | 1678 | Values: 113.0 113.0 118.0 112.0 112.0 110.0 114.0 113.0 111.0 134.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:156.00 stddev:30.68 (19.7%) stddev-sans-first:30.80 11:26:09 INFO - PROCESS | 1678 | Values: 174.0 102.0 173.0 195.0 147.0 139.0 136.0 113.0 165.0 114.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.32 (0.7%) stddev-sans-first:1.39 11:26:09 INFO - PROCESS | 1678 | Values: 184.0 183.0 186.0 182.0 184.0 182.0 184.0 183.0 185.0 185.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:78.70 Median:57.00 stddev:35.70 (62.6%) stddev-sans-first:37.72 11:26:09 INFO - PROCESS | 1678 | Values: 70.0 77.0 73.0 154.0 55.0 56.0 54.0 57.0 134.0 57.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:78.00 stddev:24.94 (32.0%) stddev-sans-first:26.38 11:26:09 INFO - PROCESS | 1678 | Values: 92.0 94.0 144.0 78.0 77.0 84.0 126.0 78.0 76.0 125.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:2.07 (2.4%) stddev-sans-first:2.00 11:26:09 INFO - PROCESS | 1678 | Values: 88.0 83.0 86.0 85.0 87.0 82.0 88.0 84.0 86.0 87.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:92.50 stddev:1.55 (1.7%) stddev-sans-first:1.62 11:26:09 INFO - PROCESS | 1678 | Values: 92.0 97.0 93.0 92.0 92.0 92.0 92.0 93.0 92.0 93.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 11:26:09 INFO - PROCESS | 1678 | Values: 84.0 82.0 84.0 84.0 86.0 84.0 86.0 84.0 85.0 83.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:5.74 (9.2%) stddev-sans-first:5.74 11:26:09 INFO - PROCESS | 1678 | Values: 57.0 61.0 63.0 63.0 62.0 62.0 64.0 77.0 57.0 58.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:4.34 (6.6%) stddev-sans-first:3.98 11:26:09 INFO - PROCESS | 1678 | Values: 60.0 63.0 63.0 73.0 74.0 67.0 65.0 65.0 66.0 66.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:1.79 (2.3%) stddev-sans-first:1.73 11:26:09 INFO - PROCESS | 1678 | Values: 77.0 79.0 79.0 80.0 78.0 77.0 78.0 80.0 80.0 83.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:135.50 stddev:8.92 (6.6%) stddev-sans-first:8.72 11:26:09 INFO - PROCESS | 1678 | Values: 141.0 139.0 134.0 124.0 123.0 124.0 121.0 124.0 145.0 137.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:163.00 stddev:11.47 (7.0%) stddev-sans-first:12.06 11:26:09 INFO - PROCESS | 1678 | Values: 162.0 162.0 162.0 168.0 163.0 163.0 161.0 165.0 158.0 198.0 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 11:26:09 INFO - PROCESS | 1678 | Values: 66.0 67.0 67.0 67.0 68.0 68.0 65.0 67.0 66.0 66.0 11:26:09 INFO - PROCESS | 1678 | -------- Summary: end -------- 11:26:09 INFO - PROCESS | 1678 | 11:26:09 INFO - TEST-INFO | 1678: exit 0 11:26:09 INFO - TEST-OK | kraken | took 57283ms 11:26:09 INFO - SUITE-END | took 1170s 11:26:10 INFO - Completed test suite (00:19:31) 11:26:10 INFO - javascript benchmark 11:26:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3516.507688923551, 3629.364861149298, 3638.054105932457, 3638.6179451157627, 3720.3861362875127, 6027.156198132259, 6028.216331876855, 6033.517318614511, 6046.637201767886, 6088.969555152218, 6027.089047403343, 6076.0, 6095.481884039862, 6102.216595924237, 6122.0, 5342.332208473941, 5407.5133238008575, 5449.100898351767, 5459.372172200208, 5508.614396992212, 5445.482679145475, 5504.422035686255, 5505.981393442206, 5507.449255074501, 5517.668939863601, 5357.732113394334, 5423.83728488146, 5427.9185812212845, 5465.043617366965, 5483.232347471358, 5459.808906688287, 5503.889922201573, 5509.118541033416, 5518.0, 5520.723963801834, 5329.333833270841, 5349.59878009147, 5369.6509726867625, 5424.105022671254, 5481.12302031677, 5873.471387575139, 5910.67491287979, 5939.2575928009, 5945.851353716192, 5961.225040744675, 6271.641791044776, 6302.1177035215105, 6321.74713011479, 6324.430801227912, 6327.4938004959495, 6207.596506227081, 6255.906161407583, 6280.78017269398, 6385.457236134934, 6407.967960160169, 6111.197196826946, 6115.6330620162935, 6124.387561243884, 6132.110843927606, 6140.969295153585, 5520.834374968757, 6449.742010319628, 6454.419102280724, 6463.353664633499, 6463.967680161663, 6214.471769899519, 6221.346758590374, 6290.0, 6298.559100862987, 6301.7164227609865, 6343.841403964845, 6351.841203969845, 6354.332795056545, 6357.809265722036, 6367.395097465826, 6233.501319894398, 6288.937110628835, 6297.370262973666, 6305.14880491137, 6310.684465776692, 6205.162303089025, 6258.593191442542, 6287.308396076428, 6294.748210071637, 6313.558050936482, 5074.213496907985, 5115.079285728604, 5126.897462050738, 5127.589792816566, 5127.897442051138, 4512.842050528281, 4616.215243408628, 4634.374359461497, 4634.884127896829, 4657.394538710014, 5012.523810238022, 5948.405159484017, 6038.305594856648, 6107.85643655375, 6132.110769107974, 6303.495720342362, 6329.525285603599, 6396.0725694774, 6397.4562162216735, 6415.518836087312, 6085.17850090241, 6088.391160883876, 6107.480864126599, 6134.386561343919, 6140.8771824564155, 5467.097928841697, 5577.3028371453565, 5579.38626751057, 5626.381098079208, 5659.151127330933, 6565.770198043046, 6579.80260592183, 6608.900866486911, 6623.602583844985, 6640.0703901453835, 6233.875322493615, 6341.682915854281, 6359.395857393541, 6366.395192456709, 6375.394337537927, 6472.805815825533, 6540.934590654223, 6589.538732288694, 6592.879210534316, 6613.735450582115, 6253.280872699515, 6283.994560870239, 6287.811365659038, 6290.968545157245, 6297.023961286008, 6214.658193799203, 6249.625022498664, 6259.749610015549, 6290.119383286435, 6339.96830015847, 6215.65813880241, 6258.967270400515, 6261.68691565429, 6265.780697675559, 6281.434670879643, 6221.968890155701, 6250.812475625738, 6255.24937007562, 6259.0, 6275.090111933835, 5099.337086178922, 6131.590761709946, 6251.843703907439, 6276.403741644536, 6292.653904035322, 6187.257529096537, 6215.9378406215355, 6265.122882796321, 6268.749250029948, 6292.370762923671, 6222.09779581949, 6261.24865016201, 6298.307186209605, 6305.716242769178, 6307.747690092345], "value": 5899.0951050896365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.8843366025814, 527.506781159616, 585.8769658371742, 611.4894063457015, 632.5730132160791, 32191.67808321919, 38692.0, 39411.0, 39443.2111357773, 39489.605103948954, 42734.931626709345, 43211.78394108033, 43272.35091473631, 43295.0, 43345.56654433455, 8991.190792828644, 9654.71035868925, 9853.753656158582, 9858.309918305722, 9864.506774661239, 11833.7633247335, 12070.336131512764, 12081.939590302036, 12112.636620901387, 12120.212186207913, 11752.23610465317, 11815.7636847263, 11829.940850295736, 11830.7633847323, 11850.3482308473, 11719.941400292986, 11813.763724725457, 11820.172587918849, 11825.11311651621, 11826.822597661085, 11644.359560224184, 11733.882661173364, 11734.295942243492, 11736.941315293454, 11740.412979350998, 41721.79139104285, 42213.577864221275, 42322.57677423248, 42347.36478952818, 42420.78789606032, 3295.8516866740815, 3359.5968483781858, 3366.091155388056, 3410.778299410555, 3931.5478719947287, 27308.044218452458, 27321.726782732316, 28651.283717907012, 28925.42149157026, 30265.394692106256, 2781.986090069557, 2787.846668433235, 2804.284907348613, 2875.611792408019, 2896.203544025389, 537953.0, 539935.0, 541325.0, 544482.999999996, 544916.0, 37334.0, 37905.62094379076, 37973.43039854404, 37990.0, 63532.0, 37769.24461510754, 37921.241575168344, 37940.62059379371, 37960.62039379571, 37992.62007379946, 16386.508404747878, 16592.25334859934, 16622.25199866009, 16629.83370166283, 16630.0, 12832.422540985677, 12984.0, 14071.015028947875, 14239.715205696035, 14393.496227631982, 7072.9646351767915, 8342.833143337099, 8366.45618034838, 8393.874091888627, 8471.322294216448, 3542.4863394808126, 3582.3193593217206, 3596.3526565218513, 3609.3683605368956, 3630.419132938717, 990.8860481044628, 1081.7944590527932, 1105.165599972032, 1117.94969226385, 1135.2393896089475, 27656.47889366064, 29679.0, 30043.0, 30689.079327620206, 30852.845735771625, 1136.4147464056018, 1171.1392126786805, 1181.3797756178076, 1207.3057991654834, 1254.6926003129292, 15704.92147539255, 15869.603259918364, 16028.441745851811, 16099.195040247942, 16187.676246475241, 642175.0, 650325.0, 651524.0, 652184.0, 652508.0, 55757.88484230293, 61994.76010479765, 63174.36825631685, 63909.72180556456, 64069.0, 1431.6277767780243, 1470.1326217531707, 1562.8280889102189, 1581.1619841484032, 1587.0874247307613, 29315.413691726473, 29717.554236686898, 29739.10782676523, 29897.402051959274, 30497.0, 47667.523324766305, 48040.27939580839, 48245.03509929852, 48332.51667483421, 48496.27255591098, 447218.0, 449317.75341123086, 450228.0, 454162.0, 809384.0, 27446.313842154104, 28297.43405131927, 28327.71672283333, 28349.858250708614, 28384.0, 42429.5757042438, 44361.669149925554, 44427.0, 44606.55393446024, 44677.77661111674, 36054.09864753297, 36508.26983460263, 37760.62239377571, 38487.2302553953, 38521.807390962866, 37310.0, 37351.813240933625, 37571.0, 37974.810125949196, 38123.80938095292, 34103.82948085244, 38821.8058909715, 40812.0, 40940.79529602333, 41241.0, 28624.85687571549, 31854.36291274115, 33473.49789753204, 34517.82741086279, 34572.30855382929, 25072.24783256505, 25250.242492725247, 25336.859841307552, 25724.61413078768, 25774.613380799678], "value": 19321.492090776457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.33989589727463, 414.749076808531, 415.2898543490632, 415.5242247626468, 424.25331416706604, 20058.59882802343, 20281.290154844584, 21032.369028929137, 21047.894760526215, 21095.789042109573, 21059.47351316218, 21206.10134897477, 22318.665220021714, 22388.10447582099, 22390.776092239113, 5620.5503559715125, 5890.970545147279, 5901.0, 6180.443760061594, 6184.783532576361, 6044.788432404866, 6125.601835880653, 6140.385961403868, 6151.8769624607485, 6157.384261573851, 5754.683492407916, 6068.96965515174, 6075.331713511532, 6080.787172448965, 6088.878222435548, 5910.704464776765, 5996.910046349309, 6057.485113765335, 6849.2465828758795, 6869.7595584154815, 6066.0, 6072.240969878765, 6088.66512341821, 6094.207752992127, 6098.72555734993, 14242.92878535611, 14248.21634810085, 14256.643583910381, 14258.572242832732, 20736.792632073786, 2172.837037222215, 2173.579527177178, 2193.2104442400723, 2322.2452702871465, 2331.219041621059, 8428.32573394127, 9969.401835889797, 9983.550740216708, 10331.01855323743, 10644.41455719935, 1583.6832633473352, 1621.5702838747623, 1844.041098628719, 1876.1088482970615, 1901.2965202875025, 114901.0, 116104.99999999916, 117110.8288917117, 117433.82566174315, 117621.0, 11722.472488738027, 11735.354555499529, 11879.0, 12028.338441385808, 12126.757464850654, 15384.769228461582, 15401.537953861402, 15429.30568124437, 15458.38166473351, 15475.303611337516, 8975.955120224487, 9053.456792592466, 9056.547172641342, 9123.954380228057, 9309.255259579217, 9169.95415022934, 9178.632854685871, 9205.355625106178, 9322.0, 9330.113639204264, 4661.883452913704, 4738.881527961828, 4747.691400058985, 4761.833335833298, 4828.010257897123, 1963.106786412179, 2023.898805059741, 2024.673838635696, 2029.1274751856843, 2034.5148041929474, 883.3992884838243, 895.1317222294364, 947.5877993073035, 1023.8668973033458, 1059.4014381874217, 19641.901790490956, 21080.262190823247, 21263.574728505344, 21373.239085570436, 21447.820369879806, 997.5610731278215, 1007.6322142418111, 1016.6746641074785, 1044.4360045575304, 1080.3895798873612, 9161.95419022914, 9752.853707194397, 10683.679489615168, 11350.545978160946, 11366.0, 649806.0, 650641.0, 660454.0, 662833.0, 664427.0, 69686.65156674184, 114855.42572287084, 120288.0, 121803.0, 126422.42644680617, 884.1600479544459, 998.1615443027746, 1024.2778840917135, 1070.662741236508, 1138.3454513654847, 18776.15507302202, 18808.623827523646, 19354.419367419, 19446.8055319445, 19644.214231431153, 54529.0, 54610.26948652472, 55405.168922467004, 57370.713146434, 58599.70700146643, 75134.62432687801, 77157.61421192858, 77584.0, 79476.4104717914, 79692.0, 8201.384896132695, 8471.152884711479, 8627.309815214894, 8678.392512524062, 8680.175383338572, 11457.770844583229, 12767.297798620793, 12911.483540658644, 13054.020948428715, 13311.66720831987, 10796.406197659204, 11224.10207183407, 11537.88462115368, 11618.5352585899, 11777.587784427504, 6521.934780652133, 9279.211267042378, 11004.174686898354, 11449.0, 11540.653780386601, 11384.430778460877, 11389.259698119597, 11551.480183391599, 11721.355325457182, 11839.82240266414, 8183.0, 8241.50550966944, 8435.24082832548, 8596.398252122292, 8766.123387661182, 10070.597176113166, 11386.715332116763, 11613.129015323715, 11781.823272650745, 11830.994365479031], "value": 9671.077192525876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.864112229899, 1634.5913521619595, 1671.8662506999442, 1940.9611807763845, 2007.8816848225135, 8292.626831792568, 8866.423682460636, 9025.052369501207, 9029.774255643595, 9030.277577793777, 8777.341699372557, 9035.72892813215, 9049.185573298402, 9054.909450905488, 9068.81862362754, 2130.2650585547963, 2542.7075886273083, 2581.0708145067856, 2587.4566341068303, 2587.974120258792, 2499.9750002500014, 2562.0136247544738, 2562.2313306008123, 2564.1794625719685, 2565.076572433922, 2528.8229823912334, 2557.3223095879607, 2576.5491039068183, 2577.5875859862426, 2590.6502622146054, 2528.3931856354434, 2555.041859302752, 2564.1025641025676, 2570.820042597019, 2572.858492782896, 2517.7230504644476, 2558.5650439425344, 2568.614707793846, 2572.498362819251, 2576.9098081567245, 8840.24857887074, 9024.954875225647, 9058.501782401965, 9108.362414630978, 9113.270938324918, 4696.718196908197, 5704.372519022904, 5719.0, 5738.913916291259, 5756.222909907151, 3555.964440355589, 3557.911052223715, 3622.2393297407575, 3719.9070023249365, 3755.906102347436, 1052.168786658539, 1063.1813503602184, 1063.3299537575128, 1079.0199983031148, 1102.4377567440583, 12257.203281786655, 12406.81389779154, 12415.006799456112, 12438.378081095909, 12445.564405245863, 4787.3776409066595, 4806.687565308313, 4861.246506791453, 4873.780679869415, 4966.577840883493, 9623.711288661352, 9658.468784216935, 9666.984966578408, 9670.56482458291, 9698.127168554864, 5577.163425486209, 5579.0, 5586.888262234733, 5600.915986260128, 5618.213450116987, 4608.493065762764, 4766.737829419346, 5039.395272567315, 5165.096108181053, 5191.377034755854, 3496.7202623790035, 4052.979735101306, 4078.388241763759, 4154.273002224599, 4178.206140833232, 1201.387292480841, 1284.6683269865164, 1298.298918583954, 1306.3402981494476, 1308.0778051473687, 936.4708939449189, 966.7438128895848, 967.0474582536197, 985.6747273399761, 999.8450240212778, 6006.849828754316, 6013.0980352946535, 6075.453209211104, 6132.202813634288, 6270.874582508415, 1002.8896821349646, 1003.7139415266614, 1012.0688966151158, 1037.0821822686976, 1054.1040115901576, 3924.5682974872743, 3982.163745613396, 4018.477597912311, 4065.837366505307, 4074.837006519706, 10978.341299521895, 11382.544698212145, 11385.259958102697, 11499.0, 11527.654170374903, 10124.392536447836, 10478.056974872297, 10722.624708135178, 10876.075533579735, 10878.72803179911, 8482.448640838325, 8562.357823163287, 8700.869486957574, 8872.556372181365, 8885.0, 6053.939460605514, 6064.696765161636, 6089.786857459968, 6112.602680825732, 6144.354842741626, 9844.950775246078, 10088.69733907984, 10250.897491024994, 10251.077403033763, 10300.793984120126, 9947.701568952943, 10246.538905749409, 10274.948625256826, 10392.636257730943, 10655.254132210981, 7102.041224434635, 7293.343599076109, 7294.379977701742, 7591.582462964369, 7737.419693523121, 7993.160718124514, 8356.0, 8542.0, 8588.355873309401, 8615.353848461265, 7577.886331704918, 7715.382769378324, 7769.067711874612, 7836.490628109154, 7854.293113619801, 7494.5503269803985, 7536.585487798224, 7546.094468663796, 7690.846183076419, 7694.153643099143, 7166.570005799668, 7213.567185968858, 7222.34998850085, 7255.383292420203, 7282.817929551804, 4980.750962451791, 4995.950040499549, 5134.666246693953, 5165.276861239505, 5191.273221749034, 4455.353973673864, 5121.9743901281745, 5122.718250496258, 5144.9742751286, 5400.2439658447065], "value": 4768.757221827277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3419629134314, 338.5970694873101, 343.46076659644353, 347.2880594780699, 350.75447186969126, 5993.041113421853, 6387.137736405584, 6695.363940425658, 6713.865722685549, 6783.55906866054, 6324.3991820776955, 6698.095757072793, 6715.563488373265, 6725.8991115133185, 6771.966140169292, 4787.880302992427, 4911.975440122795, 4920.188168952119, 4982.476839931809, 5006.924896126561, 4915.852524424273, 4968.180250258703, 4995.700257984515, 4997.950020499803, 5013.949860501403, 4230.57694230576, 4909.901801963959, 4940.60475161988, 4943.036107958949, 4987.650864439491, 4377.0, 4494.752788596626, 4743.549362810545, 4850.805967761303, 4875.68308059975, 4233.026403927083, 4299.968007678166, 4327.0913108247305, 4336.804843782037, 4346.043870348518, 6340.619562826199, 6423.100765892778, 6437.83905402364, 6459.83850403739, 6471.091028146708, 5838.511179649205, 5841.6495010299095, 5856.355800861902, 5857.70711464425, 5864.824055278348, 6920.342567456084, 7156.677949492286, 7173.10336207974, 7189.712411503534, 7192.568445893263, 4039.5758445363404, 4873.122837889178, 4887.633427492917, 4894.583960363338, 4906.184711656674, 7514.361279291267, 7643.0, 7647.197044310378, 7649.541027538366, 7682.231776822273, 4954.232094025432, 4972.403311602631, 4974.1543937530705, 4982.60139188864, 4986.227134794112, 5063.443021267658, 5064.848054558369, 5064.974675126601, 5065.986802639487, 5069.721165335868, 5144.305518754995, 5691.772329106872, 5834.912476312858, 5950.9107363389585, 5958.136070269873, 7148.249433809479, 7162.641867906584, 7226.385757210591, 7237.601931893796, 7265.8546829063125, 1358.952436664712, 1743.572824657967, 1765.479183640829, 1770.4423106721342, 1775.2277759174801, 1122.180808010157, 1122.859642544682, 1152.0553146420023, 1153.7692461507563, 1156.439127023393, 6574.76988305407, 6819.181698196248, 6831.4534837212905, 6832.965835170792, 6841.110655614738, 7439.739609113763, 7447.478676492594, 7490.363319117827, 7498.925010749932, 7629.694812207561, 6872.484563657746, 6919.688614012382, 6923.5499692519825, 6928.272531384233, 6933.5493192942295, 3975.542812576533, 4015.457913181683, 4021.416894550274, 4025.2352053109817, 4031.4759081319826, 7692.538447693157, 7922.643481043367, 7950.443468957117, 7971.123176450586, 8012.719554815553, 7786.688532458638, 7787.493812902143, 7810.9845720057165, 7842.568658723825, 7844.882326765103, 6353.714082866282, 7403.185649578542, 7914.406419518559, 7918.960405197937, 7931.048274207017, 6253.3121356651645, 7431.219721929119, 7581.772546823604, 7582.772516824504, 7597.126330471845, 7090.858182836418, 7420.925790742023, 7429.962850185714, 7430.591317477591, 7437.851242975002, 7809.453338266267, 7867.13461519221, 7881.0, 7890.0, 7920.326772224425, 4966.404031516241, 4973.179425394769, 4988.226824842155, 4991.3511243538105, 5000.6249531284575, 7463.888041679488, 7499.100107987077, 7510.962445187739, 7514.9624251878395, 7515.39876809843, 6921.0, 7147.1780745214965, 7162.104736907887, 7210.387117095106, 7271.381932535794, 7158.677859496439, 7210.783676489714, 7214.2064372917885, 7236.710531578678, 7246.782596522113, 6297.779577714758, 6592.90110648331, 7070.68181931804, 7093.0, 7094.432445404252, 6962.651867406508, 7254.528455650577, 7256.310650488195, 7257.818554536178, 7262.9273707262255, 6613.2394774601535, 6815.182178138655, 7091.468139889425, 7140.0, 7163.746344389815], "value": 5306.150973869087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7837648705389, 763.210077569715, 779.1312686354717, 782.4288269563219, 811.1645005644185, 15369.923150384246, 15486.993345432538, 15740.29168687409, 15740.842591574095, 15775.921120394396, 14559.636009099779, 14612.977091603592, 14637.41450341985, 14672.706545869076, 14686.706265874676, 801.8757092650649, 812.3663542436909, 961.9422834629927, 970.9029097090305, 993.9006099390075, 997.7854761226334, 1001.0490034467249, 1005.0652892809684, 1007.7782887764716, 1009.7627057641448, 1046.1839764983288, 1048.5648455890796, 1050.1808589300358, 1050.616524968385, 1052.6736711619385, 823.5100115431309, 1011.185995273808, 1030.6135199300263, 1034.6999370182639, 1035.79801938622, 773.0568706178509, 773.2267732267733, 775.4726785785664, 775.4920527054732, 775.6044417347138, 14716.0, 14770.0, 14772.261386930719, 14773.556793296219, 14775.039622424509, 12969.740605187844, 13152.86847131526, 13258.535951241756, 13325.86674133256, 13362.131461454974, 10303.845442318372, 10329.328593641465, 10342.172626189888, 10647.201459890539, 11021.559137634486, 3538.982305088458, 3576.0523461282783, 3611.656892595199, 3672.816359182057, 3831.597682243352, 81283.0, 81432.59283703603, 81614.59192704057, 81663.7750433738, 87820.12179878248, 10043.045910638477, 10056.849147262797, 10087.344322619007, 10122.392656440637, 10124.493775311352, 22279.108835646715, 22558.774412255996, 22596.209132680277, 22689.0, 22734.431639209153, 7017.087778588751, 7487.315354045405, 7709.267619576131, 7733.7679869604, 7745.10931242903, 4205.3902184183125, 4285.764282964405, 4316.330968699856, 4366.410534577792, 4386.670999675037, 3752.9437058444146, 3816.3702989007056, 3822.7132965027736, 3825.4261860720558, 3838.616138386195, 607.4775692904099, 668.1714673804545, 681.8943063825116, 691.7371398868398, 714.2857142857143, 588.5174157191062, 610.3987572241339, 613.984650383744, 616.0451300484322, 637.3912913167914, 7106.2183159852375, 8224.136465671138, 8466.238038576557, 8522.147785221428, 8695.521746303888, 597.6384287506083, 605.2978544887909, 609.1289456077762, 624.3288464900251, 627.6359711367396, 3982.761034337949, 4026.3356546169553, 4068.5995262795095, 4114.7119701621195, 4132.132252227006, 88032.0, 89669.55165224263, 95468.52265738627, 96068.0, 96332.0, 78544.0, 78760.0, 79597.04029596994, 80136.59931700304, 80215.0, 71597.0, 71955.0, 72185.27814721891, 73285.80635169586, 73386.8991965121, 8647.697330593399, 8719.607617657093, 8964.861545775057, 8965.237954773656, 8991.865122023044, 40418.98952526093, 48289.51710482991, 48772.2684159745, 50714.49285507245, 50906.727331817, 54746.357609271785, 63062.0, 63556.68221658862, 68489.0, 68835.04314932607, 11194.272372295774, 11454.026407755435, 11465.14011449128, 11498.310101393943, 11609.071274298205, 11877.406129693654, 11911.166218364631, 12233.143679942319, 12266.815997759863, 12506.0, 11549.942250288696, 11780.293182409083, 11853.288802671867, 11911.52353905834, 12217.938910305747, 11367.54529818798, 11893.048556115316, 11952.043836493234, 11965.05037004007, 12055.81916271239, 10220.335678180894, 11620.360880151673, 11638.6508404748, 11853.051755859684, 11960.401979900797, 8994.820103598022, 9311.72064838029, 9699.321047526606, 9738.610455581698, 10136.0, 8404.831903361775, 9759.142641690096, 9852.556634951588, 9861.211103111877, 9901.702948911545], "value": 7150.314706656488, "unit": "score"}], "name": "dromaeo_css", "value": 7643.766973837313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 118.0, 112.0, 112.0, 110.0, 114.0, 113.0, 111.0, 134.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 102.0, 173.0, 195.0, 147.0, 139.0, 136.0, 113.0, 165.0, 114.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 182.0, 184.0, 182.0, 184.0, 183.0, 185.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 73.0, 154.0, 55.0, 56.0, 54.0, 57.0, 134.0, 57.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 144.0, 78.0, 77.0, 84.0, 126.0, 78.0, 76.0, 125.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 86.0, 85.0, 87.0, 82.0, 88.0, 84.0, 86.0, 87.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 93.0, 92.0, 92.0, 92.0, 92.0, 93.0, 92.0, 93.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 84.0, 86.0, 84.0, 86.0, 84.0, 85.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 63.0, 63.0, 62.0, 62.0, 64.0, 77.0, 57.0, 58.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 63.0, 73.0, 74.0, 67.0, 65.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 79.0, 80.0, 78.0, 77.0, 78.0, 80.0, 80.0, 83.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 134.0, 124.0, 123.0, 124.0, 121.0, 124.0, 145.0, 137.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 168.0, 163.0, 163.0, 161.0, 165.0, 158.0, 198.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 68.0, 65.0, 67.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1455.1000000000001, "alertThreshold": 2.0}]} 11:26:10 INFO - Return code: 0 11:26:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:26:10 ERROR - # TBPL SUCCESS # 11:26:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:26:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:26:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:26:10 INFO - 2016-07-18 11:26:10.494 screenresolution[1682:10115] starting screenresolution argv=screenresolution get 11:26:10 INFO - 2016-07-18 11:26:10.497 screenresolution[1682:10115] Display 0: 1600x1200x32@60 11:26:10 INFO - 2016-07-18 11:26:10.503 screenresolution[1683:10118] starting screenresolution argv=screenresolution list 11:26:10 INFO - Available Modes on Display 0 11:26:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:26:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:26:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:26:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:26:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:26:10 INFO - Intel Iris: 11:26:10 INFO - Chipset Model: Intel Iris 11:26:10 INFO - Type: GPU 11:26:10 INFO - Bus: Built-In 11:26:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:26:10 INFO - Vendor: Intel (0x8086) 11:26:10 INFO - Device ID: 0x0a2e 11:26:10 INFO - Revision ID: 0x0009 11:26:10 INFO - Displays: 11:26:10 INFO - Display: 11:26:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:26:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:26:10 INFO - Display Serial Number: 1600x1200 60 11:26:10 INFO - Main Display: Yes 11:26:10 INFO - Mirror: Off 11:26:10 INFO - Online: Yes 11:26:10 INFO - Rotation: Supported 11:26:10 INFO - Return code: 0 11:26:10 INFO - Running post-action listener: _resource_record_post_action 11:26:10 INFO - Running post-run listener: _resource_record_post_run 11:26:11 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 31698432; Write bytes: 496540160; Read time: 197; Write time: 1575 11:26:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249856; Write bytes: 198248448; Read time: 4; Write time: 473 11:26:11 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 29904384; Write bytes: 297443840; Read time: 180; Write time: 1101 11:26:11 INFO - Running post-run listener: _upload_blobber_files 11:26:11 INFO - Blob upload gear active. 11:26:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:12 INFO - (blobuploader) - INFO - Done attempting. 11:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:13 INFO - (blobuploader) - INFO - Done attempting. 11:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:13 INFO - Return code: 0 11:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e5032e79c07288d2538a5f4f97b4749a23051993fe755958435459f9da24d9df384b57d231fd8aac0d8d5235f3df11dc6d2410f9c10f1d37beece9d44175c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6994506f2f241c44076938b83e025c2b4c4396d72fc4609d25bef6dda18c7fa1cd59c1cfef59b96299936b76f31c353a56ab534876f65ecaf702f2e5b32dbb1"} 11:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:13 INFO - Contents: 11:26:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e5032e79c07288d2538a5f4f97b4749a23051993fe755958435459f9da24d9df384b57d231fd8aac0d8d5235f3df11dc6d2410f9c10f1d37beece9d44175c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6994506f2f241c44076938b83e025c2b4c4396d72fc4609d25bef6dda18c7fa1cd59c1cfef59b96299936b76f31c353a56ab534876f65ecaf702f2e5b32dbb1"} 11:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:13 INFO - Copying logs to upload dir... 11:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.690818 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-18 11:26:13.927702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:26:13.930908) ========= 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.FcROANImyv/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.k9UeLswJwm/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e5032e79c07288d2538a5f4f97b4749a23051993fe755958435459f9da24d9df384b57d231fd8aac0d8d5235f3df11dc6d2410f9c10f1d37beece9d44175c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6994506f2f241c44076938b83e025c2b4c4396d72fc4609d25bef6dda18c7fa1cd59c1cfef59b96299936b76f31c353a56ab534876f65ecaf702f2e5b32dbb1"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011550 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468833238/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e5032e79c07288d2538a5f4f97b4749a23051993fe755958435459f9da24d9df384b57d231fd8aac0d8d5235f3df11dc6d2410f9c10f1d37beece9d44175c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6994506f2f241c44076938b83e025c2b4c4396d72fc4609d25bef6dda18c7fa1cd59c1cfef59b96299936b76f31c353a56ab534876f65ecaf702f2e5b32dbb1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:26:13.963467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:26:13.963813) ========= 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.FcROANImyv/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.k9UeLswJwm/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005010 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:26:14.012478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:26:14.012812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:26:14.013152) ========= ========= Total master_lag: 0.17 =========