builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0327 starttime: 1488910659.6 results: success (0) buildid: 20170307081025 builduid: e4837e4c6b064e80843b92481f618dce revision: 8718138ada821a31e92f80a7f6d25fa119ff498e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.599081) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.599559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.599843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.628648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.628963) ========= 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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 --2017-03-07 10:17:39-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.5M=0.001s 2017-03-07 10:17:39 (16.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.843697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.844033) ========= 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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.037335 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:39.905936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-07 10:17:39.906318) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8718138ada821a31e92f80a7f6d25fa119ff498e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8718138ada821a31e92f80a7f6d25fa119ff498e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V6tQhqRHk4/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.hT1zRqI7uy/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 2017-03-07 10:17:40,018 truncating revision to first 12 chars 2017-03-07 10:17:40,018 Setting DEBUG logging. 2017-03-07 10:17:40,018 attempt 1/10 2017-03-07 10:17:40,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8718138ada82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-07 10:17:40,974 unpacking tar archive at: mozilla-central-8718138ada82/testing/mozharness/ program finished with exit code 0 elapsedTime=1.241945 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-07 10:17:41.172026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:41.172374) ========= script_repo_revision: 8718138ada821a31e92f80a7f6d25fa119ff498e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:41.172769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:41.173044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 10:17:41.193130) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-07 10:17:41.193424) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V6tQhqRHk4/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.hT1zRqI7uy/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:17:41 INFO - MultiFileLogger online at 20170307 10:17:41 in /builds/slave/test 10:17:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:17:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:41 INFO - {'append_to_log': False, 10:17:41 INFO - 'base_work_dir': '/builds/slave/test', 10:17:41 INFO - 'blob_upload_branch': 'Firefox', 10:17:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:41 INFO - 'branch': 'Firefox', 10:17:41 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:41 INFO - 'config_files': ('talos/mac_config.py',), 10:17:41 INFO - 'default_actions': ('clobber', 10:17:41 INFO - 'read-buildbot-config', 10:17:41 INFO - 'download-and-extract', 10:17:41 INFO - 'populate-webroot', 10:17:41 INFO - 'create-virtualenv', 10:17:41 INFO - 'install', 10:17:41 INFO - 'run-tests'), 10:17:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:41 INFO - 'download_minidump_stackwalk': True, 10:17:41 INFO - 'download_symbols': 'ondemand', 10:17:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:41 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:41 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:41 INFO - 'gecko_profile': False, 10:17:41 INFO - 'gecko_profile_interval': 0, 10:17:41 INFO - 'installer_path': 'installer.exe', 10:17:41 INFO - 'log_level': 'info', 10:17:41 INFO - 'log_name': 'talos', 10:17:41 INFO - 'log_to_console': True, 10:17:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:17:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:17:41 INFO - 'opt_config_files': (), 10:17:41 INFO - 'pip_index': False, 10:17:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:41 INFO - 'cmd': ('bash', 10:17:41 INFO - '-c', 10:17:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:41 INFO - 'enabled': True, 10:17:41 INFO - 'halt_on_failure': False, 10:17:41 INFO - 'name': 'check_screen_resolution'},), 10:17:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:41 INFO - 'cmd': ('bash', 10:17:41 INFO - '-c', 10:17:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:41 INFO - 'enabled': True, 10:17:41 INFO - 'halt_on_failure': False, 10:17:41 INFO - 'name': 'check_screen_resolution'},), 10:17:41 INFO - 'run_cmd_checks_enabled': True, 10:17:41 INFO - 'suite': 'dromaeojs-e10s', 10:17:41 INFO - 'system_bits': '32', 10:17:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:41 INFO - 'title': 't-yosemite-r7-0327', 10:17:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:41 INFO - 'use_talos_json': True, 10:17:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:41 INFO - 'work_dir': 'build'} 10:17:41 INFO - [mozharness: 2017-03-07 18:17:41.411399Z] Running clobber step. 10:17:41 INFO - Running pre-action listener: _resource_record_pre_action 10:17:41 INFO - Running main action method: clobber 10:17:41 INFO - rmtree: /builds/slave/test/build 10:17:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:42 INFO - Running post-action listener: _resource_record_post_action 10:17:42 INFO - [mozharness: 2017-03-07 18:17:42.857428Z] Finished clobber step (success) 10:17:42 INFO - [mozharness: 2017-03-07 18:17:42.857554Z] Running read-buildbot-config step. 10:17:42 INFO - Running pre-action listener: _resource_record_pre_action 10:17:42 INFO - Running main action method: read_buildbot_config 10:17:42 INFO - Using buildbot properties: 10:17:42 INFO - { 10:17:42 INFO - "project": "", 10:17:42 INFO - "product": "firefox", 10:17:42 INFO - "script_repo_revision": "production", 10:17:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:17:42 INFO - "repository": "", 10:17:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:17:42 INFO - "buildid": "20170307081025", 10:17:42 INFO - "pgo_build": "False", 10:17:42 INFO - "basedir": "/builds/slave/test", 10:17:42 INFO - "buildnumber": 75, 10:17:42 INFO - "slavename": "t-yosemite-r7-0327", 10:17:42 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:17:42 INFO - "platform": "yosemite_r7", 10:17:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:17:42 INFO - "branch": "mozilla-central", 10:17:42 INFO - "repo_path": "mozilla-central", 10:17:42 INFO - "revision": "8718138ada821a31e92f80a7f6d25fa119ff498e", 10:17:42 INFO - "stage_platform": "macosx64", 10:17:42 INFO - "builduid": "e4837e4c6b064e80843b92481f618dce", 10:17:42 INFO - "slavebuilddir": "test" 10:17:42 INFO - } 10:17:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:17:42 INFO - Running post-action listener: _resource_record_post_action 10:17:42 INFO - [mozharness: 2017-03-07 18:17:42.860775Z] Finished read-buildbot-config step (success) 10:17:42 INFO - [mozharness: 2017-03-07 18:17:42.860906Z] Running download-and-extract step. 10:17:42 INFO - Running pre-action listener: _resource_record_pre_action 10:17:42 INFO - Running main action method: download_and_extract 10:17:42 INFO - mkdir: /builds/slave/test/build/tests 10:17:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:42 INFO - trying https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:17:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:17:43 INFO - Downloaded 1199 bytes. 10:17:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:17:43 INFO - Using the following test package requirements: 10:17:43 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:17:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:17:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:17:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'jsshell-mac.zip'], 10:17:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:17:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:17:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:17:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:17:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:17:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:17:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:17:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:17:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:17:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:17:43 INFO - Fetch https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:17:45 INFO - Expected file size: 51785419 10:17:45 INFO - Obtained file size: 51785419 10:18:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:18:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:18:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:18:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:18:03 INFO - Expected file size: 51785419 10:18:03 INFO - Obtained file size: 51785419 10:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:18:19 INFO - Expected file size: 14404424 10:18:19 INFO - Obtained file size: 14404424 10:18:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:19 INFO - trying https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:18:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:18:21 INFO - Downloaded 74921991 bytes. 10:18:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:18:21 INFO - mkdir: /builds/slave/test/properties 10:18:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:18:21 INFO - Writing to file /builds/slave/test/properties/build_url 10:18:21 INFO - Contents: 10:18:21 INFO - build_url:https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:18:23 INFO - Running post-action listener: _resource_record_post_action 10:18:23 INFO - Running post-action listener: set_extra_try_arguments 10:18:23 INFO - [mozharness: 2017-03-07 18:18:23.180776Z] Finished download-and-extract step (success) 10:18:23 INFO - [mozharness: 2017-03-07 18:18:23.180928Z] Running populate-webroot step. 10:18:23 INFO - Running pre-action listener: _resource_record_pre_action 10:18:23 INFO - Running main action method: populate_webroot 10:18:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:18:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:18:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:18:23 INFO - '--tppagecycles', 10:18:23 INFO - '7'], 10:18:23 INFO - 'tests': ['tsvgm']}}, 10:18:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:18:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:18:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:18:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:18:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['damp', 'tps']}, 10:18:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'tests': ['damp', 'tps']}, 10:18:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['dromaeo_dom']}, 10:18:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:18:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['basic_compositor_video']}, 10:18:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:18:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['a11yr', 10:18:23 INFO - 'ts_paint', 10:18:23 INFO - 'tpaint', 10:18:23 INFO - 'sessionrestore', 10:18:23 INFO - 'sessionrestore_no_auto_restore', 10:18:23 INFO - 'tabpaint']}, 10:18:23 INFO - 'other-e10s': {'tests': ['a11yr', 10:18:23 INFO - 'ts_paint', 10:18:23 INFO - 'tpaint', 10:18:23 INFO - 'sessionrestore', 10:18:23 INFO - 'sessionrestore_no_auto_restore', 10:18:23 INFO - 'tabpaint']}, 10:18:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:18:23 INFO - 'ts_paint', 10:18:23 INFO - 'tpaint', 10:18:23 INFO - 'sessionrestore', 10:18:23 INFO - 'sessionrestore_no_auto_restore', 10:18:23 INFO - 'tabpaint']}, 10:18:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:18:23 INFO - 'ts_paint', 10:18:23 INFO - 'tpaint', 10:18:23 INFO - 'sessionrestore', 10:18:23 INFO - 'sessionrestore_no_auto_restore', 10:18:23 INFO - 'tabpaint']}, 10:18:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['a11yr', 10:18:23 INFO - 'ts_paint', 10:18:23 INFO - 'tpaint', 10:18:23 INFO - 'sessionrestore', 10:18:23 INFO - 'sessionrestore_no_auto_restore', 10:18:23 INFO - 'tabpaint']}, 10:18:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['a11yr', 10:18:23 INFO - 'ts_paint', 10:18:23 INFO - 'tpaint', 10:18:23 INFO - 'sessionrestore', 10:18:23 INFO - 'sessionrestore_no_auto_restore', 10:18:23 INFO - 'tabpaint']}, 10:18:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['tsvgx', 10:18:23 INFO - 'tsvgr_opacity', 10:18:23 INFO - 'tart', 10:18:23 INFO - 'tscrollx', 10:18:23 INFO - 'cart', 10:18:23 INFO - 'tsvg_static']}, 10:18:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:18:23 INFO - 'tsvgr_opacity', 10:18:23 INFO - 'tart', 10:18:23 INFO - 'tscrollx', 10:18:23 INFO - 'cart', 10:18:23 INFO - 'tsvg_static']}, 10:18:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'talos_options': ['--disable-e10s'], 10:18:23 INFO - 'tests': ['tp5o']}, 10:18:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:18:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'talos_options': ['--disable-e10s', 10:18:23 INFO - '--xperf_path', 10:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:23 INFO - 'tests': ['tp5n']}, 10:18:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:18:23 INFO - 'talos_options': ['--xperf_path', 10:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:23 INFO - 'tests': ['tp5n']}}, 10:18:23 INFO - 'talos.zip': {'path': '', 10:18:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:18:23 INFO - Running post-action listener: _resource_record_post_action 10:18:23 INFO - [mozharness: 2017-03-07 18:18:23.199297Z] Finished populate-webroot step (success) 10:18:23 INFO - [mozharness: 2017-03-07 18:18:23.199413Z] Running create-virtualenv step. 10:18:23 INFO - Running pre-action listener: _resource_record_pre_action 10:18:23 INFO - Running main action method: create_virtualenv 10:18:23 INFO - Creating virtualenv /builds/slave/test/build/venv 10:18:23 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 10:18:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:18:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:18:23 INFO - Using real prefix '/tools/python27' 10:18:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:18:24 INFO - Installing distribute.............................................................................................................................................................................................done. 10:18:26 INFO - Installing pip.................done. 10:18:26 INFO - Return code: 0 10:18:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:18:27 INFO - Reading from file tmpfile_stdout 10:18:27 INFO - Output received: 10:18:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:18:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:27 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 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:27 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 10:18:27 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 10:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:27 INFO - 'HOME': '/Users/cltbld', 10:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:27 INFO - 'LOGNAME': 'cltbld', 10:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:27 INFO - 'MOZ_NO_REMOTE': '1', 10:18:27 INFO - 'NO_EM_RESTART': '1', 10:18:27 INFO - 'PAGER': '/bin/cat', 10:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:27 INFO - 'PWD': '/builds/slave/test', 10:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:27 INFO - 'SHELL': '/bin/bash', 10:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:27 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:27 INFO - 'USER': 'cltbld', 10:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:27 INFO - 'XPC_FLAGS': '0x0', 10:18:27 INFO - 'XPC_SERVICE_NAME': '0', 10:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:27 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 10:18:27 INFO - Cleaning up... 10:18:27 INFO - Return code: 0 10:18:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:18:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:27 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:27 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>=3.1.1'] in /builds/slave/test/build 10:18:27 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>=3.1.1 10:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:27 INFO - 'HOME': '/Users/cltbld', 10:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:27 INFO - 'LOGNAME': 'cltbld', 10:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:27 INFO - 'MOZ_NO_REMOTE': '1', 10:18:27 INFO - 'NO_EM_RESTART': '1', 10:18:27 INFO - 'PAGER': '/bin/cat', 10:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:27 INFO - 'PWD': '/builds/slave/test', 10:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:27 INFO - 'SHELL': '/bin/bash', 10:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:27 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:27 INFO - 'USER': 'cltbld', 10:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:27 INFO - 'XPC_FLAGS': '0x0', 10:18:27 INFO - 'XPC_SERVICE_NAME': '0', 10:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:27 INFO - Downloading/unpacking psutil>=3.1.1 10:18:27 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 10:18:27 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 10:18:27 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 10:18:27 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 10:18:27 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 10:18:27 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 10:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:31 INFO - Installing collected packages: psutil 10:18:31 INFO - Running setup.py install for psutil 10:18:31 INFO - building 'psutil._psutil_osx' extension 10:18:31 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 10:18:31 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 10:18:31 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 10:18:31 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 10:18:32 INFO - building 'psutil._psutil_posix' extension 10:18:32 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 10:18:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:18:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:18:32 INFO - ^ 10:18:32 INFO - 1 warning generated. 10:18:32 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 10:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:32 INFO - Successfully installed psutil 10:18:32 INFO - Cleaning up... 10:18:32 INFO - Return code: 0 10:18:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:18: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 mozsystemmonitor==0.3 10:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:32 INFO - 'HOME': '/Users/cltbld', 10:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:32 INFO - 'LOGNAME': 'cltbld', 10:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:32 INFO - 'MOZ_NO_REMOTE': '1', 10:18:32 INFO - 'NO_EM_RESTART': '1', 10:18:32 INFO - 'PAGER': '/bin/cat', 10:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:32 INFO - 'PWD': '/builds/slave/test', 10:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:32 INFO - 'SHELL': '/bin/bash', 10:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:32 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:32 INFO - 'USER': 'cltbld', 10:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:32 INFO - 'XPC_FLAGS': '0x0', 10:18:32 INFO - 'XPC_SERVICE_NAME': '0', 10:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:18:35 INFO - Installing collected packages: mozsystemmonitor 10:18:35 INFO - Running setup.py install for mozsystemmonitor 10:18:35 INFO - Successfully installed mozsystemmonitor 10:18:35 INFO - Cleaning up... 10:18:35 INFO - Return code: 0 10:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:18:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:18: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 jsonschema==2.5.1 10:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:36 INFO - 'HOME': '/Users/cltbld', 10:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:36 INFO - 'LOGNAME': 'cltbld', 10:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:36 INFO - 'MOZ_NO_REMOTE': '1', 10:18:36 INFO - 'NO_EM_RESTART': '1', 10:18:36 INFO - 'PAGER': '/bin/cat', 10:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:36 INFO - 'PWD': '/builds/slave/test', 10:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:36 INFO - 'SHELL': '/bin/bash', 10:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:36 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:36 INFO - 'USER': 'cltbld', 10:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:36 INFO - 'XPC_FLAGS': '0x0', 10:18:36 INFO - 'XPC_SERVICE_NAME': '0', 10:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:18:36 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 10:18:36 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 10:18:36 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 10:18:36 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 10:18:36 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 10:18:36 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 10:18:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:18:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:18:39 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 10:18:39 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 10:18:39 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 10:18:39 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 10:18:39 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 10:18:39 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 10:18:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:18:39 INFO - warning: no files found matching '*.txt' 10:18:39 INFO - no previously-included directories found matching 'build' 10:18:39 INFO - no previously-included directories found matching 'dist' 10:18:39 INFO - no previously-included directories found matching '.git*' 10:18:39 INFO - Installing collected packages: jsonschema, functools32 10:18:39 INFO - Running setup.py install for functools32 10:18:40 INFO - warning: no files found matching '*.txt' 10:18:40 INFO - no previously-included directories found matching 'build' 10:18:40 INFO - no previously-included directories found matching 'dist' 10:18:40 INFO - no previously-included directories found matching '.git*' 10:18:40 INFO - Successfully installed jsonschema functools32 10:18:40 INFO - Cleaning up... 10:18:40 INFO - Return code: 0 10:18:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:18:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:40 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:40 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:18:40 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 functools32==3.2.3-2 10:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:40 INFO - 'HOME': '/Users/cltbld', 10:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:40 INFO - 'LOGNAME': 'cltbld', 10:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:40 INFO - 'MOZ_NO_REMOTE': '1', 10:18:40 INFO - 'NO_EM_RESTART': '1', 10:18:40 INFO - 'PAGER': '/bin/cat', 10:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:40 INFO - 'PWD': '/builds/slave/test', 10:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:40 INFO - 'SHELL': '/bin/bash', 10:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:40 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:40 INFO - 'USER': 'cltbld', 10:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:40 INFO - 'XPC_FLAGS': '0x0', 10:18:40 INFO - 'XPC_SERVICE_NAME': '0', 10:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:18:40 INFO - Cleaning up... 10:18:40 INFO - Return code: 0 10:18:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:18:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:40 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 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:40 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 10:18:40 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 10:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:40 INFO - 'HOME': '/Users/cltbld', 10:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:40 INFO - 'LOGNAME': 'cltbld', 10:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:40 INFO - 'MOZ_NO_REMOTE': '1', 10:18:40 INFO - 'NO_EM_RESTART': '1', 10:18:40 INFO - 'PAGER': '/bin/cat', 10:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:40 INFO - 'PWD': '/builds/slave/test', 10:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:40 INFO - 'SHELL': '/bin/bash', 10:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:40 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:40 INFO - 'USER': 'cltbld', 10:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:40 INFO - 'XPC_FLAGS': '0x0', 10:18:40 INFO - 'XPC_SERVICE_NAME': '0', 10:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:18:41 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 10:18:41 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 10:18:41 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 10:18:41 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 10:18:41 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 10:18:41 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 10:18:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:18:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:18:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:44 INFO - Downloading docopt-0.6.1.tar.gz 10:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:18:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:18:45 INFO - Running setup.py install for blobuploader 10:18:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:18:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:18:45 INFO - Running setup.py install for requests 10:18:45 INFO - Running setup.py install for docopt 10:18:45 INFO - Successfully installed blobuploader requests docopt 10:18:45 INFO - Cleaning up... 10:18:45 INFO - Return code: 0 10:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:45 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 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:45 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 10:18:45 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 10:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:45 INFO - 'HOME': '/Users/cltbld', 10:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:45 INFO - 'LOGNAME': 'cltbld', 10:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:45 INFO - 'MOZ_NO_REMOTE': '1', 10:18:45 INFO - 'NO_EM_RESTART': '1', 10:18:45 INFO - 'PAGER': '/bin/cat', 10:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:45 INFO - 'PWD': '/builds/slave/test', 10:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:45 INFO - 'SHELL': '/bin/bash', 10:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:45 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:45 INFO - 'USER': 'cltbld', 10:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:45 INFO - 'XPC_FLAGS': '0x0', 10:18:45 INFO - 'XPC_SERVICE_NAME': '0', 10:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-6Y5uKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-6SDCBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-6eitRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-7eXaos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9PkT6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-caY16o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Yw0JbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:46 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-oCCjiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-jpvscf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-xCadTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-5Wzsd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-qfoXAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-cAZ_Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9RC2Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-ucdoxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-nyxtsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-5NeQP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:18:48 INFO - Running setup.py install for manifestparser 10:18:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:18:48 INFO - Running setup.py install for mozcrash 10:18:48 INFO - Running setup.py install for mozdebug 10:18:48 INFO - Running setup.py install for mozdevice 10:18:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:18:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:18:48 INFO - Running setup.py install for mozfile 10:18:48 INFO - Running setup.py install for mozhttpd 10:18:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:18:48 INFO - Running setup.py install for mozinfo 10:18:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Running setup.py install for mozInstall 10:18:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Running setup.py install for mozleak 10:18:49 INFO - Running setup.py install for mozlog 10:18:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Running setup.py install for moznetwork 10:18:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Running setup.py install for mozprocess 10:18:49 INFO - Running setup.py install for mozprofile 10:18:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:18:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:18:50 INFO - Running setup.py install for mozrunner 10:18:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:18:50 INFO - Running setup.py install for mozscreenshot 10:18:50 INFO - Running setup.py install for moztest 10:18:50 INFO - Running setup.py install for mozversion 10:18:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:18:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:18:50 INFO - Cleaning up... 10:18:50 INFO - Return code: 0 10:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:50 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 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:50 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 10:18:50 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 10:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:50 INFO - 'HOME': '/Users/cltbld', 10:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:50 INFO - 'LOGNAME': 'cltbld', 10:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:50 INFO - 'MOZ_NO_REMOTE': '1', 10:18:50 INFO - 'NO_EM_RESTART': '1', 10:18:50 INFO - 'PAGER': '/bin/cat', 10:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:50 INFO - 'PWD': '/builds/slave/test', 10:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:50 INFO - 'SHELL': '/bin/bash', 10:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:50 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:50 INFO - 'USER': 'cltbld', 10:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:50 INFO - 'XPC_FLAGS': '0x0', 10:18:50 INFO - 'XPC_SERVICE_NAME': '0', 10:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:50 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-HeNuAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Ji7z0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-DBYrzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Zjg_JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-MDmeEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Mb3ZtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-yNF4gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-nH4rqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-3i0CWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:51 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9eY9eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 10:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:51 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-QCVSqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:52 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)) 10:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-zwXIMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-rsKRui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:52 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)) 10:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-oZklrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 10:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-XppIL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:52 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)) 10:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-dy8wWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 10:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-ZyxB_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:52 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)) 10:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:18:52 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)) 10:18:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:18:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:18:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:55 INFO - Downloading blessings-1.6.tar.gz 10:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:18:55 INFO - Installing collected packages: blessings 10:18:55 INFO - Running setup.py install for blessings 10:18:55 INFO - Successfully installed blessings 10:18:55 INFO - Cleaning up... 10:18:55 INFO - Return code: 0 10:18:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:55 INFO - Reading from file tmpfile_stdout 10:18:55 INFO - Current package versions: 10:18:55 INFO - blessings == 1.6 10:18:55 INFO - blobuploader == 1.2.4 10:18:55 INFO - docopt == 0.6.1 10:18:55 INFO - functools32 == 3.2.3-2 10:18:55 INFO - jsonschema == 2.5.1 10:18:55 INFO - manifestparser == 1.1 10:18:55 INFO - mozInstall == 1.12 10:18:55 INFO - mozcrash == 1.0 10:18:55 INFO - mozdebug == 0.1 10:18:55 INFO - mozdevice == 0.49 10:18:55 INFO - mozfile == 1.2 10:18:55 INFO - mozhttpd == 0.7 10:18:55 INFO - mozinfo == 0.9 10:18:55 INFO - mozleak == 0.1 10:18:55 INFO - mozlog == 3.4 10:18:55 INFO - moznetwork == 0.27 10:18:55 INFO - mozprocess == 0.25 10:18:55 INFO - mozprofile == 0.28 10:18:55 INFO - mozrunner == 6.13 10:18:55 INFO - mozscreenshot == 0.1 10:18:55 INFO - mozsystemmonitor == 0.3 10:18:55 INFO - moztest == 0.8 10:18:55 INFO - mozversion == 1.4 10:18:55 INFO - psutil == 3.1.1 10:18:55 INFO - requests == 1.2.3 10:18:55 INFO - wsgiref == 0.1.2 10:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:55 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 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:55 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 10:18:55 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 10:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:55 INFO - 'HOME': '/Users/cltbld', 10:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:55 INFO - 'LOGNAME': 'cltbld', 10:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:55 INFO - 'MOZ_NO_REMOTE': '1', 10:18:55 INFO - 'NO_EM_RESTART': '1', 10:18:55 INFO - 'PAGER': '/bin/cat', 10:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:55 INFO - 'PWD': '/builds/slave/test', 10:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:55 INFO - 'SHELL': '/bin/bash', 10:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:55 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:55 INFO - 'USER': 'cltbld', 10:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:55 INFO - 'XPC_FLAGS': '0x0', 10:18:55 INFO - 'XPC_SERVICE_NAME': '0', 10:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 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)) 10:18:56 INFO - Cleaning up... 10:18:56 INFO - Return code: 0 10:18:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:18:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:56 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 0x10e347b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e34a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5cad72f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, '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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 10:18:56 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 10:18:56 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 10:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:56 INFO - 'HOME': '/Users/cltbld', 10:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:56 INFO - 'LOGNAME': 'cltbld', 10:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:56 INFO - 'MOZ_NO_REMOTE': '1', 10:18:56 INFO - 'NO_EM_RESTART': '1', 10:18:56 INFO - 'PAGER': '/bin/cat', 10:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:56 INFO - 'PWD': '/builds/slave/test', 10:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:56 INFO - 'SHELL': '/bin/bash', 10:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:18:56 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:56 INFO - 'USER': 'cltbld', 10:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:56 INFO - 'XPC_FLAGS': '0x0', 10:18:56 INFO - 'XPC_SERVICE_NAME': '0', 10:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:18:56 INFO - Cleaning up... 10:18:56 INFO - Return code: 0 10:18:56 INFO - Running post-action listener: _resource_record_post_action 10:18:56 INFO - Running post-action listener: _start_resource_monitoring 10:18:56 INFO - Starting resource monitoring. 10:18:56 INFO - [mozharness: 2017-03-07 18:18:56.477390Z] Finished create-virtualenv step (success) 10:18:56 INFO - [mozharness: 2017-03-07 18:18:56.478384Z] Running install step. 10:18:56 INFO - Running pre-action listener: _resource_record_pre_action 10:18:56 INFO - Running main action method: install 10:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:56 INFO - Reading from file tmpfile_stdout 10:18:56 INFO - Detecting whether we're running mozinstall >=1.0... 10:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:18:56 INFO - Reading from file tmpfile_stdout 10:18:56 INFO - Output received: 10:18:56 INFO - Usage: mozinstall [options] installer 10:18:56 INFO - Options: 10:18:56 INFO - -h, --help show this help message and exit 10:18:56 INFO - -d DEST, --destination=DEST 10:18:56 INFO - Directory to install application into. [default: 10:18:56 INFO - "/builds/slave/test"] 10:18:56 INFO - --app=APP Application being installed. [default: firefox] 10:18:56 INFO - mkdir: /builds/slave/test/build/application 10:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:19:16 INFO - Reading from file tmpfile_stdout 10:19:16 INFO - Output received: 10:19:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:19:16 INFO - Running post-action listener: _resource_record_post_action 10:19:16 INFO - [mozharness: 2017-03-07 18:19:16.868422Z] Finished install step (success) 10:19:16 INFO - [mozharness: 2017-03-07 18:19:16.868567Z] Running run-tests step. 10:19:16 INFO - Running pre-action listener: _resource_record_pre_action 10:19:16 INFO - Running main action method: run_tests 10:19:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:19:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:19:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:19:16 INFO - 2017-03-07 10:19:16.882 screenresolution[1628:7494] starting screenresolution argv=screenresolution get 10:19:16 INFO - 2017-03-07 10:19:16.884 screenresolution[1628:7494] Display 0: 1600x1200x32@60 10:19:16 INFO - 2017-03-07 10:19:16.890 screenresolution[1629:7496] starting screenresolution argv=screenresolution list 10:19:16 INFO - Available Modes on Display 0 10:19:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:19:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:19:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:19:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:19:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:19:17 INFO - Intel Iris: 10:19:17 INFO - Chipset Model: Intel Iris 10:19:17 INFO - Type: GPU 10:19:17 INFO - Bus: Built-In 10:19:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:19:17 INFO - Vendor: Intel (0x8086) 10:19:17 INFO - Device ID: 0x0a2e 10:19:17 INFO - Revision ID: 0x0009 10:19:17 INFO - Displays: 10:19:17 INFO - Display: 10:19:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:19:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:19:17 INFO - Display Serial Number: 1600x1200 60 10:19:17 INFO - Main Display: Yes 10:19:17 INFO - Mirror: Off 10:19:17 INFO - Online: Yes 10:19:17 INFO - Rotation: Supported 10:19:17 INFO - Return code: 0 10:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:17 INFO - Python 2.7.3 10:19:17 INFO - Return code: 0 10:19:17 INFO - grabbing minidump binary from tooltool 10:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:17 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e125d30>, '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 0x10e04cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:17 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 10:19:17 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 10:19:17 INFO - Calling ['/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'] with output_timeout 600 10:19:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:17 INFO - Return code: 0 10:19:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:17 INFO - ENV: RUST_BACKTRACE is now 1 10:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--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 10:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0327 --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 10:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V6tQhqRHk4/Render', 10:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:17 INFO - 'HOME': '/Users/cltbld', 10:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:17 INFO - 'LOGNAME': 'cltbld', 10:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:17 INFO - 'MOZ_NO_REMOTE': '1', 10:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:17 INFO - 'NO_EM_RESTART': '1', 10:19:17 INFO - 'PAGER': '/bin/cat', 10:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:17 INFO - 'PWD': '/builds/slave/test', 10:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:17 INFO - 'RUST_BACKTRACE': '1', 10:19:17 INFO - 'SHELL': '/bin/bash', 10:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hT1zRqI7uy/Listeners', 10:19:17 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 10:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:17 INFO - 'USER': 'cltbld', 10:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:17 INFO - 'XPC_FLAGS': '0x0', 10:19:17 INFO - 'XPC_SERVICE_NAME': '0', 10:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--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 10:19:17 INFO - mozversion application_buildid: 20170307081025 10:19:17 INFO - mozversion application_changeset: 8718138ada821a31e92f80a7f6d25fa119ff498e 10:19:17 INFO - mozversion application_display_name: Nightly 10:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:17 INFO - mozversion application_name: Firefox 10:19:17 INFO - mozversion application_remotingname: firefox 10:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:19:17 INFO - mozversion application_vendor: Mozilla 10:19:17 INFO - mozversion application_version: 55.0a1 10:19:17 INFO - mozversion platform_buildid: 20170307081025 10:19:17 INFO - mozversion platform_changeset: 8718138ada821a31e92f80a7f6d25fa119ff498e 10:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:19:17 INFO - mozversion platform_version: 55.0a1 10:19:17 INFO - using testdate: 1488910757 10:19:17 INFO - actual date: 1488910757 10:19:17 INFO - starting webserver on 'localhost:49252' 10:19:17 INFO - SUITE-START | Running 2 tests 10:19:17 INFO - TEST-START | dromaeo_css 10:19:17 INFO - operating with platform_type : mac_ 10:19:17 INFO - Initialising browser for dromaeo_css test... 10:19:17 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpV1Wjsm/profile http://localhost:49252/getInfo.html) 10:19:20 INFO - PROCESS | 1639 | 2017-03-07 10:19:20.351 plugin-container[1641:7670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 10:19:20 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:20 INFO - PROCESS | 1639 | 2017-03-07 10:19:20.355 plugin-container[1641:7670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 10:19:20 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:20 INFO - PROCESS | 1639 | 2017-03-07 10:19:20.355 plugin-container[1641:7670] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:19:20 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 10:19:20 INFO - PROCESS | 1639 | colorDepth:24 10:19:20 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 10:19:20 INFO - PROCESS | 1639 | __metrics 10:19:20 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:19:21 INFO - TEST-INFO | 1639: exit 0 10:19:21 INFO - Browser initialized. 10:19:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:21 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpV1Wjsm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:23 INFO - PROCESS | 1642 | 2017-03-07 10:19:23.961 plugin-container[1643:7801] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 10:19:23 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:23 INFO - PROCESS | 1642 | 2017-03-07 10:19:23.962 plugin-container[1643:7801] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 10:19:23 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:23 INFO - PROCESS | 1642 | 2017-03-07 10:19:23.962 plugin-container[1643:7801] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:19:33 INFO - PROCESS | 1642 | RSS: Main: 226889728 10:19:33 INFO - PROCESS | 1642 | 10:22:38 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 10:22:39 INFO - PROCESS | 1642 | RSS: Main: 250793984 10:22:39 INFO - PROCESS | 1642 | 10:24:21 INFO - PROCESS | 1642 | ************************* 10:24:21 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 10:24:21 INFO - PROCESS | 1642 | 10:24:21 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:24:21 INFO - PROCESS | 1642 | Full stack: 10:24:21 INFO - PROCESS | 1642 | ************************* 10:25:41 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 10:25:42 INFO - PROCESS | 1642 | RSS: Main: 258785280 10:25:42 INFO - PROCESS | 1642 | 10:28:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 10:28:45 INFO - PROCESS | 1642 | RSS: Main: 269881344 10:28:45 INFO - PROCESS | 1642 | 10:31:47 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 10:31:47 INFO - PROCESS | 1642 | RSS: Main: 262111232 10:31:47 INFO - PROCESS | 1642 | 10:34:50 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 10:34:51 INFO - PROCESS | 1642 | RSS: Main: 272994304 10:34:51 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 10:37:54 INFO - PROCESS | 1642 | RSS: Main: 267005952 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | __start_tp_report 10:37:54 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 10:37:54 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 10:37:54 INFO - PROCESS | 1642 | |i|pagename|runs| 10:37:54 INFO - PROCESS | 1642 | |0;dojo.html;3458.3947809133397;3474.044637724626;3482.1642805726624;3484.268303656232;3532.8056956867376;5766.82699519014;5927.762889484421;5958.076498142789;5998.040313549833;6050.515958723303;5844.26946631671;5920.822375328747;5986.371430999748;6091.482224010964;6091.969540152293;5390.973045134769;5422.024035673587;5434.864128396782;5466.863328416802;5512.39363669996;5299.443558426367;5378.2470454136455;5479.643823151482;5503.954248692756;5557.6109672322955;5229.477052294778;5253.50091741284;5336.146216605363;5453.890922181574;5456.781728730846;5320.893582128375;5326.6537675050995;5378.354597448331;5493.148561972901;5498.202760599731;5334.22653715213;5336.1195402758885;5386.353637563518;5409.24270602116;5415.377231618375;5287.576993840484;5326.536606249478;6102.572819902609;6127.9837278401355;6132.785352512686;6214.968925155391;6251.937480625181;6274.964630835907;6290.937090629081;6300.275468321156;6442.903356449657;6457.16056912603;6458.870822583569;6495.188101487314;6505.6421896795655;6133.233345831771;6159.291681456601;6161.6611086389785;6171.321154672983;6191.288001879797;6241.687915604201;6304.968475157595;6355.713992870332;6418.967905160444;6564.081028655992;6150.569460137837;6189.226346706661;6216.502679785606;6266.248050234001;6342.4926005919415;6381.234251889803;6395.072714456378;6404.071409645575;6411.935880641227;6450.838729031718;5603.327600687862;5913;6332.335104813928;6337.683115844189;6362.204724409449;5409.486098820606;6243.37566243372;6257.2491301044165;6266.404691554295;6332.905006424908;5141.922871156936;5148.588112950955;5153.201253805666;5154.561862241751;5193.246979187997;4572.3827283317;4589.2198326284615;4607.124646317256;4620.491745907947;4647.140279048387;5859.355470898197;5948.434898684618;5994.820155395258;6083.330833608299;6163.044728067157;6190.380961903774;6261.843453913598;6331.778387756406;6385.776497822554;6390.648514331757;6094.421030002142;6112.663803490851;6140.662263575547;6147.66187859663;6164.845878852975;5629.380768115504;5685.061964775766;5687.289088863892;5688.601797874109;5690.630109042899;6314.179156709598;6381.074744162163;6488.286288508355;6509.511786616117;6595.637239951849;5633.774649013993;6362.383106638605;6389.8722025560155;6393.840153996187;6411.743530258737;6505.772297969548;6550.213974323112;6596.538242322991;6613.817440244611;6646.933530664632;5136.30659860914;6145.463634091477;6203.4416902479;6273.278572964167;6312.2740884796995;4935.605151587936;6134.9079763804475;6370.076338930737;6392.456641185551;6441.806745797634;6131.713108457195;6178.783742568989;6222.066689996536;6257.124002639725;6286.15136956505;6197.938020619736;6207.131001659681;6241.31345551998;6287.025511045612;6294.968525157345;6055.848603784941;6114.419130182626;6124.930239974474;6140.596275277727;6214.720337584729;6237.688115594293;6248.5313601479165;6277.529185311211;6293.181886354744;6294.842628934313;6175.382461753788;6219.440250377488;6240.032794916795;6247.875042499034;6255.31191568918 10:37:54 INFO - PROCESS | 1642 | |1;ext.html;736.896834443178;790.5059337913804;815.2703330519188;941.7975135345899;943.985840212397;37052.07369815756;37502.43746343807;39179.02052448686;39231.21537569247;39314;38212.42681359782;38294.8085259574;38373.808130959376;38377.27302271398;38390.61609383905;7821.921780782191;7959.482633628824;10526.263161578692;10865.619703310385;11001.724956876102;10562.524686389132;10628.78742425151;10671.253012289104;10688.786224275509;10692.625758098467;8968.699538566936;10715;10716.446115313274;10762.97751713586;10776.676699698983;10650.988156125155;10662.946685266563;10689.144868410509;10719.249652524326;10719.517621707002;10539.262251642389;10621.203409744223;10628.627998020109;10652.094571961392;10672.679819605424;33089.33821323584;33264.501032484535;33402.83298583516;33433;33486.49770253448;3585.731070169748;3613.5663720353728;3624.873129440457;3673.669369756735;3771.9811400943095;22962.39263251573;24633.753662463325;24690;24878;24878.5024299513;2625.186192280399;3068.938621227563;3125.6092988376454;3133.9529907051415;3189.1867573768773;331018;331197;332268;332280;333779;37760.62239377571;43836.46572369952;43952;44114.338284925754;44216;44911;44948;44970.550294496636;45073.87315317144;45093.29440233597;12689.682757931125;12783.16909400886;12783.296918669377;12807;12817.974562035015;9173.724788256362;9655.22758179358;10707;10789.028987391173;10931.781364372668;9615.326927115175;10245.590176392861;11533.711657208469;11540.307581544967;11668.416579171007;5607.214989901417;5632.40909181781;5717.8570535736935;5739.913901291484;5761.625494342854;1100.8844071372391;1139.3619573039125;1148.1847887999447;1154;1195.8146487294484;24022.243371584722;24210.394740131287;25351.746482534938;26846.16260589273;27201.31996700059;1055.7044027672264;1220.5544976083665;1224.7183147876037;1274.7195616964252;1280.5198050730976;11335.773284534263;12275.324857132764;13492.5277615283;13924.30378481072;14015.929920350536;415719;416090;419016.8098319039;420003;421861;56465.43534564684;56949.43050569524;56950;56971.43028569661;57269;1229.9139060265695;1372.9428340178008;1419.9077059991068;1420;1421.289355322339;21053.736775793503;26432.471350573265;30300.5454918172;30543.847280763453;30729.846350768104;34672;45795.85510362268;48028.5197148024;48102.27846582234;48398;440329;441747;441968;443445;444555;29226.123216303546;29257.82968681229;29308.267293317836;29329.85335073311;29365;37678.62321376861;37828;38090;38361.61638383692;38971.22057558889;31117.222069448446;31627.683723162474;31796.36407271888;32579.34841303208;33034.17414564655;32403;32914.5062824053;33625;34776;34880;32809;33254.66745332516;33266.50300736521;33551.993440196835;34285.14287142841;27721.722782771914;29571.85214073916;29655.703442965296;29952.25119372033;30271.848640756656;20841.478963026046;22345.888270559193;22851.08595656155;22947.361053479064;23383 10:37:54 INFO - PROCESS | 1642 | |2;jquery.html;385.46997877917863;389.9395593682978;394.52262762057916;410.2881500596465;439.0034621409401;19211.42365729027;20242.696359554582;20400.591988160228;20579.588408231826;20663.276785312497;19358.806411935875;19536.609267814634;20357.185712571478;20888.895555522202;21029.474263143427;6120.112583675354;6192.690365481731;6518.250401203851;6519.576227545194;6523.151990241262;5447.237386765856;5500.7524661390335;6266.968665156668;6380.521460890452;6425.100485931974;6479.708413121397;6480.9675951620175;6487.837804054912;6498.122753428298;6507.121538592301;6156.230471191101;6412.743490260384;6427.614343139403;6460.515461340418;6495.090687303781;5925.585209035369;6270.435660790505;6287.52843536732;6295.968520157416;6339.7320535893;24221.51556968851;24561.38596535083;24609.753902460925;24867.5026499469;24934.875325623438;2773.7656742749487;2790.902318418866;2831.7593004594632;2838.9290267743263;2842.928926776847;13484.460621575125;15716.607084822857;15767.290471928676;15978.680426391524;16510.917445412815;2041.1631231195288;2059.6807494838176;2085.8122768950866;2215.3021798133536;2246.9213577524706;154697;161983;163818.18090909588;165744;165937;20124.698129528068;20201.898990504953;20209.696854547194;20330.288439904532;20358.592828143355;29823.850880745456;29841.701582983893;29848.40303193924;30005.899587029136;30153.492325383642;9576.425414475154;9691.70924872255;9849.26130540198;9860.112589866947;9988.300818942604;8095.473794203475;8126.878096828552;8127.1466496017065;8267.710630127916;8275.420720549624;9157.81684366309;9201.309901757395;9289.396189247676;9303.209227215762;9324.347295689236;3929.9760623279035;3999.5400528938962;4014.879553613396;4024.4566983457444;4025.2754504188943;655.8327626455224;785.654312102673;795.8129839487716;877.1929824561419;885.9601317940708;20511.28210512655;21099.78900210978;21126.683099753514;21154.576908461746;21353.25263615766;894.7628878347243;900.9504477253682;931.1573026411108;932.8507438809758;934.458014351688;9985.450800205914;10833.404162770965;10987.285826421417;11000.889991100146;11038.448077596087;645588;651394;671163;682990;684747.5762621255;119264;142508.57491424953;151173;152237;159435;1139.3710593912872;1182.1665725663386;1229.065909908476;1229.287013532167;1230.6062060140669;16643.75034374461;18819.717704234172;18957.90521047386;19142;19220.903895480435;58456.70771646115;60778;60899;61034.4741381469;61463;82373;82460.58769706353;83555;83865;84966.57516712624;10948.34309941406;10960.671179864617;10974.780504389708;11286.717832054264;11404.429778511207;12406.8833804958;12438.253704777742;12608.87391126077;12726.363681816058;12827.615171544869;10577.894221057692;10676;10842.457877106272;10867.945660271647;10977.780444391226;11225.270357426742;11246.325220486797;11502.88497115018;11563.132765042823;11770.3526306054;9919.603215871284;11334.716632084264;11631.941840290745;11707.473163707824;11887.16789824704;10327.431991240554;10724.678259652223;11154.665360039211;11736.823947640622;11859.229150105215;11206.99137077667;11275.32348059119;11400.486978086172;11515.654530364103;11553.480093395985 10:37:54 INFO - PROCESS | 1642 | |3;mootools.html;1494.768310911809;1500.6323450754567;1544.1738669811646;1550.100941453957;1563.8905276630637;9177.219936305406;9458.716238512856;10314.845277320837;10943.781124377507;11016.339019658815;8691.56542172892;10112.949435252833;10523.84214236787;10547.1562275018;10557.260991730582;2272;2323.907043718249;2344.1443872986324;2347.788699017088;2356.7643235676383;2293;2311.341267738695;2324.430514523944;2331.055922351442;2339.0526836631107;2299.9195028174017;2317.142657216824;2325.813934885205;2328.1851352026824;2332.242021343062;2272.602294598455;2284.6230371988604;2289.381866895945;2297.173017713622;2301.3326135420707;2243.7868402501736;2311.075569772088;2319.605667036591;2321.651752237161;2326.127702111708;10406;10469;10491.370517768959;10501.159907207406;10529.052385285284;5634.408387119334;5697.259356283698;5763.106718458645;5771.971140144315;5772.509336706343;3035.8482075896336;3352.430086885235;3440.954755041781;3604.963950360489;3663.157473781019;1123.8876112388778;1135.8239472881717;1785.1431312969717;1811.7916439609482;1900.6293772714325;14305.28473576317;14615.70768584633;14788.038777479429;14930.925345373204;14940.252987350697;4370.584794444522;4590.403247577793;4803.855884323476;4982.302477653131;5000.574951129122;12469.625911222678;12492.312922789333;12505.749885002431;12539.184952978027;12550.497980080878;5839.328477225088;5861.325947516005;5917.349091599921;5948.821535353946;5950.553708471795;4431.7562534060935;4563.657725670521;5009.699418034929;5147.176451767774;5226.608004399685;3896.6687831534637;4012.378081397388;4069.674426045909;4077.1845630873945;4150.107726838744;875.4834647557972;974.4543055888724;1101.6639924822846;1112.1047556716921;1156.8611766587894;777.872085476062;827.6813426830594;918.2369849888097;924.6024209589941;937.7093101138532;5285.471452854684;6328.430441260309;6510.576812507172;6645.235797883305;6725.092112564839;850.2475309351145;925.7825958864072;964.4117088575963;989.7327721515295;1039.29328056922;3512.4906888501023;4118.608732170439;4124.216398884262;4196.181744559782;4268.189044081614;12799.616011519669;13229;13237.867621323663;13239.933800330937;13245.536406225929;10953;12582;13112.213267203999;13202.273874936778;13211.273379964003;9596.376235544667;9862.112409883002;9870;9901;10042.447665378475;6022.638641681513;6417.582857114273;6588.242352129375;6702.463802895659;6740.191177058784;11745.354005529778;11906.166568340133;11954.760904781682;12072.939635301767;12085.516579336729;9904.405735655884;11809.881901181221;12143.574974875837;12149.453274602487;12155.696107597381;7950.40371972116;8136.471129376571;8814.779630509289;8893.333000024895;9038.954805225932;10031.849522257318;10066.798664026532;10127.493625318852;10141.695749127539;10219.1824654026;6641.302663220486;8197.959010204911;8247.876281855897;8253.09215986253;8317.376196785144;8040.758777236692;8161.347092232726;8292.212239837207;8340.457870238415;8389.244967952913;7449.366803821736;7486.588237646763;7576.886346704914;7578.052743407075;7598.354139898171;5645.830625081254;5766;5776.480116789509;5789.913151302818;5859.5019423349495;5721.971390143022;5800.1299805029585;5843;5844.444777746107;5865.061590145556 10:37:54 INFO - PROCESS | 1642 | |4;prototype.html;367.94848721179056;368.53564508719006;370.616412013566;371.4391269183533;380.22244509977094;5129.589632829374;5147.459516750739;5189.0725880948885;5197.180072646611;5198.8546929107915;4430.645548356132;4435.866923992277;5165.948340516594;5203.19350500672;5210.296609957654;4134.52452967908;4304.418903448026;4333.393324934512;4345.913081738363;4349.304111342186;3912.3544615138467;4078.2659121358142;4352.238358287303;4380.912381752363;4382.9342559861625;3730.048837546422;4024.436578878959;4048.6761059115347;4205.4112424260475;4356.213952279566;3722.702183825301;4191.497814858977;4211.620954114144;4240.197915885737;4352.52122266552;3156.542301366289;3817.1220619257447;3926.9566086283357;3930.64624183822;3952.3676211805973;4195.552534375635;4619.076184763027;5120.795168193268;5137.717425541594;5141.871453213662;4500.504944456107;4519.954800451987;4598.321612611407;5051.393832740058;5064.139096353629;4819.373481447389;5355.839324820262;5576.7211639417865;5578.776848926038;5623.746931388097;4092.874459523655;4288.142371525707;4436.648576254558;4461.107778444324;4484;5007.973365460109;5525.944740552583;5874.412558744091;5950.642961422329;5968.253968253968;3583.5341405617105;3794.9317621896134;3861.2663593917064;3906.980465097713;4010.9197816044098;3976.1312183273817;4271.337942618899;4597.517260687647;4600.263957766741;4624.421947256593;4555;4790.904181916412;4964.280179373971;4997.450280469146;5086.364204474441;4934.506549345037;5021.673591216632;5050.545450909436;5129.33296678581;5513.61404701667;1498;1510.323540869634;1572.6147093962052;1574.842515748416;1588.4440445843861;962.9022913878184;1128.9887101128884;1153.98269025963;1189.6140995739866;1192.9919218260557;4453.682006904876;4912.25614906703;4927.187014142626;4975.701457912537;5257.631965762436;5044.369453818273;5114.181730923035;5294.655847369909;5345.091334473149;5758.827235182867;4488.663350248679;4934.605231581465;5190.558802501754;5203.739813009334;5234.4296710986555;2652.429727608535;2744.4511097780523;2910.5488649258973;2981.4484320400798;2996.5916019470815;5380;5656.490915817596;5999.430054144849;6013.488853447506;6015.007523758618;4914.582260507826;5530.253415788898;5564.860878478071;5785.4214578541805;5853.88292234153;5070.569001634903;5368.91946620801;5425.810096646598;5886.882262354643;6031.246094238308;5075.92386114216;5376;5747.10345585964;5802.622829516068;5846.766129354778;4676.532346765296;4783.6651434399255;5143.742812859267;5575;5762.300121464262;5017.122003649274;5019.924701129559;5096.617753668564;5155.613329000265;5769.307683078057;4140.509416609958;4422.513523512475;5053.231369020813;5071.416787069535;5076.7207803571155;5388.515033646991;5676.886462270814;5734.971325143348;5754.798582049608;5804.332501762183;5070.873228169326;5108.744562771921;5394.514493695429;5527.44725527444;5542;5293.417724050429;5538.6122971391615;5567.832965011056;5588.972055139699;5636.408177141341;5336.412994570672;5398.246894084124;5403.5136837684795;5443.700596467233;5461.972690136524;4967.180415231591;5380.704061276668;5534.640248384003;5650.717464126859;5673.489385955284;4459.241928872035;4509.797059132413;4970.577500912463;5055.646104772631;5410.918836217381 10:37:54 INFO - PROCESS | 1642 | |5;yui.html;638.2086213095763;751.5490705576651;768.6233745464721;820.7168526858234;836.147129927474;13165.539206127787;15509.922450387747;16178.029318240884;16315.939463934836;16321.591960201002;14391.78412323816;15344.156071416068;15388.69222615547;15403.614909627266;15429.691406171869;913.155331318531;950.9429434233933;950.9572069256866;951.9381240219363;954.575214029757;797.7327595255597;910.9635614575409;940.7224868663726;943.79708362702;944.6788092048702;989.8812142542869;990.6582229130938;991.9156871665917;992.0823238504355;994.5226291380142;986.2208855004537;986.57577241786;987.3236832769576;988.8714467119264;989.8614194012844;728.9453291003196;733.9045924029842;734.5739471106746;735.7535225699397;736.1387177002866;15937.681246375008;16311;16362.509124726277;16685.83314166855;16985.3205871765;13249.337533123306;13526.797098043537;14041.1575305482;14111.223882686449;14116.011879168462;11540.596079137275;11738.70653233676;11804.796630039531;11816.113791465674;12178.208416452992;3597.2625611749527;3633.3823250047553;3642.3261696586214;3669.3578623740736;3723.7951912644794;110434.44782776115;111612;116078;116640;117541.8245817548;10835.51240194193;10852.782944341068;10876.456177191267;10903.236773425784;11441.313521188755;18846.623067538847;22590.435239118826;22847.200347987742;23099;23137;7340.70637174507;7424.183339832722;7468.701251949861;7587.355074818703;7675.53946763196;4211.4525111735275;4253.170631726845;4262.403263543107;4300.182965236595;4301.612854843079;3192.776505644629;3470.305938812248;3473.6873681368797;3480.5127282180515;3482.21650128719;591.2284468768298;593.3413910559276;594.8988671925783;597.0596310810491;608.9543284253699;642.9292777794439;664.5846346033729;675.4697562413481;683.3542302524068;698.5878331784272;9894;10155.238357123246;10183.54174062169;10228.232882533839;10344.32761870476;678.3182901184279;682.8792418646835;691.1188235000415;694.989575156373;703.7783098324114;4362.781860906942;4653.534646535387;4737.3130896020575;5020.874478138076;5024.949750502521;96557.5516367255;99541;99892;100322;101705.49147254364;83635;84853;86142;86930.56534717412;87883.56058219667;76279.23720762832;77500;77916;78674;79495.60252198702;7833.196650016334;9360.15758581731;9756.560954756911;9799.951000244953;9865.91474937742;39205.607943921335;51052.74473627608;51598.74200628973;51683;52156.73921630368;62676;63538.68230658817;64018.719625606296;65248;65496;8155.918440815516;11234.258689903078;11359.943200283946;11405.771884562428;11890.464929078385;12905.870941290466;12995.935020324838;13029.804552931524;13039.413226405024;13099.803502947272;11715.481171548267;11937.701557460785;11956;12027.338496382783;12080.736564977507;11780.646580602595;11969.64091077269;12071.336076515876;12186.451609677762;12576.685582860136;11766.764664706487;11847.822282665595;11886.227395219283;12263.816042759545;12406.131570789958;9815.58448022703;10145.442000690033;10332.431716255678;10421.739456513647;10815.459227038775;8941.837561117014;8971;10029.29794914349;10048.296619236584;10099.899001009895 10:37:54 INFO - PROCESS | 1642 | __end_tp_report 10:37:54 INFO - PROCESS | 1642 | __start_cc_report 10:37:54 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,425 10:37:54 INFO - PROCESS | 1642 | __end_cc_report 10:37:54 INFO - PROCESS | 1642 | __startTimestamp1488911874618__endTimestamp 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | ------- Summary: start ------- 10:37:54 INFO - PROCESS | 1642 | Number of tests: 6 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5899.66 Median:6150.57 stddev:637.79 (10.4%) stddev-sans-first:610.32 10:37:54 INFO - PROCESS | 1642 | Values: 3458.4 3474.0 3482.2 3484.3 3532.8 5766.8 5927.8 5958.1 5998.0 6050.5 5844.3 5920.8 5986.4 6091.5 6092.0 5391.0 5422.0 5434.9 5466.9 5512.4 5299.4 5378.2 5479.6 5504.0 5557.6 5229.5 5253.5 5336.1 5453.9 5456.8 5320.9 5326.7 5378.4 5493.1 5498.2 5334.2 5336.1 5386.4 5409.2 5415.4 5287.6 5326.5 6102.6 6128.0 6132.8 6215.0 6251.9 6275.0 6290.9 6300.3 6442.9 6457.2 6458.9 6495.2 6505.6 6133.2 6159.3 6161.7 6171.3 6191.3 6241.7 6305.0 6355.7 6419.0 6564.1 6150.6 6189.2 6216.5 6266.2 6342.5 6381.2 6395.1 6404.1 6411.9 6450.8 5603.3 5913.0 6332.3 6337.7 6362.2 5409.5 6243.4 6257.2 6266.4 6332.9 5141.9 5148.6 5153.2 5154.6 5193.2 4572.4 4589.2 4607.1 4620.5 4647.1 5859.4 5948.4 5994.8 6083.3 6163.0 6190.4 6261.8 6331.8 6385.8 6390.6 6094.4 6112.7 6140.7 6147.7 6164.8 5629.4 5685.1 5687.3 5688.6 5690.6 6314.2 6381.1 6488.3 6509.5 6595.6 5633.8 6362.4 6389.9 6393.8 6411.7 6505.8 6550.2 6596.5 6613.8 6646.9 5136.3 6145.5 6203.4 6273.3 6312.3 4935.6 6134.9 6370.1 6392.5 6441.8 6131.7 6178.8 6222.1 6257.1 6286.2 6197.9 6207.1 6241.3 6287.0 6295.0 6055.8 6114.4 6124.9 6140.6 6214.7 6237.7 6248.5 6277.5 6293.2 6294.8 6175.4 6219.4 6240.0 6247.9 6255.3 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:52919.06 Median:17492.78 stddev:106200.92 (607.1%) stddev-sans-first:106426.57 10:37:54 INFO - PROCESS | 1642 | Values: 736.9 790.5 815.3 941.8 944.0 37052.1 37502.4 39179.0 39231.2 39314.0 38212.4 38294.8 38373.8 38377.3 38390.6 7821.9 7959.5 10526.3 10865.6 11001.7 10562.5 10628.8 10671.3 10688.8 10692.6 8968.7 10715.0 10716.4 10763.0 10776.7 10651.0 10662.9 10689.1 10719.2 10719.5 10539.3 10621.2 10628.6 10652.1 10672.7 33089.3 33264.5 33402.8 33433.0 33486.5 3585.7 3613.6 3624.9 3673.7 3772.0 22962.4 24633.8 24690.0 24878.0 24878.5 2625.2 3068.9 3125.6 3134.0 3189.2 331018.0 331197.0 332268.0 332280.0 333779.0 37760.6 43836.5 43952.0 44114.3 44216.0 44911.0 44948.0 44970.6 45073.9 45093.3 12689.7 12783.2 12783.3 12807.0 12818.0 9173.7 9655.2 10707.0 10789.0 10931.8 9615.3 10245.6 11533.7 11540.3 11668.4 5607.2 5632.4 5717.9 5739.9 5761.6 1100.9 1139.4 1148.2 1154.0 1195.8 24022.2 24210.4 25351.7 26846.2 27201.3 1055.7 1220.6 1224.7 1274.7 1280.5 11335.8 12275.3 13492.5 13924.3 14015.9 415719.0 416090.0 419016.8 420003.0 421861.0 56465.4 56949.4 56950.0 56971.4 57269.0 1229.9 1372.9 1419.9 1420.0 1421.3 21053.7 26432.5 30300.5 30543.8 30729.8 34672.0 45795.9 48028.5 48102.3 48398.0 440329.0 441747.0 441968.0 443445.0 444555.0 29226.1 29257.8 29308.3 29329.9 29365.0 37678.6 37828.0 38090.0 38361.6 38971.2 31117.2 31627.7 31796.4 32579.3 33034.2 32403.0 32914.5 33625.0 34776.0 34880.0 32809.0 33254.7 33266.5 33552.0 34285.1 27721.7 29571.9 29655.7 29952.3 30271.8 20841.5 22345.9 22851.1 22947.4 23383.0 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40289.97 Median:24738.63 stddev:112170.17 (453.4%) stddev-sans-first:112444.82 10:37:54 INFO - PROCESS | 1642 | Values: 385.5 389.9 394.5 410.3 439.0 19211.4 20242.7 20400.6 20579.6 20663.3 19358.8 19536.6 20357.2 20888.9 21029.5 6120.1 6192.7 6518.3 6519.6 6523.2 5447.2 5500.8 6267.0 6380.5 6425.1 6479.7 6481.0 6487.8 6498.1 6507.1 6156.2 6412.7 6427.6 6460.5 6495.1 5925.6 6270.4 6287.5 6296.0 6339.7 24221.5 24561.4 24609.8 24867.5 24934.9 2773.8 2790.9 2831.8 2838.9 2842.9 13484.5 15716.6 15767.3 15978.7 16510.9 2041.2 2059.7 2085.8 2215.3 2246.9 154697.0 161983.0 163818.2 165744.0 165937.0 20124.7 20201.9 20209.7 20330.3 20358.6 29823.9 29841.7 29848.4 30005.9 30153.5 9576.4 9691.7 9849.3 9860.1 9988.3 8095.5 8126.9 8127.1 8267.7 8275.4 9157.8 9201.3 9289.4 9303.2 9324.3 3930.0 3999.5 4014.9 4024.5 4025.3 655.8 785.7 795.8 877.2 886.0 20511.3 21099.8 21126.7 21154.6 21353.3 894.8 901.0 931.2 932.9 934.5 9985.5 10833.4 10987.3 11000.9 11038.4 645588.0 651394.0 671163.0 682990.0 684747.6 119264.0 142508.6 151173.0 152237.0 159435.0 1139.4 1182.2 1229.1 1229.3 1230.6 16643.8 18819.7 18957.9 19142.0 19220.9 58456.7 60778.0 60899.0 61034.5 61463.0 82373.0 82460.6 83555.0 83865.0 84966.6 10948.3 10960.7 10974.8 11286.7 11404.4 12406.9 12438.3 12608.9 12726.4 12827.6 10577.9 10676.0 10842.5 10867.9 10977.8 11225.3 11246.3 11502.9 11563.1 11770.4 9919.6 11334.7 11631.9 11707.5 11887.2 10327.4 10724.7 11154.7 11736.8 11859.2 11207.0 11275.3 11400.5 11515.7 11553.5 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6506.49 Median:3634.06 stddev:4027.62 (110.8%) stddev-sans-first:4021.31 10:37:54 INFO - PROCESS | 1642 | Values: 1494.8 1500.6 1544.2 1550.1 1563.9 9177.2 9458.7 10314.8 10943.8 11016.3 8691.6 10112.9 10523.8 10547.2 10557.3 2272.0 2323.9 2344.1 2347.8 2356.8 2293.0 2311.3 2324.4 2331.1 2339.1 2299.9 2317.1 2325.8 2328.2 2332.2 2272.6 2284.6 2289.4 2297.2 2301.3 2243.8 2311.1 2319.6 2321.7 2326.1 10406.0 10469.0 10491.4 10501.2 10529.1 5634.4 5697.3 5763.1 5772.0 5772.5 3035.8 3352.4 3441.0 3605.0 3663.2 1123.9 1135.8 1785.1 1811.8 1900.6 14305.3 14615.7 14788.0 14930.9 14940.3 4370.6 4590.4 4803.9 4982.3 5000.6 12469.6 12492.3 12505.7 12539.2 12550.5 5839.3 5861.3 5917.3 5948.8 5950.6 4431.8 4563.7 5009.7 5147.2 5226.6 3896.7 4012.4 4069.7 4077.2 4150.1 875.5 974.5 1101.7 1112.1 1156.9 777.9 827.7 918.2 924.6 937.7 5285.5 6328.4 6510.6 6645.2 6725.1 850.2 925.8 964.4 989.7 1039.3 3512.5 4118.6 4124.2 4196.2 4268.2 12799.6 13229.0 13237.9 13239.9 13245.5 10953.0 12582.0 13112.2 13202.3 13211.3 9596.4 9862.1 9870.0 9901.0 10042.4 6022.6 6417.6 6588.2 6702.5 6740.2 11745.4 11906.2 11954.8 12072.9 12085.5 9904.4 11809.9 12143.6 12149.5 12155.7 7950.4 8136.5 8814.8 8893.3 9039.0 10031.8 10066.8 10127.5 10141.7 10219.2 6641.3 8198.0 8247.9 8253.1 8317.4 8040.8 8161.3 8292.2 8340.5 8389.2 7449.4 7486.6 7576.9 7578.1 7598.4 5645.8 5766.0 5776.5 5789.9 5859.5 5722.0 5800.1 5843.0 5844.4 5865.1 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4578.12 Median:5033.02 stddev:1283.64 (25.5%) stddev-sans-first:1247.74 10:37:54 INFO - PROCESS | 1642 | Values: 367.9 368.5 370.6 371.4 380.2 5129.6 5147.5 5189.1 5197.2 5198.9 4430.6 4435.9 5165.9 5203.2 5210.3 4134.5 4304.4 4333.4 4345.9 4349.3 3912.4 4078.3 4352.2 4380.9 4382.9 3730.0 4024.4 4048.7 4205.4 4356.2 3722.7 4191.5 4211.6 4240.2 4352.5 3156.5 3817.1 3927.0 3930.6 3952.4 4195.6 4619.1 5120.8 5137.7 5141.9 4500.5 4520.0 4598.3 5051.4 5064.1 4819.4 5355.8 5576.7 5578.8 5623.7 4092.9 4288.1 4436.6 4461.1 4484.0 5008.0 5525.9 5874.4 5950.6 5968.3 3583.5 3794.9 3861.3 3907.0 4010.9 3976.1 4271.3 4597.5 4600.3 4624.4 4555.0 4790.9 4964.3 4997.5 5086.4 4934.5 5021.7 5050.5 5129.3 5513.6 1498.0 1510.3 1572.6 1574.8 1588.4 962.9 1129.0 1154.0 1189.6 1193.0 4453.7 4912.3 4927.2 4975.7 5257.6 5044.4 5114.2 5294.7 5345.1 5758.8 4488.7 4934.6 5190.6 5203.7 5234.4 2652.4 2744.5 2910.5 2981.4 2996.6 5380.0 5656.5 5999.4 6013.5 6015.0 4914.6 5530.3 5564.9 5785.4 5853.9 5070.6 5368.9 5425.8 5886.9 6031.2 5075.9 5376.0 5747.1 5802.6 5846.8 4676.5 4783.7 5143.7 5575.0 5762.3 5017.1 5019.9 5096.6 5155.6 5769.3 4140.5 4422.5 5053.2 5071.4 5076.7 5388.5 5676.9 5735.0 5754.8 5804.3 5070.9 5108.7 5394.5 5527.4 5542.0 5293.4 5538.6 5567.8 5589.0 5636.4 5336.4 5398.2 5403.5 5443.7 5462.0 4967.2 5380.7 5534.6 5650.7 5673.5 4459.2 4509.8 4970.6 5055.6 5410.9 10:37:54 INFO - PROCESS | 1642 | 10:37:54 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20203.65 Median:4281.29 stddev:29562.44 (690.5%) stddev-sans-first:29608.86 10:37:54 INFO - PROCESS | 1642 | Values: 638.2 751.5 768.6 820.7 836.1 13165.5 15509.9 16178.0 16315.9 16321.6 14391.8 15344.2 15388.7 15403.6 15429.7 913.2 950.9 951.0 951.9 954.6 797.7 911.0 940.7 943.8 944.7 989.9 990.7 991.9 992.1 994.5 986.2 986.6 987.3 988.9 989.9 728.9 733.9 734.6 735.8 736.1 15937.7 16311.0 16362.5 16685.8 16985.3 13249.3 13526.8 14041.2 14111.2 14116.0 11540.6 11738.7 11804.8 11816.1 12178.2 3597.3 3633.4 3642.3 3669.4 3723.8 110434.4 111612.0 116078.0 116640.0 117541.8 10835.5 10852.8 10876.5 10903.2 11441.3 18846.6 22590.4 22847.2 23099.0 23137.0 7340.7 7424.2 7468.7 7587.4 7675.5 4211.5 4253.2 4262.4 4300.2 4301.6 3192.8 3470.3 3473.7 3480.5 3482.2 591.2 593.3 594.9 597.1 609.0 642.9 664.6 675.5 683.4 698.6 9894.0 10155.2 10183.5 10228.2 10344.3 678.3 682.9 691.1 695.0 703.8 4362.8 4653.5 4737.3 5020.9 5024.9 96557.6 99541.0 99892.0 100322.0 101705.5 83635.0 84853.0 86142.0 86930.6 87883.6 76279.2 77500.0 77916.0 78674.0 79495.6 7833.2 9360.2 9756.6 9800.0 9865.9 39205.6 51052.7 51598.7 51683.0 52156.7 62676.0 63538.7 64018.7 65248.0 65496.0 8155.9 11234.3 11359.9 11405.8 11890.5 12905.9 12995.9 13029.8 13039.4 13099.8 11715.5 11937.7 11956.0 12027.3 12080.7 11780.6 11969.6 12071.3 12186.5 12576.7 11766.8 11847.8 11886.2 12263.8 12406.1 9815.6 10145.4 10332.4 10421.7 10815.5 8941.8 8971.0 10029.3 10048.3 10099.9 10:37:54 INFO - PROCESS | 1642 | -------- Summary: end -------- 10:37:54 INFO - PROCESS | 1642 | 10:37:55 INFO - TEST-INFO | 1642: exit 0 10:37:55 INFO - TEST-OK | dromaeo_css | took 1117894ms 10:37:55 INFO - TEST-START | kraken 10:37:55 INFO - operating with platform_type : mac_ 10:37:55 INFO - Initialising browser for kraken test... 10:37:55 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpZEVGMi/profile http://localhost:49252/getInfo.html) 10:37:58 INFO - PROCESS | 1656 | 2017-03-07 10:37:58.320 plugin-container[1657:10201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 10:37:58 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:37:58 INFO - PROCESS | 1656 | 2017-03-07 10:37:58.323 plugin-container[1657:10201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4627, name = 'com.apple.CFPasteboardClient' 10:37:58 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:37:58 INFO - PROCESS | 1656 | 2017-03-07 10:37:58.323 plugin-container[1657:10201] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:37:58 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:37:58 INFO - PROCESS | 1656 | colorDepth:24 10:37:58 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:37:58 INFO - PROCESS | 1656 | __metrics 10:37:58 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:37:59 INFO - TEST-INFO | 1656: exit 0 10:37:59 INFO - Browser initialized. 10:37:59 INFO - Running cycle 1/1 for kraken test... 10:37:59 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpZEVGMi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:01 INFO - PROCESS | 1658 | 2017-03-07 10:38:01.661 plugin-container[1659:10322] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:38:01 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:38:01 INFO - PROCESS | 1658 | 2017-03-07 10:38:01.661 plugin-container[1659:10322] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 10:38:01 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:38:01 INFO - PROCESS | 1658 | 2017-03-07 10:38:01.661 plugin-container[1659:10322] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:38:11 INFO - PROCESS | 1658 | RSS: Main: 228024320 10:38:11 INFO - PROCESS | 1658 | 10:38:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:15 INFO - PROCESS | 1658 | RSS: Main: 241065984 10:38:15 INFO - PROCESS | 1658 | 10:38:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 10:38:18 INFO - PROCESS | 1658 | RSS: Main: 249573376 10:38:18 INFO - PROCESS | 1658 | 10:38:21 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 10:38:22 INFO - PROCESS | 1658 | RSS: Main: 252010496 10:38:22 INFO - PROCESS | 1658 | 10:38:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 10:38:25 INFO - PROCESS | 1658 | RSS: Main: 253321216 10:38:25 INFO - PROCESS | 1658 | 10:38:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:27 INFO - PROCESS | 1658 | RSS: Main: 253677568 10:38:27 INFO - PROCESS | 1658 | 10:38:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:31 INFO - PROCESS | 1658 | RSS: Main: 256913408 10:38:31 INFO - PROCESS | 1658 | 10:38:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:36 INFO - PROCESS | 1658 | RSS: Main: 258650112 10:38:36 INFO - PROCESS | 1658 | 10:38:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 10:38:39 INFO - PROCESS | 1658 | RSS: Main: 260435968 10:38:39 INFO - PROCESS | 1658 | 10:38:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:42 INFO - PROCESS | 1658 | RSS: Main: 260132864 10:38:42 INFO - PROCESS | 1658 | 10:38:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:44 INFO - PROCESS | 1658 | RSS: Main: 260124672 10:38:44 INFO - PROCESS | 1658 | 10:38:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:47 INFO - PROCESS | 1658 | RSS: Main: 260317184 10:38:47 INFO - PROCESS | 1658 | 10:38:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:51 INFO - PROCESS | 1658 | RSS: Main: 260866048 10:38:51 INFO - PROCESS | 1658 | 10:38:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:55 INFO - PROCESS | 1658 | RSS: Main: 260390912 10:38:55 INFO - PROCESS | 1658 | 10:38:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 10:38:57 INFO - PROCESS | 1658 | RSS: Main: 263774208 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | __start_tp_report 10:38:57 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 10:38:57 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 10:38:57 INFO - PROCESS | 1658 | |i|pagename|runs| 10:38:57 INFO - PROCESS | 1658 | |0;ai-astar;110;124;120;122;123;122;121;122;128;163 10:38:57 INFO - PROCESS | 1658 | |1;audio-beat-detection;145;114;114;150;115;115;115;113;135;115 10:38:57 INFO - PROCESS | 1658 | |2;audio-dft;195;202;204;217;215;279;194;201;195;196 10:38:57 INFO - PROCESS | 1658 | |3;audio-fft;83;64;85;86;61;61;62;62;74;62 10:38:57 INFO - PROCESS | 1658 | |4;audio-oscillator;90;71;89;88;102;103;68;99;103;117 10:38:57 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;138;129;90;89;107;131;115;85;137;138 10:38:57 INFO - PROCESS | 1658 | |6;imaging-darkroom;103;154;136;96;97;129;95;136;97;96 10:38:57 INFO - PROCESS | 1658 | |7;imaging-desaturate;91;89;91;90;111;91;112;139;94;89 10:38:57 INFO - PROCESS | 1658 | |8;json-parse-financial;66;66;67;71;68;68;67;67;66;68 10:38:57 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;57;62;70;65;61;58;57;57;58;59 10:38:57 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;77;76;107;112;109;108;81;87;89;90 10:38:57 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;127;145;161;159;155;146;144;145;185;155 10:38:57 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;175;173;172;204;236;175;235;167;231;212 10:38:57 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;65;68;68;69;69;68;69;65;66;73 10:38:57 INFO - PROCESS | 1658 | __end_tp_report 10:38:57 INFO - PROCESS | 1658 | __start_cc_report 10:38:57 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,993 10:38:57 INFO - PROCESS | 1658 | __end_cc_report 10:38:57 INFO - PROCESS | 1658 | __startTimestamp1488911937064__endTimestamp 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | ------- Summary: start ------- 10:38:57 INFO - PROCESS | 1658 | Number of tests: 14 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:125.50 Median:122.50 stddev:13.94 (11.4%) stddev-sans-first:13.61 10:38:57 INFO - PROCESS | 1658 | Values: 110.0 124.0 120.0 122.0 123.0 122.0 121.0 122.0 128.0 163.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:115.00 stddev:14.43 (12.6%) stddev-sans-first:12.95 10:38:57 INFO - PROCESS | 1658 | Values: 145.0 114.0 114.0 150.0 115.0 115.0 115.0 113.0 135.0 115.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:209.80 Median:203.00 stddev:25.64 (12.6%) stddev-sans-first:26.63 10:38:57 INFO - PROCESS | 1658 | Values: 195.0 202.0 204.0 217.0 215.0 279.0 194.0 201.0 195.0 196.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:70.00 Median:69.00 stddev:10.83 (15.7%) stddev-sans-first:10.42 10:38:57 INFO - PROCESS | 1658 | Values: 83.0 64.0 85.0 86.0 61.0 61.0 62.0 62.0 74.0 62.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.50 stddev:15.10 (19.0%) stddev-sans-first:15.98 10:38:57 INFO - PROCESS | 1658 | Values: 90.0 71.0 89.0 88.0 102.0 103.0 68.0 99.0 103.0 117.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:138.00 stddev:21.73 (15.7%) stddev-sans-first:21.53 10:38:57 INFO - PROCESS | 1658 | Values: 138.0 129.0 90.0 89.0 107.0 131.0 115.0 85.0 137.0 138.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:113.90 Median:95.50 stddev:22.36 (23.4%) stddev-sans-first:23.37 10:38:57 INFO - PROCESS | 1658 | Values: 103.0 154.0 136.0 96.0 97.0 129.0 95.0 136.0 97.0 96.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:99.70 Median:90.50 stddev:16.35 (18.1%) stddev-sans-first:17.04 10:38:57 INFO - PROCESS | 1658 | Values: 91.0 89.0 91.0 90.0 111.0 91.0 112.0 139.0 94.0 89.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.51 10:38:57 INFO - PROCESS | 1658 | Values: 66.0 66.0 67.0 71.0 68.0 68.0 67.0 67.0 66.0 68.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:4.27 (7.1%) stddev-sans-first:4.35 10:38:57 INFO - PROCESS | 1658 | Values: 57.0 62.0 70.0 65.0 61.0 58.0 57.0 57.0 58.0 59.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:79.00 stddev:14.08 (17.8%) stddev-sans-first:13.59 10:38:57 INFO - PROCESS | 1658 | Values: 77.0 76.0 107.0 112.0 109.0 108.0 81.0 87.0 89.0 90.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:155.00 stddev:15.13 (9.8%) stddev-sans-first:13.01 10:38:57 INFO - PROCESS | 1658 | Values: 127.0 145.0 161.0 159.0 155.0 146.0 144.0 145.0 185.0 155.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.00 Median:208.00 stddev:28.78 (13.8%) stddev-sans-first:29.30 10:38:57 INFO - PROCESS | 1658 | Values: 175.0 173.0 172.0 204.0 236.0 175.0 235.0 167.0 231.0 212.0 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.24 10:38:57 INFO - PROCESS | 1658 | Values: 65.0 68.0 68.0 69.0 69.0 68.0 69.0 65.0 66.0 73.0 10:38:57 INFO - PROCESS | 1658 | -------- Summary: end -------- 10:38:57 INFO - PROCESS | 1658 | 10:38:57 INFO - TEST-INFO | 1658: exit 0 10:38:57 INFO - TEST-OK | kraken | took 62564ms 10:38:57 INFO - SUITE-END | took 1180s 10:38:58 INFO - Completed test suite (00:19:40) 10:38:58 INFO - javascript benchmark 10:38:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7540.681423899226, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3458.3947809133397, 3474.044637724626, 3482.1642805726624, 3484.268303656232, 3532.8056956867376, 5766.82699519014, 5927.762889484421, 5958.076498142789, 5998.040313549833, 6050.515958723303, 5844.26946631671, 5920.822375328747, 5986.371430999748, 6091.482224010964, 6091.969540152293, 5390.973045134769, 5422.024035673587, 5434.864128396782, 5466.863328416802, 5512.39363669996, 5299.443558426367, 5378.2470454136455, 5479.643823151482, 5503.954248692756, 5557.6109672322955, 5229.477052294778, 5253.50091741284, 5336.146216605363, 5453.890922181574, 5456.781728730846, 5320.893582128375, 5326.6537675050995, 5378.354597448331, 5493.148561972901, 5498.202760599731, 5334.22653715213, 5336.1195402758885, 5386.353637563518, 5409.24270602116, 5415.377231618375, 5287.576993840484, 5326.536606249478, 6102.572819902609, 6127.9837278401355, 6132.785352512686, 6214.968925155391, 6251.937480625181, 6274.964630835907, 6290.937090629081, 6300.275468321156, 6442.903356449657, 6457.16056912603, 6458.870822583569, 6495.188101487314, 6505.6421896795655, 6133.233345831771, 6159.291681456601, 6161.6611086389785, 6171.321154672983, 6191.288001879797, 6241.687915604201, 6304.968475157595, 6355.713992870332, 6418.967905160444, 6564.081028655992, 6150.569460137837, 6189.226346706661, 6216.502679785606, 6266.248050234001, 6342.4926005919415, 6381.234251889803, 6395.072714456378, 6404.071409645575, 6411.935880641227, 6450.838729031718, 5603.327600687862, 5913.0, 6332.335104813928, 6337.683115844189, 6362.204724409449, 5409.486098820606, 6243.37566243372, 6257.2491301044165, 6266.404691554295, 6332.905006424908, 5141.922871156936, 5148.588112950955, 5153.201253805666, 5154.561862241751, 5193.246979187997, 4572.3827283317, 4589.2198326284615, 4607.124646317256, 4620.491745907947, 4647.140279048387, 5859.355470898197, 5948.434898684618, 5994.820155395258, 6083.330833608299, 6163.044728067157, 6190.380961903774, 6261.843453913598, 6331.778387756406, 6385.776497822554, 6390.648514331757, 6094.421030002142, 6112.663803490851, 6140.662263575547, 6147.66187859663, 6164.845878852975, 5629.380768115504, 5685.061964775766, 5687.289088863892, 5688.601797874109, 5690.630109042899, 6314.179156709598, 6381.074744162163, 6488.286288508355, 6509.511786616117, 6595.637239951849, 5633.774649013993, 6362.383106638605, 6389.8722025560155, 6393.840153996187, 6411.743530258737, 6505.772297969548, 6550.213974323112, 6596.538242322991, 6613.817440244611, 6646.933530664632, 5136.30659860914, 6145.463634091477, 6203.4416902479, 6273.278572964167, 6312.2740884796995, 4935.605151587936, 6134.9079763804475, 6370.076338930737, 6392.456641185551, 6441.806745797634, 6131.713108457195, 6178.783742568989, 6222.066689996536, 6257.124002639725, 6286.15136956505, 6197.938020619736, 6207.131001659681, 6241.31345551998, 6287.025511045612, 6294.968525157345, 6055.848603784941, 6114.419130182626, 6124.930239974474, 6140.596275277727, 6214.720337584729, 6237.688115594293, 6248.5313601479165, 6277.529185311211, 6293.181886354744, 6294.842628934313, 6175.382461753788, 6219.440250377488, 6240.032794916795, 6247.875042499034, 6255.31191568918], "value": 5861.648426637278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.896834443178, 790.5059337913804, 815.2703330519188, 941.7975135345899, 943.985840212397, 37052.07369815756, 37502.43746343807, 39179.02052448686, 39231.21537569247, 39314.0, 38212.42681359782, 38294.8085259574, 38373.808130959376, 38377.27302271398, 38390.61609383905, 7821.921780782191, 7959.482633628824, 10526.263161578692, 10865.619703310385, 11001.724956876102, 10562.524686389132, 10628.78742425151, 10671.253012289104, 10688.786224275509, 10692.625758098467, 8968.699538566936, 10715.0, 10716.446115313274, 10762.97751713586, 10776.676699698983, 10650.988156125155, 10662.946685266563, 10689.144868410509, 10719.249652524326, 10719.517621707002, 10539.262251642389, 10621.203409744223, 10628.627998020109, 10652.094571961392, 10672.679819605424, 33089.33821323584, 33264.501032484535, 33402.83298583516, 33433.0, 33486.49770253448, 3585.731070169748, 3613.5663720353728, 3624.873129440457, 3673.669369756735, 3771.9811400943095, 22962.39263251573, 24633.753662463325, 24690.0, 24878.0, 24878.5024299513, 2625.186192280399, 3068.938621227563, 3125.6092988376454, 3133.9529907051415, 3189.1867573768773, 331018.0, 331197.0, 332268.0, 332280.0, 333779.0, 37760.62239377571, 43836.46572369952, 43952.0, 44114.338284925754, 44216.0, 44911.0, 44948.0, 44970.550294496636, 45073.87315317144, 45093.29440233597, 12689.682757931125, 12783.16909400886, 12783.296918669377, 12807.0, 12817.974562035015, 9173.724788256362, 9655.22758179358, 10707.0, 10789.028987391173, 10931.781364372668, 9615.326927115175, 10245.590176392861, 11533.711657208469, 11540.307581544967, 11668.416579171007, 5607.214989901417, 5632.40909181781, 5717.8570535736935, 5739.913901291484, 5761.625494342854, 1100.8844071372391, 1139.3619573039125, 1148.1847887999447, 1154.0, 1195.8146487294484, 24022.243371584722, 24210.394740131287, 25351.746482534938, 26846.16260589273, 27201.31996700059, 1055.7044027672264, 1220.5544976083665, 1224.7183147876037, 1274.7195616964252, 1280.5198050730976, 11335.773284534263, 12275.324857132764, 13492.5277615283, 13924.30378481072, 14015.929920350536, 415719.0, 416090.0, 419016.8098319039, 420003.0, 421861.0, 56465.43534564684, 56949.43050569524, 56950.0, 56971.43028569661, 57269.0, 1229.9139060265695, 1372.9428340178008, 1419.9077059991068, 1420.0, 1421.289355322339, 21053.736775793503, 26432.471350573265, 30300.5454918172, 30543.847280763453, 30729.846350768104, 34672.0, 45795.85510362268, 48028.5197148024, 48102.27846582234, 48398.0, 440329.0, 441747.0, 441968.0, 443445.0, 444555.0, 29226.123216303546, 29257.82968681229, 29308.267293317836, 29329.85335073311, 29365.0, 37678.62321376861, 37828.0, 38090.0, 38361.61638383692, 38971.22057558889, 31117.222069448446, 31627.683723162474, 31796.36407271888, 32579.34841303208, 33034.17414564655, 32403.0, 32914.5062824053, 33625.0, 34776.0, 34880.0, 32809.0, 33254.66745332516, 33266.50300736521, 33551.993440196835, 34285.14287142841, 27721.722782771914, 29571.85214073916, 29655.703442965296, 29952.25119372033, 30271.848640756656, 20841.478963026046, 22345.888270559193, 22851.08595656155, 22947.361053479064, 23383.0], "value": 18011.76857540535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.46997877917863, 389.9395593682978, 394.52262762057916, 410.2881500596465, 439.0034621409401, 19211.42365729027, 20242.696359554582, 20400.591988160228, 20579.588408231826, 20663.276785312497, 19358.806411935875, 19536.609267814634, 20357.185712571478, 20888.895555522202, 21029.474263143427, 6120.112583675354, 6192.690365481731, 6518.250401203851, 6519.576227545194, 6523.151990241262, 5447.237386765856, 5500.7524661390335, 6266.968665156668, 6380.521460890452, 6425.100485931974, 6479.708413121397, 6480.9675951620175, 6487.837804054912, 6498.122753428298, 6507.121538592301, 6156.230471191101, 6412.743490260384, 6427.614343139403, 6460.515461340418, 6495.090687303781, 5925.585209035369, 6270.435660790505, 6287.52843536732, 6295.968520157416, 6339.7320535893, 24221.51556968851, 24561.38596535083, 24609.753902460925, 24867.5026499469, 24934.875325623438, 2773.7656742749487, 2790.902318418866, 2831.7593004594632, 2838.9290267743263, 2842.928926776847, 13484.460621575125, 15716.607084822857, 15767.290471928676, 15978.680426391524, 16510.917445412815, 2041.1631231195288, 2059.6807494838176, 2085.8122768950866, 2215.3021798133536, 2246.9213577524706, 154697.0, 161983.0, 163818.18090909588, 165744.0, 165937.0, 20124.698129528068, 20201.898990504953, 20209.696854547194, 20330.288439904532, 20358.592828143355, 29823.850880745456, 29841.701582983893, 29848.40303193924, 30005.899587029136, 30153.492325383642, 9576.425414475154, 9691.70924872255, 9849.26130540198, 9860.112589866947, 9988.300818942604, 8095.473794203475, 8126.878096828552, 8127.1466496017065, 8267.710630127916, 8275.420720549624, 9157.81684366309, 9201.309901757395, 9289.396189247676, 9303.209227215762, 9324.347295689236, 3929.9760623279035, 3999.5400528938962, 4014.879553613396, 4024.4566983457444, 4025.2754504188943, 655.8327626455224, 785.654312102673, 795.8129839487716, 877.1929824561419, 885.9601317940708, 20511.28210512655, 21099.78900210978, 21126.683099753514, 21154.576908461746, 21353.25263615766, 894.7628878347243, 900.9504477253682, 931.1573026411108, 932.8507438809758, 934.458014351688, 9985.450800205914, 10833.404162770965, 10987.285826421417, 11000.889991100146, 11038.448077596087, 645588.0, 651394.0, 671163.0, 682990.0, 684747.5762621255, 119264.0, 142508.57491424953, 151173.0, 152237.0, 159435.0, 1139.3710593912872, 1182.1665725663386, 1229.065909908476, 1229.287013532167, 1230.6062060140669, 16643.75034374461, 18819.717704234172, 18957.90521047386, 19142.0, 19220.903895480435, 58456.70771646115, 60778.0, 60899.0, 61034.4741381469, 61463.0, 82373.0, 82460.58769706353, 83555.0, 83865.0, 84966.57516712624, 10948.34309941406, 10960.671179864617, 10974.780504389708, 11286.717832054264, 11404.429778511207, 12406.8833804958, 12438.253704777742, 12608.87391126077, 12726.363681816058, 12827.615171544869, 10577.894221057692, 10676.0, 10842.457877106272, 10867.945660271647, 10977.780444391226, 11225.270357426742, 11246.325220486797, 11502.88497115018, 11563.132765042823, 11770.3526306054, 9919.603215871284, 11334.716632084264, 11631.941840290745, 11707.473163707824, 11887.16789824704, 10327.431991240554, 10724.678259652223, 11154.665360039211, 11736.823947640622, 11859.229150105215, 11206.99137077667, 11275.32348059119, 11400.486978086172, 11515.654530364103, 11553.480093395985], "value": 11144.897380146553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.768310911809, 1500.6323450754567, 1544.1738669811646, 1550.100941453957, 1563.8905276630637, 9177.219936305406, 9458.716238512856, 10314.845277320837, 10943.781124377507, 11016.339019658815, 8691.56542172892, 10112.949435252833, 10523.84214236787, 10547.1562275018, 10557.260991730582, 2272.0, 2323.907043718249, 2344.1443872986324, 2347.788699017088, 2356.7643235676383, 2293.0, 2311.341267738695, 2324.430514523944, 2331.055922351442, 2339.0526836631107, 2299.9195028174017, 2317.142657216824, 2325.813934885205, 2328.1851352026824, 2332.242021343062, 2272.602294598455, 2284.6230371988604, 2289.381866895945, 2297.173017713622, 2301.3326135420707, 2243.7868402501736, 2311.075569772088, 2319.605667036591, 2321.651752237161, 2326.127702111708, 10406.0, 10469.0, 10491.370517768959, 10501.159907207406, 10529.052385285284, 5634.408387119334, 5697.259356283698, 5763.106718458645, 5771.971140144315, 5772.509336706343, 3035.8482075896336, 3352.430086885235, 3440.954755041781, 3604.963950360489, 3663.157473781019, 1123.8876112388778, 1135.8239472881717, 1785.1431312969717, 1811.7916439609482, 1900.6293772714325, 14305.28473576317, 14615.70768584633, 14788.038777479429, 14930.925345373204, 14940.252987350697, 4370.584794444522, 4590.403247577793, 4803.855884323476, 4982.302477653131, 5000.574951129122, 12469.625911222678, 12492.312922789333, 12505.749885002431, 12539.184952978027, 12550.497980080878, 5839.328477225088, 5861.325947516005, 5917.349091599921, 5948.821535353946, 5950.553708471795, 4431.7562534060935, 4563.657725670521, 5009.699418034929, 5147.176451767774, 5226.608004399685, 3896.6687831534637, 4012.378081397388, 4069.674426045909, 4077.1845630873945, 4150.107726838744, 875.4834647557972, 974.4543055888724, 1101.6639924822846, 1112.1047556716921, 1156.8611766587894, 777.872085476062, 827.6813426830594, 918.2369849888097, 924.6024209589941, 937.7093101138532, 5285.471452854684, 6328.430441260309, 6510.576812507172, 6645.235797883305, 6725.092112564839, 850.2475309351145, 925.7825958864072, 964.4117088575963, 989.7327721515295, 1039.29328056922, 3512.4906888501023, 4118.608732170439, 4124.216398884262, 4196.181744559782, 4268.189044081614, 12799.616011519669, 13229.0, 13237.867621323663, 13239.933800330937, 13245.536406225929, 10953.0, 12582.0, 13112.213267203999, 13202.273874936778, 13211.273379964003, 9596.376235544667, 9862.112409883002, 9870.0, 9901.0, 10042.447665378475, 6022.638641681513, 6417.582857114273, 6588.242352129375, 6702.463802895659, 6740.191177058784, 11745.354005529778, 11906.166568340133, 11954.760904781682, 12072.939635301767, 12085.516579336729, 9904.405735655884, 11809.881901181221, 12143.574974875837, 12149.453274602487, 12155.696107597381, 7950.40371972116, 8136.471129376571, 8814.779630509289, 8893.333000024895, 9038.954805225932, 10031.849522257318, 10066.798664026532, 10127.493625318852, 10141.695749127539, 10219.1824654026, 6641.302663220486, 8197.959010204911, 8247.876281855897, 8253.09215986253, 8317.376196785144, 8040.758777236692, 8161.347092232726, 8292.212239837207, 8340.457870238415, 8389.244967952913, 7449.366803821736, 7486.588237646763, 7576.886346704914, 7578.052743407075, 7598.354139898171, 5645.830625081254, 5766.0, 5776.480116789509, 5789.913151302818, 5859.5019423349495, 5721.971390143022, 5800.1299805029585, 5843.0, 5844.444777746107, 5865.061590145556], "value": 5012.307750990474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.94848721179056, 368.53564508719006, 370.616412013566, 371.4391269183533, 380.22244509977094, 5129.589632829374, 5147.459516750739, 5189.0725880948885, 5197.180072646611, 5198.8546929107915, 4430.645548356132, 4435.866923992277, 5165.948340516594, 5203.19350500672, 5210.296609957654, 4134.52452967908, 4304.418903448026, 4333.393324934512, 4345.913081738363, 4349.304111342186, 3912.3544615138467, 4078.2659121358142, 4352.238358287303, 4380.912381752363, 4382.9342559861625, 3730.048837546422, 4024.436578878959, 4048.6761059115347, 4205.4112424260475, 4356.213952279566, 3722.702183825301, 4191.497814858977, 4211.620954114144, 4240.197915885737, 4352.52122266552, 3156.542301366289, 3817.1220619257447, 3926.9566086283357, 3930.64624183822, 3952.3676211805973, 4195.552534375635, 4619.076184763027, 5120.795168193268, 5137.717425541594, 5141.871453213662, 4500.504944456107, 4519.954800451987, 4598.321612611407, 5051.393832740058, 5064.139096353629, 4819.373481447389, 5355.839324820262, 5576.7211639417865, 5578.776848926038, 5623.746931388097, 4092.874459523655, 4288.142371525707, 4436.648576254558, 4461.107778444324, 4484.0, 5007.973365460109, 5525.944740552583, 5874.412558744091, 5950.642961422329, 5968.253968253968, 3583.5341405617105, 3794.9317621896134, 3861.2663593917064, 3906.980465097713, 4010.9197816044098, 3976.1312183273817, 4271.337942618899, 4597.517260687647, 4600.263957766741, 4624.421947256593, 4555.0, 4790.904181916412, 4964.280179373971, 4997.450280469146, 5086.364204474441, 4934.506549345037, 5021.673591216632, 5050.545450909436, 5129.33296678581, 5513.61404701667, 1498.0, 1510.323540869634, 1572.6147093962052, 1574.842515748416, 1588.4440445843861, 962.9022913878184, 1128.9887101128884, 1153.98269025963, 1189.6140995739866, 1192.9919218260557, 4453.682006904876, 4912.25614906703, 4927.187014142626, 4975.701457912537, 5257.631965762436, 5044.369453818273, 5114.181730923035, 5294.655847369909, 5345.091334473149, 5758.827235182867, 4488.663350248679, 4934.605231581465, 5190.558802501754, 5203.739813009334, 5234.4296710986555, 2652.429727608535, 2744.4511097780523, 2910.5488649258973, 2981.4484320400798, 2996.5916019470815, 5380.0, 5656.490915817596, 5999.430054144849, 6013.488853447506, 6015.007523758618, 4914.582260507826, 5530.253415788898, 5564.860878478071, 5785.4214578541805, 5853.88292234153, 5070.569001634903, 5368.91946620801, 5425.810096646598, 5886.882262354643, 6031.246094238308, 5075.92386114216, 5376.0, 5747.10345585964, 5802.622829516068, 5846.766129354778, 4676.532346765296, 4783.6651434399255, 5143.742812859267, 5575.0, 5762.300121464262, 5017.122003649274, 5019.924701129559, 5096.617753668564, 5155.613329000265, 5769.307683078057, 4140.509416609958, 4422.513523512475, 5053.231369020813, 5071.416787069535, 5076.7207803571155, 5388.515033646991, 5676.886462270814, 5734.971325143348, 5754.798582049608, 5804.332501762183, 5070.873228169326, 5108.744562771921, 5394.514493695429, 5527.44725527444, 5542.0, 5293.417724050429, 5538.6122971391615, 5567.832965011056, 5588.972055139699, 5636.408177141341, 5336.412994570672, 5398.246894084124, 5403.5136837684795, 5443.700596467233, 5461.972690136524, 4967.180415231591, 5380.704061276668, 5534.640248384003, 5650.717464126859, 5673.489385955284, 4459.241928872035, 4509.797059132413, 4970.577500912463, 5055.646104772631, 5410.918836217381], "value": 4202.498313313477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.2086213095763, 751.5490705576651, 768.6233745464721, 820.7168526858234, 836.147129927474, 13165.539206127787, 15509.922450387747, 16178.029318240884, 16315.939463934836, 16321.591960201002, 14391.78412323816, 15344.156071416068, 15388.69222615547, 15403.614909627266, 15429.691406171869, 913.155331318531, 950.9429434233933, 950.9572069256866, 951.9381240219363, 954.575214029757, 797.7327595255597, 910.9635614575409, 940.7224868663726, 943.79708362702, 944.6788092048702, 989.8812142542869, 990.6582229130938, 991.9156871665917, 992.0823238504355, 994.5226291380142, 986.2208855004537, 986.57577241786, 987.3236832769576, 988.8714467119264, 989.8614194012844, 728.9453291003196, 733.9045924029842, 734.5739471106746, 735.7535225699397, 736.1387177002866, 15937.681246375008, 16311.0, 16362.509124726277, 16685.83314166855, 16985.3205871765, 13249.337533123306, 13526.797098043537, 14041.1575305482, 14111.223882686449, 14116.011879168462, 11540.596079137275, 11738.70653233676, 11804.796630039531, 11816.113791465674, 12178.208416452992, 3597.2625611749527, 3633.3823250047553, 3642.3261696586214, 3669.3578623740736, 3723.7951912644794, 110434.44782776115, 111612.0, 116078.0, 116640.0, 117541.8245817548, 10835.51240194193, 10852.782944341068, 10876.456177191267, 10903.236773425784, 11441.313521188755, 18846.623067538847, 22590.435239118826, 22847.200347987742, 23099.0, 23137.0, 7340.70637174507, 7424.183339832722, 7468.701251949861, 7587.355074818703, 7675.53946763196, 4211.4525111735275, 4253.170631726845, 4262.403263543107, 4300.182965236595, 4301.612854843079, 3192.776505644629, 3470.305938812248, 3473.6873681368797, 3480.5127282180515, 3482.21650128719, 591.2284468768298, 593.3413910559276, 594.8988671925783, 597.0596310810491, 608.9543284253699, 642.9292777794439, 664.5846346033729, 675.4697562413481, 683.3542302524068, 698.5878331784272, 9894.0, 10155.238357123246, 10183.54174062169, 10228.232882533839, 10344.32761870476, 678.3182901184279, 682.8792418646835, 691.1188235000415, 694.989575156373, 703.7783098324114, 4362.781860906942, 4653.534646535387, 4737.3130896020575, 5020.874478138076, 5024.949750502521, 96557.5516367255, 99541.0, 99892.0, 100322.0, 101705.49147254364, 83635.0, 84853.0, 86142.0, 86930.56534717412, 87883.56058219667, 76279.23720762832, 77500.0, 77916.0, 78674.0, 79495.60252198702, 7833.196650016334, 9360.15758581731, 9756.560954756911, 9799.951000244953, 9865.91474937742, 39205.607943921335, 51052.74473627608, 51598.74200628973, 51683.0, 52156.73921630368, 62676.0, 63538.68230658817, 64018.719625606296, 65248.0, 65496.0, 8155.918440815516, 11234.258689903078, 11359.943200283946, 11405.771884562428, 11890.464929078385, 12905.870941290466, 12995.935020324838, 13029.804552931524, 13039.413226405024, 13099.803502947272, 11715.481171548267, 11937.701557460785, 11956.0, 12027.338496382783, 12080.736564977507, 11780.646580602595, 11969.64091077269, 12071.336076515876, 12186.451609677762, 12576.685582860136, 11766.764664706487, 11847.822282665595, 11886.227395219283, 12263.816042759545, 12406.131570789958, 9815.58448022703, 10145.442000690033, 10332.431716255678, 10421.739456513647, 10815.459227038775, 8941.837561117014, 8971.0, 10029.29794914349, 10048.296619236584, 10099.899001009895], "value": 7416.960123179533, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 124.0, 120.0, 122.0, 123.0, 122.0, 121.0, 122.0, 128.0, 163.0], "value": 125.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 114.0, 150.0, 115.0, 115.0, 115.0, 113.0, 135.0, 115.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 202.0, 204.0, 217.0, 215.0, 279.0, 194.0, 201.0, 195.0, 196.0], "value": 209.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 64.0, 85.0, 86.0, 61.0, 61.0, 62.0, 62.0, 74.0, 62.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 89.0, 88.0, 102.0, 103.0, 68.0, 99.0, 103.0, 117.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 129.0, 90.0, 89.0, 107.0, 131.0, 115.0, 85.0, 137.0, 138.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 154.0, 136.0, 96.0, 97.0, 129.0, 95.0, 136.0, 97.0, 96.0], "value": 113.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 90.0, 111.0, 91.0, 112.0, 139.0, 94.0, 89.0], "value": 99.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 71.0, 68.0, 68.0, 67.0, 67.0, 66.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 70.0, 65.0, 61.0, 58.0, 57.0, 57.0, 58.0, 59.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 107.0, 112.0, 109.0, 108.0, 81.0, 87.0, 89.0, 90.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 145.0, 161.0, 159.0, 155.0, 146.0, 144.0, 145.0, 185.0, 155.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 172.0, 204.0, 236.0, 175.0, 235.0, 167.0, 231.0, 212.0], "value": 198.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 65.0, 66.0, 73.0], "value": 68.0, "unit": "score"}]}]} 10:38:58 INFO - Return code: 0 10:38:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:38:58 ERROR - # TBPL SUCCESS # 10:38:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:38:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:38:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:38:58 INFO - 2017-03-07 10:38:58.370 screenresolution[1663:10716] starting screenresolution argv=screenresolution get 10:38:58 INFO - 2017-03-07 10:38:58.373 screenresolution[1663:10716] Display 0: 1600x1200x32@60 10:38:58 INFO - 2017-03-07 10:38:58.379 screenresolution[1664:10719] starting screenresolution argv=screenresolution list 10:38:58 INFO - Available Modes on Display 0 10:38:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:38:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:38:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:38:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:38:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:38:58 INFO - Intel Iris: 10:38:58 INFO - Chipset Model: Intel Iris 10:38:58 INFO - Type: GPU 10:38:58 INFO - Bus: Built-In 10:38:58 INFO - VRAM (Dynamic, Max): 1536 MB 10:38:58 INFO - Vendor: Intel (0x8086) 10:38:58 INFO - Device ID: 0x0a2e 10:38:58 INFO - Revision ID: 0x0009 10:38:58 INFO - Displays: 10:38:58 INFO - Display: 10:38:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:38:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:38:58 INFO - Display Serial Number: 1600x1200 60 10:38:58 INFO - Main Display: Yes 10:38:58 INFO - Mirror: Off 10:38:58 INFO - Online: Yes 10:38:58 INFO - Rotation: Supported 10:38:58 INFO - Return code: 0 10:38:58 INFO - Running post-action listener: _resource_record_post_action 10:38:58 INFO - [mozharness: 2017-03-07 18:38:58.616599Z] Finished run-tests step (success) 10:38:58 INFO - Running post-run listener: _resource_record_post_run 10:38:58 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 38554112; Write bytes: 516051968; Read time: 244; Write time: 1629 10:38:58 INFO - TinderboxPrint: CPU usage
54.7% 10:38:58 INFO - TinderboxPrint: I/O read bytes / time
38,554,112 / 244 10:38:58 INFO - TinderboxPrint: I/O write bytes / time
516,051,968 / 1,629 10:38:58 INFO - TinderboxPrint: CPU idle
2,176.4 (45.3%) 10:38:58 INFO - TinderboxPrint: CPU system
965.5 (20.1%) 10:38:58 INFO - TinderboxPrint: CPU user
1,663.9 (34.6%) 10:38:58 INFO - TinderboxPrint: Swap in / out
249,167,872 / 0 10:38:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207862272; Write bytes: 203708416; Read time: 15709; Write time: 456 10:38:58 INFO - run-tests - Wall time: 1182s; CPU: 55.0%; Read bytes: 36448768; Write bytes: 301292544; Read time: 222; Write time: 1136 10:38:59 INFO - Running post-run listener: _upload_blobber_files 10:38:59 INFO - Blob upload gear active. 10:38:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:59 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 10:38:59 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:38:59 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:38:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:00 INFO - (blobuploader) - INFO - Done attempting. 10:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:01 INFO - (blobuploader) - INFO - Done attempting. 10:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:03 INFO - (blobuploader) - INFO - Done attempting. 10:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:05 INFO - (blobuploader) - INFO - Done attempting. 10:39:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:05 INFO - Return code: 0 10:39:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/957d5c5abf9b619308ac8dac3811639724849e7629e602c6b3c8edbc45691f6287a919ea41cffc688eacac59209f5894a522152ad219cbf50fcdcb11037f09e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e2614643ffdd20c074dc41752d7c09ce760bac9cf53a05e2e0548a1c74214bc8ae9f779a648ac3650e08703a45fbf884bc489b43f5adab6d62bd0d59f4e5fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/895432584de16a83b724a6d90fc6bcdf39b7f180b68a1fed871f96b7e6527a377131a274b303613916704bde811283310f749729ddcdf4b370463eef2f72eee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90cb6ca8201664807c5387f30b6c59f22dd69080d62bfebeae605c0045bdd1e19c3b553c988bcda0ca1c8c4bfd55c4ae3782577fd3f582e85a545b0570fa6a6d"} 10:39:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:05 INFO - Contents: 10:39:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/957d5c5abf9b619308ac8dac3811639724849e7629e602c6b3c8edbc45691f6287a919ea41cffc688eacac59209f5894a522152ad219cbf50fcdcb11037f09e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e2614643ffdd20c074dc41752d7c09ce760bac9cf53a05e2e0548a1c74214bc8ae9f779a648ac3650e08703a45fbf884bc489b43f5adab6d62bd0d59f4e5fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/895432584de16a83b724a6d90fc6bcdf39b7f180b68a1fed871f96b7e6527a377131a274b303613916704bde811283310f749729ddcdf4b370463eef2f72eee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90cb6ca8201664807c5387f30b6c59f22dd69080d62bfebeae605c0045bdd1e19c3b553c988bcda0ca1c8c4bfd55c4ae3782577fd3f582e85a545b0570fa6a6d"} 10:39:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:05 INFO - Copying logs to upload dir... 10:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.466853 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-07 10:39:05.702921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 10:39:05.706650) ========= 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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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/Firefox/sha512/957d5c5abf9b619308ac8dac3811639724849e7629e602c6b3c8edbc45691f6287a919ea41cffc688eacac59209f5894a522152ad219cbf50fcdcb11037f09e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e2614643ffdd20c074dc41752d7c09ce760bac9cf53a05e2e0548a1c74214bc8ae9f779a648ac3650e08703a45fbf884bc489b43f5adab6d62bd0d59f4e5fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/895432584de16a83b724a6d90fc6bcdf39b7f180b68a1fed871f96b7e6527a377131a274b303613916704bde811283310f749729ddcdf4b370463eef2f72eee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90cb6ca8201664807c5387f30b6c59f22dd69080d62bfebeae605c0045bdd1e19c3b553c988bcda0ca1c8c4bfd55c4ae3782577fd3f582e85a545b0570fa6a6d"} build_url:https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/GJPyYG2uSSaEAd5b6cDR3w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/957d5c5abf9b619308ac8dac3811639724849e7629e602c6b3c8edbc45691f6287a919ea41cffc688eacac59209f5894a522152ad219cbf50fcdcb11037f09e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e2614643ffdd20c074dc41752d7c09ce760bac9cf53a05e2e0548a1c74214bc8ae9f779a648ac3650e08703a45fbf884bc489b43f5adab6d62bd0d59f4e5fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/895432584de16a83b724a6d90fc6bcdf39b7f180b68a1fed871f96b7e6527a377131a274b303613916704bde811283310f749729ddcdf4b370463eef2f72eee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90cb6ca8201664807c5387f30b6c59f22dd69080d62bfebeae605c0045bdd1e19c3b553c988bcda0ca1c8c4bfd55c4ae3782577fd3f582e85a545b0570fa6a6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 10:39:05.741295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 10:39:05.741636) ========= 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.V6tQhqRHk4/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.hT1zRqI7uy/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.005223 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 10:39:05.790262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 10:39:05.790593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 10:39:05.790928) ========= ========= Total master_lag: 0.18 =========