builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0253 starttime: 1468664580.82 results: success (0) buildid: 20160713152957 builduid: d0b3f394d70d4790be5c40362e3bc315 revision: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:00.821650) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:00.822208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:00.822573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:00.854584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:00.855027) ========= 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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-16 03:23:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-07-16 03:23:00 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115753 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:01.035701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:01.036011) ========= 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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.039579 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:01.097167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-16 03:23:01.097618) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f8051a3ef4ec5842689306cc3d7b22a6ec439c9a --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 f8051a3ef4ec5842689306cc3d7b22a6ec439c9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IcUaWNaGbL/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.k6OWJXUhsr/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-16 03:23:01,176 truncating revision to first 12 chars 2016-07-16 03:23:01,176 Setting DEBUG logging. 2016-07-16 03:23:01,176 attempt 1/10 2016-07-16 03:23:01,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f8051a3ef4ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 03:23:03,427 unpacking tar archive at: mozilla-beta-f8051a3ef4ec/testing/mozharness/ program finished with exit code 0 elapsedTime=2.527359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-16 03:23:03.646752) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:03.647107) ========= script_repo_revision: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:03.647535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:03.647797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:23:03.665841) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-16 03:23:03.666308) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:03 INFO - MultiFileLogger online at 20160716 03:23:03 in /builds/slave/test 03:23:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:23:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:03 INFO - {'append_to_log': False, 03:23:03 INFO - 'base_work_dir': '/builds/slave/test', 03:23:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:23:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:03 INFO - 'branch': 'Mozilla-Beta', 03:23:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:03 INFO - 'config_files': ('talos/mac_config.py',), 03:23:03 INFO - 'default_actions': ('clobber', 03:23:03 INFO - 'read-buildbot-config', 03:23:03 INFO - 'download-and-extract', 03:23:03 INFO - 'populate-webroot', 03:23:03 INFO - 'create-virtualenv', 03:23:03 INFO - 'install', 03:23:03 INFO - 'run-tests'), 03:23:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:03 INFO - 'download_minidump_stackwalk': True, 03:23:03 INFO - 'download_symbols': 'ondemand', 03:23:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:03 INFO - 'installer_path': 'installer.exe', 03:23:03 INFO - 'log_level': 'info', 03:23:03 INFO - 'log_name': 'talos', 03:23:03 INFO - 'log_to_console': True, 03:23:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:23:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:23:03 INFO - 'opt_config_files': (), 03:23:03 INFO - 'pip_index': False, 03:23:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:03 INFO - 'cmd': ('bash', 03:23:03 INFO - '-c', 03:23:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:03 INFO - 'enabled': True, 03:23:03 INFO - 'halt_on_failure': False, 03:23:03 INFO - 'name': 'check_screen_resolution'},), 03:23:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:03 INFO - 'cmd': ('bash', 03:23:03 INFO - '-c', 03:23:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:03 INFO - 'enabled': True, 03:23:03 INFO - 'halt_on_failure': False, 03:23:03 INFO - 'name': 'check_screen_resolution'},), 03:23:03 INFO - 'run_cmd_checks_enabled': True, 03:23:03 INFO - 'sps_profile': False, 03:23:03 INFO - 'sps_profile_interval': 0, 03:23:03 INFO - 'suite': 'dromaeojs-e10s', 03:23:03 INFO - 'system_bits': '32', 03:23:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:03 INFO - 'title': 't-yosemite-r7-0253', 03:23:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:03 INFO - 'use_talos_json': True, 03:23:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:03 INFO - 'work_dir': 'build'} 03:23:03 INFO - ##### 03:23:03 INFO - ##### Running clobber step. 03:23:03 INFO - ##### 03:23:03 INFO - Running pre-action listener: _resource_record_pre_action 03:23:03 INFO - Running main action method: clobber 03:23:03 INFO - rmtree: /builds/slave/test/build 03:23:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:05 INFO - Running post-action listener: _resource_record_post_action 03:23:05 INFO - ##### 03:23:05 INFO - ##### Running read-buildbot-config step. 03:23:05 INFO - ##### 03:23:05 INFO - Running pre-action listener: _resource_record_pre_action 03:23:05 INFO - Running main action method: read_buildbot_config 03:23:05 INFO - Using buildbot properties: 03:23:05 INFO - { 03:23:05 INFO - "project": "", 03:23:05 INFO - "product": "firefox", 03:23:05 INFO - "script_repo_revision": "production", 03:23:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 03:23:05 INFO - "repository": "", 03:23:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 03:23:05 INFO - "buildid": "20160713152957", 03:23:05 INFO - "pgo_build": "False", 03:23:05 INFO - "basedir": "/builds/slave/test", 03:23:05 INFO - "buildnumber": 44, 03:23:05 INFO - "slavename": "t-yosemite-r7-0253", 03:23:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:23:05 INFO - "platform": "yosemite_r7", 03:23:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:23:05 INFO - "branch": "mozilla-beta", 03:23:05 INFO - "repo_path": "releases/mozilla-beta", 03:23:05 INFO - "revision": "f8051a3ef4ec5842689306cc3d7b22a6ec439c9a", 03:23:05 INFO - "stage_platform": "macosx64", 03:23:05 INFO - "builduid": "d0b3f394d70d4790be5c40362e3bc315", 03:23:05 INFO - "slavebuilddir": "test" 03:23:05 INFO - } 03:23:05 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg. 03:23:05 INFO - Running post-action listener: _resource_record_post_action 03:23:05 INFO - ##### 03:23:05 INFO - ##### Running download-and-extract step. 03:23:05 INFO - ##### 03:23:05 INFO - Running pre-action listener: _resource_record_pre_action 03:23:05 INFO - Running main action method: download_and_extract 03:23:05 INFO - mkdir: /builds/slave/test/build/tests 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.test_packages.json 03:23:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/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 03:23:06 INFO - Downloaded 1165 bytes. 03:23:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:23:06 INFO - Using the following test package requirements: 03:23:06 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:23:06 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 03:23:06 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 03:23:06 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:23:06 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 03:23:06 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:23:06 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 03:23:06 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 03:23:06 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 03:23:06 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:23:06 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 03:23:06 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 03:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.common.tests.zip 03:23:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/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 03:23:06 INFO - Downloaded 18352256 bytes. 03:23:06 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'] 03:23:06 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 03:23:09 INFO - Return code: 0 03:23:09 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 03:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.common.tests.zip 03:23:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/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 03:23:09 INFO - Downloaded 18352256 bytes. 03:23:09 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'] 03:23:09 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 03:23:13 INFO - Return code: 0 03:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.talos.tests.zip 03:23:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 03:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/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 03:23:16 INFO - Downloaded 10840145 bytes. 03:23:16 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'] 03:23:16 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 03:23:16 INFO - Return code: 0 03:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg 03:23:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 03:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 03:23:28 INFO - Downloaded 86191266 bytes. 03:23:28 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg 03:23:28 INFO - mkdir: /builds/slave/test/properties 03:23:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:28 INFO - Contents: 03:23:28 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg 03:23:28 INFO - Running post-action listener: _resource_record_post_action 03:23:28 INFO - Running post-action listener: set_extra_try_arguments 03:23:28 INFO - ##### 03:23:28 INFO - ##### Running populate-webroot step. 03:23:28 INFO - ##### 03:23:28 INFO - Running pre-action listener: _resource_record_pre_action 03:23:28 INFO - Running main action method: populate_webroot 03:23:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:28 INFO - '--tppagecycles', 03:23:28 INFO - '7'], 03:23:28 INFO - 'tests': ['tsvgm']}}, 03:23:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['damp', 'tps']}, 03:23:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'tests': ['damp', 'tps']}, 03:23:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['dromaeo_dom']}, 03:23:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['a11yr', 03:23:28 INFO - 'ts_paint', 03:23:28 INFO - 'tpaint', 03:23:28 INFO - 'sessionrestore', 03:23:28 INFO - 'sessionrestore_no_auto_restore', 03:23:28 INFO - 'tabpaint']}, 03:23:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:28 INFO - 'ts_paint', 03:23:28 INFO - 'tpaint', 03:23:28 INFO - 'sessionrestore', 03:23:28 INFO - 'sessionrestore_no_auto_restore', 03:23:28 INFO - 'tabpaint']}, 03:23:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:23:28 INFO - 'ts_paint', 03:23:28 INFO - 'tpaint', 03:23:28 INFO - 'sessionrestore', 03:23:28 INFO - 'sessionrestore_no_auto_restore', 03:23:28 INFO - 'tabpaint']}, 03:23:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:23:28 INFO - 'ts_paint', 03:23:28 INFO - 'tpaint', 03:23:28 INFO - 'sessionrestore', 03:23:28 INFO - 'sessionrestore_no_auto_restore', 03:23:28 INFO - 'tabpaint']}, 03:23:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['a11yr', 03:23:28 INFO - 'ts_paint', 03:23:28 INFO - 'tpaint', 03:23:28 INFO - 'sessionrestore', 03:23:28 INFO - 'sessionrestore_no_auto_restore', 03:23:28 INFO - 'tabpaint']}, 03:23:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['a11yr', 03:23:28 INFO - 'ts_paint', 03:23:28 INFO - 'tpaint', 03:23:28 INFO - 'sessionrestore', 03:23:28 INFO - 'sessionrestore_no_auto_restore', 03:23:28 INFO - 'tabpaint']}, 03:23:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['tsvgx', 03:23:28 INFO - 'tsvgr_opacity', 03:23:28 INFO - 'tart', 03:23:28 INFO - 'tscrollx', 03:23:28 INFO - 'cart']}, 03:23:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:28 INFO - 'tsvgr_opacity', 03:23:28 INFO - 'tart', 03:23:28 INFO - 'tscrollx', 03:23:28 INFO - 'cart']}, 03:23:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'talos_options': ['--disable-e10s'], 03:23:28 INFO - 'tests': ['tp5o']}, 03:23:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'tests': ['tp5o']}, 03:23:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'talos_options': ['--disable-e10s', 03:23:28 INFO - '--xperf_path', 03:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:28 INFO - 'tests': ['tp5n']}, 03:23:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:28 INFO - 'talos_options': ['--xperf_path', 03:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:28 INFO - 'tests': ['tp5n']}}, 03:23:28 INFO - 'talos.zip': {'path': '', 03:23:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:28 INFO - Running post-action listener: _resource_record_post_action 03:23:28 INFO - ##### 03:23:28 INFO - ##### Running create-virtualenv step. 03:23:28 INFO - ##### 03:23:28 INFO - Running pre-action listener: _resource_record_pre_action 03:23:28 INFO - Running main action method: create_virtualenv 03:23:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:28 INFO - Using real prefix '/tools/python27' 03:23:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:32 INFO - Installing pip.................done. 03:23:32 INFO - Return code: 0 03:23:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:32 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:32 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 03:23:32 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 03:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:32 INFO - 'HOME': '/Users/cltbld', 03:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:32 INFO - 'LOGNAME': 'cltbld', 03:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:32 INFO - 'MOZ_NO_REMOTE': '1', 03:23:32 INFO - 'NO_EM_RESTART': '1', 03:23:32 INFO - 'PAGER': '/bin/cat', 03:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:32 INFO - 'PWD': '/builds/slave/test', 03:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:32 INFO - 'SHELL': '/bin/bash', 03:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:32 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:32 INFO - 'USER': 'cltbld', 03:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:32 INFO - 'XPC_FLAGS': '0x0', 03:23:32 INFO - 'XPC_SERVICE_NAME': '0', 03:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:23:32 INFO - Cleaning up... 03:23:32 INFO - Return code: 0 03:23:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:32 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:32 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 03:23:32 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 03:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:32 INFO - 'HOME': '/Users/cltbld', 03:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:32 INFO - 'LOGNAME': 'cltbld', 03:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:32 INFO - 'MOZ_NO_REMOTE': '1', 03:23:32 INFO - 'NO_EM_RESTART': '1', 03:23:32 INFO - 'PAGER': '/bin/cat', 03:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:32 INFO - 'PWD': '/builds/slave/test', 03:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:32 INFO - 'SHELL': '/bin/bash', 03:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:32 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:32 INFO - 'USER': 'cltbld', 03:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:32 INFO - 'XPC_FLAGS': '0x0', 03:23:32 INFO - 'XPC_SERVICE_NAME': '0', 03:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:32 INFO - Downloading/unpacking psutil>=0.7.1 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:35 INFO - Installing collected packages: psutil 03:23:35 INFO - Running setup.py install for psutil 03:23:35 INFO - building 'psutil._psutil_osx' extension 03:23:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:23:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:23:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:23:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:23:36 INFO - building 'psutil._psutil_posix' extension 03:23:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:23:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:23:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:23:36 INFO - ^ 03:23:36 INFO - 1 warning generated. 03:23:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:23:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:36 INFO - Successfully installed psutil 03:23:36 INFO - Cleaning up... 03:23:36 INFO - Return code: 0 03:23:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:36 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:36 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 03:23:36 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 03:23:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:36 INFO - 'HOME': '/Users/cltbld', 03:23:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:36 INFO - 'LOGNAME': 'cltbld', 03:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:36 INFO - 'MOZ_NO_REMOTE': '1', 03:23:36 INFO - 'NO_EM_RESTART': '1', 03:23:36 INFO - 'PAGER': '/bin/cat', 03:23:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:36 INFO - 'PWD': '/builds/slave/test', 03:23:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:36 INFO - 'SHELL': '/bin/bash', 03:23:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:36 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:36 INFO - 'USER': 'cltbld', 03:23:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:36 INFO - 'XPC_FLAGS': '0x0', 03:23:36 INFO - 'XPC_SERVICE_NAME': '0', 03:23:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:23:39 INFO - Installing collected packages: mozsystemmonitor 03:23:39 INFO - Running setup.py install for mozsystemmonitor 03:23:39 INFO - Successfully installed mozsystemmonitor 03:23:39 INFO - Cleaning up... 03:23:39 INFO - Return code: 0 03:23:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:39 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:39 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 03:23:39 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 03:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:39 INFO - 'HOME': '/Users/cltbld', 03:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:39 INFO - 'LOGNAME': 'cltbld', 03:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:39 INFO - 'MOZ_NO_REMOTE': '1', 03:23:39 INFO - 'NO_EM_RESTART': '1', 03:23:39 INFO - 'PAGER': '/bin/cat', 03:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:39 INFO - 'PWD': '/builds/slave/test', 03:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:39 INFO - 'SHELL': '/bin/bash', 03:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:39 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:39 INFO - 'USER': 'cltbld', 03:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:39 INFO - 'XPC_FLAGS': '0x0', 03:23:39 INFO - 'XPC_SERVICE_NAME': '0', 03:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:43 INFO - Downloading docopt-0.6.1.tar.gz 03:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:43 INFO - Running setup.py install for blobuploader 03:23:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:43 INFO - Running setup.py install for requests 03:23:44 INFO - Running setup.py install for docopt 03:23:44 INFO - Successfully installed blobuploader requests docopt 03:23:44 INFO - Cleaning up... 03:23:44 INFO - Return code: 0 03:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:44 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:44 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 03:23:44 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 03:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:44 INFO - 'HOME': '/Users/cltbld', 03:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:44 INFO - 'LOGNAME': 'cltbld', 03:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:44 INFO - 'MOZ_NO_REMOTE': '1', 03:23:44 INFO - 'NO_EM_RESTART': '1', 03:23:44 INFO - 'PAGER': '/bin/cat', 03:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:44 INFO - 'PWD': '/builds/slave/test', 03:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:44 INFO - 'SHELL': '/bin/bash', 03:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:44 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:44 INFO - 'USER': 'cltbld', 03:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:44 INFO - 'XPC_FLAGS': '0x0', 03:23:44 INFO - 'XPC_SERVICE_NAME': '0', 03:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:44 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-7fweNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:44 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-c74oLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-MvoiJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-EP8FZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-YECvNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-tSwfER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6JcQ6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uisJGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uxYZol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ve5X1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:45 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-BJ7OyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-WOlO1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zcLg9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6jEuWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-KiNLv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-EUm2NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:46 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-md70vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:46 INFO - Running setup.py install for manifestparser 03:23:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozcrash 03:23:46 INFO - Running setup.py install for mozdebug 03:23:47 INFO - Running setup.py install for mozdevice 03:23:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozfile 03:23:47 INFO - Running setup.py install for mozhttpd 03:23:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozinfo 03:23:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozInstall 03:23:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozleak 03:23:47 INFO - Running setup.py install for mozlog 03:23:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:48 INFO - Running setup.py install for moznetwork 03:23:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:48 INFO - Running setup.py install for mozprocess 03:23:48 INFO - Running setup.py install for mozprofile 03:23:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:48 INFO - Running setup.py install for mozrunner 03:23:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:48 INFO - Running setup.py install for mozscreenshot 03:23:48 INFO - Running setup.py install for moztest 03:23:49 INFO - Running setup.py install for mozversion 03:23:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:49 INFO - Cleaning up... 03:23:49 INFO - Return code: 0 03:23:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:49 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:49 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 03:23:49 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 03:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:49 INFO - 'HOME': '/Users/cltbld', 03:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:49 INFO - 'LOGNAME': 'cltbld', 03:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:49 INFO - 'MOZ_NO_REMOTE': '1', 03:23:49 INFO - 'NO_EM_RESTART': '1', 03:23:49 INFO - 'PAGER': '/bin/cat', 03:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:49 INFO - 'PWD': '/builds/slave/test', 03:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:49 INFO - 'SHELL': '/bin/bash', 03:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:49 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:49 INFO - 'USER': 'cltbld', 03:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:49 INFO - 'XPC_FLAGS': '0x0', 03:23:49 INFO - 'XPC_SERVICE_NAME': '0', 03:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:49 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-YxJK_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:49 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GrouiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:49 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)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:49 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-4t9hXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:49 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-dMeT9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:49 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)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:49 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-YRcbF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:49 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-bYBONy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-woNCZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uHB2nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-pfWfvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zgS13v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:50 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)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-nvMFPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GqYWHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GA6Ldd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:50 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)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6nwBNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:50 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jhZ5oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:51 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-rBLPXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:51 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-dqRAgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:51 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)) 03:23:51 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)) 03:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:51 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)) 03:23:51 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)) 03:23:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:53 INFO - Downloading blessings-1.6.tar.gz 03:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:53 INFO - Installing collected packages: blessings 03:23:53 INFO - Running setup.py install for blessings 03:23:53 INFO - Successfully installed blessings 03:23:53 INFO - Cleaning up... 03:23:54 INFO - Return code: 0 03:23:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:54 INFO - Reading from file tmpfile_stdout 03:23:54 INFO - Current package versions: 03:23:54 INFO - blessings == 1.6 03:23:54 INFO - blobuploader == 1.2.4 03:23:54 INFO - docopt == 0.6.1 03:23:54 INFO - manifestparser == 1.1 03:23:54 INFO - mozInstall == 1.12 03:23:54 INFO - mozcrash == 0.17 03:23:54 INFO - mozdebug == 0.1 03:23:54 INFO - mozdevice == 0.48 03:23:54 INFO - mozfile == 1.2 03:23:54 INFO - mozhttpd == 0.7 03:23:54 INFO - mozinfo == 0.9 03:23:54 INFO - mozleak == 0.1 03:23:54 INFO - mozlog == 3.1 03:23:54 INFO - moznetwork == 0.27 03:23:54 INFO - mozprocess == 0.22 03:23:54 INFO - mozprofile == 0.28 03:23:54 INFO - mozrunner == 6.11 03:23:54 INFO - mozscreenshot == 0.1 03:23:54 INFO - mozsystemmonitor == 0.0 03:23:54 INFO - moztest == 0.7 03:23:54 INFO - mozversion == 1.4 03:23:54 INFO - psutil == 3.1.1 03:23:54 INFO - requests == 1.2.3 03:23:54 INFO - wsgiref == 0.1.2 03:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:54 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 03:23:54 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 03:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:54 INFO - 'HOME': '/Users/cltbld', 03:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:54 INFO - 'LOGNAME': 'cltbld', 03:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:54 INFO - 'MOZ_NO_REMOTE': '1', 03:23:54 INFO - 'NO_EM_RESTART': '1', 03:23:54 INFO - 'PAGER': '/bin/cat', 03:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:54 INFO - 'PWD': '/builds/slave/test', 03:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:54 INFO - 'SHELL': '/bin/bash', 03:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:54 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:54 INFO - 'USER': 'cltbld', 03:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:54 INFO - 'XPC_FLAGS': '0x0', 03:23:54 INFO - 'XPC_SERVICE_NAME': '0', 03:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 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)) 03:23:54 INFO - Cleaning up... 03:23:54 INFO - Return code: 0 03:23:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:54 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:54 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 03:23:54 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 03:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:54 INFO - 'HOME': '/Users/cltbld', 03:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:54 INFO - 'LOGNAME': 'cltbld', 03:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:54 INFO - 'MOZ_NO_REMOTE': '1', 03:23:54 INFO - 'NO_EM_RESTART': '1', 03:23:54 INFO - 'PAGER': '/bin/cat', 03:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:54 INFO - 'PWD': '/builds/slave/test', 03:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:54 INFO - 'SHELL': '/bin/bash', 03:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:54 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:54 INFO - 'USER': 'cltbld', 03:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:54 INFO - 'XPC_FLAGS': '0x0', 03:23:54 INFO - 'XPC_SERVICE_NAME': '0', 03:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:55 INFO - Downloading/unpacking jsonschema 03:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:57 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:58 INFO - warning: no files found matching '*.txt' 03:23:58 INFO - no previously-included directories found matching 'build' 03:23:58 INFO - no previously-included directories found matching 'dist' 03:23:58 INFO - no previously-included directories found matching '.git*' 03:23:58 INFO - Installing collected packages: jsonschema, functools32 03:23:58 INFO - Running setup.py install for functools32 03:23:58 INFO - warning: no files found matching '*.txt' 03:23:58 INFO - no previously-included directories found matching 'build' 03:23:58 INFO - no previously-included directories found matching 'dist' 03:23:58 INFO - no previously-included directories found matching '.git*' 03:23:58 INFO - Successfully installed jsonschema functools32 03:23:58 INFO - Cleaning up... 03:23:58 INFO - Return code: 0 03:23:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:58 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 0x10126da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10127d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d53d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, '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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:23:58 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 03:23:58 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 03:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:58 INFO - 'HOME': '/Users/cltbld', 03:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:58 INFO - 'LOGNAME': 'cltbld', 03:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:58 INFO - 'MOZ_NO_REMOTE': '1', 03:23:58 INFO - 'NO_EM_RESTART': '1', 03:23:58 INFO - 'PAGER': '/bin/cat', 03:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:58 INFO - 'PWD': '/builds/slave/test', 03:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:58 INFO - 'SHELL': '/bin/bash', 03:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:23:58 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:58 INFO - 'USER': 'cltbld', 03:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:58 INFO - 'XPC_FLAGS': '0x0', 03:23:58 INFO - 'XPC_SERVICE_NAME': '0', 03:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:58 INFO - Downloading/unpacking flake8 03:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:24:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:24:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:24:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:24:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:24:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:24:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:24:03 INFO - no previously-included directories found matching 'docs/_build' 03:24:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:24:03 INFO - Running setup.py install for pep8 03:24:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:24:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:24:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:24:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:24:03 INFO - no previously-included directories found matching 'docs/_build' 03:24:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:24:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:24:03 INFO - Cleaning up... 03:24:04 INFO - Return code: 0 03:24:04 INFO - Running post-action listener: _resource_record_post_action 03:24:04 INFO - Running post-action listener: _start_resource_monitoring 03:24:04 INFO - Starting resource monitoring. 03:24:04 INFO - ##### 03:24:04 INFO - ##### Running install step. 03:24:04 INFO - ##### 03:24:04 INFO - Running pre-action listener: _resource_record_pre_action 03:24:04 INFO - Running main action method: install 03:24:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:04 INFO - Reading from file tmpfile_stdout 03:24:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:04 INFO - Reading from file tmpfile_stdout 03:24:04 INFO - Output received: 03:24:04 INFO - Usage: mozinstall [options] installer 03:24:04 INFO - Options: 03:24:04 INFO - -h, --help show this help message and exit 03:24:04 INFO - -d DEST, --destination=DEST 03:24:04 INFO - Directory to install application into. [default: 03:24:04 INFO - "/builds/slave/test"] 03:24:04 INFO - --app=APP Application being installed. [default: firefox] 03:24:04 INFO - mkdir: /builds/slave/test/build/application 03:24:04 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'] 03:24:04 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 03:24:26 INFO - Reading from file tmpfile_stdout 03:24:26 INFO - Output received: 03:24:26 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:24:26 INFO - Running post-action listener: _resource_record_post_action 03:24:26 INFO - ##### 03:24:26 INFO - ##### Running run-tests step. 03:24:26 INFO - ##### 03:24:26 INFO - Running pre-action listener: _resource_record_pre_action 03:24:26 INFO - Running main action method: run_tests 03:24:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:26 INFO - 2016-07-16 03:24:26.289 screenresolution[1643:7608] starting screenresolution argv=screenresolution get 03:24:26 INFO - 2016-07-16 03:24:26.292 screenresolution[1643:7608] Display 0: 1600x1200x32@60 03:24:26 INFO - 2016-07-16 03:24:26.298 screenresolution[1644:7610] starting screenresolution argv=screenresolution list 03:24:26 INFO - Available Modes on Display 0 03:24:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:26 INFO - Intel Iris: 03:24:26 INFO - Chipset Model: Intel Iris 03:24:26 INFO - Type: GPU 03:24:26 INFO - Bus: Built-In 03:24:26 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:26 INFO - Vendor: Intel (0x8086) 03:24:26 INFO - Device ID: 0x0a2e 03:24:26 INFO - Revision ID: 0x0009 03:24:26 INFO - Displays: 03:24:26 INFO - Display: 03:24:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:26 INFO - Display Serial Number: 1600x1200 60 03:24:26 INFO - Main Display: Yes 03:24:26 INFO - Mirror: Off 03:24:26 INFO - Online: Yes 03:24:26 INFO - Rotation: Supported 03:24:26 INFO - Return code: 0 03:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:26 INFO - Python 2.7.3 03:24:26 INFO - Return code: 0 03:24:26 INFO - grabbing minidump binary from tooltool 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 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 0x10110ce00>, '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 0x100f75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101107b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:24:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:26 INFO - Return code: 0 03:24:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:24:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:24:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:24:27 INFO - Return code: 0 03:24:27 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:24:27 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IcUaWNaGbL/Render', 03:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:27 INFO - 'HOME': '/Users/cltbld', 03:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:27 INFO - 'LOGNAME': 'cltbld', 03:24:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:27 INFO - 'MOZ_NO_REMOTE': '1', 03:24:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:27 INFO - 'NO_EM_RESTART': '1', 03:24:27 INFO - 'PAGER': '/bin/cat', 03:24:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:27 INFO - 'PWD': '/builds/slave/test', 03:24:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:27 INFO - 'SHELL': '/bin/bash', 03:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k6OWJXUhsr/Listeners', 03:24:27 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:27 INFO - 'USER': 'cltbld', 03:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:27 INFO - 'XPC_FLAGS': '0x0', 03:24:27 INFO - 'XPC_SERVICE_NAME': '0', 03:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:24:27 INFO - mozversion application_buildid: 20160713152957 03:24:27 INFO - mozversion application_changeset: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a 03:24:27 INFO - mozversion application_display_name: Firefox 03:24:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:27 INFO - mozversion application_name: Firefox 03:24:27 INFO - mozversion application_remotingname: firefox 03:24:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:24:27 INFO - mozversion application_vendor: Mozilla 03:24:27 INFO - mozversion application_version: 48.0 03:24:27 INFO - mozversion platform_buildid: 20160713152957 03:24:27 INFO - mozversion platform_changeset: f8051a3ef4ec5842689306cc3d7b22a6ec439c9a 03:24:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:24:27 INFO - mozversion platform_version: 48.0 03:24:27 INFO - using testdate: 1468664667 03:24:27 INFO - actual date: 1468664667 03:24:27 INFO - starting webserver on 'localhost:49265' 03:24:27 INFO - SUITE-START | Running 2 tests 03:24:27 INFO - TEST-START | dromaeo_css 03:24:27 INFO - operating with platform_type : mac_ 03:24:27 INFO - Initialising browser for dromaeo_css test... 03:24:27 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpTVWYc2/profile http://localhost:49265/getInfo.html) 03:24:30 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 03:24:30 INFO - PROCESS | 1662 | colorDepth:24 03:24:30 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 03:24:30 INFO - PROCESS | 1662 | __metrics 03:24:30 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:24:31 INFO - TEST-INFO | 1662: exit 0 03:24:31 INFO - Browser initialized. 03:24:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:31 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpTVWYc2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:43 INFO - PROCESS | 1666 | RSS: Main: 170954752 03:24:43 INFO - PROCESS | 1666 | 03:25:32 INFO - PROCESS | 1666 | 1468664732719 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:27:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 03:27:44 INFO - PROCESS | 1666 | RSS: Main: 182956032 03:27:44 INFO - PROCESS | 1666 | 03:30:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 03:30:46 INFO - PROCESS | 1666 | RSS: Main: 192446464 03:30:46 INFO - PROCESS | 1666 | 03:33:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 03:33:49 INFO - PROCESS | 1666 | RSS: Main: 194801664 03:33:49 INFO - PROCESS | 1666 | 03:36:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 03:36:51 INFO - PROCESS | 1666 | RSS: Main: 198443008 03:36:51 INFO - PROCESS | 1666 | 03:39:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 03:39:54 INFO - PROCESS | 1666 | RSS: Main: 197619712 03:39:54 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 03:42:56 INFO - PROCESS | 1666 | RSS: Main: 203100160 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | __start_tp_report 03:42:56 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 03:42:56 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 03:42:56 INFO - PROCESS | 1666 | |i|pagename|runs| 03:42:56 INFO - PROCESS | 1666 | |0;dojo.html;3537.0980399998007;3686.2258925625615;3708.2583483303347;3727.347714150023;3733.7386382953196;5917.881642367155;6025.969870150654;6026.397360263972;6061.090836374546;6064.757409703612;6022.247219097613;6030;6041.184440100585;6072.332043475225;6077.908831367533;5403.78384864606;5410.702411367373;5425.674459532421;5479.205515200293;5514.393416724157;5382.434844341346;5468.6171967962255;5485.369182543998;5499.065158922993;5505.862353441176;5473.781048758045;5508.834734957958;5515.255440515519;5517.475839795213;5538.113901775717;5447.836564903019;5450.700211488366;5494.120940649517;5519.089350257183;5560.805371811967;5368.32895888014;5467.125259958388;5479.75341109651;5495.477929596682;5517.613767036309;4512.706674066175;5787.594868359217;5860.06239001762;5978.432048955342;6037.849053773647;6242.812715618538;6289.685515724242;6312.147860038928;6312.747490100391;6331.33520980295;6375.10748495211;6390.968045159791;6403.327650596667;6416.839579010515;6420.422162005395;5998.310194327621;6075.453209211104;6126.724297406583;6159;6164.352742962014;5255.973720131375;6454.419102280817;6552.770653027216;6557.147570815859;6562.606243625398;6210.813675589739;6261.5616906816085;6262.812115636447;6267.341929097471;6270.717817698214;6271.3728627136925;6302.684865756693;6359.332270111664;6401.711922963478;6405.711742971577;6236.376362363818;6247.187865577446;6275.215598050244;6284.874302513924;6299.748010079637;6277.7175027123885;6286.5599408041;6289.905651415233;6300.180976473029;6308.936910630927;4949.480304567968;5040.546350828443;5116.360454943132;5131.589472842238;5177.58579313654;4613.538646135359;4637.211674015425;4638.165130276515;4652.023075154188;4658.138244424792;5900.527957763368;6095.786647467317;6116.5718399711595;6176.598521096114;6184.5052395809125;6238.937610623926;6313.715882785285;6331.841703957346;6364.88614492462;6371.681415929185;6124.3809352984035;6158.938410615837;6182.629042257479;6194.783182588588;6200.410960958701;5550.278463799761;5666.773329066874;5673.234113394721;5696.316442026983;5708.372079071299;6550.410463058348;6612.437942774822;6672.099266599044;6672.633005184762;6682.2649508555;6411.647359395278;6420.422162005442;6427.517936154713;6476.805695829133;6499.6750162492635;6460.321666224979;6571.112899758471;6661.134052573135;6711.395974362331;6720.059191713066;5788.507976822018;5855.502282306052;6257.09272155544;6304.148939893055;6324.557280990287;6316.842078948063;6341.985282354801;6353.491720662243;6393.904091438725;6499.447546958372;5681.17622944679;6178.258608966953;6205.875882482234;6210.099535567408;6270.874582508415;6193.4425901669065;6225.439710426083;6227.439530442282;6235.75056997715;6251.53113516479;6095.207623008981;6152.077188421773;6225.097360882737;6232.470240029648;6237.345078766664;6115.879294474606;6172.166757487682;6226.688665566794;6226.968865155826;6251.937480625317;6155.907661385172;6162.537809664203;6174.660393678211;6183.721732521957;6185.195924529782 03:42:56 INFO - PROCESS | 1666 | |1;ext.html;528.2419727690764;528.4900071431066;564.6075977195851;578.881329327488;656.7241758461446;38321;39079.80460097695;39104.41343379844;39130.21739565207;39181.41227881584;36070.45894311581;37704.62295377046;40576.59423405765;40673.18653626933;41383;9498.620055197784;9755.463449510275;9779.168770654504;9804.558794854249;9812.460314682725;9657.275704322205;9886.406815591088;9891;9895.703128906145;9923.354981926188;9891;9909.405435673847;9922;9990.45052522111;10025;9874.358166719141;9973.401595904234;9976.700698979042;9986.900130998669;10005.649802256923;9872.753181170456;9903.950480247624;9923.751906202331;9973.800523989552;9982.650607228712;39088;39322.60677393218;39886.60113398887;39938.60061399378;40299;3444.689977902001;3576.8748093816594;3606.963930360689;3885.669718073967;3968.7420317679257;28373.432531349463;28482.857585712147;28598.571021434695;29464.705352946625;29770.85114574435;2136.4445244236454;2715.932101697473;2758.7792976561827;2821.2241633550734;2936.4273966576525;331758;454655;460119;460618.6969065133;461221;36798.264034719694;37764.86705398787;49633.25550116679;62284;62412.37587624157;36473.08817279589;36712.08219794527;36724.265514689556;36871.4469282961;37033.888983330544;16093.195340232942;16272.349106035863;16367.91816040912;16472.752908706378;16474.670506589802;13609.659758506117;13622.182669039888;13919.930400348136;13933.512327068504;14070.85929140716;8158.592070396457;8255.711050113337;8264.917350826414;8376.49741015541;8516.531590762444;3535.7171426285836;3541.698955588752;3553.751237413408;3594.191306955914;3599.676029157336;974.541965276319;1031.9793604128026;1052.5158427123456;1058.687227837476;1093.578972095749;28449.57325640117;28571.428571428456;28586.857065714954;28620.570691439643;29182.27044323909;1095.5976350271665;1125.307935619588;1131.7510147767478;1217.190568272107;1227.8219658149696;14735.263236838115;14823.962322637311;14834.258287085602;14960.625984350478;14994;519032;524915;642793;643169;649513;62126.68936655378;62751.6862415685;62916.68541657354;63073.68463157655;63212.683936580026;1541.8149822021205;1545.8995165314218;1558.2676142213143;1564.749640057608;1571.677806049757;29236;29428.411431770815;29660.258493537833;30136.698633013388;30230.54654180233;51125.744371277906;51472.970540589726;51800;51810;51966.74016629893;572826;575525;580842;581102;583162;26441.867790660923;26725.866370668024;27180.184594462196;27671.169864904085;27945.882164713184;43501.3474797872;43584.69245922627;43636.56363436325;44914.77542612266;46938.76530617462;31935.6806431942;39043.023924402114;39067.804660976515;39300.606993929694;39463.80268098641;38321;38363;38474.807625961694;38901.805490972365;39274.2145157101;36558.7204447843;38772.41841372438;39048.6095139045;39286;40175;31187.37625247437;31571.526427103152;31834;31877.521837171997;33669;21723.100902215174;23710.117011612296;24973.500529989662;25638;26115.347116322246 03:42:56 INFO - PROCESS | 1666 | |2;jquery.html;418.4163092485982;421.191312679655;423.4727763933899;429.80014293353594;432.3860118631543;20757.273495427664;20811.375658730245;21568.245111421104;21863.344099677037;21955.451113722163;21032.158713651475;21200.787992120073;21924.780752192473;22041.559168816613;22620;5791.971040144794;6076.544259180557;6132.202813634232;6135;6147.446729794317;4450.421445212118;5969.910451343233;6069.605475644091;6324.241091069055;6608.570442921195;6466.773662921799;6478.416942475176;6539.901901471458;6541.182352205974;6549.34506549346;5041.621878359119;5283.735813209324;5512.33851937768;5904.439078287556;6064.332923378425;5429.321334833146;5747.683877386742;5763.6541807491685;5895.056790913476;5904.5276377890095;25586.84859181323;25676.48647027049;25747.098851540293;25964.480710385877;26752.929882804663;2193.4187440328324;2309.549637820626;2326.1160758911674;2335.427820184049;2792.8688881003022;10171.288009839314;10401.271910966236;10420.635277765241;11587.884121158764;12365.629031129081;1496.9251537423086;1764.2678288510253;1816.5539196179786;1817.0654393155091;1874.6719324118362;104804;106179;111110.88889111087;113205;115479;11957.940210299066;12098.455569499218;12229.3273869938;12333.321667308204;12369.690757731129;15323.23383830804;15352.692946141238;15590.064596124268;15630.218489075502;15680.05919644825;9217.262618990464;9380.24958003358;9393.295502837314;9395.718128456158;9403.4828084456;9046.185843274137;9222.86165707515;9252.676156334495;9272.397294175857;9365.157135857806;4148.522919864194;4152.314868046738;4725.031368569435;4802.207635740064;4835;2006.057153138052;2017.8486613504047;2109.177420805887;2109.5780843831294;2151.204054499814;956.2445667922264;978.3787295067683;988.5255077562811;1013.9898601014042;1088.0860077534908;17856;19810.504737381394;19843.801561984485;21177.470563235733;21611.567768644538;997.4738649865717;1003.5534187286734;1015.8120747661559;1020.7754294055296;1023.6826583759058;9209.401388909699;10624.150067994542;10999.505022274017;11001.22991390595;11046;605010;638084;669059;675978;687025;114331;128437.35781321034;130467;131242.34378828044;135253.3237333807;1044.1490185498794;1064.9094826939643;1073.4954571351452;1081.5295346524288;1082.637316498966;14650.267486625413;18094.909525452287;18308.359207427675;18477.53806154803;18510.907445463225;49885.501144988084;51449.742751286;52653.7367313161;52737.68155796136;55625;67982.3201767976;68187.31812682009;73802.52394952178;74744.62627686826;75489;8001.719939802079;8024.959875200587;8080.909077274728;8203.015638123225;8219.890314807424;11181.440927953407;11923.76152476963;12724.363781811058;12739.74520509566;12789.872101278868;9168.129027742354;11200.38397888124;11328.546858125583;11392.601258955896;11404.885951140383;11135.3875536843;11172.385518796544;11202.887971120184;11378.71896204595;11472.254303470248;9831.803363932824;11690.415479226174;11734.882651173379;11902.98824599884;12087.274763513866;8299.875501867356;8332.125126861834;8355.916440835514;8376.455530390505;8575.099614540633;8599.742007739778;10997.890021100007;11328;11477.253978491372;11663.88336116662 03:42:56 INFO - PROCESS | 1666 | |3;mootools.html;1642.5154579399077;1657.7513372994053;1959.333826498991;2050.5591297870956;2126.0432805237647;7453.888191677129;8382.664693412271;9121;9424.717258482257;9433.386829856054;9119.088091190877;9143.131402516767;9221.216196623294;9242.86135707965;9247.90752092479;2351.1535847095033;2385.224801939368;2556.5142622901635;2581.225632310309;2594.818362714611;2532.8606926619027;2578.1363243313417;2578.278082136995;2580.5742052561304;2585.1856665150513;2429.963550546743;2484.5527804995095;2602.557565213918;2604.466084452692;2609.073778808524;2582.6255192997005;2593.1701855406277;2609.739026097394;2611.229687242268;2612.203278000209;2565.9101931432497;2573.163721790426;2591.935201619956;2600.2199340197867;2611.099170786076;9345.906540934571;9349.626014959393;9425.19885809707;9437.197838183763;9486.667966621135;5746.425357464262;5762.683052432115;5767.480926716574;5796.739146738407;5957.1362152487645;3738.1776009277914;3812.33284175271;3822.311983842907;3891.0855948851995;3915.843366265346;1060.2843080920425;1075.4300220882944;1083.1118482844072;1121.0359091181576;1125.4991528769701;10906.945465272624;12388.31864247466;12389.876101238962;12408.317542535156;12666.240025598494;4453.0648563801315;4992.425871024806;5060.721660308718;5075.822346217865;5193.974030129825;10467.371957682564;10472.738181545523;10691.83962240567;10720.356778593154;10734.677959661223;5712.542996560265;5810.070388737781;5812.709364531756;5822.737976791054;5834.774697313612;4711.340412342275;4941.160002799533;5123.205903085028;5217.217417387346;5235.240890070919;3636.5090712753968;4254.0215750376965;4281.143771245701;4322.37325587788;4381.7370957742;1418.6453386653336;1445.1184777285848;1453.1934776199312;1461.5396150212648;1463.7438448271723;912.5528491039342;934.7336009237334;965.666844938495;973.1922504321396;1000.7248006798043;5920.496757775637;5967.880642387215;6109.84725381869;6130.846728831815;6154.261488621394;1020.2093377632245;1024.4979959819634;1043.2332235806675;1060.7772367802693;1080.8756992945912;3917.6865850731874;4113;4134.896627584334;4160.396742472385;4176.1230141669985;10972.615958441416;11254.549818007188;11428.657140285804;11479.31124132538;11545.422728863523;10957.780844383227;11273.887261127447;11320.92451217133;11375.772484550263;11398.886011139948;8391.202835730595;8548.914510854811;8550.401471896908;8664.306855451548;8766.868496972678;5848;6034;6038.335783063947;6045.335013148638;6164.106204600218;9995.70012899614;10094.596216151565;10123.848142277724;10248.282620216512;10249.38503689781;9765.365251258645;10077.496125193858;10256.794864102825;10323.432211228455;10463.424511651932;7802.531848089133;8385;8599.355048371272;8667.783305417415;8826.073262307365;8558.828823423371;8722.781930451789;8776.91223087761;8779.034306226438;8781.121887811423;7644.541327520366;7665.501742386727;7724.1117271514495;7974.003249593801;8048.315893149148;7620.69517219305;7650.387968962581;7677;7813.413993950363;7829.608519573884;7217.963910180415;7307.744228951961;7315.378192853667;7333.816654583678;7344.8898266524975;4893.681910675937;5001.474845141208;5110.488951105009;5180.844574662766;5198.090334191577;5064.696118232918;5122.206058061007;5125.179971204739;5143.5627971622835;5269.077911365419 03:42:56 INFO - PROCESS | 1666 | |4;prototype.html;310.9626844778627;337.9087646335488;337.9273456206915;344.6915011065096;349.7499288009073;7029.648517574114;7031.1562612486505;7037.507374483788;7043.683034263464;7075.752348667797;6143.017117261239;6583.802485925418;6929.7574584889535;7027;7040.753573624911;4858.963148032471;4981.1532039553185;5122.538971492565;5131.307273518065;5142.408623008346;5054.69671819692;5091.66904151229;5098.464661210556;5103.183490641498;5116.718580478072;4174.624283814456;5030.044291584605;5032.57223136032;5045.142325804603;5051.242313652945;5054.368203974504;5057.822976195852;5082.3138876251605;5087.338645976018;5090.872728181788;4332.198543269474;4387.210302145612;4399.36209249657;4402.537733537964;4406.449193850769;5523.944760552424;6405.103285540028;6718.4625229981975;6722.092517510123;6750.662466876636;5901.586888917777;5935.52515798735;5959;5983.341832398432;5988.880222395571;7497.1753107158165;7502.437317201177;7509.061367329084;7510.399168066541;7510.924890751077;4738.620910327166;4740.928886066712;4744.881377965578;4755.144074066667;4762.214234651278;7646.161366295856;7774.7667569973555;7812.375009999187;7835.333996610295;7921.524708517507;4767.094252092092;4816.253480710496;4818.783154757974;4825.613950883921;4836.927446088312;4915.729634870117;4926.704397736147;4933.9506604933495;4936.136176169156;4936.2102063669645;5898.321693005273;5904.350521442638;5910.290765108214;5924.970375148183;5926.733297001645;7393;7473.177950425449;7486.588237646873;7505.512141710771;7507.286807753255;1491.0978857791097;1633.4772872680867;1647.044714065839;1683.520196743922;1710.0252855872282;914.7833381602453;1061.3048453263125;1072.5280876414354;1081.789051135021;1085.1861104171871;6804.387605115563;6844.589324640538;6860.279670634512;6869.450443964471;6980.406665433495;6167.660778657128;6258;7561.395088392916;7633.427492938052;7692.884606730903;6938.340857618518;6971.268016858258;6989.545679530815;6990.6155161465595;6997.510174287751;3339.1652086978256;4131.8967025824595;4144.233316836395;4144.48193975753;4145.2124096421585;8290.336773058141;8301.086880443147;8303.211194936472;8313.83372332562;8327.417080804407;7828.982232309877;8033.919660803434;8134.837303253902;8138.308243799225;8139.633716482773;8226.218509241613;8272.669093236324;8283.710070147636;8312.08567057611;8320.875186872201;7800.45396822217;7823.76528704117;7827.139014708491;7829.217078292353;7853.018372703412;7294.562326260441;7668.309852113337;7690.884636730565;7695.192004839411;7701.845963080595;8241.711540096068;8286;8292.12932642088;8333.37499687538;8338.749837504885;4186.476690413699;4705.952940470552;4809.2064809306075;4843.830465933675;4850.369451971221;7774.222577742181;7807.453478256468;7809.062912450542;7811;7856.45004849655;7257.709691612487;7390.002349682939;7426.777196684108;7466.738664146946;7520.247975202436;6671.366220209073;6989;7442.255774422514;7515.812104697427;7516.924830751623;5926.762929482772;7343.28954597681;7348.191698913222;7348.632568371667;7365.410767138509;7440.776776696708;7489.625518724151;7508.399328053633;7534.133574638768;7536.8492630148185;7112.679929403293;7286.198518162892;7333.816654583678;7355.521891077063;7364.963175184304 03:42:56 INFO - PROCESS | 1666 | |5;yui.html;713.3686687281755;721.3183541553234;774.2760518914812;785.128507356834;792.5403266105659;15257.160856152906;15408.07551546908;15427.5371738848;15482.922585387085;15496.922515387421;14179.43282268708;14192.651698088692;14219.85780142201;14303.642408939782;14508.709825803478;935.5182081228173;961.5721004153155;966.3428868369489;975.0152346130424;991.3803872579638;963.6579014449875;978.227200511595;978.2565250409668;979.7354714227155;984.5077461269366;976.8730065091528;1025.707673313106;1026.8819085805153;1032.7521394865253;1035.7100011996615;985.3644399362407;1003.5383723487205;1005.416858222233;1015.619142821442;1017.1811691588268;755.9055118110236;759.593617414686;760.5702777930452;763.9465237433382;765.4718244411339;13766.105203161762;13849.723005539832;13882.583522494342;13895.861041389659;13907.860921390858;11485.598004069901;11587;11635.650930472098;11636.069114470822;11855.762884742257;9492.857607135898;9514.90485095147;9567.856482152773;9599.520023998772;9666.130048295687;3439.22617411083;3446.276281980787;3462.87879924204;3489.4068008438626;3522.7005704515145;72671.63664181698;77387;87190.56404717999;90367.64448533277;90735.09264907398;9917.752056198653;10283.691489255334;10302.433366164933;10306.433146177033;10502.527386267637;22264.777352226596;22763;22901.541969160524;22908.656370154462;22966.770332296797;7775.22247775218;7805;7827.530348179127;7875.251851074138;7939.84120317602;4171.499420069611;4194.895127621773;4225.679816636389;4290.356446532983;4303.505096913832;3775.6413140751583;3846.4038074098557;3847.9038024049623;3860.5560360558334;3862.0731024553907;701.6071000239882;708.4828075504807;708.6456771614193;710.094629347586;710.4955481608013;507.6370395167473;558.104242690484;580.91741108127;583.9503642190376;593.4065934065934;8072.717454889051;8132.75601731949;8144.185581441809;8159.918400815915;8453.957730211432;576.4149388370807;583.8744669895908;593.851537115721;594.5719082260765;607.3016031563649;3717.20080182762;3730.4404339349317;3811.066288759216;3884.989902625338;3971.3050216212046;90652.54673726721;91686;91927.16145677182;95530;95961;70968.58062838715;77129.61435192788;78834;79570.20429795743;80179.59910200411;52047.219291709895;52727;57615;69643;70430.2956970434;8276.420650554403;8437.367197460093;8440;8459.450135741157;8606.569671516525;49873.251901220785;50110.997780043464;50246;51263.487365125875;51872.740636298084;62763.372366275755;66455;66600;68065.65967170331;68128.6593567029;10852.782944340912;10975.341479510935;11010.50452729613;11102.573381783557;11248.156388270749;12065.457054432396;12095.274283543016;12108.818367724667;12358.81461778092;12439.875601243872;11160.832587511357;11323.773524529628;11341.922517360837;11705.063594912557;11918.40407979615;11047.226694131334;11260;11329.093672506344;11422.25755325901;11429.771404572028;11062.502187401426;11069.778604428027;11143.387113708499;11237.60668376603;11659.825102623638;9350.345475816628;9448.905510945078;9628.037196280316;9711.077447642463;9759.80480390374;7891.565963872042;9319.906800931903;9674.22606191489;9882.209423245979;10036.347637403545 03:42:56 INFO - PROCESS | 1666 | __end_tp_report 03:42:56 INFO - PROCESS | 1666 | __start_cc_report 03:42:56 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,400 03:42:56 INFO - PROCESS | 1666 | __end_cc_report 03:42:56 INFO - PROCESS | 1666 | __startTimestamp1468665776822__endTimestamp 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | ------- Summary: start ------- 03:42:56 INFO - PROCESS | 1666 | Number of tests: 6 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5941.76 Median:6178.26 stddev:617.22 (10.0%) stddev-sans-first:589.59 03:42:56 INFO - PROCESS | 1666 | Values: 3537.1 3686.2 3708.3 3727.3 3733.7 5917.9 6026.0 6026.4 6061.1 6064.8 6022.2 6030.0 6041.2 6072.3 6077.9 5403.8 5410.7 5425.7 5479.2 5514.4 5382.4 5468.6 5485.4 5499.1 5505.9 5473.8 5508.8 5515.3 5517.5 5538.1 5447.8 5450.7 5494.1 5519.1 5560.8 5368.3 5467.1 5479.8 5495.5 5517.6 4512.7 5787.6 5860.1 5978.4 6037.8 6242.8 6289.7 6312.1 6312.7 6331.3 6375.1 6391.0 6403.3 6416.8 6420.4 5998.3 6075.5 6126.7 6159.0 6164.4 5256.0 6454.4 6552.8 6557.1 6562.6 6210.8 6261.6 6262.8 6267.3 6270.7 6271.4 6302.7 6359.3 6401.7 6405.7 6236.4 6247.2 6275.2 6284.9 6299.7 6277.7 6286.6 6289.9 6300.2 6308.9 4949.5 5040.5 5116.4 5131.6 5177.6 4613.5 4637.2 4638.2 4652.0 4658.1 5900.5 6095.8 6116.6 6176.6 6184.5 6238.9 6313.7 6331.8 6364.9 6371.7 6124.4 6158.9 6182.6 6194.8 6200.4 5550.3 5666.8 5673.2 5696.3 5708.4 6550.4 6612.4 6672.1 6672.6 6682.3 6411.6 6420.4 6427.5 6476.8 6499.7 6460.3 6571.1 6661.1 6711.4 6720.1 5788.5 5855.5 6257.1 6304.1 6324.6 6316.8 6342.0 6353.5 6393.9 6499.4 5681.2 6178.3 6205.9 6210.1 6270.9 6193.4 6225.4 6227.4 6235.8 6251.5 6095.2 6152.1 6225.1 6232.5 6237.3 6115.9 6172.2 6226.7 6227.0 6251.9 6155.9 6162.5 6174.7 6183.7 6185.2 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:65971.07 Median:21329.04 stddev:145264.07 (681.1%) stddev-sans-first:145588.47 03:42:56 INFO - PROCESS | 1666 | Values: 528.2 528.5 564.6 578.9 656.7 38321.0 39079.8 39104.4 39130.2 39181.4 36070.5 37704.6 40576.6 40673.2 41383.0 9498.6 9755.5 9779.2 9804.6 9812.5 9657.3 9886.4 9891.0 9895.7 9923.4 9891.0 9909.4 9922.0 9990.5 10025.0 9874.4 9973.4 9976.7 9986.9 10005.6 9872.8 9904.0 9923.8 9973.8 9982.7 39088.0 39322.6 39886.6 39938.6 40299.0 3444.7 3576.9 3607.0 3885.7 3968.7 28373.4 28482.9 28598.6 29464.7 29770.9 2136.4 2715.9 2758.8 2821.2 2936.4 331758.0 454655.0 460119.0 460618.7 461221.0 36798.3 37764.9 49633.3 62284.0 62412.4 36473.1 36712.1 36724.3 36871.4 37033.9 16093.2 16272.3 16367.9 16472.8 16474.7 13609.7 13622.2 13919.9 13933.5 14070.9 8158.6 8255.7 8264.9 8376.5 8516.5 3535.7 3541.7 3553.8 3594.2 3599.7 974.5 1032.0 1052.5 1058.7 1093.6 28449.6 28571.4 28586.9 28620.6 29182.3 1095.6 1125.3 1131.8 1217.2 1227.8 14735.3 14824.0 14834.3 14960.6 14994.0 519032.0 524915.0 642793.0 643169.0 649513.0 62126.7 62751.7 62916.7 63073.7 63212.7 1541.8 1545.9 1558.3 1564.7 1571.7 29236.0 29428.4 29660.3 30136.7 30230.5 51125.7 51473.0 51800.0 51810.0 51966.7 572826.0 575525.0 580842.0 581102.0 583162.0 26441.9 26725.9 27180.2 27671.2 27945.9 43501.3 43584.7 43636.6 44914.8 46938.8 31935.7 39043.0 39067.8 39300.6 39463.8 38321.0 38363.0 38474.8 38901.8 39274.2 36558.7 38772.4 39048.6 39286.0 40175.0 31187.4 31571.5 31834.0 31877.5 33669.0 21723.1 23710.1 24973.5 25638.0 26115.3 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36375.43 Median:21998.51 stddev:108695.69 (494.1%) stddev-sans-first:108967.08 03:42:56 INFO - PROCESS | 1666 | Values: 418.4 421.2 423.5 429.8 432.4 20757.3 20811.4 21568.2 21863.3 21955.5 21032.2 21200.8 21924.8 22041.6 22620.0 5792.0 6076.5 6132.2 6135.0 6147.4 4450.4 5969.9 6069.6 6324.2 6608.6 6466.8 6478.4 6539.9 6541.2 6549.3 5041.6 5283.7 5512.3 5904.4 6064.3 5429.3 5747.7 5763.7 5895.1 5904.5 25586.8 25676.5 25747.1 25964.5 26752.9 2193.4 2309.5 2326.1 2335.4 2792.9 10171.3 10401.3 10420.6 11587.9 12365.6 1496.9 1764.3 1816.6 1817.1 1874.7 104804.0 106179.0 111110.9 113205.0 115479.0 11957.9 12098.5 12229.3 12333.3 12369.7 15323.2 15352.7 15590.1 15630.2 15680.1 9217.3 9380.2 9393.3 9395.7 9403.5 9046.2 9222.9 9252.7 9272.4 9365.2 4148.5 4152.3 4725.0 4802.2 4835.0 2006.1 2017.8 2109.2 2109.6 2151.2 956.2 978.4 988.5 1014.0 1088.1 17856.0 19810.5 19843.8 21177.5 21611.6 997.5 1003.6 1015.8 1020.8 1023.7 9209.4 10624.2 10999.5 11001.2 11046.0 605010.0 638084.0 669059.0 675978.0 687025.0 114331.0 128437.4 130467.0 131242.3 135253.3 1044.1 1064.9 1073.5 1081.5 1082.6 14650.3 18094.9 18308.4 18477.5 18510.9 49885.5 51449.7 52653.7 52737.7 55625.0 67982.3 68187.3 73802.5 74744.6 75489.0 8001.7 8025.0 8080.9 8203.0 8219.9 11181.4 11923.8 12724.4 12739.7 12789.9 9168.1 11200.4 11328.5 11392.6 11404.9 11135.4 11172.4 11202.9 11378.7 11472.3 9831.8 11690.4 11734.9 11903.0 12087.3 8299.9 8332.1 8355.9 8376.5 8575.1 8599.7 10997.9 11328.0 11477.3 11663.9 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6025.27 Median:4802.51 stddev:3322.64 (69.2%) stddev-sans-first:3315.63 03:42:56 INFO - PROCESS | 1666 | Values: 1642.5 1657.8 1959.3 2050.6 2126.0 7453.9 8382.7 9121.0 9424.7 9433.4 9119.1 9143.1 9221.2 9242.9 9247.9 2351.2 2385.2 2556.5 2581.2 2594.8 2532.9 2578.1 2578.3 2580.6 2585.2 2430.0 2484.6 2602.6 2604.5 2609.1 2582.6 2593.2 2609.7 2611.2 2612.2 2565.9 2573.2 2591.9 2600.2 2611.1 9345.9 9349.6 9425.2 9437.2 9486.7 5746.4 5762.7 5767.5 5796.7 5957.1 3738.2 3812.3 3822.3 3891.1 3915.8 1060.3 1075.4 1083.1 1121.0 1125.5 10906.9 12388.3 12389.9 12408.3 12666.2 4453.1 4992.4 5060.7 5075.8 5194.0 10467.4 10472.7 10691.8 10720.4 10734.7 5712.5 5810.1 5812.7 5822.7 5834.8 4711.3 4941.2 5123.2 5217.2 5235.2 3636.5 4254.0 4281.1 4322.4 4381.7 1418.6 1445.1 1453.2 1461.5 1463.7 912.6 934.7 965.7 973.2 1000.7 5920.5 5967.9 6109.8 6130.8 6154.3 1020.2 1024.5 1043.2 1060.8 1080.9 3917.7 4113.0 4134.9 4160.4 4176.1 10972.6 11254.5 11428.7 11479.3 11545.4 10957.8 11273.9 11320.9 11375.8 11398.9 8391.2 8548.9 8550.4 8664.3 8766.9 5848.0 6034.0 6038.3 6045.3 6164.1 9995.7 10094.6 10123.8 10248.3 10249.4 9765.4 10077.5 10256.8 10323.4 10463.4 7802.5 8385.0 8599.4 8667.8 8826.1 8558.8 8722.8 8776.9 8779.0 8781.1 7644.5 7665.5 7724.1 7974.0 8048.3 7620.7 7650.4 7677.0 7813.4 7829.6 7218.0 7307.7 7315.4 7333.8 7344.9 4893.7 5001.5 5110.5 5180.8 5198.1 5064.7 5122.2 5125.2 5143.6 5269.1 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:6085.82 Median:6954.80 stddev:2003.37 (28.8%) stddev-sans-first:1961.54 03:42:56 INFO - PROCESS | 1666 | Values: 311.0 337.9 337.9 344.7 349.7 7029.6 7031.2 7037.5 7043.7 7075.8 6143.0 6583.8 6929.8 7027.0 7040.8 4859.0 4981.2 5122.5 5131.3 5142.4 5054.7 5091.7 5098.5 5103.2 5116.7 4174.6 5030.0 5032.6 5045.1 5051.2 5054.4 5057.8 5082.3 5087.3 5090.9 4332.2 4387.2 4399.4 4402.5 4406.4 5523.9 6405.1 6718.5 6722.1 6750.7 5901.6 5935.5 5959.0 5983.3 5988.9 7497.2 7502.4 7509.1 7510.4 7510.9 4738.6 4740.9 4744.9 4755.1 4762.2 7646.2 7774.8 7812.4 7835.3 7921.5 4767.1 4816.3 4818.8 4825.6 4836.9 4915.7 4926.7 4934.0 4936.1 4936.2 5898.3 5904.4 5910.3 5925.0 5926.7 7393.0 7473.2 7486.6 7505.5 7507.3 1491.1 1633.5 1647.0 1683.5 1710.0 914.8 1061.3 1072.5 1081.8 1085.2 6804.4 6844.6 6860.3 6869.5 6980.4 6167.7 6258.0 7561.4 7633.4 7692.9 6938.3 6971.3 6989.5 6990.6 6997.5 3339.2 4131.9 4144.2 4144.5 4145.2 8290.3 8301.1 8303.2 8313.8 8327.4 7829.0 8033.9 8134.8 8138.3 8139.6 8226.2 8272.7 8283.7 8312.1 8320.9 7800.5 7823.8 7827.1 7829.2 7853.0 7294.6 7668.3 7690.9 7695.2 7701.8 8241.7 8286.0 8292.1 8333.4 8338.7 4186.5 4706.0 4809.2 4843.8 4850.4 7774.2 7807.5 7809.1 7811.0 7856.5 7257.7 7390.0 7426.8 7466.7 7520.2 6671.4 6989.0 7442.3 7515.8 7516.9 5926.8 7343.3 7348.2 7348.6 7365.4 7440.8 7489.6 7508.4 7534.1 7536.8 7112.7 7286.2 7333.8 7355.5 7365.0 03:42:56 INFO - PROCESS | 1666 | 03:42:56 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18136.96 Median:26642.55 stddev:25444.80 (95.5%) stddev-sans-first:25482.55 03:42:56 INFO - PROCESS | 1666 | Values: 713.4 721.3 774.3 785.1 792.5 15257.2 15408.1 15427.5 15482.9 15496.9 14179.4 14192.7 14219.9 14303.6 14508.7 935.5 961.6 966.3 975.0 991.4 963.7 978.2 978.3 979.7 984.5 976.9 1025.7 1026.9 1032.8 1035.7 985.4 1003.5 1005.4 1015.6 1017.2 755.9 759.6 760.6 763.9 765.5 13766.1 13849.7 13882.6 13895.9 13907.9 11485.6 11587.0 11635.7 11636.1 11855.8 9492.9 9514.9 9567.9 9599.5 9666.1 3439.2 3446.3 3462.9 3489.4 3522.7 72671.6 77387.0 87190.6 90367.6 90735.1 9917.8 10283.7 10302.4 10306.4 10502.5 22264.8 22763.0 22901.5 22908.7 22966.8 7775.2 7805.0 7827.5 7875.3 7939.8 4171.5 4194.9 4225.7 4290.4 4303.5 3775.6 3846.4 3847.9 3860.6 3862.1 701.6 708.5 708.6 710.1 710.5 507.6 558.1 580.9 584.0 593.4 8072.7 8132.8 8144.2 8159.9 8454.0 576.4 583.9 593.9 594.6 607.3 3717.2 3730.4 3811.1 3885.0 3971.3 90652.5 91686.0 91927.2 95530.0 95961.0 70968.6 77129.6 78834.0 79570.2 80179.6 52047.2 52727.0 57615.0 69643.0 70430.3 8276.4 8437.4 8440.0 8459.5 8606.6 49873.3 50111.0 50246.0 51263.5 51872.7 62763.4 66455.0 66600.0 68065.7 68128.7 10852.8 10975.3 11010.5 11102.6 11248.2 12065.5 12095.3 12108.8 12358.8 12439.9 11160.8 11323.8 11341.9 11705.1 11918.4 11047.2 11260.0 11329.1 11422.3 11429.8 11062.5 11069.8 11143.4 11237.6 11659.8 9350.3 9448.9 9628.0 9711.1 9759.8 7891.6 9319.9 9674.2 9882.2 10036.3 03:42:56 INFO - PROCESS | 1666 | -------- Summary: end -------- 03:42:56 INFO - PROCESS | 1666 | 03:42:57 INFO - TEST-INFO | 1666: exit 0 03:42:57 INFO - TEST-OK | dromaeo_css | took 1109404ms 03:42:57 INFO - TEST-START | kraken 03:42:57 INFO - operating with platform_type : mac_ 03:42:57 INFO - Initialising browser for kraken test... 03:42:57 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmphKjX0q/profile http://localhost:49265/getInfo.html) 03:42:59 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 03:42:59 INFO - PROCESS | 1698 | colorDepth:24 03:42:59 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 03:42:59 INFO - PROCESS | 1698 | __metrics 03:42:59 ERROR - PROCESS | 1698 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:43:00 INFO - TEST-INFO | 1698: exit 0 03:43:00 INFO - Browser initialized. 03:43:00 INFO - Running cycle 1/1 for kraken test... 03:43:00 INFO - TEST-INFO | started process 1702 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmphKjX0q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:12 INFO - PROCESS | 1702 | RSS: Main: 170967040 03:43:12 INFO - PROCESS | 1702 | 03:43:15 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:16 INFO - PROCESS | 1702 | RSS: Main: 183578624 03:43:16 INFO - PROCESS | 1702 | 03:43:18 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 03:43:19 INFO - PROCESS | 1702 | RSS: Main: 193323008 03:43:19 INFO - PROCESS | 1702 | 03:43:22 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 03:43:23 INFO - PROCESS | 1702 | RSS: Main: 195907584 03:43:23 INFO - PROCESS | 1702 | 03:43:25 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 03:43:25 INFO - PROCESS | 1702 | RSS: Main: 197214208 03:43:25 INFO - PROCESS | 1702 | 03:43:27 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:28 INFO - PROCESS | 1702 | RSS: Main: 197365760 03:43:28 INFO - PROCESS | 1702 | 03:43:31 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:32 INFO - PROCESS | 1702 | RSS: Main: 197369856 03:43:32 INFO - PROCESS | 1702 | 03:43:34 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:35 INFO - PROCESS | 1702 | RSS: Main: 197353472 03:43:35 INFO - PROCESS | 1702 | 03:43:38 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 03:43:39 INFO - PROCESS | 1702 | RSS: Main: 198287360 03:43:39 INFO - PROCESS | 1702 | 03:43:40 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:41 INFO - PROCESS | 1702 | RSS: Main: 197578752 03:43:41 INFO - PROCESS | 1702 | 03:43:43 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:43 INFO - PROCESS | 1702 | RSS: Main: 197681152 03:43:43 INFO - PROCESS | 1702 | 03:43:46 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:46 INFO - PROCESS | 1702 | RSS: Main: 198688768 03:43:46 INFO - PROCESS | 1702 | 03:43:49 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:50 INFO - PROCESS | 1702 | RSS: Main: 198103040 03:43:50 INFO - PROCESS | 1702 | 03:43:52 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:53 INFO - PROCESS | 1702 | RSS: Main: 198656000 03:43:53 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 03:43:55 INFO - PROCESS | 1702 | RSS: Main: 199671808 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | __start_tp_report 03:43:55 INFO - PROCESS | 1702 | _x_x_mozilla_page_load 03:43:55 INFO - PROCESS | 1702 | _x_x_mozilla_page_load_details 03:43:55 INFO - PROCESS | 1702 | |i|pagename|runs| 03:43:55 INFO - PROCESS | 1702 | |0;ai-astar;115;112;115;115;116;131;115;119;163;154 03:43:55 INFO - PROCESS | 1702 | |1;audio-beat-detection;193;152;173;157;120;157;121;151;151;119 03:43:55 INFO - PROCESS | 1702 | |2;audio-dft;200;195;200;216;233;223;196;195;234;195 03:43:55 INFO - PROCESS | 1702 | |3;audio-fft;65;67;82;141;56;73;88;78;125;62 03:43:55 INFO - PROCESS | 1702 | |4;audio-oscillator;77;82;122;76;85;93;114;81;81;120 03:43:55 INFO - PROCESS | 1702 | |5;imaging-gaussian-blur;89;86;113;85;90;85;89;101;113;132 03:43:55 INFO - PROCESS | 1702 | |6;imaging-darkroom;89;91;134;151;150;95;95;95;94;94 03:43:55 INFO - PROCESS | 1702 | |7;imaging-desaturate;91;91;121;144;149;98;84;92;93;97 03:43:55 INFO - PROCESS | 1702 | |8;json-parse-financial;61;63;66;65;65;65;66;77;63;67 03:43:55 INFO - PROCESS | 1702 | |9;json-stringify-tinderbox;62;65;74;84;103;66;89;59;68;81 03:43:55 INFO - PROCESS | 1702 | |10;stanford-crypto-aes;80;80;78;81;106;104;105;106;84;83 03:43:55 INFO - PROCESS | 1702 | |11;stanford-crypto-ccm;127;149;145;127;123;127;126;131;140;171 03:43:55 INFO - PROCESS | 1702 | |12;stanford-crypto-pbkdf2;166;165;173;170;167;167;177;163;167;161 03:43:55 INFO - PROCESS | 1702 | |13;stanford-crypto-sha256-iterative;65;67;68;68;67;68;65;69;69;67 03:43:55 INFO - PROCESS | 1702 | __end_tp_report 03:43:55 INFO - PROCESS | 1702 | __start_cc_report 03:43:55 INFO - PROCESS | 1702 | _x_x_mozilla_cycle_collect,1035 03:43:55 INFO - PROCESS | 1702 | __end_cc_report 03:43:55 INFO - PROCESS | 1702 | __startTimestamp1468665835442__endTimestamp 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | ------- Summary: start ------- 03:43:55 INFO - PROCESS | 1702 | Number of tests: 14 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#0] ai-astar Cycles:10 Average:125.50 Median:117.50 stddev:18.27 (15.5%) stddev-sans-first:18.98 03:43:55 INFO - PROCESS | 1702 | Values: 115.0 112.0 115.0 115.0 116.0 131.0 115.0 119.0 163.0 154.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.50 stddev:23.99 (15.5%) stddev-sans-first:19.58 03:43:55 INFO - PROCESS | 1702 | Values: 193.0 152.0 173.0 157.0 120.0 157.0 121.0 151.0 151.0 119.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#2] audio-dft Cycles:10 Average:208.70 Median:208.00 stddev:16.21 (7.8%) stddev-sans-first:16.88 03:43:55 INFO - PROCESS | 1702 | Values: 200.0 195.0 200.0 216.0 233.0 223.0 196.0 195.0 234.0 195.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#3] audio-fft Cycles:10 Average:83.70 Median:70.00 stddev:27.94 (39.9%) stddev-sans-first:28.80 03:43:55 INFO - PROCESS | 1702 | Values: 65.0 67.0 82.0 141.0 56.0 73.0 88.0 78.0 125.0 62.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:81.00 stddev:18.35 (22.6%) stddev-sans-first:18.51 03:43:55 INFO - PROCESS | 1702 | Values: 77.0 82.0 122.0 76.0 85.0 93.0 114.0 81.0 81.0 120.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:85.50 stddev:16.06 (18.8%) stddev-sans-first:16.68 03:43:55 INFO - PROCESS | 1702 | Values: 89.0 86.0 113.0 85.0 90.0 85.0 89.0 101.0 113.0 132.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#6] imaging-darkroom Cycles:10 Average:108.80 Median:94.00 stddev:25.45 (27.1%) stddev-sans-first:25.97 03:43:55 INFO - PROCESS | 1702 | Values: 89.0 91.0 134.0 151.0 150.0 95.0 95.0 95.0 94.0 94.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:91.50 stddev:23.48 (25.7%) stddev-sans-first:24.27 03:43:55 INFO - PROCESS | 1702 | Values: 91.0 91.0 121.0 144.0 149.0 98.0 84.0 92.0 93.0 97.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.50 stddev:4.32 (6.6%) stddev-sans-first:4.21 03:43:55 INFO - PROCESS | 1702 | Values: 61.0 63.0 66.0 65.0 65.0 65.0 66.0 77.0 63.0 67.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:71.00 stddev:13.96 (19.7%) stddev-sans-first:13.97 03:43:55 INFO - PROCESS | 1702 | Values: 62.0 65.0 74.0 84.0 103.0 66.0 89.0 59.0 68.0 81.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:80.00 stddev:12.64 (15.8%) stddev-sans-first:12.80 03:43:55 INFO - PROCESS | 1702 | Values: 80.0 80.0 78.0 81.0 106.0 104.0 105.0 106.0 84.0 83.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:135.50 stddev:15.00 (11.1%) stddev-sans-first:15.50 03:43:55 INFO - PROCESS | 1702 | Values: 127.0 149.0 145.0 127.0 123.0 127.0 126.0 131.0 140.0 171.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.00 stddev:4.70 (2.8%) stddev-sans-first:4.94 03:43:55 INFO - PROCESS | 1702 | Values: 166.0 165.0 173.0 170.0 167.0 167.0 177.0 163.0 167.0 161.0 03:43:55 INFO - PROCESS | 1702 | 03:43:55 INFO - PROCESS | 1702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.24 03:43:55 INFO - PROCESS | 1702 | Values: 65.0 67.0 68.0 68.0 67.0 68.0 65.0 69.0 69.0 67.0 03:43:55 INFO - PROCESS | 1702 | -------- Summary: end -------- 03:43:55 INFO - PROCESS | 1702 | 03:43:56 INFO - TEST-INFO | 1702: exit 0 03:43:56 INFO - TEST-OK | kraken | took 58985ms 03:43:56 INFO - SUITE-END | took 1168s 03:43:56 INFO - Completed test suite (00:19:28) 03:43:56 INFO - javascript benchmark 03:43:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3537.0980399998007, 3686.2258925625615, 3708.2583483303347, 3727.347714150023, 3733.7386382953196, 5917.881642367155, 6025.969870150654, 6026.397360263972, 6061.090836374546, 6064.757409703612, 6022.247219097613, 6030.0, 6041.184440100585, 6072.332043475225, 6077.908831367533, 5403.78384864606, 5410.702411367373, 5425.674459532421, 5479.205515200293, 5514.393416724157, 5382.434844341346, 5468.6171967962255, 5485.369182543998, 5499.065158922993, 5505.862353441176, 5473.781048758045, 5508.834734957958, 5515.255440515519, 5517.475839795213, 5538.113901775717, 5447.836564903019, 5450.700211488366, 5494.120940649517, 5519.089350257183, 5560.805371811967, 5368.32895888014, 5467.125259958388, 5479.75341109651, 5495.477929596682, 5517.613767036309, 4512.706674066175, 5787.594868359217, 5860.06239001762, 5978.432048955342, 6037.849053773647, 6242.812715618538, 6289.685515724242, 6312.147860038928, 6312.747490100391, 6331.33520980295, 6375.10748495211, 6390.968045159791, 6403.327650596667, 6416.839579010515, 6420.422162005395, 5998.310194327621, 6075.453209211104, 6126.724297406583, 6159.0, 6164.352742962014, 5255.973720131375, 6454.419102280817, 6552.770653027216, 6557.147570815859, 6562.606243625398, 6210.813675589739, 6261.5616906816085, 6262.812115636447, 6267.341929097471, 6270.717817698214, 6271.3728627136925, 6302.684865756693, 6359.332270111664, 6401.711922963478, 6405.711742971577, 6236.376362363818, 6247.187865577446, 6275.215598050244, 6284.874302513924, 6299.748010079637, 6277.7175027123885, 6286.5599408041, 6289.905651415233, 6300.180976473029, 6308.936910630927, 4949.480304567968, 5040.546350828443, 5116.360454943132, 5131.589472842238, 5177.58579313654, 4613.538646135359, 4637.211674015425, 4638.165130276515, 4652.023075154188, 4658.138244424792, 5900.527957763368, 6095.786647467317, 6116.5718399711595, 6176.598521096114, 6184.5052395809125, 6238.937610623926, 6313.715882785285, 6331.841703957346, 6364.88614492462, 6371.681415929185, 6124.3809352984035, 6158.938410615837, 6182.629042257479, 6194.783182588588, 6200.410960958701, 5550.278463799761, 5666.773329066874, 5673.234113394721, 5696.316442026983, 5708.372079071299, 6550.410463058348, 6612.437942774822, 6672.099266599044, 6672.633005184762, 6682.2649508555, 6411.647359395278, 6420.422162005442, 6427.517936154713, 6476.805695829133, 6499.6750162492635, 6460.321666224979, 6571.112899758471, 6661.134052573135, 6711.395974362331, 6720.059191713066, 5788.507976822018, 5855.502282306052, 6257.09272155544, 6304.148939893055, 6324.557280990287, 6316.842078948063, 6341.985282354801, 6353.491720662243, 6393.904091438725, 6499.447546958372, 5681.17622944679, 6178.258608966953, 6205.875882482234, 6210.099535567408, 6270.874582508415, 6193.4425901669065, 6225.439710426083, 6227.439530442282, 6235.75056997715, 6251.53113516479, 6095.207623008981, 6152.077188421773, 6225.097360882737, 6232.470240029648, 6237.345078766664, 6115.879294474606, 6172.166757487682, 6226.688665566794, 6226.968865155826, 6251.937480625317, 6155.907661385172, 6162.537809664203, 6174.660393678211, 6183.721732521957, 6185.195924529782], "value": 5906.495777882869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.2419727690764, 528.4900071431066, 564.6075977195851, 578.881329327488, 656.7241758461446, 38321.0, 39079.80460097695, 39104.41343379844, 39130.21739565207, 39181.41227881584, 36070.45894311581, 37704.62295377046, 40576.59423405765, 40673.18653626933, 41383.0, 9498.620055197784, 9755.463449510275, 9779.168770654504, 9804.558794854249, 9812.460314682725, 9657.275704322205, 9886.406815591088, 9891.0, 9895.703128906145, 9923.354981926188, 9891.0, 9909.405435673847, 9922.0, 9990.45052522111, 10025.0, 9874.358166719141, 9973.401595904234, 9976.700698979042, 9986.900130998669, 10005.649802256923, 9872.753181170456, 9903.950480247624, 9923.751906202331, 9973.800523989552, 9982.650607228712, 39088.0, 39322.60677393218, 39886.60113398887, 39938.60061399378, 40299.0, 3444.689977902001, 3576.8748093816594, 3606.963930360689, 3885.669718073967, 3968.7420317679257, 28373.432531349463, 28482.857585712147, 28598.571021434695, 29464.705352946625, 29770.85114574435, 2136.4445244236454, 2715.932101697473, 2758.7792976561827, 2821.2241633550734, 2936.4273966576525, 331758.0, 454655.0, 460119.0, 460618.6969065133, 461221.0, 36798.264034719694, 37764.86705398787, 49633.25550116679, 62284.0, 62412.37587624157, 36473.08817279589, 36712.08219794527, 36724.265514689556, 36871.4469282961, 37033.888983330544, 16093.195340232942, 16272.349106035863, 16367.91816040912, 16472.752908706378, 16474.670506589802, 13609.659758506117, 13622.182669039888, 13919.930400348136, 13933.512327068504, 14070.85929140716, 8158.592070396457, 8255.711050113337, 8264.917350826414, 8376.49741015541, 8516.531590762444, 3535.7171426285836, 3541.698955588752, 3553.751237413408, 3594.191306955914, 3599.676029157336, 974.541965276319, 1031.9793604128026, 1052.5158427123456, 1058.687227837476, 1093.578972095749, 28449.57325640117, 28571.428571428456, 28586.857065714954, 28620.570691439643, 29182.27044323909, 1095.5976350271665, 1125.307935619588, 1131.7510147767478, 1217.190568272107, 1227.8219658149696, 14735.263236838115, 14823.962322637311, 14834.258287085602, 14960.625984350478, 14994.0, 519032.0, 524915.0, 642793.0, 643169.0, 649513.0, 62126.68936655378, 62751.6862415685, 62916.68541657354, 63073.68463157655, 63212.683936580026, 1541.8149822021205, 1545.8995165314218, 1558.2676142213143, 1564.749640057608, 1571.677806049757, 29236.0, 29428.411431770815, 29660.258493537833, 30136.698633013388, 30230.54654180233, 51125.744371277906, 51472.970540589726, 51800.0, 51810.0, 51966.74016629893, 572826.0, 575525.0, 580842.0, 581102.0, 583162.0, 26441.867790660923, 26725.866370668024, 27180.184594462196, 27671.169864904085, 27945.882164713184, 43501.3474797872, 43584.69245922627, 43636.56363436325, 44914.77542612266, 46938.76530617462, 31935.6806431942, 39043.023924402114, 39067.804660976515, 39300.606993929694, 39463.80268098641, 38321.0, 38363.0, 38474.807625961694, 38901.805490972365, 39274.2145157101, 36558.7204447843, 38772.41841372438, 39048.6095139045, 39286.0, 40175.0, 31187.37625247437, 31571.526427103152, 31834.0, 31877.521837171997, 33669.0, 21723.100902215174, 23710.117011612296, 24973.500529989662, 25638.0, 26115.347116322246], "value": 18782.14513284023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.4163092485982, 421.191312679655, 423.4727763933899, 429.80014293353594, 432.3860118631543, 20757.273495427664, 20811.375658730245, 21568.245111421104, 21863.344099677037, 21955.451113722163, 21032.158713651475, 21200.787992120073, 21924.780752192473, 22041.559168816613, 22620.0, 5791.971040144794, 6076.544259180557, 6132.202813634232, 6135.0, 6147.446729794317, 4450.421445212118, 5969.910451343233, 6069.605475644091, 6324.241091069055, 6608.570442921195, 6466.773662921799, 6478.416942475176, 6539.901901471458, 6541.182352205974, 6549.34506549346, 5041.621878359119, 5283.735813209324, 5512.33851937768, 5904.439078287556, 6064.332923378425, 5429.321334833146, 5747.683877386742, 5763.6541807491685, 5895.056790913476, 5904.5276377890095, 25586.84859181323, 25676.48647027049, 25747.098851540293, 25964.480710385877, 26752.929882804663, 2193.4187440328324, 2309.549637820626, 2326.1160758911674, 2335.427820184049, 2792.8688881003022, 10171.288009839314, 10401.271910966236, 10420.635277765241, 11587.884121158764, 12365.629031129081, 1496.9251537423086, 1764.2678288510253, 1816.5539196179786, 1817.0654393155091, 1874.6719324118362, 104804.0, 106179.0, 111110.88889111087, 113205.0, 115479.0, 11957.940210299066, 12098.455569499218, 12229.3273869938, 12333.321667308204, 12369.690757731129, 15323.23383830804, 15352.692946141238, 15590.064596124268, 15630.218489075502, 15680.05919644825, 9217.262618990464, 9380.24958003358, 9393.295502837314, 9395.718128456158, 9403.4828084456, 9046.185843274137, 9222.86165707515, 9252.676156334495, 9272.397294175857, 9365.157135857806, 4148.522919864194, 4152.314868046738, 4725.031368569435, 4802.207635740064, 4835.0, 2006.057153138052, 2017.8486613504047, 2109.177420805887, 2109.5780843831294, 2151.204054499814, 956.2445667922264, 978.3787295067683, 988.5255077562811, 1013.9898601014042, 1088.0860077534908, 17856.0, 19810.504737381394, 19843.801561984485, 21177.470563235733, 21611.567768644538, 997.4738649865717, 1003.5534187286734, 1015.8120747661559, 1020.7754294055296, 1023.6826583759058, 9209.401388909699, 10624.150067994542, 10999.505022274017, 11001.22991390595, 11046.0, 605010.0, 638084.0, 669059.0, 675978.0, 687025.0, 114331.0, 128437.35781321034, 130467.0, 131242.34378828044, 135253.3237333807, 1044.1490185498794, 1064.9094826939643, 1073.4954571351452, 1081.5295346524288, 1082.637316498966, 14650.267486625413, 18094.909525452287, 18308.359207427675, 18477.53806154803, 18510.907445463225, 49885.501144988084, 51449.742751286, 52653.7367313161, 52737.68155796136, 55625.0, 67982.3201767976, 68187.31812682009, 73802.52394952178, 74744.62627686826, 75489.0, 8001.719939802079, 8024.959875200587, 8080.909077274728, 8203.015638123225, 8219.890314807424, 11181.440927953407, 11923.76152476963, 12724.363781811058, 12739.74520509566, 12789.872101278868, 9168.129027742354, 11200.38397888124, 11328.546858125583, 11392.601258955896, 11404.885951140383, 11135.3875536843, 11172.385518796544, 11202.887971120184, 11378.71896204595, 11472.254303470248, 9831.803363932824, 11690.415479226174, 11734.882651173379, 11902.98824599884, 12087.274763513866, 8299.875501867356, 8332.125126861834, 8355.916440835514, 8376.455530390505, 8575.099614540633, 8599.742007739778, 10997.890021100007, 11328.0, 11477.253978491372, 11663.88336116662], "value": 9803.721387949947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1642.5154579399077, 1657.7513372994053, 1959.333826498991, 2050.5591297870956, 2126.0432805237647, 7453.888191677129, 8382.664693412271, 9121.0, 9424.717258482257, 9433.386829856054, 9119.088091190877, 9143.131402516767, 9221.216196623294, 9242.86135707965, 9247.90752092479, 2351.1535847095033, 2385.224801939368, 2556.5142622901635, 2581.225632310309, 2594.818362714611, 2532.8606926619027, 2578.1363243313417, 2578.278082136995, 2580.5742052561304, 2585.1856665150513, 2429.963550546743, 2484.5527804995095, 2602.557565213918, 2604.466084452692, 2609.073778808524, 2582.6255192997005, 2593.1701855406277, 2609.739026097394, 2611.229687242268, 2612.203278000209, 2565.9101931432497, 2573.163721790426, 2591.935201619956, 2600.2199340197867, 2611.099170786076, 9345.906540934571, 9349.626014959393, 9425.19885809707, 9437.197838183763, 9486.667966621135, 5746.425357464262, 5762.683052432115, 5767.480926716574, 5796.739146738407, 5957.1362152487645, 3738.1776009277914, 3812.33284175271, 3822.311983842907, 3891.0855948851995, 3915.843366265346, 1060.2843080920425, 1075.4300220882944, 1083.1118482844072, 1121.0359091181576, 1125.4991528769701, 10906.945465272624, 12388.31864247466, 12389.876101238962, 12408.317542535156, 12666.240025598494, 4453.0648563801315, 4992.425871024806, 5060.721660308718, 5075.822346217865, 5193.974030129825, 10467.371957682564, 10472.738181545523, 10691.83962240567, 10720.356778593154, 10734.677959661223, 5712.542996560265, 5810.070388737781, 5812.709364531756, 5822.737976791054, 5834.774697313612, 4711.340412342275, 4941.160002799533, 5123.205903085028, 5217.217417387346, 5235.240890070919, 3636.5090712753968, 4254.0215750376965, 4281.143771245701, 4322.37325587788, 4381.7370957742, 1418.6453386653336, 1445.1184777285848, 1453.1934776199312, 1461.5396150212648, 1463.7438448271723, 912.5528491039342, 934.7336009237334, 965.666844938495, 973.1922504321396, 1000.7248006798043, 5920.496757775637, 5967.880642387215, 6109.84725381869, 6130.846728831815, 6154.261488621394, 1020.2093377632245, 1024.4979959819634, 1043.2332235806675, 1060.7772367802693, 1080.8756992945912, 3917.6865850731874, 4113.0, 4134.896627584334, 4160.396742472385, 4176.1230141669985, 10972.615958441416, 11254.549818007188, 11428.657140285804, 11479.31124132538, 11545.422728863523, 10957.780844383227, 11273.887261127447, 11320.92451217133, 11375.772484550263, 11398.886011139948, 8391.202835730595, 8548.914510854811, 8550.401471896908, 8664.306855451548, 8766.868496972678, 5848.0, 6034.0, 6038.335783063947, 6045.335013148638, 6164.106204600218, 9995.70012899614, 10094.596216151565, 10123.848142277724, 10248.282620216512, 10249.38503689781, 9765.365251258645, 10077.496125193858, 10256.794864102825, 10323.432211228455, 10463.424511651932, 7802.531848089133, 8385.0, 8599.355048371272, 8667.783305417415, 8826.073262307365, 8558.828823423371, 8722.781930451789, 8776.91223087761, 8779.034306226438, 8781.121887811423, 7644.541327520366, 7665.501742386727, 7724.1117271514495, 7974.003249593801, 8048.315893149148, 7620.69517219305, 7650.387968962581, 7677.0, 7813.413993950363, 7829.608519573884, 7217.963910180415, 7307.744228951961, 7315.378192853667, 7333.816654583678, 7344.8898266524975, 4893.681910675937, 5001.474845141208, 5110.488951105009, 5180.844574662766, 5198.090334191577, 5064.696118232918, 5122.206058061007, 5125.179971204739, 5143.5627971622835, 5269.077911365419], "value": 4883.958822889805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.9626844778627, 337.9087646335488, 337.9273456206915, 344.6915011065096, 349.7499288009073, 7029.648517574114, 7031.1562612486505, 7037.507374483788, 7043.683034263464, 7075.752348667797, 6143.017117261239, 6583.802485925418, 6929.7574584889535, 7027.0, 7040.753573624911, 4858.963148032471, 4981.1532039553185, 5122.538971492565, 5131.307273518065, 5142.408623008346, 5054.69671819692, 5091.66904151229, 5098.464661210556, 5103.183490641498, 5116.718580478072, 4174.624283814456, 5030.044291584605, 5032.57223136032, 5045.142325804603, 5051.242313652945, 5054.368203974504, 5057.822976195852, 5082.3138876251605, 5087.338645976018, 5090.872728181788, 4332.198543269474, 4387.210302145612, 4399.36209249657, 4402.537733537964, 4406.449193850769, 5523.944760552424, 6405.103285540028, 6718.4625229981975, 6722.092517510123, 6750.662466876636, 5901.586888917777, 5935.52515798735, 5959.0, 5983.341832398432, 5988.880222395571, 7497.1753107158165, 7502.437317201177, 7509.061367329084, 7510.399168066541, 7510.924890751077, 4738.620910327166, 4740.928886066712, 4744.881377965578, 4755.144074066667, 4762.214234651278, 7646.161366295856, 7774.7667569973555, 7812.375009999187, 7835.333996610295, 7921.524708517507, 4767.094252092092, 4816.253480710496, 4818.783154757974, 4825.613950883921, 4836.927446088312, 4915.729634870117, 4926.704397736147, 4933.9506604933495, 4936.136176169156, 4936.2102063669645, 5898.321693005273, 5904.350521442638, 5910.290765108214, 5924.970375148183, 5926.733297001645, 7393.0, 7473.177950425449, 7486.588237646873, 7505.512141710771, 7507.286807753255, 1491.0978857791097, 1633.4772872680867, 1647.044714065839, 1683.520196743922, 1710.0252855872282, 914.7833381602453, 1061.3048453263125, 1072.5280876414354, 1081.789051135021, 1085.1861104171871, 6804.387605115563, 6844.589324640538, 6860.279670634512, 6869.450443964471, 6980.406665433495, 6167.660778657128, 6258.0, 7561.395088392916, 7633.427492938052, 7692.884606730903, 6938.340857618518, 6971.268016858258, 6989.545679530815, 6990.6155161465595, 6997.510174287751, 3339.1652086978256, 4131.8967025824595, 4144.233316836395, 4144.48193975753, 4145.2124096421585, 8290.336773058141, 8301.086880443147, 8303.211194936472, 8313.83372332562, 8327.417080804407, 7828.982232309877, 8033.919660803434, 8134.837303253902, 8138.308243799225, 8139.633716482773, 8226.218509241613, 8272.669093236324, 8283.710070147636, 8312.08567057611, 8320.875186872201, 7800.45396822217, 7823.76528704117, 7827.139014708491, 7829.217078292353, 7853.018372703412, 7294.562326260441, 7668.309852113337, 7690.884636730565, 7695.192004839411, 7701.845963080595, 8241.711540096068, 8286.0, 8292.12932642088, 8333.37499687538, 8338.749837504885, 4186.476690413699, 4705.952940470552, 4809.2064809306075, 4843.830465933675, 4850.369451971221, 7774.222577742181, 7807.453478256468, 7809.062912450542, 7811.0, 7856.45004849655, 7257.709691612487, 7390.002349682939, 7426.777196684108, 7466.738664146946, 7520.247975202436, 6671.366220209073, 6989.0, 7442.255774422514, 7515.812104697427, 7516.924830751623, 5926.762929482772, 7343.28954597681, 7348.191698913222, 7348.632568371667, 7365.410767138509, 7440.776776696708, 7489.625518724151, 7508.399328053633, 7534.133574638768, 7536.8492630148185, 7112.679929403293, 7286.198518162892, 7333.816654583678, 7355.521891077063, 7364.963175184304], "value": 5402.793776989628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.3686687281755, 721.3183541553234, 774.2760518914812, 785.128507356834, 792.5403266105659, 15257.160856152906, 15408.07551546908, 15427.5371738848, 15482.922585387085, 15496.922515387421, 14179.43282268708, 14192.651698088692, 14219.85780142201, 14303.642408939782, 14508.709825803478, 935.5182081228173, 961.5721004153155, 966.3428868369489, 975.0152346130424, 991.3803872579638, 963.6579014449875, 978.227200511595, 978.2565250409668, 979.7354714227155, 984.5077461269366, 976.8730065091528, 1025.707673313106, 1026.8819085805153, 1032.7521394865253, 1035.7100011996615, 985.3644399362407, 1003.5383723487205, 1005.416858222233, 1015.619142821442, 1017.1811691588268, 755.9055118110236, 759.593617414686, 760.5702777930452, 763.9465237433382, 765.4718244411339, 13766.105203161762, 13849.723005539832, 13882.583522494342, 13895.861041389659, 13907.860921390858, 11485.598004069901, 11587.0, 11635.650930472098, 11636.069114470822, 11855.762884742257, 9492.857607135898, 9514.90485095147, 9567.856482152773, 9599.520023998772, 9666.130048295687, 3439.22617411083, 3446.276281980787, 3462.87879924204, 3489.4068008438626, 3522.7005704515145, 72671.63664181698, 77387.0, 87190.56404717999, 90367.64448533277, 90735.09264907398, 9917.752056198653, 10283.691489255334, 10302.433366164933, 10306.433146177033, 10502.527386267637, 22264.777352226596, 22763.0, 22901.541969160524, 22908.656370154462, 22966.770332296797, 7775.22247775218, 7805.0, 7827.530348179127, 7875.251851074138, 7939.84120317602, 4171.499420069611, 4194.895127621773, 4225.679816636389, 4290.356446532983, 4303.505096913832, 3775.6413140751583, 3846.4038074098557, 3847.9038024049623, 3860.5560360558334, 3862.0731024553907, 701.6071000239882, 708.4828075504807, 708.6456771614193, 710.094629347586, 710.4955481608013, 507.6370395167473, 558.104242690484, 580.91741108127, 583.9503642190376, 593.4065934065934, 8072.717454889051, 8132.75601731949, 8144.185581441809, 8159.918400815915, 8453.957730211432, 576.4149388370807, 583.8744669895908, 593.851537115721, 594.5719082260765, 607.3016031563649, 3717.20080182762, 3730.4404339349317, 3811.066288759216, 3884.989902625338, 3971.3050216212046, 90652.54673726721, 91686.0, 91927.16145677182, 95530.0, 95961.0, 70968.58062838715, 77129.61435192788, 78834.0, 79570.20429795743, 80179.59910200411, 52047.219291709895, 52727.0, 57615.0, 69643.0, 70430.2956970434, 8276.420650554403, 8437.367197460093, 8440.0, 8459.450135741157, 8606.569671516525, 49873.251901220785, 50110.997780043464, 50246.0, 51263.487365125875, 51872.740636298084, 62763.372366275755, 66455.0, 66600.0, 68065.65967170331, 68128.6593567029, 10852.782944340912, 10975.341479510935, 11010.50452729613, 11102.573381783557, 11248.156388270749, 12065.457054432396, 12095.274283543016, 12108.818367724667, 12358.81461778092, 12439.875601243872, 11160.832587511357, 11323.773524529628, 11341.922517360837, 11705.063594912557, 11918.40407979615, 11047.226694131334, 11260.0, 11329.093672506344, 11422.25755325901, 11429.771404572028, 11062.502187401426, 11069.778604428027, 11143.387113708499, 11237.60668376603, 11659.825102623638, 9350.345475816628, 9448.905510945078, 9628.037196280316, 9711.077447642463, 9759.80480390374, 7891.565963872042, 9319.906800931903, 9674.22606191489, 9882.209423245979, 10036.347637403545], "value": 7001.720819966775, "unit": "score"}], "name": "dromaeo_css", "value": 7653.301759758773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 115.0, 115.0, 116.0, 131.0, 115.0, 119.0, 163.0, 154.0], "value": 125.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 152.0, 173.0, 157.0, 120.0, 157.0, 121.0, 151.0, 151.0, 119.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 195.0, 200.0, 216.0, 233.0, 223.0, 196.0, 195.0, 234.0, 195.0], "value": 208.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 82.0, 141.0, 56.0, 73.0, 88.0, 78.0, 125.0, 62.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 122.0, 76.0, 85.0, 93.0, 114.0, 81.0, 81.0, 120.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 113.0, 85.0, 90.0, 85.0, 89.0, 101.0, 113.0, 132.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 134.0, 151.0, 150.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 108.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 121.0, 144.0, 149.0, 98.0, 84.0, 92.0, 93.0, 97.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 66.0, 65.0, 65.0, 65.0, 66.0, 77.0, 63.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 74.0, 84.0, 103.0, 66.0, 89.0, 59.0, 68.0, 81.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 81.0, 106.0, 104.0, 105.0, 106.0, 84.0, 83.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 149.0, 145.0, 127.0, 123.0, 127.0, 126.0, 131.0, 140.0, 171.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 173.0, 170.0, 167.0, 167.0, 177.0, 163.0, 167.0, 161.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 68.0, 67.0, 68.0, 65.0, 69.0, 69.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1576.5999999999997, "alertThreshold": 2.0}]} 03:43:56 INFO - Return code: 0 03:43:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:56 ERROR - # TBPL SUCCESS # 03:43:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:43:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:43:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:43:56 INFO - 2016-07-16 03:43:56.777 screenresolution[1707:10458] starting screenresolution argv=screenresolution get 03:43:56 INFO - 2016-07-16 03:43:56.780 screenresolution[1707:10458] Display 0: 1600x1200x32@60 03:43:56 INFO - 2016-07-16 03:43:56.786 screenresolution[1708:10461] starting screenresolution argv=screenresolution list 03:43:56 INFO - Available Modes on Display 0 03:43:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:43:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:43:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:43:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:43:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:43:57 INFO - Intel Iris: 03:43:57 INFO - Chipset Model: Intel Iris 03:43:57 INFO - Type: GPU 03:43:57 INFO - Bus: Built-In 03:43:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:43:57 INFO - Vendor: Intel (0x8086) 03:43:57 INFO - Device ID: 0x0a2e 03:43:57 INFO - Revision ID: 0x0009 03:43:57 INFO - Displays: 03:43:57 INFO - Display: 03:43:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:43:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:43:57 INFO - Display Serial Number: 1600x1200 60 03:43:57 INFO - Main Display: Yes 03:43:57 INFO - Mirror: Off 03:43:57 INFO - Online: Yes 03:43:57 INFO - Rotation: Supported 03:43:57 INFO - Return code: 0 03:43:57 INFO - Running post-action listener: _resource_record_post_action 03:43:57 INFO - Running post-run listener: _resource_record_post_run 03:43:58 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 31718912; Write bytes: 495042048; Read time: 197; Write time: 1557 03:43:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193430016; Write bytes: 187209728; Read time: 17518; Write time: 423 03:43:58 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 29937152; Write bytes: 298087936; Read time: 182; Write time: 1105 03:43:58 INFO - Running post-run listener: _upload_blobber_files 03:43:58 INFO - Blob upload gear active. 03:43:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:58 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 03:43:58 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'] 03:43:58 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 03:43:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:59 INFO - (blobuploader) - INFO - Done attempting. 03:43:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:00 INFO - (blobuploader) - INFO - Done attempting. 03:44:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:00 INFO - Return code: 0 03:44:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358b23f232380b048af0764455df70965cae7c102505694201435b8035fdd123f330538327016c04e5782f5567372fc7077836a43bd7f2ee9370f980ac8ffda0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8002fdcc0974d656d89bbc16cf36376af4f02ff4bb2bfb98e042c7a6b5a4d458d92c13d47e68a58e4756e65a9fad4a4b24466e08949eee85752858545606e7fa"} 03:44:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:00 INFO - Contents: 03:44:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358b23f232380b048af0764455df70965cae7c102505694201435b8035fdd123f330538327016c04e5782f5567372fc7077836a43bd7f2ee9370f980ac8ffda0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8002fdcc0974d656d89bbc16cf36376af4f02ff4bb2bfb98e042c7a6b5a4d458d92c13d47e68a58e4756e65a9fad4a4b24466e08949eee85752858545606e7fa"} 03:44:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:00 INFO - Copying logs to upload dir... 03:44:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.320832 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-16 03:44:01.022990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:01.027043) ========= 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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358b23f232380b048af0764455df70965cae7c102505694201435b8035fdd123f330538327016c04e5782f5567372fc7077836a43bd7f2ee9370f980ac8ffda0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8002fdcc0974d656d89bbc16cf36376af4f02ff4bb2bfb98e042c7a6b5a4d458d92c13d47e68a58e4756e65a9fad4a4b24466e08949eee85752858545606e7fa"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011053 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468448997/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358b23f232380b048af0764455df70965cae7c102505694201435b8035fdd123f330538327016c04e5782f5567372fc7077836a43bd7f2ee9370f980ac8ffda0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8002fdcc0974d656d89bbc16cf36376af4f02ff4bb2bfb98e042c7a6b5a4d458d92c13d47e68a58e4756e65a9fad4a4b24466e08949eee85752858545606e7fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:01.060267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:01.060620) ========= 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.IcUaWNaGbL/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.k6OWJXUhsr/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.004984 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:01.109170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:44:01.109482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:44:01.109799) ========= ========= Total master_lag: 0.21 =========