builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0384 starttime: 1467837002.41 results: success (0) buildid: 20160705080357 builduid: 990d6470d6634a1fb097a655daaae542 revision: 03b0c9698c91a81d9267cf1774cce1ca04b2533c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:02.411378) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:02.411763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:02.412050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:02.438879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:02.439158) ========= 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.WixlBOlA4p/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.jhjAs60q9M/Listeners TMPDIR=/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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-06 13:30:02-- 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% 19.4M=0.001s 2016-07-06 13:30:03 (19.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.683079 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:03.144076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:03.144381) ========= 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.WixlBOlA4p/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.jhjAs60q9M/Listeners TMPDIR=/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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.025949 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:03.193761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 13:30:03.194123) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 03b0c9698c91a81d9267cf1774cce1ca04b2533c --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 03b0c9698c91a81d9267cf1774cce1ca04b2533c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WixlBOlA4p/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.jhjAs60q9M/Listeners TMPDIR=/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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-06 13:30:03,276 truncating revision to first 12 chars 2016-07-06 13:30:03,276 Setting DEBUG logging. 2016-07-06 13:30:03,276 attempt 1/10 2016-07-06 13:30:03,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/03b0c9698c91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 13:30:04,594 unpacking tar archive at: mozilla-beta-03b0c9698c91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.597327 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 13:30:04.827390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:04.827681) ========= script_repo_revision: 03b0c9698c91a81d9267cf1774cce1ca04b2533c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:04.832071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:04.832373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 13:30:04.855809) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-06 13:30:04.856100) ========= /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.WixlBOlA4p/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.jhjAs60q9M/Listeners TMPDIR=/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:05 INFO - MultiFileLogger online at 20160706 13:30:05 in /builds/slave/test 13:30:05 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 13:30:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:30:05 INFO - {'append_to_log': False, 13:30:05 INFO - 'base_work_dir': '/builds/slave/test', 13:30:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:30:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:30:05 INFO - 'branch': 'Mozilla-Beta', 13:30:05 INFO - 'buildbot_json_path': 'buildprops.json', 13:30:05 INFO - 'config_files': ('talos/mac_config.py',), 13:30:05 INFO - 'default_actions': ('clobber', 13:30:05 INFO - 'read-buildbot-config', 13:30:05 INFO - 'download-and-extract', 13:30:05 INFO - 'populate-webroot', 13:30:05 INFO - 'create-virtualenv', 13:30:05 INFO - 'install', 13:30:05 INFO - 'run-tests'), 13:30:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:30:05 INFO - 'download_minidump_stackwalk': True, 13:30:05 INFO - 'download_symbols': 'ondemand', 13:30:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:30:05 INFO - 'tooltool.py': '/tools/tooltool.py', 13:30:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:30:05 INFO - '/tools/misc-python/virtualenv.py')}, 13:30:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:30:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:30:05 INFO - 'installer_path': 'installer.exe', 13:30:05 INFO - 'log_level': 'info', 13:30:05 INFO - 'log_name': 'talos', 13:30:05 INFO - 'log_to_console': True, 13:30:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:30:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:30:05 INFO - 'opt_config_files': (), 13:30:05 INFO - 'pip_index': False, 13:30:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:30:05 INFO - 'cmd': ('bash', 13:30:05 INFO - '-c', 13:30:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:30:05 INFO - 'enabled': True, 13:30:05 INFO - 'halt_on_failure': False, 13:30:05 INFO - 'name': 'check_screen_resolution'},), 13:30:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:30:05 INFO - 'cmd': ('bash', 13:30:05 INFO - '-c', 13:30:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:30:05 INFO - 'enabled': True, 13:30:05 INFO - 'halt_on_failure': False, 13:30:05 INFO - 'name': 'check_screen_resolution'},), 13:30:05 INFO - 'run_cmd_checks_enabled': True, 13:30:05 INFO - 'sps_profile': False, 13:30:05 INFO - 'sps_profile_interval': 0, 13:30:05 INFO - 'suite': 'dromaeojs', 13:30:05 INFO - 'system_bits': '32', 13:30:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:30:05 INFO - 'title': 't-yosemite-r7-0384', 13:30:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:30:05 INFO - 'use_talos_json': True, 13:30:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:30:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:30:05 INFO - 'work_dir': 'build'} 13:30:05 INFO - ##### 13:30:05 INFO - ##### Running clobber step. 13:30:05 INFO - ##### 13:30:05 INFO - Running pre-action listener: _resource_record_pre_action 13:30:05 INFO - Running main action method: clobber 13:30:05 INFO - rmtree: /builds/slave/test/build 13:30:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:30:06 INFO - Running post-action listener: _resource_record_post_action 13:30:06 INFO - ##### 13:30:06 INFO - ##### Running read-buildbot-config step. 13:30:06 INFO - ##### 13:30:06 INFO - Running pre-action listener: _resource_record_pre_action 13:30:06 INFO - Running main action method: read_buildbot_config 13:30:07 INFO - Using buildbot properties: 13:30:07 INFO - { 13:30:07 INFO - "project": "", 13:30:07 INFO - "product": "firefox", 13:30:07 INFO - "script_repo_revision": "production", 13:30:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:30:07 INFO - "repository": "", 13:30:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:30:07 INFO - "buildid": "20160705080357", 13:30:07 INFO - "pgo_build": "False", 13:30:07 INFO - "basedir": "/builds/slave/test", 13:30:07 INFO - "buildnumber": 59, 13:30:07 INFO - "slavename": "t-yosemite-r7-0384", 13:30:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:30:07 INFO - "platform": "yosemite_r7", 13:30:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:30:07 INFO - "branch": "mozilla-beta", 13:30:07 INFO - "repo_path": "releases/mozilla-beta", 13:30:07 INFO - "revision": "03b0c9698c91a81d9267cf1774cce1ca04b2533c", 13:30:07 INFO - "stage_platform": "macosx64", 13:30:07 INFO - "builduid": "990d6470d6634a1fb097a655daaae542", 13:30:07 INFO - "slavebuilddir": "test" 13:30:07 INFO - } 13:30:07 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg. 13:30:07 INFO - Running post-action listener: _resource_record_post_action 13:30:07 INFO - ##### 13:30:07 INFO - ##### Running download-and-extract step. 13:30:07 INFO - ##### 13:30:07 INFO - Running pre-action listener: _resource_record_pre_action 13:30:07 INFO - Running main action method: download_and_extract 13:30:07 INFO - mkdir: /builds/slave/test/build/tests 13:30: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')]} 13:30:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.test_packages.json 13:30:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/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 13:30:07 INFO - Downloaded 1165 bytes. 13:30:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:30:07 INFO - Using the following test package requirements: 13:30:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:30:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 13:30:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 13:30:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:30:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 13:30:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:30:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 13:30:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 13:30:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 13:30:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:30:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 13:30:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 13:30: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')]} 13:30:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.common.tests.zip 13:30:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/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 13:30:07 INFO - Downloaded 18351413 bytes. 13:30:07 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'] 13:30:07 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 13:30:10 INFO - Return code: 0 13:30:10 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 13:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.common.tests.zip 13:30:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/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 13:30:11 INFO - Downloaded 18351413 bytes. 13:30:11 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'] 13:30:11 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 13:30:14 INFO - Return code: 0 13:30:14 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')]} 13:30:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.talos.tests.zip 13:30:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 13:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/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 13:30:14 INFO - Downloaded 10840145 bytes. 13:30:14 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'] 13:30:14 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 13:30:14 INFO - Return code: 0 13:30:14 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')]} 13:30:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg 13:30:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 13:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 13:30:16 INFO - Downloaded 86194399 bytes. 13:30:16 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg 13:30:16 INFO - mkdir: /builds/slave/test/properties 13:30:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:30:16 INFO - Writing to file /builds/slave/test/properties/build_url 13:30:16 INFO - Contents: 13:30:16 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg 13:30:16 INFO - Running post-action listener: _resource_record_post_action 13:30:16 INFO - Running post-action listener: set_extra_try_arguments 13:30:16 INFO - ##### 13:30:16 INFO - ##### Running populate-webroot step. 13:30:16 INFO - ##### 13:30:16 INFO - Running pre-action listener: _resource_record_pre_action 13:30:16 INFO - Running main action method: populate_webroot 13:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:30:16 INFO - '--tppagecycles', 13:30:16 INFO - '7'], 13:30:16 INFO - 'tests': ['tsvgm']}}, 13:30:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:30:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:30:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:30:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['damp', 'tps']}, 13:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'tests': ['damp', 'tps']}, 13:30:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['dromaeo_dom']}, 13:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:30:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['a11yr', 13:30:16 INFO - 'ts_paint', 13:30:16 INFO - 'tpaint', 13:30:16 INFO - 'sessionrestore', 13:30:16 INFO - 'sessionrestore_no_auto_restore', 13:30:16 INFO - 'tabpaint']}, 13:30:16 INFO - 'other-e10s': {'tests': ['a11yr', 13:30:16 INFO - 'ts_paint', 13:30:16 INFO - 'tpaint', 13:30:16 INFO - 'sessionrestore', 13:30:16 INFO - 'sessionrestore_no_auto_restore', 13:30:16 INFO - 'tabpaint']}, 13:30:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:30:16 INFO - 'ts_paint', 13:30:16 INFO - 'tpaint', 13:30:16 INFO - 'sessionrestore', 13:30:16 INFO - 'sessionrestore_no_auto_restore', 13:30:16 INFO - 'tabpaint']}, 13:30:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:30:16 INFO - 'ts_paint', 13:30:16 INFO - 'tpaint', 13:30:16 INFO - 'sessionrestore', 13:30:16 INFO - 'sessionrestore_no_auto_restore', 13:30:16 INFO - 'tabpaint']}, 13:30:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['a11yr', 13:30:16 INFO - 'ts_paint', 13:30:16 INFO - 'tpaint', 13:30:16 INFO - 'sessionrestore', 13:30:16 INFO - 'sessionrestore_no_auto_restore', 13:30:16 INFO - 'tabpaint']}, 13:30:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['a11yr', 13:30:16 INFO - 'ts_paint', 13:30:16 INFO - 'tpaint', 13:30:16 INFO - 'sessionrestore', 13:30:16 INFO - 'sessionrestore_no_auto_restore', 13:30:16 INFO - 'tabpaint']}, 13:30:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['tsvgx', 13:30:16 INFO - 'tsvgr_opacity', 13:30:16 INFO - 'tart', 13:30:16 INFO - 'tscrollx', 13:30:16 INFO - 'cart']}, 13:30:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:30:16 INFO - 'tsvgr_opacity', 13:30:16 INFO - 'tart', 13:30:16 INFO - 'tscrollx', 13:30:16 INFO - 'cart']}, 13:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'talos_options': ['--disable-e10s'], 13:30:16 INFO - 'tests': ['tp5o']}, 13:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'tests': ['tp5o']}, 13:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'talos_options': ['--disable-e10s', 13:30:16 INFO - '--xperf_path', 13:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:16 INFO - 'tests': ['tp5n']}, 13:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:16 INFO - 'talos_options': ['--xperf_path', 13:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:16 INFO - 'tests': ['tp5n']}}, 13:30:16 INFO - 'talos.zip': {'path': '', 13:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:30:16 INFO - Running post-action listener: _resource_record_post_action 13:30:16 INFO - ##### 13:30:16 INFO - ##### Running create-virtualenv step. 13:30:16 INFO - ##### 13:30:16 INFO - Running pre-action listener: _resource_record_pre_action 13:30:16 INFO - Running main action method: create_virtualenv 13:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 13:30:16 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 13:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:30:16 INFO - Using real prefix '/tools/python27' 13:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:30:17 INFO - Installing distribute.............................................................................................................................................................................................done. 13:30:20 INFO - Installing pip.................done. 13:30:20 INFO - Return code: 0 13:30:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:20 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:20 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 13:30:20 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 13:30:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:20 INFO - 'HOME': '/Users/cltbld', 13:30:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:20 INFO - 'LOGNAME': 'cltbld', 13:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:20 INFO - 'MOZ_NO_REMOTE': '1', 13:30:20 INFO - 'NO_EM_RESTART': '1', 13:30:20 INFO - 'PAGER': '/bin/cat', 13:30:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:20 INFO - 'PWD': '/builds/slave/test', 13:30:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:20 INFO - 'SHELL': '/bin/bash', 13:30:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:20 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:20 INFO - 'USER': 'cltbld', 13:30:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:20 INFO - 'XPC_FLAGS': '0x0', 13:30:20 INFO - 'XPC_SERVICE_NAME': '0', 13:30:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:20 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 13:30:20 INFO - Cleaning up... 13:30:20 INFO - Return code: 0 13:30:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:20 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:20 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 13:30:20 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 13:30:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:20 INFO - 'HOME': '/Users/cltbld', 13:30:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:20 INFO - 'LOGNAME': 'cltbld', 13:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:20 INFO - 'MOZ_NO_REMOTE': '1', 13:30:20 INFO - 'NO_EM_RESTART': '1', 13:30:20 INFO - 'PAGER': '/bin/cat', 13:30:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:20 INFO - 'PWD': '/builds/slave/test', 13:30:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:20 INFO - 'SHELL': '/bin/bash', 13:30:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:20 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:20 INFO - 'USER': 'cltbld', 13:30:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:20 INFO - 'XPC_FLAGS': '0x0', 13:30:20 INFO - 'XPC_SERVICE_NAME': '0', 13:30:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:21 INFO - Downloading/unpacking psutil>=0.7.1 13:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:30:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:24 INFO - Installing collected packages: psutil 13:30:24 INFO - Running setup.py install for psutil 13:30:24 INFO - building 'psutil._psutil_osx' extension 13:30:24 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 13:30:25 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 13:30:25 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 13:30:25 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 13:30:25 INFO - building 'psutil._psutil_posix' extension 13:30:25 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 13:30:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:30:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:30:25 INFO - ^ 13:30:25 INFO - 1 warning generated. 13:30:25 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 13:30:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:25 INFO - Successfully installed psutil 13:30:25 INFO - Cleaning up... 13:30:25 INFO - Return code: 0 13:30:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:30:25 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')]} 13:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:25 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')]} 13:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:25 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:25 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 13:30:25 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 13:30:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:25 INFO - 'HOME': '/Users/cltbld', 13:30:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:25 INFO - 'LOGNAME': 'cltbld', 13:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:25 INFO - 'MOZ_NO_REMOTE': '1', 13:30:25 INFO - 'NO_EM_RESTART': '1', 13:30:25 INFO - 'PAGER': '/bin/cat', 13:30:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:25 INFO - 'PWD': '/builds/slave/test', 13:30:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:25 INFO - 'SHELL': '/bin/bash', 13:30:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:25 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:25 INFO - 'USER': 'cltbld', 13:30:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:25 INFO - 'XPC_FLAGS': '0x0', 13:30:25 INFO - 'XPC_SERVICE_NAME': '0', 13:30:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:30:28 INFO - Installing collected packages: mozsystemmonitor 13:30:28 INFO - Running setup.py install for mozsystemmonitor 13:30:28 INFO - Successfully installed mozsystemmonitor 13:30:28 INFO - Cleaning up... 13:30:28 INFO - Return code: 0 13:30:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:28 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:28 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 13:30:28 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 13:30:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:28 INFO - 'HOME': '/Users/cltbld', 13:30:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:28 INFO - 'LOGNAME': 'cltbld', 13:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:28 INFO - 'MOZ_NO_REMOTE': '1', 13:30:28 INFO - 'NO_EM_RESTART': '1', 13:30:28 INFO - 'PAGER': '/bin/cat', 13:30:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:28 INFO - 'PWD': '/builds/slave/test', 13:30:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:28 INFO - 'SHELL': '/bin/bash', 13:30:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:28 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:28 INFO - 'USER': 'cltbld', 13:30:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:28 INFO - 'XPC_FLAGS': '0x0', 13:30:28 INFO - 'XPC_SERVICE_NAME': '0', 13:30:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:29 INFO - Downloading/unpacking blobuploader==1.2.4 13:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:31 INFO - Downloading blobuploader-1.2.4.tar.gz 13:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:30:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:30:31 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 13:30:31 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 13:30:31 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 13:30:31 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 13:30:31 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 13:30:31 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 13:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:30:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:30:32 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 13:30:32 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 13:30:32 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 13:30:32 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 13:30:32 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 13:30:32 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 13:30:32 INFO - Downloading docopt-0.6.1.tar.gz 13:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:30:32 INFO - Installing collected packages: blobuploader, requests, docopt 13:30:32 INFO - Running setup.py install for blobuploader 13:30:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:30:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:30:32 INFO - Running setup.py install for requests 13:30:33 INFO - Running setup.py install for docopt 13:30:33 INFO - Successfully installed blobuploader requests docopt 13:30:33 INFO - Cleaning up... 13:30:33 INFO - Return code: 0 13:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:33 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')]} 13:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:33 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')]} 13:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:33 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:33 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 13:30:33 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 13:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:33 INFO - 'HOME': '/Users/cltbld', 13:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:33 INFO - 'LOGNAME': 'cltbld', 13:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:33 INFO - 'MOZ_NO_REMOTE': '1', 13:30:33 INFO - 'NO_EM_RESTART': '1', 13:30:33 INFO - 'PAGER': '/bin/cat', 13:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:33 INFO - 'PWD': '/builds/slave/test', 13:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:33 INFO - 'SHELL': '/bin/bash', 13:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:33 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:33 INFO - 'USER': 'cltbld', 13:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:33 INFO - 'XPC_FLAGS': '0x0', 13:30:33 INFO - 'XPC_SERVICE_NAME': '0', 13:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:33 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-yJe7Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-yXBZQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-lIAwls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-ZZyQUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-WW_ykX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-t5PNaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-GAyQu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-e0WtrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-gMrAFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-VxR8Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:34 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-5MsqDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:35 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-6K0J0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:35 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-oBkZCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:35 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-bomxPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:35 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-PnliiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:35 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-r1XPpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:35 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-BVHq2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:30:35 INFO - Running setup.py install for manifestparser 13:30:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:30:35 INFO - Running setup.py install for mozcrash 13:30:35 INFO - Running setup.py install for mozdebug 13:30:36 INFO - Running setup.py install for mozdevice 13:30:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Running setup.py install for mozfile 13:30:36 INFO - Running setup.py install for mozhttpd 13:30:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Running setup.py install for mozinfo 13:30:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Running setup.py install for mozInstall 13:30:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:30:36 INFO - Running setup.py install for mozleak 13:30:36 INFO - Running setup.py install for mozlog 13:30:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:30:37 INFO - Running setup.py install for moznetwork 13:30:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:30:37 INFO - Running setup.py install for mozprocess 13:30:37 INFO - Running setup.py install for mozprofile 13:30:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:30:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:30:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:30:37 INFO - Running setup.py install for mozrunner 13:30:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:30:37 INFO - Running setup.py install for mozscreenshot 13:30:37 INFO - Running setup.py install for moztest 13:30:38 INFO - Running setup.py install for mozversion 13:30:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:30:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:30:38 INFO - Cleaning up... 13:30:38 INFO - Return code: 0 13:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:38 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:38 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 13:30:38 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 13:30:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:38 INFO - 'HOME': '/Users/cltbld', 13:30:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:38 INFO - 'LOGNAME': 'cltbld', 13:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:38 INFO - 'MOZ_NO_REMOTE': '1', 13:30:38 INFO - 'NO_EM_RESTART': '1', 13:30:38 INFO - 'PAGER': '/bin/cat', 13:30:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:38 INFO - 'PWD': '/builds/slave/test', 13:30:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:38 INFO - 'SHELL': '/bin/bash', 13:30:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:38 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:38 INFO - 'USER': 'cltbld', 13:30:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:38 INFO - 'XPC_FLAGS': '0x0', 13:30:38 INFO - 'XPC_SERVICE_NAME': '0', 13:30:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:38 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-A2w9Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:38 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)) 13:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:38 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-oaSW_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:38 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)) 13:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:38 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-HvXJeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:38 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)) 13:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:38 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-NTD93o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:38 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)) 13:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:38 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-0oAEsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-BdNtQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-LtXfi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-RnzpBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-LmNQvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-YbJ87a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-28IbQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-esS_kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-NuZZa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:39 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)) 13:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:39 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-ieNNXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:40 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)) 13:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:40 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-82aECI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:40 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)) 13:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:40 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-dQij_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:40 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)) 13:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:40 INFO - Running setup.py (path:/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/pip-F2JiUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:40 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)) 13:30:40 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)) 13:30:40 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)) 13:30:40 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)) 13:30:40 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)) 13:30:40 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)) 13:30:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:30:40 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 13:30:40 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 13:30:40 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 13:30:40 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 13:30:40 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 13:30:40 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 13:30:42 INFO - Downloading blessings-1.6.tar.gz 13:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:30:42 INFO - Installing collected packages: blessings 13:30:42 INFO - Running setup.py install for blessings 13:30:43 INFO - Successfully installed blessings 13:30:43 INFO - Cleaning up... 13:30:43 INFO - Return code: 0 13:30:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:43 INFO - Reading from file tmpfile_stdout 13:30:43 INFO - Current package versions: 13:30:43 INFO - blessings == 1.6 13:30:43 INFO - blobuploader == 1.2.4 13:30:43 INFO - docopt == 0.6.1 13:30:43 INFO - manifestparser == 1.1 13:30:43 INFO - mozInstall == 1.12 13:30:43 INFO - mozcrash == 0.17 13:30:43 INFO - mozdebug == 0.1 13:30:43 INFO - mozdevice == 0.48 13:30:43 INFO - mozfile == 1.2 13:30:43 INFO - mozhttpd == 0.7 13:30:43 INFO - mozinfo == 0.9 13:30:43 INFO - mozleak == 0.1 13:30:43 INFO - mozlog == 3.1 13:30:43 INFO - moznetwork == 0.27 13:30:43 INFO - mozprocess == 0.22 13:30:43 INFO - mozprofile == 0.28 13:30:43 INFO - mozrunner == 6.11 13:30:43 INFO - mozscreenshot == 0.1 13:30:43 INFO - mozsystemmonitor == 0.0 13:30:43 INFO - moztest == 0.7 13:30:43 INFO - mozversion == 1.4 13:30:43 INFO - psutil == 3.1.1 13:30:43 INFO - requests == 1.2.3 13:30:43 INFO - wsgiref == 0.1.2 13:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:43 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')]} 13:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:43 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')]} 13:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:43 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:43 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 13:30:43 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 13:30:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:43 INFO - 'HOME': '/Users/cltbld', 13:30:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:43 INFO - 'LOGNAME': 'cltbld', 13:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:43 INFO - 'MOZ_NO_REMOTE': '1', 13:30:43 INFO - 'NO_EM_RESTART': '1', 13:30:43 INFO - 'PAGER': '/bin/cat', 13:30:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:43 INFO - 'PWD': '/builds/slave/test', 13:30:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:43 INFO - 'SHELL': '/bin/bash', 13:30:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:43 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:43 INFO - 'USER': 'cltbld', 13:30:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:43 INFO - 'XPC_FLAGS': '0x0', 13:30:43 INFO - 'XPC_SERVICE_NAME': '0', 13:30:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 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)) 13:30:43 INFO - Cleaning up... 13:30:43 INFO - Return code: 0 13:30:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:30:43 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')]} 13:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:43 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')]} 13:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:43 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:43 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 13:30:43 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 13:30:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:43 INFO - 'HOME': '/Users/cltbld', 13:30:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:43 INFO - 'LOGNAME': 'cltbld', 13:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:43 INFO - 'MOZ_NO_REMOTE': '1', 13:30:43 INFO - 'NO_EM_RESTART': '1', 13:30:43 INFO - 'PAGER': '/bin/cat', 13:30:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:43 INFO - 'PWD': '/builds/slave/test', 13:30:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:43 INFO - 'SHELL': '/bin/bash', 13:30:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:43 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:43 INFO - 'USER': 'cltbld', 13:30:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:43 INFO - 'XPC_FLAGS': '0x0', 13:30:43 INFO - 'XPC_SERVICE_NAME': '0', 13:30:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:43 INFO - Downloading/unpacking jsonschema 13:30:43 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 13:30:43 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 13:30:43 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 13:30:43 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 13:30:43 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 13:30:43 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 13:30:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:30:46 INFO - Downloading/unpacking functools32 (from jsonschema) 13:30:46 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 13:30:46 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 13:30:46 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 13:30:46 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 13:30:46 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 13:30:46 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 13:30:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:30:46 INFO - warning: no files found matching '*.txt' 13:30:46 INFO - no previously-included directories found matching 'build' 13:30:46 INFO - no previously-included directories found matching 'dist' 13:30:46 INFO - no previously-included directories found matching '.git*' 13:30:46 INFO - Installing collected packages: jsonschema, functools32 13:30:47 INFO - Running setup.py install for functools32 13:30:47 INFO - warning: no files found matching '*.txt' 13:30:47 INFO - no previously-included directories found matching 'build' 13:30:47 INFO - no previously-included directories found matching 'dist' 13:30:47 INFO - no previously-included directories found matching '.git*' 13:30:47 INFO - Successfully installed jsonschema functools32 13:30:47 INFO - Cleaning up... 13:30:47 INFO - Return code: 0 13:30:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:30:47 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')]} 13:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:47 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')]} 13:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:47 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 0x108a24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e95bc0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, '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.WixlBOlA4p/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.jhjAs60q9M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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 13:30:47 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 13:30:47 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 13:30:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:30:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:47 INFO - 'HOME': '/Users/cltbld', 13:30:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:47 INFO - 'LOGNAME': 'cltbld', 13:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:47 INFO - 'MOZ_NO_REMOTE': '1', 13:30:47 INFO - 'NO_EM_RESTART': '1', 13:30:47 INFO - 'PAGER': '/bin/cat', 13:30:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:47 INFO - 'PWD': '/builds/slave/test', 13:30:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:47 INFO - 'SHELL': '/bin/bash', 13:30:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:30:47 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:30:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:47 INFO - 'USER': 'cltbld', 13:30:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:47 INFO - 'XPC_FLAGS': '0x0', 13:30:47 INFO - 'XPC_SERVICE_NAME': '0', 13:30:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:47 INFO - Downloading/unpacking flake8 13:30:47 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 13:30:47 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 13:30:47 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 13:30:47 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 13:30:47 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 13:30:47 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 13:30:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:30:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:30: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 13:30: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 13:30: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 13:30: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 13:30: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 13:30: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 13:30:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:30:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 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 13:30:50 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 13:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:30:51 INFO - no previously-included directories found matching 'docs/_build' 13:30:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:30:51 INFO - Running setup.py install for pep8 13:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:30:51 INFO - no previously-included directories found matching 'docs/_build' 13:30:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:30:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:30:51 INFO - Cleaning up... 13:30:51 INFO - Return code: 0 13:30:51 INFO - Running post-action listener: _resource_record_post_action 13:30:51 INFO - Running post-action listener: _start_resource_monitoring 13:30:51 INFO - Starting resource monitoring. 13:30:51 INFO - ##### 13:30:51 INFO - ##### Running install step. 13:30:51 INFO - ##### 13:30:51 INFO - Running pre-action listener: _resource_record_pre_action 13:30:51 INFO - Running main action method: install 13:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:51 INFO - Reading from file tmpfile_stdout 13:30:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:30:52 INFO - Reading from file tmpfile_stdout 13:30:52 INFO - Output received: 13:30:52 INFO - Usage: mozinstall [options] installer 13:30:52 INFO - Options: 13:30:52 INFO - -h, --help show this help message and exit 13:30:52 INFO - -d DEST, --destination=DEST 13:30:52 INFO - Directory to install application into. [default: 13:30:52 INFO - "/builds/slave/test"] 13:30:52 INFO - --app=APP Application being installed. [default: firefox] 13:30:52 INFO - mkdir: /builds/slave/test/build/application 13:30:52 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'] 13:30:52 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 13:31:13 INFO - Reading from file tmpfile_stdout 13:31:13 INFO - Output received: 13:31:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:31:13 INFO - Running post-action listener: _resource_record_post_action 13:31:13 INFO - ##### 13:31:13 INFO - ##### Running run-tests step. 13:31:13 INFO - ##### 13:31:13 INFO - Running pre-action listener: _resource_record_pre_action 13:31:13 INFO - Running main action method: run_tests 13:31:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:31:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:31:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:31:13 INFO - 2016-07-06 13:31:13.835 screenresolution[1650:8395] starting screenresolution argv=screenresolution get 13:31:13 INFO - 2016-07-06 13:31:13.837 screenresolution[1650:8395] Display 0: 1600x1200x32@60 13:31:13 INFO - 2016-07-06 13:31:13.843 screenresolution[1651:8398] starting screenresolution argv=screenresolution list 13:31:13 INFO - Available Modes on Display 0 13:31:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:31:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:31:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:31:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:31:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:31:14 INFO - Intel Iris: 13:31:14 INFO - Chipset Model: Intel Iris 13:31:14 INFO - Type: GPU 13:31:14 INFO - Bus: Built-In 13:31:14 INFO - VRAM (Dynamic, Max): 1536 MB 13:31:14 INFO - Vendor: Intel (0x8086) 13:31:14 INFO - Device ID: 0x0a2e 13:31:14 INFO - Revision ID: 0x0009 13:31:14 INFO - Displays: 13:31:14 INFO - Display: 13:31:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:31:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:31:14 INFO - Display Serial Number: 1600x1200 60 13:31:14 INFO - Main Display: Yes 13:31:14 INFO - Mirror: Off 13:31:14 INFO - Online: Yes 13:31:14 INFO - Rotation: Supported 13:31:14 INFO - Return code: 0 13:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:31:14 INFO - Python 2.7.3 13:31:14 INFO - Return code: 0 13:31:14 INFO - grabbing minidump binary from tooltool 13:31:14 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')]} 13:31:14 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 0x1088c3e00>, '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 0x10872cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:31:14 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 13:31:14 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 13:31:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:31:14 INFO - Return code: 0 13:31:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:31:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:31:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:31:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:31:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:31:15 INFO - Return code: 0 13:31:15 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/1467731037/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0384', '--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 13:31:15 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/1467731037/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0384 --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 13:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WixlBOlA4p/Render', 13:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:31:15 INFO - 'HOME': '/Users/cltbld', 13:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:31:15 INFO - 'LOGNAME': 'cltbld', 13:31:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:31:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:15 INFO - 'MOZ_NO_REMOTE': '1', 13:31:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:31:15 INFO - 'NO_EM_RESTART': '1', 13:31:15 INFO - 'PAGER': '/bin/cat', 13:31:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:15 INFO - 'PWD': '/builds/slave/test', 13:31:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:31:15 INFO - 'SHELL': '/bin/bash', 13:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jhjAs60q9M/Listeners', 13:31:15 INFO - 'TMPDIR': '/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/', 13:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:31:15 INFO - 'USER': 'cltbld', 13:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:15 INFO - 'XPC_FLAGS': '0x0', 13:31:15 INFO - 'XPC_SERVICE_NAME': '0', 13:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:31:15 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/1467731037/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0384', '--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 13:31:15 INFO - mozversion application_buildid: 20160705080357 13:31:15 INFO - mozversion application_changeset: 03b0c9698c91a81d9267cf1774cce1ca04b2533c 13:31:15 INFO - mozversion application_display_name: Firefox 13:31:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:31:15 INFO - mozversion application_name: Firefox 13:31:15 INFO - mozversion application_remotingname: firefox 13:31:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:31:15 INFO - mozversion application_vendor: Mozilla 13:31:15 INFO - mozversion application_version: 48.0 13:31:15 INFO - mozversion platform_buildid: 20160705080357 13:31:15 INFO - mozversion platform_changeset: 03b0c9698c91a81d9267cf1774cce1ca04b2533c 13:31:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:31:15 INFO - mozversion platform_version: 48.0 13:31:15 INFO - using testdate: 1467837075 13:31:15 INFO - actual date: 1467837075 13:31:15 INFO - starting webserver on 'localhost:49269' 13:31:15 INFO - SUITE-START | Running 2 tests 13:31:15 INFO - TEST-START | dromaeo_css 13:31:15 INFO - operating with platform_type : mac_ 13:31:15 INFO - Initialising browser for dromaeo_css test... 13:31:15 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/tmpcfhuaJ/profile http://localhost:49269/getInfo.html) 13:31:17 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 13:31:17 INFO - PROCESS | 1669 | colorDepth:24 13:31:17 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 13:31:17 INFO - PROCESS | 1669 | __metrics 13:31:17 INFO - PROCESS | 1669 | 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" 13:31:17 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:31:18 INFO - TEST-INFO | 1669: exit 0 13:31:18 INFO - Browser initialized. 13:31:18 INFO - Running cycle 1/1 for dromaeo_css test... 13:31:18 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/tmpcfhuaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:30 INFO - PROCESS | 1673 | RSS: Main: 161091584 13:31:30 INFO - PROCESS | 1673 | 13:32:21 INFO - PROCESS | 1673 | 1467837141730 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] 13:34:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 13:34:33 INFO - PROCESS | 1673 | RSS: Main: 323842048 13:34:33 INFO - PROCESS | 1673 | 13:37:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 13:37:36 INFO - PROCESS | 1673 | RSS: Main: 308445184 13:37:36 INFO - PROCESS | 1673 | 13:40:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 13:40:39 INFO - PROCESS | 1673 | RSS: Main: 307474432 13:40:39 INFO - PROCESS | 1673 | 13:43:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 13:43:42 INFO - PROCESS | 1673 | RSS: Main: 308019200 13:43:42 INFO - PROCESS | 1673 | 13:46:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 13:46:45 INFO - PROCESS | 1673 | RSS: Main: 277729280 13:46:45 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 13:49:48 INFO - PROCESS | 1673 | RSS: Main: 313294848 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | __start_tp_report 13:49:48 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 13:49:48 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 13:49:48 INFO - PROCESS | 1673 | |i|pagename|runs| 13:49:48 INFO - PROCESS | 1673 | |0;dojo.html;3539.115221194701;3637.8908632740995;3647.6899463545615;3655.6892664123548;3716;5940.524758019359;5991.550633702468;6002;6012.5791194616395;6063.090536419529;6002.3097343805475;6055.455009049185;6064.787732429366;6068.908966365508;6081.54388420868;5247.711375874325;5312.362516498016;5368.409474957752;5372.764264219232;5432.83701488954;5380;5427.755750991215;5432.429594892538;5433.402325744165;5440.727963601804;5333.866653333678;5366.436524164965;5397.433269506704;5405.324334458192;5422.186671999192;5385.515303622654;5386.245925570423;5408.0535906216255;5408.215808707755;5466.590005749545;5248.5538729208065;5279.60402969775;5320.787168513255;5330.680159190461;5341.6527925685095;5811.418858114197;5831.533477321804;5870.3836097209605;5875.794347197828;5924.4667979882015;6282.654454005074;6308.716107775161;6327.81016569499;6340.397662222082;6342.270638876542;4992.675476094042;6266.091416744592;6320.367963203689;6335.461485773715;6350.587211831263;5918;5996.640201587918;6017.315151757427;6031.974564324031;6050.848728781772;6460.998545225498;6497.675116244169;6499.480041596661;6506.902396464056;6508.088867558546;6111.561351782648;6296.590721603081;6311.652859092794;6311.684415779193;6313.116163737081;6255.12428260044;6301.6534090625455;6306.873862522815;6307.810765677037;6324.525660575475;6184.010558310649;6241.937580624226;6257.4681152102585;6258.468030217483;6267.185265915402;6173.32093469718;6265.686715664198;6267.9373206268265;6268.310485846553;6270.467010304084;5049.747512624354;5059.924101138486;5080.491950804964;5080.796768129233;5081.568066714297;4523.185826551252;4575.496695363508;4579.244424669892;4605.40129783126;4633.2818413146015;6075.149479072933;6100.0849872519475;6102.7253773579405;6103.176071230327;6103.908441373383;6187.752489900444;6258.593191442542;6302.558820882586;6305.684715764193;6345.96827015862;6050.425209605169;6104.481119104926;6114.540688159395;6127.586602260269;6147.493864003348;5583.274174357308;5594.41258667834;5607.41122182165;5614.989301925611;5619.522340601095;6397.552171347961;6506.739730410731;6539.738410463623;6592.472602191813;6599.670016499156;5758.8770189812585;6232.25212974446;6248.687565621792;6250.781222657367;6260.718267677874;6567.704453299518;6617.43751781104;6619;6634.303398143125;6637;6218.5647004711045;6271.153394291895;6277.183966084563;6277.843053923689;6287.779927702509;6216.191895053614;6228.813135605939;6265.655388953469;6322.0516922462;6326.525510586816;6275.654838983717;6308.747650093945;6310.6213627182515;6317.652529110943;6318;6253.468455181361;6276.058591211355;6289.27673317556;6294.433500984934;6302.779402720883;5086.949130508796;6147.108669243024;6196.690165491617;6209.130721698875;6210.968945155245;5374.871277031867;6263.561550691408;6264.624122552661;6287.559870808999;6296.433321001132;6044.607100538451;6078.756849725962;6162.568620196544;6194.349593292639;6202.534809889366 13:49:48 INFO - PROCESS | 1673 | |1;ext.html;532.095437755815;550.4468009650299;578.5718568259488;583.8365257727837;630.9841155739259;27142.728572714266;34431.31137377251;39251.80374098125;39986;40143;44889.7755511222;45165.870853228684;45248;45329.77335113328;45330;9826.656067037655;10039.29724919256;10046.397216167054;10054.698359049204;10061.69814905554;9277.907220927806;10930.726731831728;11059.668209953714;11089.778204435946;11090.667279981573;11796;11873.584424545143;11881.524739010429;11891;11906.285622862613;11863.347515886622;11921.225120367148;11937.582184623496;11952.103592230618;11955.282683038959;10855.620053298097;11701.70745731355;11809.704757381134;11810.350430726307;11816.940915295454;37070.44394334087;39934.400983985266;39939;39961.20077598432;40020;3334.4498157803932;3467.2545402738533;3586.677199052098;3851.595582463829;3985.242803867256;27654.308642284104;28131.718682813116;28183;28224.717752822413;29595.70404295951;2796.748292653671;2835.9858200709073;2871.8851245950136;2911.039357012181;2956.9408611827644;486768;501331.99999999633;501455;501603;503361;38910;39573.40639890404;39586.60413395887;39642;72767.63616181885;38846;38864.61135388666;38929.026774330865;39092.6090739089;39123.60876391257;16440.75338869918;16608.25262863174;16614.501564953072;16618.418355357506;16658.833411665728;12993.545225917047;13147.07970442079;13276.800847987288;13853.307334633228;13915.512957046658;8164.836703265902;8628.913710862937;8849.646014159362;8856.822863542693;8866.42368246062;3608.0619039050034;3676.878552041653;3682.5396825396824;3687.4100143976834;3707.443883417455;876.4434584039182;1038.065740833256;1050.9527071281811;1125.1129581632813;1133.699569614053;29803.254918627208;29831.254218644706;30200.395992080037;30483;30622.234444139074;1162.6744511536783;1226.2274766896976;1228;1239.4670291774444;1246.738184981164;13366.39851206698;15380.00029998069;15448.304826282843;15549.405698130588;15749.055056696634;525943;623389;632954;634383;634930;64795.35204647987;65525;65547.36131596749;65565.01652475217;65606;1476.1069552920544;1524.5045360258182;1557.1046648177116;1567.6551158745058;1633.0609899307944;29993.550096749004;30538;32027.83986080148;32288.83855580707;32855.83572082124;52287.73856130695;58043.839123218146;64062.67968660127;64063.03905441515;64186.67906660437;582767;593797;596596;596631;597755;37875.81062094672;45152.64542063743;45406;45968.62094137181;47275.81810454766;43567.78216109026;43825;44344.891377715816;45998.310025348976;46213;37067;37106.8144659275;37107.443388348656;37657.4351384724;37817.432738508396;33613.83193084117;33620.99137025893;36340.27319453543;36623;36943.891683249545;36992.07519812026;37124.81437592795;37152.44271335986;38944.6105538941;39468;30243.63903624298;30819.845900771248;32457.350852982338;33780.63535552488;34002.829985849916;24432.51134977326;25567.23298301054;25924.963001480482;26082.73917260879;26254.737452625992 13:49:48 INFO - PROCESS | 1673 | |2;jquery.html;359.7194188532944;413.4026331950332;417.46772864597654;421.19551656336404;428.20354141297184;16061.518154455356;16079.356825726956;16627.251773670185;21156.25953091642;21190.046447909823;20364.18543258268;20389.184432622715;20533.897330513362;21131.47171320718;21619;5892.9705351473185;5939.584229103964;6061.696915154247;6084.817455476343;6088.1476593276975;5875.441833025877;5977.1034344848185;6006;6056.818295451121;6078.057901025326;5885.735141918624;6017.638941663492;6030.095485677161;6045.33501314855;6070.150178974947;6125.142480052797;6127.417895299939;6157.230346206724;6158.753649854;6164.044573091178;5704.201411802351;6023.608465449732;6034;6043.214382130339;6044.607100538495;13934.86065139356;14152;14159.858401415957;14163.645908852259;22112.22607208756;2232.8325375596896;2265.3317271404976;2712.715164907696;2853.843038632874;2917.6352955880516;9621;10354.119899808526;10533;10555.050045495866;10555.313904596254;1754.9912250438795;1799.9370022049166;1804.9441076969988;1818.7726534183228;1838.4484654603566;122289.38855305666;131255.6874431253;133957.33021334928;134225;137150.31424842912;11940.402979850973;11973.76052478963;11976.341301228342;12082.69793255158;12084.093692973061;15408.460703875311;15442;15443.92278038625;15476.535703928901;15493.612659683598;7582.54504729718;9234;9235.769105772275;9340.252779777737;9363.391379560308;9218.354715169873;9220.769480763034;9236.538173091318;9240.8613870792;9344.626214951462;4324.978375108104;4713.552212539803;4745.881352966135;4775.808967641325;4814.470408255089;1854.4992851929903;1950.7854136045023;2045.1308194017483;2046.9385918422472;2056.3008577083565;909.9545022748836;952.9571169297399;977.9559919803626;989.2679417231341;998.5257002923698;16926.561242294298;17354.39259625907;19926.904020278733;21684.566308673737;21707.565848682938;986.1371300112402;1014.629660174046;1014.9391036537831;1019.97450063749;1088.211046990941;10944.56221751137;11426.371549564687;11437;11443.427828608535;11458.94270528642;610811;629392;632109;653128;671649;125914;129696;132870.33564832114;134369;135923;1060.4697651174413;1060.671191930504;1071.0574694269148;1081.7782354617284;1083.1118482843992;18632.254709811998;18751;18769.436916892515;18771;18989.430317090508;34413.999999998996;49888;52003.47996519986;53386.46613533815;53804;70916;73188;74260;74784.25215747773;74890.62554687192;8119.675212991414;8255.42212045151;8431.620577074169;8493.91506084956;8775.122487751174;12086.637400877988;13115.213087214415;13317.26755028444;13528.864711353153;13553.79669304981;11211.271267367594;11626;11721.355325456841;11732.70668233301;11887.583934562248;11640.35978021217;11670;11684.182107252751;11692.824607631062;11958.162928594915;11800.822987655363;11819.054475641757;11903.166778325434;12058.879411206126;12063.21589096706;8587.742367728979;8625.180607842245;8677;8734.344924130588;9002;10581.788364232827;11858.11064170208;11911.3448760319;12012.879871201525;12034.217775844541 13:49:48 INFO - PROCESS | 1673 | |3;mootools.html;1471.2423102102425;1589.6502769390734;1629.103992803958;1873.7095750158721;1975.6937674660423;8337.24964753172;9054.185123338899;9203.631854725803;9224.677136300232;9238.983711791698;8867.467951922888;9121.224695900839;9134.040925702806;9135.634574617025;9148.222401095914;2498.5127900059542;2515.6729625148705;2522.3441905104623;2523.255639586317;2523.4196134888984;2199.626063569197;2459.5695753243112;2573.4595734895693;2575.7939364850768;2581.896724131042;2525.053105085593;2558.6801649793774;2562.8334158279745;2571.614257861317;2578.419855532509;2516.018752686463;2549.821512494126;2554.604036374365;2565.8075644326564;2572.9228123156336;2517.7230504644476;2543.6438898554215;2559.372953626355;2559.7056338521124;2575.6007818788116;8941.6870409536;9173.220276276525;9225.492597907112;9225.985141634415;9226.215771659417;4778.784954677013;5805.680687562182;5854.414558544154;5856.472917437451;5872.17789509469;3670.5778835434;3762.3792074307707;3805.353089974711;3811.218700166487;3811.7331786774935;1052.074174726236;1068.56188962525;1076.4671487613602;1094.5676457799204;1105.983410248847;12462.81305780414;12520.874791252154;12638.241705497607;12681.873181268162;12717.809232861515;4805.8077676892535;4848.272759086095;4881.170201065827;4897.975510122498;4935.777889994959;9828.115469607626;9832.705018849447;9847.16299114569;9856.359336643096;9883.505824708736;5604.635698679573;5639.351474580394;5642.463965923231;5644.97177514118;5663.745131469093;4635.95364046362;4795.832145874948;5099.464556221617;5186.429492755794;5206.349206349207;4013.1171142348635;4061.086255592468;4131.752094874317;4152.937705934413;4160.45914031174;1143.451143451148;1263.8483381994035;1263.9368031598383;1273.0706584193406;1284.1652925598248;878.2052242720348;966.8646389505475;970.3547141151197;982.4940155819759;1010.4796030044533;6206.410391012847;6226.875462490725;6265.498760099181;6276.246850377984;6289.968550157311;928.5589345061042;993.5876611206413;998.2114129837493;999.645125980281;1046.4610725476387;3534.734894882894;4114.6091121343425;4143.937840932388;4186.979065104655;4190.161967606491;11095.611653592085;11395.430228488542;11482.138839587064;11597.594084207012;11612.6516204514;11257.774844503065;11546.960773530423;11561.710957226136;11565.190436669352;11619.244749091282;7966.800829979297;8437.40938134337;8510.404271701045;8557.614907329185;8800.163984421342;6034.818955431344;6079.878402432015;6109.694515274307;6139.728300528833;6163.537734670007;9829.655962041294;9839.803203936024;9888.357256778287;10083.24375671813;10263.589456421958;10068.647597334058;10092.54583543757;10364.481775911325;10414.375137491776;10464.895351046696;7137.964310178416;7359.190489046094;7359.448041397024;7891.605419729105;8047.155048720034;7821.491603045783;8704.173103555153;8785.692500762443;8814.735557933273;8836.955815220883;7642.197569255148;7699.422543309386;7751.30238278535;7853.978982732437;7893.960530197542;7545.660445280086;7568.243175682388;7599.278068583476;7729.690812367442;7739.806504837199;7325.4872158948365;7348.632568371667;7375.631218439164;7395.926040739739;7431.702731890664;4495.43807024122;5032.672876263031;5088.2876397305145;5150.536451719363;5251.107311756934;5178.042062218502;5216.321878155815;5271.868203294948;5435.782568697366;5529.087700529368 13:49:48 INFO - PROCESS | 1673 | |4;prototype.html;288.79859783301464;329.90762586475796;344.7586689317478;348.445970906259;348.8953314005798;6365.777197798078;6757.121574195354;6775.356341147595;6787.2534021257625;6836.521443498951;5525.557955363572;6816.591004539731;6857.725690972356;6868.519203655734;6879.380855722984;4295.334223195409;4914.287428322909;5056.873578160538;5061.240813877929;5077.0861244975795;5027.396712394499;5049.621278404116;5050.141475949097;5055.595552355802;5056.84829455117;4083.734557253784;5010.123228435027;5011.67424117433;5030.195168772997;5041.72270525121;4864.635152363551;5022.970291090318;5025.296458495795;5026.371703537058;5027.824026159085;3605.675489205984;3930.842766289345;4015.5984401559904;4333.241682705546;4342.34864770287;5413.052715774763;6442.775872584194;6603;6607.867842643121;6619.834504137387;4568.680192386534;5986.401359864022;5986.491148252404;5989.251343582052;6002.909956350658;7251.5286506376915;7256.238095000054;7259.673314700851;7260.818479538001;7276.708931642728;4805.927911081337;4810;4817.686850354751;4825.10735513931;4825.276208568707;7271.636418179123;7321.78034658961;7566.962165189194;7567.508111972759;7598.354139898115;4014.759114453142;4653.906921861544;4738.597219236403;4773.212419950739;4781.139394908881;4615.79228934692;4843.007183527368;4852.223644216909;4858.416989961227;4864.635152363587;5600.243967064394;5617.354004289477;5633.380328163898;5637.985162670759;5743.396943320975;7244.601546914971;7246.456515761339;7250.347468727839;7259.6007219603425;7263.30998555147;1653.9503814885572;1676.513810994798;1678.4880611413391;1680.9495715128567;1682.5793551612096;920.6547544670749;1039.6828967164936;1063.1335461598771;1076.7954088723118;1089.3844977587637;6928.272531384132;6970.093887794555;6979.581225126509;6983.720651173998;6988.720451181895;6198.597091189058;7525.397968162534;7530.43521735872;7543.660535275816;7552.282533159451;6982.546134501241;6983.650817459106;6987.231404545496;6987.8602427951155;7010.088688470568;3869.8645547405704;3954.8813535593977;3989.58109398509;3997.84008639657;4001.2597669430666;7987.720429784929;8033.598320084089;8034.598270086472;8038.718644847402;8043.83912321762;7807.258310460497;7824.9608751955875;7830.530168189927;7847.332976696931;7852.489588176751;8029.7189598363775;8045.758627241192;8048.07447143586;8049.39629527776;8055.590271702428;6253.937460625518;7301.452391070798;7576.924230757621;7595.734149304748;7613.276738709814;6105.786297479567;7419.258074192538;7465.253474652492;7485.812854678677;7509.6245187739305;6393.944999075101;7749.225077492206;7770.844583108419;7984.441089123938;8005;4720.386349774644;4823.348847905488;4828.203346447796;4828.396450443694;4839.540243676845;7606.96196519036;7612.619369031416;7624.390048796194;7626.8093297668;7630.465867389229;6526.543141980016;6809.672113937734;7091.468139889632;7334.853302934018;7348.669309880961;7294;7313.049303590499;7324.523905946096;7327.864181051946;7335.193128755725;5814.796482123105;7064.293570642894;7147.928520714726;7151.642417878981;7158.463115266271;6987.672342254955;7325.047743793273;7327.047483827068;7334.523255988343;7337.853242935218;6195.31851496326;6893.448524118159;7151.892721609076;7198.856022879409;7201.3158749918675 13:49:48 INFO - PROCESS | 1673 | |5;yui.html;766.2529034191664;784.4195295481345;792.271110578268;797.2864286463619;857.5883575883572;15394.384224631016;15405;15603.297851596677;15660.373585056584;15785.36858525659;14565.198914059722;14613.415463381452;14672.413103475848;14674.26628668565;14674.486392976221;786.437697046613;808.9887640449438;811.2495941254346;811.5495899775622;814.7189219719218;952.5046975572698;979.6130528441262;980.181548407081;981.1660088924393;981.5141504955058;1010.3735683876007;1031.4275577054732;1032.8347464405697;1033.1579762493582;1036.6060896859183;827.8344331133798;1007.0885848307294;1013.2856336282903;1024.6464969585481;1026.7843752811882;776.5379599138504;781.277318480409;781.5584194929846;782.1787123520281;783.7100272899064;15464.5360639181;15622.14078225697;15635.218239088;15641.530754077396;15651.373945042185;13094.279814610192;13493.12294700851;13505.932470337684;13588.116772409861;13693.383797729026;9920.702378928643;10248.74378140545;10283.177345812317;10751.892481075167;10752.032317091422;3599.8560057597665;3600.261946301002;3628.4738712886747;3682.318771027342;3861.5366156061455;80966;82463;82745.58627206825;82767.5861620694;86920.13079869247;9064.637414503346;9178.449293042439;9280.489573073546;9701.466419346863;9933.950330248303;21827.162468878945;21951.780482195292;22060.558788824135;22074.779252207594;22116.33650990473;7656.808579785438;7733.535987840747;7743.264389882952;7807.297343239135;7968;4151.73013754105;4186.225548273518;4214.852480163179;4227.51383590891;4484.349769283501;3124.8281344526267;3616.5479315085613;3843.0584506795453;3847.019010152393;3858.903527411781;686.7459040155074;702.4029574861327;706.2549010793662;714.1430283659629;731.6524650790939;508.53977150678696;573.9454751798572;584.5586582130464;620.7089254350939;645.1516256123183;8331.916680833114;8335.208155225244;8338.958305208434;8354.331653467709;8478.194571515696;605.678990135229;619.2476141488114;636.3922454056365;639.4245179338633;641.8748344072861;3849.8845034649007;3873.5932727063814;3873.7288389812443;3922.666573341241;4061.6953728470485;87446.56276718575;89084.55457722669;89229.55385223032;94793.5260323694;95493;70694;72136.55726885538;73501;77836.05409864799;79145.60427197827;60758.5696572141;63973.04040439397;66747.66626166838;68378.65810670915;72637.54724905473;8681;8728;8856.557172141496;8997.235235005099;9096.590653420479;46514.53485465102;50562.2415663758;50931.745341273054;51166.465006049875;52293;63170.68414657897;64902.67548662415;70426;71757.92363114453;71933;10877.45612719345;11046.392448415414;11213.990740833038;11305.830412543653;11711.355875426932;12093.213941093802;12182.269063856196;12236.08229382782;12314.630561083182;12426.62720118398;8935.854468674099;10361.844572331573;11057.778844423228;11829.64511064635;12121.333326667118;11328.716782080513;11459.48432320531;11545.711357215801;11642.941785291358;11911.047116230855;11356.313151404038;11546.59586914454;11691.356975366096;11717.414129293671;11751.764964700487;9529.952350238205;9764.658236961672;9845.556949937127;10058.245631577514;10099.293049486465;9982.60069597208;9982.950085249528;9992.450415227233;10013.148882345082;10020.148287395654 13:49:48 INFO - PROCESS | 1673 | __end_tp_report 13:49:48 INFO - PROCESS | 1673 | __start_cc_report 13:49:48 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1514 13:49:48 INFO - PROCESS | 1673 | __end_cc_report 13:49:48 INFO - PROCESS | 1673 | __startTimestamp1467838188419__endTimestamp 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | ------- Summary: start ------- 13:49:48 INFO - PROCESS | 1673 | Number of tests: 6 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5900.81 Median:6147.49 stddev:622.69 (10.1%) stddev-sans-first:596.40 13:49:48 INFO - PROCESS | 1673 | Values: 3539.1 3637.9 3647.7 3655.7 3716.0 5940.5 5991.6 6002.0 6012.6 6063.1 6002.3 6055.5 6064.8 6068.9 6081.5 5247.7 5312.4 5368.4 5372.8 5432.8 5380.0 5427.8 5432.4 5433.4 5440.7 5333.9 5366.4 5397.4 5405.3 5422.2 5385.5 5386.2 5408.1 5408.2 5466.6 5248.6 5279.6 5320.8 5330.7 5341.7 5811.4 5831.5 5870.4 5875.8 5924.5 6282.7 6308.7 6327.8 6340.4 6342.3 4992.7 6266.1 6320.4 6335.5 6350.6 5918.0 5996.6 6017.3 6032.0 6050.8 6461.0 6497.7 6499.5 6506.9 6508.1 6111.6 6296.6 6311.7 6311.7 6313.1 6255.1 6301.7 6306.9 6307.8 6324.5 6184.0 6241.9 6257.5 6258.5 6267.2 6173.3 6265.7 6267.9 6268.3 6270.5 5049.7 5059.9 5080.5 5080.8 5081.6 4523.2 4575.5 4579.2 4605.4 4633.3 6075.1 6100.1 6102.7 6103.2 6103.9 6187.8 6258.6 6302.6 6305.7 6346.0 6050.4 6104.5 6114.5 6127.6 6147.5 5583.3 5594.4 5607.4 5615.0 5619.5 6397.6 6506.7 6539.7 6592.5 6599.7 5758.9 6232.3 6248.7 6250.8 6260.7 6567.7 6617.4 6619.0 6634.3 6637.0 6218.6 6271.2 6277.2 6277.8 6287.8 6216.2 6228.8 6265.7 6322.1 6326.5 6275.7 6308.7 6310.6 6317.7 6318.0 6253.5 6276.1 6289.3 6294.4 6302.8 5086.9 6147.1 6196.7 6209.1 6211.0 5374.9 6263.6 6264.6 6287.6 6296.4 6044.6 6078.8 6162.6 6194.3 6202.5 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:69633.84 Median:36481.64 stddev:152410.19 (417.8%) stddev-sans-first:152749.44 13:49:48 INFO - PROCESS | 1673 | Values: 532.1 550.4 578.6 583.8 631.0 27142.7 34431.3 39251.8 39986.0 40143.0 44889.8 45165.9 45248.0 45329.8 45330.0 9826.7 10039.3 10046.4 10054.7 10061.7 9277.9 10930.7 11059.7 11089.8 11090.7 11796.0 11873.6 11881.5 11891.0 11906.3 11863.3 11921.2 11937.6 11952.1 11955.3 10855.6 11701.7 11809.7 11810.4 11816.9 37070.4 39934.4 39939.0 39961.2 40020.0 3334.4 3467.3 3586.7 3851.6 3985.2 27654.3 28131.7 28183.0 28224.7 29595.7 2796.7 2836.0 2871.9 2911.0 2956.9 486768.0 501332.0 501455.0 501603.0 503361.0 38910.0 39573.4 39586.6 39642.0 72767.6 38846.0 38864.6 38929.0 39092.6 39123.6 16440.8 16608.3 16614.5 16618.4 16658.8 12993.5 13147.1 13276.8 13853.3 13915.5 8164.8 8628.9 8849.6 8856.8 8866.4 3608.1 3676.9 3682.5 3687.4 3707.4 876.4 1038.1 1051.0 1125.1 1133.7 29803.3 29831.3 30200.4 30483.0 30622.2 1162.7 1226.2 1228.0 1239.5 1246.7 13366.4 15380.0 15448.3 15549.4 15749.1 525943.0 623389.0 632954.0 634383.0 634930.0 64795.4 65525.0 65547.4 65565.0 65606.0 1476.1 1524.5 1557.1 1567.7 1633.1 29993.6 30538.0 32027.8 32288.8 32855.8 52287.7 58043.8 64062.7 64063.0 64186.7 582767.0 593797.0 596596.0 596631.0 597755.0 37875.8 45152.6 45406.0 45968.6 47275.8 43567.8 43825.0 44344.9 45998.3 46213.0 37067.0 37106.8 37107.4 37657.4 37817.4 33613.8 33621.0 36340.3 36623.0 36943.9 36992.1 37124.8 37152.4 38944.6 39468.0 30243.6 30819.8 32457.4 33780.6 34002.8 24432.5 25567.2 25925.0 26082.7 26254.7 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:36320.39 Median:11593.89 stddev:106762.35 (920.9%) stddev-sans-first:107027.70 13:49:48 INFO - PROCESS | 1673 | Values: 359.7 413.4 417.5 421.2 428.2 16061.5 16079.4 16627.3 21156.3 21190.0 20364.2 20389.2 20533.9 21131.5 21619.0 5893.0 5939.6 6061.7 6084.8 6088.1 5875.4 5977.1 6006.0 6056.8 6078.1 5885.7 6017.6 6030.1 6045.3 6070.2 6125.1 6127.4 6157.2 6158.8 6164.0 5704.2 6023.6 6034.0 6043.2 6044.6 13934.9 14152.0 14159.9 14163.6 22112.2 2232.8 2265.3 2712.7 2853.8 2917.6 9621.0 10354.1 10533.0 10555.1 10555.3 1755.0 1799.9 1804.9 1818.8 1838.4 122289.4 131255.7 133957.3 134225.0 137150.3 11940.4 11973.8 11976.3 12082.7 12084.1 15408.5 15442.0 15443.9 15476.5 15493.6 7582.5 9234.0 9235.8 9340.3 9363.4 9218.4 9220.8 9236.5 9240.9 9344.6 4325.0 4713.6 4745.9 4775.8 4814.5 1854.5 1950.8 2045.1 2046.9 2056.3 910.0 953.0 978.0 989.3 998.5 16926.6 17354.4 19926.9 21684.6 21707.6 986.1 1014.6 1014.9 1020.0 1088.2 10944.6 11426.4 11437.0 11443.4 11458.9 610811.0 629392.0 632109.0 653128.0 671649.0 125914.0 129696.0 132870.3 134369.0 135923.0 1060.5 1060.7 1071.1 1081.8 1083.1 18632.3 18751.0 18769.4 18771.0 18989.4 34414.0 49888.0 52003.5 53386.5 53804.0 70916.0 73188.0 74260.0 74784.3 74890.6 8119.7 8255.4 8431.6 8493.9 8775.1 12086.6 13115.2 13317.3 13528.9 13553.8 11211.3 11626.0 11721.4 11732.7 11887.6 11640.4 11670.0 11684.2 11692.8 11958.2 11800.8 11819.1 11903.2 12058.9 12063.2 8587.7 8625.2 8677.0 8734.3 9002.0 10581.8 11858.1 11911.3 12012.9 12034.2 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5963.21 Median:5125.00 stddev:3331.49 (65.0%) stddev-sans-first:3323.73 13:49:48 INFO - PROCESS | 1673 | Values: 1471.2 1589.7 1629.1 1873.7 1975.7 8337.2 9054.2 9203.6 9224.7 9239.0 8867.5 9121.2 9134.0 9135.6 9148.2 2498.5 2515.7 2522.3 2523.3 2523.4 2199.6 2459.6 2573.5 2575.8 2581.9 2525.1 2558.7 2562.8 2571.6 2578.4 2516.0 2549.8 2554.6 2565.8 2572.9 2517.7 2543.6 2559.4 2559.7 2575.6 8941.7 9173.2 9225.5 9226.0 9226.2 4778.8 5805.7 5854.4 5856.5 5872.2 3670.6 3762.4 3805.4 3811.2 3811.7 1052.1 1068.6 1076.5 1094.6 1106.0 12462.8 12520.9 12638.2 12681.9 12717.8 4805.8 4848.3 4881.2 4898.0 4935.8 9828.1 9832.7 9847.2 9856.4 9883.5 5604.6 5639.4 5642.5 5645.0 5663.7 4636.0 4795.8 5099.5 5186.4 5206.3 4013.1 4061.1 4131.8 4152.9 4160.5 1143.5 1263.8 1263.9 1273.1 1284.2 878.2 966.9 970.4 982.5 1010.5 6206.4 6226.9 6265.5 6276.2 6290.0 928.6 993.6 998.2 999.6 1046.5 3534.7 4114.6 4143.9 4187.0 4190.2 11095.6 11395.4 11482.1 11597.6 11612.7 11257.8 11547.0 11561.7 11565.2 11619.2 7966.8 8437.4 8510.4 8557.6 8800.2 6034.8 6079.9 6109.7 6139.7 6163.5 9829.7 9839.8 9888.4 10083.2 10263.6 10068.6 10092.5 10364.5 10414.4 10464.9 7138.0 7359.2 7359.4 7891.6 8047.2 7821.5 8704.2 8785.7 8814.7 8837.0 7642.2 7699.4 7751.3 7854.0 7894.0 7545.7 7568.2 7599.3 7729.7 7739.8 7325.5 7348.6 7375.6 7395.9 7431.7 4495.4 5032.7 5088.3 5150.5 5251.1 5178.0 5216.3 5271.9 5435.8 5529.1 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5916.67 Median:6798.46 stddev:1926.07 (28.3%) stddev-sans-first:1884.58 13:49:48 INFO - PROCESS | 1673 | Values: 288.8 329.9 344.8 348.4 348.9 6365.8 6757.1 6775.4 6787.3 6836.5 5525.6 6816.6 6857.7 6868.5 6879.4 4295.3 4914.3 5056.9 5061.2 5077.1 5027.4 5049.6 5050.1 5055.6 5056.8 4083.7 5010.1 5011.7 5030.2 5041.7 4864.6 5023.0 5025.3 5026.4 5027.8 3605.7 3930.8 4015.6 4333.2 4342.3 5413.1 6442.8 6603.0 6607.9 6619.8 4568.7 5986.4 5986.5 5989.3 6002.9 7251.5 7256.2 7259.7 7260.8 7276.7 4805.9 4810.0 4817.7 4825.1 4825.3 7271.6 7321.8 7567.0 7567.5 7598.4 4014.8 4653.9 4738.6 4773.2 4781.1 4615.8 4843.0 4852.2 4858.4 4864.6 5600.2 5617.4 5633.4 5638.0 5743.4 7244.6 7246.5 7250.3 7259.6 7263.3 1654.0 1676.5 1678.5 1680.9 1682.6 920.7 1039.7 1063.1 1076.8 1089.4 6928.3 6970.1 6979.6 6983.7 6988.7 6198.6 7525.4 7530.4 7543.7 7552.3 6982.5 6983.7 6987.2 6987.9 7010.1 3869.9 3954.9 3989.6 3997.8 4001.3 7987.7 8033.6 8034.6 8038.7 8043.8 7807.3 7825.0 7830.5 7847.3 7852.5 8029.7 8045.8 8048.1 8049.4 8055.6 6253.9 7301.5 7576.9 7595.7 7613.3 6105.8 7419.3 7465.3 7485.8 7509.6 6393.9 7749.2 7770.8 7984.4 8005.0 4720.4 4823.3 4828.2 4828.4 4839.5 7607.0 7612.6 7624.4 7626.8 7630.5 6526.5 6809.7 7091.5 7334.9 7348.7 7294.0 7313.0 7324.5 7327.9 7335.2 5814.8 7064.3 7147.9 7151.6 7158.5 6987.7 7325.0 7327.0 7334.5 7337.9 6195.3 6893.4 7151.9 7198.9 7201.3 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18350.02 Median:51729.73 stddev:25393.26 (49.1%) stddev-sans-first:25430.17 13:49:48 INFO - PROCESS | 1673 | Values: 766.3 784.4 792.3 797.3 857.6 15394.4 15405.0 15603.3 15660.4 15785.4 14565.2 14613.4 14672.4 14674.3 14674.5 786.4 809.0 811.2 811.5 814.7 952.5 979.6 980.2 981.2 981.5 1010.4 1031.4 1032.8 1033.2 1036.6 827.8 1007.1 1013.3 1024.6 1026.8 776.5 781.3 781.6 782.2 783.7 15464.5 15622.1 15635.2 15641.5 15651.4 13094.3 13493.1 13505.9 13588.1 13693.4 9920.7 10248.7 10283.2 10751.9 10752.0 3599.9 3600.3 3628.5 3682.3 3861.5 80966.0 82463.0 82745.6 82767.6 86920.1 9064.6 9178.4 9280.5 9701.5 9934.0 21827.2 21951.8 22060.6 22074.8 22116.3 7656.8 7733.5 7743.3 7807.3 7968.0 4151.7 4186.2 4214.9 4227.5 4484.3 3124.8 3616.5 3843.1 3847.0 3858.9 686.7 702.4 706.3 714.1 731.7 508.5 573.9 584.6 620.7 645.2 8331.9 8335.2 8339.0 8354.3 8478.2 605.7 619.2 636.4 639.4 641.9 3849.9 3873.6 3873.7 3922.7 4061.7 87446.6 89084.6 89229.6 94793.5 95493.0 70694.0 72136.6 73501.0 77836.1 79145.6 60758.6 63973.0 66747.7 68378.7 72637.5 8681.0 8728.0 8856.6 8997.2 9096.6 46514.5 50562.2 50931.7 51166.5 52293.0 63170.7 64902.7 70426.0 71757.9 71933.0 10877.5 11046.4 11214.0 11305.8 11711.4 12093.2 12182.3 12236.1 12314.6 12426.6 8935.9 10361.8 11057.8 11829.6 12121.3 11328.7 11459.5 11545.7 11642.9 11911.0 11356.3 11546.6 11691.4 11717.4 11751.8 9530.0 9764.7 9845.6 10058.2 10099.3 9982.6 9983.0 9992.5 10013.1 10020.1 13:49:48 INFO - PROCESS | 1673 | -------- Summary: end -------- 13:49:48 INFO - PROCESS | 1673 | 13:49:48 INFO - TEST-INFO | 1673: exit 0 13:49:48 INFO - TEST-OK | dromaeo_css | took 1113476ms 13:49:48 INFO - TEST-START | kraken 13:49:48 INFO - operating with platform_type : mac_ 13:49:48 INFO - Initialising browser for kraken test... 13:49:48 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/tmpp6yQRF/profile http://localhost:49269/getInfo.html) 13:49:51 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 13:49:51 INFO - PROCESS | 1679 | colorDepth:24 13:49:51 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 13:49:51 INFO - PROCESS | 1679 | __metrics 13:49:51 INFO - PROCESS | 1679 | 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" 13:49:51 ERROR - PROCESS | 1679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:49:51 INFO - TEST-INFO | 1679: exit 0 13:49:51 INFO - Browser initialized. 13:49:51 INFO - Running cycle 1/1 for kraken test... 13:49:51 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/T/tmpp6yQRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:03 INFO - PROCESS | 1682 | RSS: Main: 161468416 13:50:03 INFO - PROCESS | 1682 | 13:50:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 13:50:07 INFO - PROCESS | 1682 | RSS: Main: 223932416 13:50:07 INFO - PROCESS | 1682 | 13:50:09 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 13:50:10 INFO - PROCESS | 1682 | RSS: Main: 239566848 13:50:10 INFO - PROCESS | 1682 | 13:50:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 13:50:14 INFO - PROCESS | 1682 | RSS: Main: 325197824 13:50:14 INFO - PROCESS | 1682 | 13:50:16 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 13:50:16 INFO - PROCESS | 1682 | RSS: Main: 230461440 13:50:16 INFO - PROCESS | 1682 | 13:50:19 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:50:19 INFO - PROCESS | 1682 | RSS: Main: 232017920 13:50:19 INFO - PROCESS | 1682 | 13:50:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 13:50:23 INFO - PROCESS | 1682 | RSS: Main: 270581760 13:50:23 INFO - PROCESS | 1682 | 13:50:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 13:50:26 INFO - PROCESS | 1682 | RSS: Main: 270467072 13:50:26 INFO - PROCESS | 1682 | 13:50:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 13:50:29 INFO - PROCESS | 1682 | RSS: Main: 269283328 13:50:29 INFO - PROCESS | 1682 | 13:50:31 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:50:32 INFO - PROCESS | 1682 | RSS: Main: 259383296 13:50:32 INFO - PROCESS | 1682 | 13:50:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:50:34 INFO - PROCESS | 1682 | RSS: Main: 267567104 13:50:34 INFO - PROCESS | 1682 | 13:50:36 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:50:37 INFO - PROCESS | 1682 | RSS: Main: 270893056 13:50:37 INFO - PROCESS | 1682 | 13:50:39 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:50:40 INFO - PROCESS | 1682 | RSS: Main: 278077440 13:50:40 INFO - PROCESS | 1682 | 13:50:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:50:44 INFO - PROCESS | 1682 | RSS: Main: 275214336 13:50:44 INFO - PROCESS | 1682 | 13:50:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 13:50:46 INFO - PROCESS | 1682 | RSS: Main: 336011264 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | __start_tp_report 13:50:46 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 13:50:46 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 13:50:46 INFO - PROCESS | 1682 | |i|pagename|runs| 13:50:46 INFO - PROCESS | 1682 | |0;ai-astar;152;165;167;113;112;112;114;113;115;133 13:50:46 INFO - PROCESS | 1682 | |1;audio-beat-detection;153;123;176;195;132;139;118;148;151;111 13:50:46 INFO - PROCESS | 1682 | |2;audio-dft;186;184;187;184;186;185;186;187;186;185 13:50:46 INFO - PROCESS | 1682 | |3;audio-fft;70;77;72;152;55;79;82;90;128;56 13:50:46 INFO - PROCESS | 1682 | |4;audio-oscillator;92;91;137;75;82;129;120;79;73;124 13:50:46 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;88;85;88;85;87;83;89;89;134;113 13:50:46 INFO - PROCESS | 1682 | |6;imaging-darkroom;93;93;93;94;93;92;93;93;93;93 13:50:46 INFO - PROCESS | 1682 | |7;imaging-desaturate;87;85;86;84;85;86;85;83;87;83 13:50:46 INFO - PROCESS | 1682 | |8;json-parse-financial;58;61;64;61;63;62;62;78;59;57 13:50:46 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;61;65;66;77;70;68;68;66;66;67 13:50:46 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;79;79;79;77;79;77;80;77;78;94 13:50:46 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;129;135;135;127;138;136;124;129;169;135 13:50:46 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;163;164;174;173;160;165;186;191;162;162 13:50:46 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;66;67;67;67;66;66;67;72;92;89 13:50:46 INFO - PROCESS | 1682 | __end_tp_report 13:50:46 INFO - PROCESS | 1682 | __start_cc_report 13:50:46 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1904 13:50:46 INFO - PROCESS | 1682 | __end_cc_report 13:50:46 INFO - PROCESS | 1682 | __startTimestamp1467838246107__endTimestamp 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | ------- Summary: start ------- 13:50:46 INFO - PROCESS | 1682 | Number of tests: 14 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:129.60 Median:124.00 stddev:23.08 (18.6%) stddev-sans-first:23.01 13:50:46 INFO - PROCESS | 1682 | Values: 152.0 165.0 167.0 113.0 112.0 112.0 114.0 113.0 115.0 133.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:149.50 stddev:26.12 (17.5%) stddev-sans-first:27.53 13:50:46 INFO - PROCESS | 1682 | Values: 153.0 123.0 176.0 195.0 132.0 139.0 118.0 148.0 151.0 111.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.00 stddev:1.07 (0.6%) stddev-sans-first:1.13 13:50:46 INFO - PROCESS | 1682 | Values: 186.0 184.0 187.0 184.0 186.0 185.0 186.0 187.0 186.0 185.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.50 stddev:30.90 (41.5%) stddev-sans-first:32.22 13:50:46 INFO - PROCESS | 1682 | Values: 70.0 77.0 72.0 152.0 55.0 79.0 82.0 90.0 128.0 56.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:77.00 stddev:24.61 (32.0%) stddev-sans-first:25.92 13:50:46 INFO - PROCESS | 1682 | Values: 92.0 91.0 137.0 75.0 82.0 129.0 120.0 79.0 73.0 124.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:87.50 stddev:16.38 (18.7%) stddev-sans-first:17.22 13:50:46 INFO - PROCESS | 1682 | Values: 88.0 85.0 88.0 85.0 87.0 83.0 89.0 89.0 134.0 113.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:50:46 INFO - PROCESS | 1682 | Values: 93.0 93.0 93.0 94.0 93.0 92.0 93.0 93.0 93.0 93.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.45 (1.7%) stddev-sans-first:1.36 13:50:46 INFO - PROCESS | 1682 | Values: 87.0 85.0 86.0 84.0 85.0 86.0 85.0 83.0 87.0 83.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.00 stddev:5.87 (9.5%) stddev-sans-first:6.00 13:50:46 INFO - PROCESS | 1682 | Values: 58.0 61.0 64.0 61.0 63.0 62.0 62.0 78.0 59.0 57.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:4.12 (6.1%) stddev-sans-first:3.66 13:50:46 INFO - PROCESS | 1682 | Values: 61.0 65.0 66.0 77.0 70.0 68.0 68.0 66.0 66.0 67.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:5.07 (6.4%) stddev-sans-first:5.36 13:50:46 INFO - PROCESS | 1682 | Values: 79.0 79.0 79.0 77.0 79.0 77.0 80.0 77.0 78.0 94.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:135.00 stddev:12.55 (9.3%) stddev-sans-first:13.08 13:50:46 INFO - PROCESS | 1682 | Values: 129.0 135.0 135.0 127.0 138.0 136.0 124.0 129.0 169.0 135.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:169.00 stddev:10.85 (6.4%) stddev-sans-first:11.21 13:50:46 INFO - PROCESS | 1682 | Values: 163.0 164.0 174.0 173.0 160.0 165.0 186.0 191.0 162.0 162.0 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:67.00 stddev:9.98 (14.9%) stddev-sans-first:10.36 13:50:46 INFO - PROCESS | 1682 | Values: 66.0 67.0 67.0 67.0 66.0 66.0 67.0 72.0 92.0 89.0 13:50:46 INFO - PROCESS | 1682 | -------- Summary: end -------- 13:50:46 INFO - PROCESS | 1682 | 13:50:46 INFO - TEST-INFO | 1682: exit 0 13:50:46 INFO - TEST-OK | kraken | took 57890ms 13:50:46 INFO - SUITE-END | took 1171s 13:50:47 INFO - Completed test suite (00:19:31) 13:50:47 INFO - javascript benchmark 13:50:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3539.115221194701, 3637.8908632740995, 3647.6899463545615, 3655.6892664123548, 3716.0, 5940.524758019359, 5991.550633702468, 6002.0, 6012.5791194616395, 6063.090536419529, 6002.3097343805475, 6055.455009049185, 6064.787732429366, 6068.908966365508, 6081.54388420868, 5247.711375874325, 5312.362516498016, 5368.409474957752, 5372.764264219232, 5432.83701488954, 5380.0, 5427.755750991215, 5432.429594892538, 5433.402325744165, 5440.727963601804, 5333.866653333678, 5366.436524164965, 5397.433269506704, 5405.324334458192, 5422.186671999192, 5385.515303622654, 5386.245925570423, 5408.0535906216255, 5408.215808707755, 5466.590005749545, 5248.5538729208065, 5279.60402969775, 5320.787168513255, 5330.680159190461, 5341.6527925685095, 5811.418858114197, 5831.533477321804, 5870.3836097209605, 5875.794347197828, 5924.4667979882015, 6282.654454005074, 6308.716107775161, 6327.81016569499, 6340.397662222082, 6342.270638876542, 4992.675476094042, 6266.091416744592, 6320.367963203689, 6335.461485773715, 6350.587211831263, 5918.0, 5996.640201587918, 6017.315151757427, 6031.974564324031, 6050.848728781772, 6460.998545225498, 6497.675116244169, 6499.480041596661, 6506.902396464056, 6508.088867558546, 6111.561351782648, 6296.590721603081, 6311.652859092794, 6311.684415779193, 6313.116163737081, 6255.12428260044, 6301.6534090625455, 6306.873862522815, 6307.810765677037, 6324.525660575475, 6184.010558310649, 6241.937580624226, 6257.4681152102585, 6258.468030217483, 6267.185265915402, 6173.32093469718, 6265.686715664198, 6267.9373206268265, 6268.310485846553, 6270.467010304084, 5049.747512624354, 5059.924101138486, 5080.491950804964, 5080.796768129233, 5081.568066714297, 4523.185826551252, 4575.496695363508, 4579.244424669892, 4605.40129783126, 4633.2818413146015, 6075.149479072933, 6100.0849872519475, 6102.7253773579405, 6103.176071230327, 6103.908441373383, 6187.752489900444, 6258.593191442542, 6302.558820882586, 6305.684715764193, 6345.96827015862, 6050.425209605169, 6104.481119104926, 6114.540688159395, 6127.586602260269, 6147.493864003348, 5583.274174357308, 5594.41258667834, 5607.41122182165, 5614.989301925611, 5619.522340601095, 6397.552171347961, 6506.739730410731, 6539.738410463623, 6592.472602191813, 6599.670016499156, 5758.8770189812585, 6232.25212974446, 6248.687565621792, 6250.781222657367, 6260.718267677874, 6567.704453299518, 6617.43751781104, 6619.0, 6634.303398143125, 6637.0, 6218.5647004711045, 6271.153394291895, 6277.183966084563, 6277.843053923689, 6287.779927702509, 6216.191895053614, 6228.813135605939, 6265.655388953469, 6322.0516922462, 6326.525510586816, 6275.654838983717, 6308.747650093945, 6310.6213627182515, 6317.652529110943, 6318.0, 6253.468455181361, 6276.058591211355, 6289.27673317556, 6294.433500984934, 6302.779402720883, 5086.949130508796, 6147.108669243024, 6196.690165491617, 6209.130721698875, 6210.968945155245, 5374.871277031867, 6263.561550691408, 6264.624122552661, 6287.559870808999, 6296.433321001132, 6044.607100538451, 6078.756849725962, 6162.568620196544, 6194.349593292639, 6202.534809889366], "value": 5864.456758550424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.095437755815, 550.4468009650299, 578.5718568259488, 583.8365257727837, 630.9841155739259, 27142.728572714266, 34431.31137377251, 39251.80374098125, 39986.0, 40143.0, 44889.7755511222, 45165.870853228684, 45248.0, 45329.77335113328, 45330.0, 9826.656067037655, 10039.29724919256, 10046.397216167054, 10054.698359049204, 10061.69814905554, 9277.907220927806, 10930.726731831728, 11059.668209953714, 11089.778204435946, 11090.667279981573, 11796.0, 11873.584424545143, 11881.524739010429, 11891.0, 11906.285622862613, 11863.347515886622, 11921.225120367148, 11937.582184623496, 11952.103592230618, 11955.282683038959, 10855.620053298097, 11701.70745731355, 11809.704757381134, 11810.350430726307, 11816.940915295454, 37070.44394334087, 39934.400983985266, 39939.0, 39961.20077598432, 40020.0, 3334.4498157803932, 3467.2545402738533, 3586.677199052098, 3851.595582463829, 3985.242803867256, 27654.308642284104, 28131.718682813116, 28183.0, 28224.717752822413, 29595.70404295951, 2796.748292653671, 2835.9858200709073, 2871.8851245950136, 2911.039357012181, 2956.9408611827644, 486768.0, 501331.99999999633, 501455.0, 501603.0, 503361.0, 38910.0, 39573.40639890404, 39586.60413395887, 39642.0, 72767.63616181885, 38846.0, 38864.61135388666, 38929.026774330865, 39092.6090739089, 39123.60876391257, 16440.75338869918, 16608.25262863174, 16614.501564953072, 16618.418355357506, 16658.833411665728, 12993.545225917047, 13147.07970442079, 13276.800847987288, 13853.307334633228, 13915.512957046658, 8164.836703265902, 8628.913710862937, 8849.646014159362, 8856.822863542693, 8866.42368246062, 3608.0619039050034, 3676.878552041653, 3682.5396825396824, 3687.4100143976834, 3707.443883417455, 876.4434584039182, 1038.065740833256, 1050.9527071281811, 1125.1129581632813, 1133.699569614053, 29803.254918627208, 29831.254218644706, 30200.395992080037, 30483.0, 30622.234444139074, 1162.6744511536783, 1226.2274766896976, 1228.0, 1239.4670291774444, 1246.738184981164, 13366.39851206698, 15380.00029998069, 15448.304826282843, 15549.405698130588, 15749.055056696634, 525943.0, 623389.0, 632954.0, 634383.0, 634930.0, 64795.35204647987, 65525.0, 65547.36131596749, 65565.01652475217, 65606.0, 1476.1069552920544, 1524.5045360258182, 1557.1046648177116, 1567.6551158745058, 1633.0609899307944, 29993.550096749004, 30538.0, 32027.83986080148, 32288.83855580707, 32855.83572082124, 52287.73856130695, 58043.839123218146, 64062.67968660127, 64063.03905441515, 64186.67906660437, 582767.0, 593797.0, 596596.0, 596631.0, 597755.0, 37875.81062094672, 45152.64542063743, 45406.0, 45968.62094137181, 47275.81810454766, 43567.78216109026, 43825.0, 44344.891377715816, 45998.310025348976, 46213.0, 37067.0, 37106.8144659275, 37107.443388348656, 37657.4351384724, 37817.432738508396, 33613.83193084117, 33620.99137025893, 36340.27319453543, 36623.0, 36943.891683249545, 36992.07519812026, 37124.81437592795, 37152.44271335986, 38944.6105538941, 39468.0, 30243.63903624298, 30819.845900771248, 32457.350852982338, 33780.63535552488, 34002.829985849916, 24432.51134977326, 25567.23298301054, 25924.963001480482, 26082.73917260879, 26254.737452625992], "value": 19723.005945633424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.7194188532944, 413.4026331950332, 417.46772864597654, 421.19551656336404, 428.20354141297184, 16061.518154455356, 16079.356825726956, 16627.251773670185, 21156.25953091642, 21190.046447909823, 20364.18543258268, 20389.184432622715, 20533.897330513362, 21131.47171320718, 21619.0, 5892.9705351473185, 5939.584229103964, 6061.696915154247, 6084.817455476343, 6088.1476593276975, 5875.441833025877, 5977.1034344848185, 6006.0, 6056.818295451121, 6078.057901025326, 5885.735141918624, 6017.638941663492, 6030.095485677161, 6045.33501314855, 6070.150178974947, 6125.142480052797, 6127.417895299939, 6157.230346206724, 6158.753649854, 6164.044573091178, 5704.201411802351, 6023.608465449732, 6034.0, 6043.214382130339, 6044.607100538495, 13934.86065139356, 14152.0, 14159.858401415957, 14163.645908852259, 22112.22607208756, 2232.8325375596896, 2265.3317271404976, 2712.715164907696, 2853.843038632874, 2917.6352955880516, 9621.0, 10354.119899808526, 10533.0, 10555.050045495866, 10555.313904596254, 1754.9912250438795, 1799.9370022049166, 1804.9441076969988, 1818.7726534183228, 1838.4484654603566, 122289.38855305666, 131255.6874431253, 133957.33021334928, 134225.0, 137150.31424842912, 11940.402979850973, 11973.76052478963, 11976.341301228342, 12082.69793255158, 12084.093692973061, 15408.460703875311, 15442.0, 15443.92278038625, 15476.535703928901, 15493.612659683598, 7582.54504729718, 9234.0, 9235.769105772275, 9340.252779777737, 9363.391379560308, 9218.354715169873, 9220.769480763034, 9236.538173091318, 9240.8613870792, 9344.626214951462, 4324.978375108104, 4713.552212539803, 4745.881352966135, 4775.808967641325, 4814.470408255089, 1854.4992851929903, 1950.7854136045023, 2045.1308194017483, 2046.9385918422472, 2056.3008577083565, 909.9545022748836, 952.9571169297399, 977.9559919803626, 989.2679417231341, 998.5257002923698, 16926.561242294298, 17354.39259625907, 19926.904020278733, 21684.566308673737, 21707.565848682938, 986.1371300112402, 1014.629660174046, 1014.9391036537831, 1019.97450063749, 1088.211046990941, 10944.56221751137, 11426.371549564687, 11437.0, 11443.427828608535, 11458.94270528642, 610811.0, 629392.0, 632109.0, 653128.0, 671649.0, 125914.0, 129696.0, 132870.33564832114, 134369.0, 135923.0, 1060.4697651174413, 1060.671191930504, 1071.0574694269148, 1081.7782354617284, 1083.1118482843992, 18632.254709811998, 18751.0, 18769.436916892515, 18771.0, 18989.430317090508, 34413.999999998996, 49888.0, 52003.47996519986, 53386.46613533815, 53804.0, 70916.0, 73188.0, 74260.0, 74784.25215747773, 74890.62554687192, 8119.675212991414, 8255.42212045151, 8431.620577074169, 8493.91506084956, 8775.122487751174, 12086.637400877988, 13115.213087214415, 13317.26755028444, 13528.864711353153, 13553.79669304981, 11211.271267367594, 11626.0, 11721.355325456841, 11732.70668233301, 11887.583934562248, 11640.35978021217, 11670.0, 11684.182107252751, 11692.824607631062, 11958.162928594915, 11800.822987655363, 11819.054475641757, 11903.166778325434, 12058.879411206126, 12063.21589096706, 8587.742367728979, 8625.180607842245, 8677.0, 8734.344924130588, 9002.0, 10581.788364232827, 11858.11064170208, 11911.3448760319, 12012.879871201525, 12034.217775844541], "value": 9769.598871190145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.2423102102425, 1589.6502769390734, 1629.103992803958, 1873.7095750158721, 1975.6937674660423, 8337.24964753172, 9054.185123338899, 9203.631854725803, 9224.677136300232, 9238.983711791698, 8867.467951922888, 9121.224695900839, 9134.040925702806, 9135.634574617025, 9148.222401095914, 2498.5127900059542, 2515.6729625148705, 2522.3441905104623, 2523.255639586317, 2523.4196134888984, 2199.626063569197, 2459.5695753243112, 2573.4595734895693, 2575.7939364850768, 2581.896724131042, 2525.053105085593, 2558.6801649793774, 2562.8334158279745, 2571.614257861317, 2578.419855532509, 2516.018752686463, 2549.821512494126, 2554.604036374365, 2565.8075644326564, 2572.9228123156336, 2517.7230504644476, 2543.6438898554215, 2559.372953626355, 2559.7056338521124, 2575.6007818788116, 8941.6870409536, 9173.220276276525, 9225.492597907112, 9225.985141634415, 9226.215771659417, 4778.784954677013, 5805.680687562182, 5854.414558544154, 5856.472917437451, 5872.17789509469, 3670.5778835434, 3762.3792074307707, 3805.353089974711, 3811.218700166487, 3811.7331786774935, 1052.074174726236, 1068.56188962525, 1076.4671487613602, 1094.5676457799204, 1105.983410248847, 12462.81305780414, 12520.874791252154, 12638.241705497607, 12681.873181268162, 12717.809232861515, 4805.8077676892535, 4848.272759086095, 4881.170201065827, 4897.975510122498, 4935.777889994959, 9828.115469607626, 9832.705018849447, 9847.16299114569, 9856.359336643096, 9883.505824708736, 5604.635698679573, 5639.351474580394, 5642.463965923231, 5644.97177514118, 5663.745131469093, 4635.95364046362, 4795.832145874948, 5099.464556221617, 5186.429492755794, 5206.349206349207, 4013.1171142348635, 4061.086255592468, 4131.752094874317, 4152.937705934413, 4160.45914031174, 1143.451143451148, 1263.8483381994035, 1263.9368031598383, 1273.0706584193406, 1284.1652925598248, 878.2052242720348, 966.8646389505475, 970.3547141151197, 982.4940155819759, 1010.4796030044533, 6206.410391012847, 6226.875462490725, 6265.498760099181, 6276.246850377984, 6289.968550157311, 928.5589345061042, 993.5876611206413, 998.2114129837493, 999.645125980281, 1046.4610725476387, 3534.734894882894, 4114.6091121343425, 4143.937840932388, 4186.979065104655, 4190.161967606491, 11095.611653592085, 11395.430228488542, 11482.138839587064, 11597.594084207012, 11612.6516204514, 11257.774844503065, 11546.960773530423, 11561.710957226136, 11565.190436669352, 11619.244749091282, 7966.800829979297, 8437.40938134337, 8510.404271701045, 8557.614907329185, 8800.163984421342, 6034.818955431344, 6079.878402432015, 6109.694515274307, 6139.728300528833, 6163.537734670007, 9829.655962041294, 9839.803203936024, 9888.357256778287, 10083.24375671813, 10263.589456421958, 10068.647597334058, 10092.54583543757, 10364.481775911325, 10414.375137491776, 10464.895351046696, 7137.964310178416, 7359.190489046094, 7359.448041397024, 7891.605419729105, 8047.155048720034, 7821.491603045783, 8704.173103555153, 8785.692500762443, 8814.735557933273, 8836.955815220883, 7642.197569255148, 7699.422543309386, 7751.30238278535, 7853.978982732437, 7893.960530197542, 7545.660445280086, 7568.243175682388, 7599.278068583476, 7729.690812367442, 7739.806504837199, 7325.4872158948365, 7348.632568371667, 7375.631218439164, 7395.926040739739, 7431.702731890664, 4495.43807024122, 5032.672876263031, 5088.2876397305145, 5150.536451719363, 5251.107311756934, 5178.042062218502, 5216.321878155815, 5271.868203294948, 5435.782568697366, 5529.087700529368], "value": 4801.507453135729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.79859783301464, 329.90762586475796, 344.7586689317478, 348.445970906259, 348.8953314005798, 6365.777197798078, 6757.121574195354, 6775.356341147595, 6787.2534021257625, 6836.521443498951, 5525.557955363572, 6816.591004539731, 6857.725690972356, 6868.519203655734, 6879.380855722984, 4295.334223195409, 4914.287428322909, 5056.873578160538, 5061.240813877929, 5077.0861244975795, 5027.396712394499, 5049.621278404116, 5050.141475949097, 5055.595552355802, 5056.84829455117, 4083.734557253784, 5010.123228435027, 5011.67424117433, 5030.195168772997, 5041.72270525121, 4864.635152363551, 5022.970291090318, 5025.296458495795, 5026.371703537058, 5027.824026159085, 3605.675489205984, 3930.842766289345, 4015.5984401559904, 4333.241682705546, 4342.34864770287, 5413.052715774763, 6442.775872584194, 6603.0, 6607.867842643121, 6619.834504137387, 4568.680192386534, 5986.401359864022, 5986.491148252404, 5989.251343582052, 6002.909956350658, 7251.5286506376915, 7256.238095000054, 7259.673314700851, 7260.818479538001, 7276.708931642728, 4805.927911081337, 4810.0, 4817.686850354751, 4825.10735513931, 4825.276208568707, 7271.636418179123, 7321.78034658961, 7566.962165189194, 7567.508111972759, 7598.354139898115, 4014.759114453142, 4653.906921861544, 4738.597219236403, 4773.212419950739, 4781.139394908881, 4615.79228934692, 4843.007183527368, 4852.223644216909, 4858.416989961227, 4864.635152363587, 5600.243967064394, 5617.354004289477, 5633.380328163898, 5637.985162670759, 5743.396943320975, 7244.601546914971, 7246.456515761339, 7250.347468727839, 7259.6007219603425, 7263.30998555147, 1653.9503814885572, 1676.513810994798, 1678.4880611413391, 1680.9495715128567, 1682.5793551612096, 920.6547544670749, 1039.6828967164936, 1063.1335461598771, 1076.7954088723118, 1089.3844977587637, 6928.272531384132, 6970.093887794555, 6979.581225126509, 6983.720651173998, 6988.720451181895, 6198.597091189058, 7525.397968162534, 7530.43521735872, 7543.660535275816, 7552.282533159451, 6982.546134501241, 6983.650817459106, 6987.231404545496, 6987.8602427951155, 7010.088688470568, 3869.8645547405704, 3954.8813535593977, 3989.58109398509, 3997.84008639657, 4001.2597669430666, 7987.720429784929, 8033.598320084089, 8034.598270086472, 8038.718644847402, 8043.83912321762, 7807.258310460497, 7824.9608751955875, 7830.530168189927, 7847.332976696931, 7852.489588176751, 8029.7189598363775, 8045.758627241192, 8048.07447143586, 8049.39629527776, 8055.590271702428, 6253.937460625518, 7301.452391070798, 7576.924230757621, 7595.734149304748, 7613.276738709814, 6105.786297479567, 7419.258074192538, 7465.253474652492, 7485.812854678677, 7509.6245187739305, 6393.944999075101, 7749.225077492206, 7770.844583108419, 7984.441089123938, 8005.0, 4720.386349774644, 4823.348847905488, 4828.203346447796, 4828.396450443694, 4839.540243676845, 7606.96196519036, 7612.619369031416, 7624.390048796194, 7626.8093297668, 7630.465867389229, 6526.543141980016, 6809.672113937734, 7091.468139889632, 7334.853302934018, 7348.669309880961, 7294.0, 7313.049303590499, 7324.523905946096, 7327.864181051946, 7335.193128755725, 5814.796482123105, 7064.293570642894, 7147.928520714726, 7151.642417878981, 7158.463115266271, 6987.672342254955, 7325.047743793273, 7327.047483827068, 7334.523255988343, 7337.853242935218, 6195.31851496326, 6893.448524118159, 7151.892721609076, 7198.856022879409, 7201.3158749918675], "value": 5269.485020456859, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2529034191664, 784.4195295481345, 792.271110578268, 797.2864286463619, 857.5883575883572, 15394.384224631016, 15405.0, 15603.297851596677, 15660.373585056584, 15785.36858525659, 14565.198914059722, 14613.415463381452, 14672.413103475848, 14674.26628668565, 14674.486392976221, 786.437697046613, 808.9887640449438, 811.2495941254346, 811.5495899775622, 814.7189219719218, 952.5046975572698, 979.6130528441262, 980.181548407081, 981.1660088924393, 981.5141504955058, 1010.3735683876007, 1031.4275577054732, 1032.8347464405697, 1033.1579762493582, 1036.6060896859183, 827.8344331133798, 1007.0885848307294, 1013.2856336282903, 1024.6464969585481, 1026.7843752811882, 776.5379599138504, 781.277318480409, 781.5584194929846, 782.1787123520281, 783.7100272899064, 15464.5360639181, 15622.14078225697, 15635.218239088, 15641.530754077396, 15651.373945042185, 13094.279814610192, 13493.12294700851, 13505.932470337684, 13588.116772409861, 13693.383797729026, 9920.702378928643, 10248.74378140545, 10283.177345812317, 10751.892481075167, 10752.032317091422, 3599.8560057597665, 3600.261946301002, 3628.4738712886747, 3682.318771027342, 3861.5366156061455, 80966.0, 82463.0, 82745.58627206825, 82767.5861620694, 86920.13079869247, 9064.637414503346, 9178.449293042439, 9280.489573073546, 9701.466419346863, 9933.950330248303, 21827.162468878945, 21951.780482195292, 22060.558788824135, 22074.779252207594, 22116.33650990473, 7656.808579785438, 7733.535987840747, 7743.264389882952, 7807.297343239135, 7968.0, 4151.73013754105, 4186.225548273518, 4214.852480163179, 4227.51383590891, 4484.349769283501, 3124.8281344526267, 3616.5479315085613, 3843.0584506795453, 3847.019010152393, 3858.903527411781, 686.7459040155074, 702.4029574861327, 706.2549010793662, 714.1430283659629, 731.6524650790939, 508.53977150678696, 573.9454751798572, 584.5586582130464, 620.7089254350939, 645.1516256123183, 8331.916680833114, 8335.208155225244, 8338.958305208434, 8354.331653467709, 8478.194571515696, 605.678990135229, 619.2476141488114, 636.3922454056365, 639.4245179338633, 641.8748344072861, 3849.8845034649007, 3873.5932727063814, 3873.7288389812443, 3922.666573341241, 4061.6953728470485, 87446.56276718575, 89084.55457722669, 89229.55385223032, 94793.5260323694, 95493.0, 70694.0, 72136.55726885538, 73501.0, 77836.05409864799, 79145.60427197827, 60758.5696572141, 63973.04040439397, 66747.66626166838, 68378.65810670915, 72637.54724905473, 8681.0, 8728.0, 8856.557172141496, 8997.235235005099, 9096.590653420479, 46514.53485465102, 50562.2415663758, 50931.745341273054, 51166.465006049875, 52293.0, 63170.68414657897, 64902.67548662415, 70426.0, 71757.92363114453, 71933.0, 10877.45612719345, 11046.392448415414, 11213.990740833038, 11305.830412543653, 11711.355875426932, 12093.213941093802, 12182.269063856196, 12236.08229382782, 12314.630561083182, 12426.62720118398, 8935.854468674099, 10361.844572331573, 11057.778844423228, 11829.64511064635, 12121.333326667118, 11328.716782080513, 11459.48432320531, 11545.711357215801, 11642.941785291358, 11911.047116230855, 11356.313151404038, 11546.59586914454, 11691.356975366096, 11717.414129293671, 11751.764964700487, 9529.952350238205, 9764.658236961672, 9845.556949937127, 10058.245631577514, 10099.293049486465, 9982.60069597208, 9982.950085249528, 9992.450415227233, 10013.148882345082, 10020.148287395654], "value": 7102.6466514988, "unit": "score"}], "name": "dromaeo_css", "value": 7666.7807786248095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 165.0, 167.0, 113.0, 112.0, 112.0, 114.0, 113.0, 115.0, 133.0], "value": 129.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 176.0, 195.0, 132.0, 139.0, 118.0, 148.0, 151.0, 111.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 187.0, 184.0, 186.0, 185.0, 186.0, 187.0, 186.0, 185.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 72.0, 152.0, 55.0, 79.0, 82.0, 90.0, 128.0, 56.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 137.0, 75.0, 82.0, 129.0, 120.0, 79.0, 73.0, 124.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 83.0, 89.0, 89.0, 134.0, 113.0], "value": 94.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 85.0, 86.0, 85.0, 83.0, 87.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 64.0, 61.0, 63.0, 62.0, 62.0, 78.0, 59.0, 57.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 66.0, 77.0, 70.0, 68.0, 68.0, 66.0, 66.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 77.0, 79.0, 77.0, 80.0, 77.0, 78.0, 94.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 135.0, 135.0, 127.0, 138.0, 136.0, 124.0, 129.0, 169.0, 135.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 174.0, 173.0, 160.0, 165.0, 186.0, 191.0, 162.0, 162.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 72.0, 92.0, 89.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1505.7000000000003, "alertThreshold": 2.0}]} 13:50:47 INFO - Return code: 0 13:50:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:50:47 ERROR - # TBPL SUCCESS # 13:50:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:47 INFO - 2016-07-06 13:50:47.379 screenresolution[1686:10679] starting screenresolution argv=screenresolution get 13:50:47 INFO - 2016-07-06 13:50:47.382 screenresolution[1686:10679] Display 0: 1600x1200x32@60 13:50:47 INFO - 2016-07-06 13:50:47.388 screenresolution[1687:10682] starting screenresolution argv=screenresolution list 13:50:47 INFO - Available Modes on Display 0 13:50:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:47 INFO - Intel Iris: 13:50:47 INFO - Chipset Model: Intel Iris 13:50:47 INFO - Type: GPU 13:50:47 INFO - Bus: Built-In 13:50:47 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:47 INFO - Vendor: Intel (0x8086) 13:50:47 INFO - Device ID: 0x0a2e 13:50:47 INFO - Revision ID: 0x0009 13:50:47 INFO - Displays: 13:50:47 INFO - Display: 13:50:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:47 INFO - Display Serial Number: 1600x1200 60 13:50:47 INFO - Main Display: Yes 13:50:47 INFO - Mirror: Off 13:50:47 INFO - Online: Yes 13:50:47 INFO - Rotation: Supported 13:50:47 INFO - Return code: 0 13:50:47 INFO - Running post-action listener: _resource_record_post_action 13:50:47 INFO - Running post-run listener: _resource_record_post_run 13:50:48 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 31739392; Write bytes: 494656000; Read time: 198; Write time: 1543 13:50:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193425920; Write bytes: 186844672; Read time: 17665; Write time: 423 13:50:48 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 29957632; Write bytes: 298071040; Read time: 183; Write time: 1087 13:50:48 INFO - Running post-run listener: _upload_blobber_files 13:50:48 INFO - Blob upload gear active. 13:50:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:50:48 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 13:50:48 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'] 13:50:48 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 13:50:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:49 INFO - (blobuploader) - INFO - Done attempting. 13:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:50 INFO - (blobuploader) - INFO - Done attempting. 13:50:50 INFO - (blobuploader) - INFO - Iteration through files over. 13:50:50 INFO - Return code: 0 13:50:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:50:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:50:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccc78705f1024024e46055f8a51abed2895f89e691eb16a41d808149cf992b02d9f7734fbac3cdd2839d4b8bd9ed65ee73398b8effe968a4ed5a754da7c9eed7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c198bfe769ab72f3f7ae80d3880b80a2b81e5534a4acd9c97cd67374a30fcc2e7e6fa096a775891c230a42c687d53fe106fba95912afd9841a78ca990af60d79"} 13:50:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:50:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:50:50 INFO - Contents: 13:50:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccc78705f1024024e46055f8a51abed2895f89e691eb16a41d808149cf992b02d9f7734fbac3cdd2839d4b8bd9ed65ee73398b8effe968a4ed5a754da7c9eed7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c198bfe769ab72f3f7ae80d3880b80a2b81e5534a4acd9c97cd67374a30fcc2e7e6fa096a775891c230a42c687d53fe106fba95912afd9841a78ca990af60d79"} 13:50:50 INFO - Running post-run listener: copy_logs_to_upload_dir 13:50:50 INFO - Copying logs to upload dir... 13:50:50 INFO - mkdir: /builds/slave/test/build/upload/logs 13:50:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.872279 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-06 13:50:50.918954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 13:50:50.924408) ========= 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.WixlBOlA4p/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.jhjAs60q9M/Listeners TMPDIR=/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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/ccc78705f1024024e46055f8a51abed2895f89e691eb16a41d808149cf992b02d9f7734fbac3cdd2839d4b8bd9ed65ee73398b8effe968a4ed5a754da7c9eed7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c198bfe769ab72f3f7ae80d3880b80a2b81e5534a4acd9c97cd67374a30fcc2e7e6fa096a775891c230a42c687d53fe106fba95912afd9841a78ca990af60d79"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010940 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467731037/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccc78705f1024024e46055f8a51abed2895f89e691eb16a41d808149cf992b02d9f7734fbac3cdd2839d4b8bd9ed65ee73398b8effe968a4ed5a754da7c9eed7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c198bfe769ab72f3f7ae80d3880b80a2b81e5534a4acd9c97cd67374a30fcc2e7e6fa096a775891c230a42c687d53fe106fba95912afd9841a78ca990af60d79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 13:50:50.957583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 13:50:50.957909) ========= 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.WixlBOlA4p/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.jhjAs60q9M/Listeners TMPDIR=/var/folders/h3/hfjysk0d4wl2f0m0l6zfjwlr00000w/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.004901 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 13:50:51.006896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 13:50:51.007273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 13:50:51.007664) ========= ========= Total master_lag: 0.34 =========