builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0084 starttime: 1476912481.1 results: success (0) buildid: 20161019115222 builduid: b2d71adc09884e9b882dd74d1444f536 revision: 33bc172941df74d989e77412854cae45682f5501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.104290) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.104716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.104988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.128422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.128727) ========= 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.qNDHsufBdn/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.1B1OZBIycr/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-19 14:28:01-- 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% 75.4M=0s 2016-10-19 14:28:01 (75.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.231502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.231809) ========= 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.qNDHsufBdn/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.1B1OZBIycr/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.028532 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:01.280038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 14:28:01.280385) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33bc172941df74d989e77412854cae45682f5501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33bc172941df74d989e77412854cae45682f5501 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qNDHsufBdn/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.1B1OZBIycr/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-19 14:28:01,354 truncating revision to first 12 chars 2016-10-19 14:28:01,354 Setting DEBUG logging. 2016-10-19 14:28:01,354 attempt 1/10 2016-10-19 14:28:01,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33bc172941df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 14:28:02,399 unpacking tar archive at: mozilla-aurora-33bc172941df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.299863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 14:28:02.603809) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:02.604396) ========= script_repo_revision: 33bc172941df74d989e77412854cae45682f5501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:02.605007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:02.605450) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:02.626293) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-19 14:28:02.626797) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qNDHsufBdn/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.1B1OZBIycr/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:02 INFO - MultiFileLogger online at 20161019 14:28:02 in /builds/slave/test 14:28:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:28:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:28:02 INFO - {'append_to_log': False, 14:28:02 INFO - 'base_work_dir': '/builds/slave/test', 14:28:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:28:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:28:02 INFO - 'branch': 'Mozilla-Aurora', 14:28:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:28:02 INFO - 'config_files': ('talos/mac_config.py',), 14:28:02 INFO - 'default_actions': ('clobber', 14:28:02 INFO - 'read-buildbot-config', 14:28:02 INFO - 'download-and-extract', 14:28:02 INFO - 'populate-webroot', 14:28:02 INFO - 'create-virtualenv', 14:28:02 INFO - 'install', 14:28:02 INFO - 'run-tests'), 14:28:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:28:02 INFO - 'download_minidump_stackwalk': True, 14:28:02 INFO - 'download_symbols': 'ondemand', 14:28:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:28:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:28:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:28:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:28:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:28:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:28:02 INFO - 'installer_path': 'installer.exe', 14:28:02 INFO - 'log_level': 'info', 14:28:02 INFO - 'log_name': 'talos', 14:28:02 INFO - 'log_to_console': True, 14:28:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:28:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:28:02 INFO - 'opt_config_files': (), 14:28:02 INFO - 'pip_index': False, 14:28:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:28:02 INFO - 'cmd': ('bash', 14:28:02 INFO - '-c', 14:28:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:28:02 INFO - 'enabled': True, 14:28:02 INFO - 'halt_on_failure': False, 14:28:02 INFO - 'name': 'check_screen_resolution'},), 14:28:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:28:02 INFO - 'cmd': ('bash', 14:28:02 INFO - '-c', 14:28:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:28:02 INFO - 'enabled': True, 14:28:02 INFO - 'halt_on_failure': False, 14:28:02 INFO - 'name': 'check_screen_resolution'},), 14:28:02 INFO - 'run_cmd_checks_enabled': True, 14:28:02 INFO - 'sps_profile': False, 14:28:02 INFO - 'sps_profile_interval': 0, 14:28:02 INFO - 'suite': 'dromaeojs-e10s', 14:28:02 INFO - 'system_bits': '32', 14:28:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:28:02 INFO - 'title': 't-yosemite-r7-0084', 14:28:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:28:02 INFO - 'use_talos_json': True, 14:28:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:28:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:28:02 INFO - 'work_dir': 'build'} 14:28:02 INFO - [mozharness: 2016-10-19 21:28:02.825007Z] Running clobber step. 14:28:02 INFO - Running pre-action listener: _resource_record_pre_action 14:28:02 INFO - Running main action method: clobber 14:28:02 INFO - rmtree: /builds/slave/test/build 14:28:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:28:05 INFO - Running post-action listener: _resource_record_post_action 14:28:05 INFO - [mozharness: 2016-10-19 21:28:05.039202Z] Finished clobber step (success) 14:28:05 INFO - [mozharness: 2016-10-19 21:28:05.039329Z] Running read-buildbot-config step. 14:28:05 INFO - Running pre-action listener: _resource_record_pre_action 14:28:05 INFO - Running main action method: read_buildbot_config 14:28:05 INFO - Using buildbot properties: 14:28:05 INFO - { 14:28:05 INFO - "project": "", 14:28:05 INFO - "product": "firefox", 14:28:05 INFO - "script_repo_revision": "production", 14:28:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:28:05 INFO - "repository": "", 14:28:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:28:05 INFO - "buildid": "20161019115222", 14:28:05 INFO - "pgo_build": "False", 14:28:05 INFO - "basedir": "/builds/slave/test", 14:28:05 INFO - "buildnumber": 10, 14:28:05 INFO - "slavename": "t-yosemite-r7-0084", 14:28:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:28:05 INFO - "platform": "yosemite_r7", 14:28:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:28:05 INFO - "branch": "mozilla-aurora", 14:28:05 INFO - "repo_path": "releases/mozilla-aurora", 14:28:05 INFO - "revision": "33bc172941df74d989e77412854cae45682f5501", 14:28:05 INFO - "stage_platform": "macosx64", 14:28:05 INFO - "builduid": "b2d71adc09884e9b882dd74d1444f536", 14:28:05 INFO - "slavebuilddir": "test" 14:28:05 INFO - } 14:28:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:28:05 INFO - Running post-action listener: _resource_record_post_action 14:28:05 INFO - [mozharness: 2016-10-19 21:28:05.042651Z] Finished read-buildbot-config step (success) 14:28:05 INFO - [mozharness: 2016-10-19 21:28:05.042767Z] Running download-and-extract step. 14:28:05 INFO - Running pre-action listener: _resource_record_pre_action 14:28:05 INFO - Running main action method: download_and_extract 14:28:05 INFO - mkdir: /builds/slave/test/build/tests 14:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:05 INFO - trying https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 14:28:06 INFO - Downloaded 1199 bytes. 14:28:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:28:06 INFO - Using the following test package requirements: 14:28:06 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:28:06 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:28:06 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:28:06 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'jsshell-mac.zip'], 14:28:06 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:28:06 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:28:06 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:28:06 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:28:06 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:28:06 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:28:06 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:28:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:28:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:28:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:28:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:28:06 INFO - Expected file size: 16436237 14:28:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:28:14 INFO - Expected file size: 16436237 14:28:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:28:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:28:21 INFO - Fetch https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:28:22 INFO - Expected file size: 14414081 14:28:22 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')]} 14:28:22 INFO - trying https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:28:22 INFO - Downloading https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:28:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 14:28:25 INFO - Downloaded 115412760 bytes. 14:28:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:28:25 INFO - mkdir: /builds/slave/test/properties 14:28:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:25 INFO - Contents: 14:28:25 INFO - build_url:https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:28:26 INFO - Running post-action listener: _resource_record_post_action 14:28:26 INFO - Running post-action listener: set_extra_try_arguments 14:28:26 INFO - [mozharness: 2016-10-19 21:28:26.315904Z] Finished download-and-extract step (success) 14:28:26 INFO - [mozharness: 2016-10-19 21:28:26.316031Z] Running populate-webroot step. 14:28:26 INFO - Running pre-action listener: _resource_record_pre_action 14:28:26 INFO - Running main action method: populate_webroot 14:28:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:26 INFO - '--tppagecycles', 14:28:26 INFO - '7'], 14:28:26 INFO - 'tests': ['tsvgm']}}, 14:28:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:28:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:28:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:28:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['damp', 'tps']}, 14:28:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'tests': ['damp', 'tps']}, 14:28:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['dromaeo_dom']}, 14:28:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['basic_compositor_video']}, 14:28:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:28:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['a11yr', 14:28:26 INFO - 'ts_paint', 14:28:26 INFO - 'tpaint', 14:28:26 INFO - 'sessionrestore', 14:28:26 INFO - 'sessionrestore_no_auto_restore', 14:28:26 INFO - 'tabpaint']}, 14:28:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:28:26 INFO - 'ts_paint', 14:28:26 INFO - 'tpaint', 14:28:26 INFO - 'sessionrestore', 14:28:26 INFO - 'sessionrestore_no_auto_restore', 14:28:26 INFO - 'tabpaint']}, 14:28:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:28:26 INFO - 'ts_paint', 14:28:26 INFO - 'tpaint', 14:28:26 INFO - 'sessionrestore', 14:28:26 INFO - 'sessionrestore_no_auto_restore', 14:28:26 INFO - 'tabpaint']}, 14:28:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:28:26 INFO - 'ts_paint', 14:28:26 INFO - 'tpaint', 14:28:26 INFO - 'sessionrestore', 14:28:26 INFO - 'sessionrestore_no_auto_restore', 14:28:26 INFO - 'tabpaint']}, 14:28:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['a11yr', 14:28:26 INFO - 'ts_paint', 14:28:26 INFO - 'tpaint', 14:28:26 INFO - 'sessionrestore', 14:28:26 INFO - 'sessionrestore_no_auto_restore', 14:28:26 INFO - 'tabpaint']}, 14:28:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['a11yr', 14:28:26 INFO - 'ts_paint', 14:28:26 INFO - 'tpaint', 14:28:26 INFO - 'sessionrestore', 14:28:26 INFO - 'sessionrestore_no_auto_restore', 14:28:26 INFO - 'tabpaint']}, 14:28:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['tsvgx', 14:28:26 INFO - 'tsvgr_opacity', 14:28:26 INFO - 'tart', 14:28:26 INFO - 'tscrollx', 14:28:26 INFO - 'cart']}, 14:28:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:28:26 INFO - 'tsvgr_opacity', 14:28:26 INFO - 'tart', 14:28:26 INFO - 'tscrollx', 14:28:26 INFO - 'cart']}, 14:28:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'talos_options': ['--disable-e10s'], 14:28:26 INFO - 'tests': ['tp5o']}, 14:28:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'tests': ['tp5o']}, 14:28:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'talos_options': ['--disable-e10s', 14:28:26 INFO - '--xperf_path', 14:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:26 INFO - 'tests': ['tp5n']}, 14:28:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:26 INFO - 'talos_options': ['--xperf_path', 14:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:26 INFO - 'tests': ['tp5n']}}, 14:28:26 INFO - 'talos.zip': {'path': '', 14:28:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:26 INFO - Running post-action listener: _resource_record_post_action 14:28:26 INFO - [mozharness: 2016-10-19 21:28:26.334451Z] Finished populate-webroot step (success) 14:28:26 INFO - [mozharness: 2016-10-19 21:28:26.334574Z] Running create-virtualenv step. 14:28:26 INFO - Running pre-action listener: _resource_record_pre_action 14:28:26 INFO - Running main action method: create_virtualenv 14:28:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:26 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 14:28:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:26 INFO - Using real prefix '/tools/python27' 14:28:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:30 INFO - Installing pip.................done. 14:28:30 INFO - Return code: 0 14:28:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:30 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')]} 14:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 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')]} 14:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:30 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 14:28:30 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 14:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:30 INFO - 'HOME': '/Users/cltbld', 14:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:30 INFO - 'LOGNAME': 'cltbld', 14:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:30 INFO - 'MOZ_NO_REMOTE': '1', 14:28:30 INFO - 'NO_EM_RESTART': '1', 14:28:30 INFO - 'PAGER': '/bin/cat', 14:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:30 INFO - 'PWD': '/builds/slave/test', 14:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:30 INFO - 'SHELL': '/bin/bash', 14:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:30 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:30 INFO - 'USER': 'cltbld', 14:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:30 INFO - 'XPC_FLAGS': '0x0', 14:28:30 INFO - 'XPC_SERVICE_NAME': '0', 14:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:30 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 14:28:30 INFO - Cleaning up... 14:28:30 INFO - Return code: 0 14:28:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:30 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')]} 14:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 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')]} 14:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:30 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 14:28:30 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 14:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:30 INFO - 'HOME': '/Users/cltbld', 14:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:30 INFO - 'LOGNAME': 'cltbld', 14:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:30 INFO - 'MOZ_NO_REMOTE': '1', 14:28:30 INFO - 'NO_EM_RESTART': '1', 14:28:30 INFO - 'PAGER': '/bin/cat', 14:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:30 INFO - 'PWD': '/builds/slave/test', 14:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:30 INFO - 'SHELL': '/bin/bash', 14:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:30 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:30 INFO - 'USER': 'cltbld', 14:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:30 INFO - 'XPC_FLAGS': '0x0', 14:28:30 INFO - 'XPC_SERVICE_NAME': '0', 14:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:30 INFO - Downloading/unpacking psutil>=3.1.1 14:28:30 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 14:28:30 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 14:28:30 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 14:28:30 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 14:28:30 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 14:28:30 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 14:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:33 INFO - Installing collected packages: psutil 14:28:33 INFO - Running setup.py install for psutil 14:28:33 INFO - building 'psutil._psutil_osx' extension 14:28:33 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 14:28:34 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 14:28:34 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 14:28:34 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 14:28:34 INFO - building 'psutil._psutil_posix' extension 14:28:34 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 14:28:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:28:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:28:34 INFO - ^ 14:28:34 INFO - 1 warning generated. 14:28:34 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 14:28:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:34 INFO - Successfully installed psutil 14:28:34 INFO - Cleaning up... 14:28:34 INFO - Return code: 0 14:28:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28:34 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')]} 14:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:34 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')]} 14:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:34 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:34 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 14:28:34 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 14:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:34 INFO - 'HOME': '/Users/cltbld', 14:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:34 INFO - 'LOGNAME': 'cltbld', 14:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:34 INFO - 'MOZ_NO_REMOTE': '1', 14:28:34 INFO - 'NO_EM_RESTART': '1', 14:28:34 INFO - 'PAGER': '/bin/cat', 14:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:34 INFO - 'PWD': '/builds/slave/test', 14:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:34 INFO - 'SHELL': '/bin/bash', 14:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:34 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:34 INFO - 'USER': 'cltbld', 14:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:34 INFO - 'XPC_FLAGS': '0x0', 14:28:34 INFO - 'XPC_SERVICE_NAME': '0', 14:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:35 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 14:28:35 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 14:28:35 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 14:28:35 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 14:28:35 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 14:28:35 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 14:28:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:37 INFO - Installing collected packages: mozsystemmonitor 14:28:37 INFO - Running setup.py install for mozsystemmonitor 14:28:37 INFO - Successfully installed mozsystemmonitor 14:28:37 INFO - Cleaning up... 14:28:38 INFO - Return code: 0 14:28:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:38 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:38 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 14:28:38 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 14:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:38 INFO - 'HOME': '/Users/cltbld', 14:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:38 INFO - 'LOGNAME': 'cltbld', 14:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:38 INFO - 'MOZ_NO_REMOTE': '1', 14:28:38 INFO - 'NO_EM_RESTART': '1', 14:28:38 INFO - 'PAGER': '/bin/cat', 14:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:38 INFO - 'PWD': '/builds/slave/test', 14:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:38 INFO - 'SHELL': '/bin/bash', 14:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:38 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:38 INFO - 'USER': 'cltbld', 14:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:38 INFO - 'XPC_FLAGS': '0x0', 14:28:38 INFO - 'XPC_SERVICE_NAME': '0', 14:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:41 INFO - warning: no files found matching '*.txt' 14:28:41 INFO - no previously-included directories found matching 'build' 14:28:41 INFO - no previously-included directories found matching 'dist' 14:28:41 INFO - no previously-included directories found matching '.git*' 14:28:41 INFO - Installing collected packages: jsonschema, functools32 14:28:41 INFO - Running setup.py install for functools32 14:28:41 INFO - warning: no files found matching '*.txt' 14:28:41 INFO - no previously-included directories found matching 'build' 14:28:41 INFO - no previously-included directories found matching 'dist' 14:28:41 INFO - no previously-included directories found matching '.git*' 14:28:41 INFO - Successfully installed jsonschema functools32 14:28:41 INFO - Cleaning up... 14:28:41 INFO - Return code: 0 14:28:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:28:41 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')]} 14:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:41 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')]} 14:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:41 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:41 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 14:28:41 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 14:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:41 INFO - 'HOME': '/Users/cltbld', 14:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:41 INFO - 'LOGNAME': 'cltbld', 14:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:41 INFO - 'MOZ_NO_REMOTE': '1', 14:28:41 INFO - 'NO_EM_RESTART': '1', 14:28:41 INFO - 'PAGER': '/bin/cat', 14:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:41 INFO - 'PWD': '/builds/slave/test', 14:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:41 INFO - 'SHELL': '/bin/bash', 14:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:41 INFO - 'USER': 'cltbld', 14:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:41 INFO - 'XPC_FLAGS': '0x0', 14:28:41 INFO - 'XPC_SERVICE_NAME': '0', 14:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:28:41 INFO - Cleaning up... 14:28:41 INFO - Return code: 0 14:28:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:41 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')]} 14:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:41 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')]} 14:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:41 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:41 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 14:28:41 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 14:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:41 INFO - 'HOME': '/Users/cltbld', 14:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:41 INFO - 'LOGNAME': 'cltbld', 14:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:41 INFO - 'MOZ_NO_REMOTE': '1', 14:28:41 INFO - 'NO_EM_RESTART': '1', 14:28:41 INFO - 'PAGER': '/bin/cat', 14:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:41 INFO - 'PWD': '/builds/slave/test', 14:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:41 INFO - 'SHELL': '/bin/bash', 14:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:41 INFO - 'USER': 'cltbld', 14:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:41 INFO - 'XPC_FLAGS': '0x0', 14:28:41 INFO - 'XPC_SERVICE_NAME': '0', 14:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:45 INFO - Downloading docopt-0.6.1.tar.gz 14:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:46 INFO - Running setup.py install for blobuploader 14:28:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:46 INFO - Running setup.py install for requests 14:28:46 INFO - Running setup.py install for docopt 14:28:46 INFO - Successfully installed blobuploader requests docopt 14:28:46 INFO - Cleaning up... 14:28:46 INFO - Return code: 0 14:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:46 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')]} 14:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:46 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')]} 14:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:46 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:46 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 14:28:46 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 14:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:47 INFO - 'HOME': '/Users/cltbld', 14:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:47 INFO - 'LOGNAME': 'cltbld', 14:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:47 INFO - 'MOZ_NO_REMOTE': '1', 14:28:47 INFO - 'NO_EM_RESTART': '1', 14:28:47 INFO - 'PAGER': '/bin/cat', 14:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:47 INFO - 'PWD': '/builds/slave/test', 14:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:47 INFO - 'SHELL': '/bin/bash', 14:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:47 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:47 INFO - 'USER': 'cltbld', 14:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:47 INFO - 'XPC_FLAGS': '0x0', 14:28:47 INFO - 'XPC_SERVICE_NAME': '0', 14:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mJAsVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dKlD_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-todLVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-msGBRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-1LhIXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-CWeeSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-89CZBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-aLT4OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-satUtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pvCQ93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-i9pHwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AvDrqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4MnTP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0f4rls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JWPRRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mKv9tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AO8mNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:49 INFO - Running setup.py install for manifestparser 14:28:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:49 INFO - Running setup.py install for mozcrash 14:28:49 INFO - Running setup.py install for mozdebug 14:28:49 INFO - Running setup.py install for mozdevice 14:28:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:49 INFO - Running setup.py install for mozfile 14:28:49 INFO - Running setup.py install for mozhttpd 14:28:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:49 INFO - Running setup.py install for mozinfo 14:28:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Running setup.py install for mozInstall 14:28:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Running setup.py install for mozleak 14:28:50 INFO - Running setup.py install for mozlog 14:28:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Running setup.py install for moznetwork 14:28:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Running setup.py install for mozprocess 14:28:50 INFO - Running setup.py install for mozprofile 14:28:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:50 INFO - Running setup.py install for mozrunner 14:28:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:51 INFO - Running setup.py install for mozscreenshot 14:28:51 INFO - Running setup.py install for moztest 14:28:51 INFO - Running setup.py install for mozversion 14:28:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:51 INFO - Cleaning up... 14:28:51 INFO - Return code: 0 14:28:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:51 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')]} 14:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:51 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')]} 14:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:51 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:51 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 14:28:51 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 14:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:51 INFO - 'HOME': '/Users/cltbld', 14:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:51 INFO - 'LOGNAME': 'cltbld', 14:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:51 INFO - 'MOZ_NO_REMOTE': '1', 14:28:51 INFO - 'NO_EM_RESTART': '1', 14:28:51 INFO - 'PAGER': '/bin/cat', 14:28:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:51 INFO - 'PWD': '/builds/slave/test', 14:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:51 INFO - 'SHELL': '/bin/bash', 14:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:51 INFO - 'USER': 'cltbld', 14:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:51 INFO - 'XPC_FLAGS': '0x0', 14:28:51 INFO - 'XPC_SERVICE_NAME': '0', 14:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-a5Cq6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28: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)) 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5KW7wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Lp8LdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-VqvTPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-l19myd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-BtyfAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FbaPTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-IC6Qp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xinIlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-6qW0kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:52 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)) 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-htXfIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:53 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)) 14:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-y9S8L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-grt9DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:53 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)) 14:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-GaEV8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ETLmxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:53 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)) 14:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-gzip4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-GLdXMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:53 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)) 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:53 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)) 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:56 INFO - Downloading blessings-1.6.tar.gz 14:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:56 INFO - Installing collected packages: blessings 14:28:56 INFO - Running setup.py install for blessings 14:28:56 INFO - Successfully installed blessings 14:28:56 INFO - Cleaning up... 14:28:56 INFO - Return code: 0 14:28:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:56 INFO - Reading from file tmpfile_stdout 14:28:56 INFO - Current package versions: 14:28:56 INFO - blessings == 1.6 14:28:56 INFO - blobuploader == 1.2.4 14:28:56 INFO - docopt == 0.6.1 14:28:56 INFO - functools32 == 3.2.3-2 14:28:56 INFO - jsonschema == 2.5.1 14:28:56 INFO - manifestparser == 1.1 14:28:56 INFO - mozInstall == 1.12 14:28:56 INFO - mozcrash == 0.17 14:28:56 INFO - mozdebug == 0.1 14:28:56 INFO - mozdevice == 0.48 14:28:56 INFO - mozfile == 1.2 14:28:56 INFO - mozhttpd == 0.7 14:28:56 INFO - mozinfo == 0.9 14:28:56 INFO - mozleak == 0.1 14:28:56 INFO - mozlog == 3.4 14:28:56 INFO - moznetwork == 0.27 14:28:56 INFO - mozprocess == 0.23 14:28:56 INFO - mozprofile == 0.28 14:28:56 INFO - mozrunner == 6.12 14:28:56 INFO - mozscreenshot == 0.1 14:28:56 INFO - mozsystemmonitor == 0.3 14:28:56 INFO - moztest == 0.7 14:28:56 INFO - mozversion == 1.4 14:28:56 INFO - psutil == 3.1.1 14:28:56 INFO - requests == 1.2.3 14:28:56 INFO - wsgiref == 0.1.2 14:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:56 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:56 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 14:28:56 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 14:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:56 INFO - 'HOME': '/Users/cltbld', 14:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:56 INFO - 'LOGNAME': 'cltbld', 14:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:56 INFO - 'MOZ_NO_REMOTE': '1', 14:28:56 INFO - 'NO_EM_RESTART': '1', 14:28:56 INFO - 'PAGER': '/bin/cat', 14:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:56 INFO - 'PWD': '/builds/slave/test', 14:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:56 INFO - 'SHELL': '/bin/bash', 14:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:56 INFO - 'USER': 'cltbld', 14:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:56 INFO - 'XPC_FLAGS': '0x0', 14:28:56 INFO - 'XPC_SERVICE_NAME': '0', 14:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 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)) 14:28:57 INFO - Cleaning up... 14:28:57 INFO - Return code: 0 14:28:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:57 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 0x104bfa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b70570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd5354c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, '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.qNDHsufBdn/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.1B1OZBIycr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 14:28:57 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 14:28:57 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 14:28:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:28:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:57 INFO - 'HOME': '/Users/cltbld', 14:28:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:57 INFO - 'LOGNAME': 'cltbld', 14:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:57 INFO - 'MOZ_NO_REMOTE': '1', 14:28:57 INFO - 'NO_EM_RESTART': '1', 14:28:57 INFO - 'PAGER': '/bin/cat', 14:28:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:57 INFO - 'PWD': '/builds/slave/test', 14:28:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:57 INFO - 'SHELL': '/bin/bash', 14:28:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:28:57 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:28:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:57 INFO - 'USER': 'cltbld', 14:28:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:57 INFO - 'XPC_FLAGS': '0x0', 14:28:57 INFO - 'XPC_SERVICE_NAME': '0', 14:28:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:57 INFO - Cleaning up... 14:28:57 INFO - Return code: 0 14:28:57 INFO - Running post-action listener: _resource_record_post_action 14:28:57 INFO - Running post-action listener: _start_resource_monitoring 14:28:57 INFO - Starting resource monitoring. 14:28:57 INFO - [mozharness: 2016-10-19 21:28:57.468408Z] Finished create-virtualenv step (success) 14:28:57 INFO - [mozharness: 2016-10-19 21:28:57.469368Z] Running install step. 14:28:57 INFO - Running pre-action listener: _resource_record_pre_action 14:28:57 INFO - Running main action method: install 14:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:57 INFO - Reading from file tmpfile_stdout 14:28:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:57 INFO - Reading from file tmpfile_stdout 14:28:57 INFO - Output received: 14:28:57 INFO - Usage: mozinstall [options] installer 14:28:57 INFO - Options: 14:28:57 INFO - -h, --help show this help message and exit 14:28:57 INFO - -d DEST, --destination=DEST 14:28:57 INFO - Directory to install application into. [default: 14:28:57 INFO - "/builds/slave/test"] 14:28:57 INFO - --app=APP Application being installed. [default: firefox] 14:28:57 INFO - mkdir: /builds/slave/test/build/application 14:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:29:30 INFO - Reading from file tmpfile_stdout 14:29:30 INFO - Output received: 14:29:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:29:30 INFO - Running post-action listener: _resource_record_post_action 14:29:30 INFO - [mozharness: 2016-10-19 21:29:30.388732Z] Finished install step (success) 14:29:30 INFO - [mozharness: 2016-10-19 21:29:30.388876Z] Running run-tests step. 14:29:30 INFO - Running pre-action listener: _resource_record_pre_action 14:29:30 INFO - Running main action method: run_tests 14:29:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:30 INFO - 2016-10-19 14:29:30.403 screenresolution[1637:7658] starting screenresolution argv=screenresolution get 14:29:30 INFO - 2016-10-19 14:29:30.406 screenresolution[1637:7658] Display 0: 1600x1200x32@60 14:29:30 INFO - 2016-10-19 14:29:30.411 screenresolution[1638:7660] starting screenresolution argv=screenresolution list 14:29:30 INFO - Available Modes on Display 0 14:29:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:30 INFO - Intel Iris: 14:29:30 INFO - Chipset Model: Intel Iris 14:29:30 INFO - Type: GPU 14:29:30 INFO - Bus: Built-In 14:29:30 INFO - VRAM (Dynamic, Max): 1536 MB 14:29:30 INFO - Vendor: Intel (0x8086) 14:29:30 INFO - Device ID: 0x0a2e 14:29:30 INFO - Revision ID: 0x0009 14:29:30 INFO - Displays: 14:29:30 INFO - Display: 14:29:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:30 INFO - Display Serial Number: 1600x1200 60 14:29:30 INFO - Main Display: Yes 14:29:30 INFO - Mirror: Off 14:29:30 INFO - Online: Yes 14:29:30 INFO - Rotation: Supported 14:29:30 INFO - Return code: 0 14:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:30 INFO - Python 2.7.3 14:29:30 INFO - Return code: 0 14:29:30 INFO - grabbing minidump binary from tooltool 14:29:30 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')]} 14:29:30 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 0x104a0ed30>, '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 0x104874db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a06b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:30 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 14:29:30 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 14:29:30 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 14:29:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:30 INFO - Return code: 0 14:29:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:29:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:29:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 14:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 14:29:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qNDHsufBdn/Render', 14:29:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:29:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:29:30 INFO - 'HOME': '/Users/cltbld', 14:29:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:29:30 INFO - 'LOGNAME': 'cltbld', 14:29:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:30 INFO - 'MOZ_NO_REMOTE': '1', 14:29:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:30 INFO - 'NO_EM_RESTART': '1', 14:29:30 INFO - 'PAGER': '/bin/cat', 14:29:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:30 INFO - 'PWD': '/builds/slave/test', 14:29:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:29:30 INFO - 'SHELL': '/bin/bash', 14:29:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1B1OZBIycr/Listeners', 14:29:30 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 14:29:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:29:30 INFO - 'USER': 'cltbld', 14:29:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:29:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:30 INFO - 'XPC_FLAGS': '0x0', 14:29:30 INFO - 'XPC_SERVICE_NAME': '0', 14:29:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:29:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 14:29:30 INFO - mozversion application_buildid: 20161019115222 14:29:30 INFO - mozversion application_changeset: 33bc172941df74d989e77412854cae45682f5501 14:29:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:29:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:30 INFO - mozversion application_name: Firefox 14:29:30 INFO - mozversion application_remotingname: firefox-dev 14:29:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:29:30 INFO - mozversion application_vendor: Mozilla 14:29:30 INFO - mozversion application_version: 51.0a2 14:29:30 INFO - mozversion platform_buildid: 20161019115222 14:29:30 INFO - mozversion platform_changeset: 33bc172941df74d989e77412854cae45682f5501 14:29:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:29:30 INFO - mozversion platform_version: 51.0a2 14:29:30 INFO - using testdate: 1476912570 14:29:30 INFO - actual date: 1476912570 14:29:30 INFO - starting webserver on 'localhost:49283' 14:29:30 INFO - SUITE-START | Running 2 tests 14:29:30 INFO - TEST-START | dromaeo_css 14:29:30 INFO - operating with platform_type : mac_ 14:29:30 INFO - Initialising browser for dromaeo_css test... 14:29:31 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpTF1Fh2/profile http://localhost:49283/getInfo.html) 14:29:33 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 14:29:33 INFO - PROCESS | 1648 | colorDepth:24 14:29:33 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 14:29:33 INFO - PROCESS | 1648 | __metrics 14:29:33 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 14:29:34 INFO - TEST-INFO | 1648: exit 0 14:29:34 INFO - Browser initialized. 14:29:34 INFO - Running cycle 1/1 for dromaeo_css test... 14:29:34 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpTF1Fh2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:46 INFO - PROCESS | 1651 | RSS: Main: 225284096 14:29:46 INFO - PROCESS | 1651 | 14:30:36 INFO - PROCESS | 1651 | 1476912636405 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:32:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 14:32:49 INFO - PROCESS | 1651 | RSS: Main: 237002752 14:32:49 INFO - PROCESS | 1651 | 14:35:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 14:35:52 INFO - PROCESS | 1651 | RSS: Main: 248852480 14:35:52 INFO - PROCESS | 1651 | 14:38:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 14:38:54 INFO - PROCESS | 1651 | RSS: Main: 252219392 14:38:54 INFO - PROCESS | 1651 | 14:41:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 14:41:57 INFO - PROCESS | 1651 | RSS: Main: 252588032 14:41:57 INFO - PROCESS | 1651 | 14:45:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 14:45:00 INFO - PROCESS | 1651 | RSS: Main: 256913408 14:45:00 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 14:48:03 INFO - PROCESS | 1651 | RSS: Main: 258797568 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | __start_tp_report 14:48:03 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 14:48:03 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 14:48:03 INFO - PROCESS | 1651 | |i|pagename|runs| 14:48:03 INFO - PROCESS | 1651 | |0;dojo.html;3127.6715944825796;3359.781614195077;3368.3936891359576;3391.236971681372;3424.726021918246;5807.245058142441;5811.912821307684;5824.970875145629;5842.298924129105;5861.238039054928;5670.659760414378;5839.591228613998;5862.73617687204;5881.500072493843;5886.411358864122;5260.210968354749;5296.894062118756;5307.681539107666;5351.117065684158;5353.250544923714;5322.254884316179;5351;5367.382750983647;5372.516473517383;5374.4894235047805;5171.405288391846;5230.2416149658275;5261.86845328866;5353.678779273256;5358.758855851496;5284.709340986245;5362.142057270857;5365.061114304981;5372.543333816591;5427.0773968425065;5165.612579056586;5328.387235467932;5329.387120481156;5356.571474282048;5367.597430192751;5644.350899646511;5689.061304884689;5757.740901659436;5852.444017818343;6002.669853158074;5666.688332141731;6154.292256390528;6177.289611694668;6177.81466556004;6185.41238582334;4349.499807522144;6236.719347629368;6266.154069200691;6271.122042913996;6284.34014428483;5799.507041901401;5865.237519122486;5914;5916.230889984317;5927.170196172539;5372.462753724596;6148.907766383508;6191.442770150708;6193.163922870355;6309.022101574264;5178.300929374562;6254.999200127958;6257.092721555349;6260.780872669435;6270.717817698123;5989.970050149721;6253.74985000604;6278.183836101369;6279.686015699197;6281.2462504498835;4957.876053098701;6068.726907289094;6209.59637623553;6217.658028808459;6252.749890004349;6220.942439785247;6223.066540018943;6235.438810507076;6237.157983672146;6267.4986001119805;4981.8329026873425;4991.700497970133;4997.150484417658;5001.924971125436;5008.64939454242;4352.303631418958;4388.4733831940375;4398;4422.71252368595;4434.024514606781;5733.0540460823495;5826.82519524415;5948.702564871739;5967.6121052131475;5985.880282394328;6183.938160618426;6215.440610345091;6223.190985171898;6227.813165605039;6240.4071613196675;5853.239078919713;5917.733701983421;5961.552883533753;5975.641461512323;6055.848603784941;5456.672599644034;5479.068558345091;5486.725663716798;5513.062779327443;5514.6691198528215;6401.29585745577;6401.583897046677;6420.293767685551;6424.100625912376;6445.065465507569;6126.670355029888;6135.07955838608;6178.62928224308;6221.9377806221355;6230.376962303733;6324.778632747832;6333.334999824952;6338.176037115146;6338.968305158444;6353.555251132377;4836.733979631154;6219.689015549295;6248.187735594343;6264.279607844974;6289.622622642656;4814.5907597853175;5947.375525569926;6172.814815555541;6228.532860035425;6244.132393184529;6119.571629985859;6135.325114237341;6187.690615469119;6203.4416902479;6224.128621993015;6148.50811935053;6180.4746596538;6196.628202307876;6206.844828879133;6227.1282020516255;5128.282040514257;5753.597248192586;5915.438033386821;6033.155358249936;6060.000099983454;6114.69277300208;6132.722655450899;6148;6151.354107818794;6192.969035154795;6018.638881667114;6021.548383871314;6033.215681961317;6045.788397406246;6065.059915713072 14:48:03 INFO - PROCESS | 1651 | |1;ext.html;480.0159672671023;514.2466286889706;525.7634064670898;528.4741682026385;534.8582625604215;38441.615583844155;42405.515806946765;42637.57362426375;44268;44373.890652733695;43320.3501947471;43558;43688.9077773055;43841;43967.340489892675;7591.658375373094;8251.504909705407;8548.999999999984;8893.155150260714;9907.801843963116;9711;9745.951270243675;9820.312578119534;9874.703758887208;9877.259205559576;9828.312018158696;9866.309358344883;9879.110880020797;9916.95041524795;9939.850902236472;8220.547869867154;9835.164011059069;9848.60605575776;9854.113129818279;9887.55506002228;9691.563879625433;9709.805803883954;9730.270229732798;9746.951265243628;9806.16647584956;40465.59534404648;41278.58721412777;41300.58699413027;41542.37686434706;41697.166056679;3238.805671659708;3439.3637177122314;3451.4995325677887;3827.158025234444;4194.30793919003;29775.957841475443;30424;30903.381932361226;31372;31417.37165256705;3205.6153261608524;3217.7264932480766;3298.802071875671;3307.834608269601;3320.2197483591335;520282;532386;532802;533206.3339683316;536529;61284.693576531834;61489;61831.690841545504;62015.6899215501;62032;34709;35682.64317356845;35693.46459803105;36707.81646091752;36730.44904326437;16228.269727862275;17006.744898826528;17080.316787328367;17107.973521588745;17161.485155445356;12895.161814482217;13039.543615973396;13166.539171128965;13166.868331316564;13180.868191317964;19116.203919391737;19133.521661958282;19492.769854899212;19579.00101427486;19604.411867643994;6963.8607227855155;7240.637968101574;7946.284834364935;7983.20167983197;7995.320397766255;823.9258466738022;859.3426029087752;954.5275088831073;954.8424509955919;1090.5038207615517;29533.556996645068;29714.257143571584;29966.55050174249;30292.54561181584;30486.84756576203;1003.5333569890037;1008.8486726990864;1024.9846252306222;1067.1409515340226;1087.526925787285;12855.357232138356;15333.616659583377;15373.846961477933;15584.298706558233;15673.373065077498;710395;710599;720331;720910;721423;55967.160492592644;57031.71484142636;57291.71354143286;57742;57893.710531447075;1182.7752726981846;1338.6184937292826;1361.9591412257648;1368.1790925444654;1383.3429121167364;28654.28364290826;29205.7079429203;29545.556816648197;29642.407151857275;30029;49916.75041624768;50448.991020178655;50551.74724126356;50734;50856.237156441945;545165;594161;599508;601793;607099;26330.473390532465;26350.341241468348;26742.732572674024;26757.86621066882;26772.330691732863;35359;39437.80281098576;45507;46679.29981050355;46917.53082469268;32179;38753.03117422087;39485.605143948196;40242.93319337206;40282.79858600688;38726.419103712906;39866.60133398745;39904;40073;40219.798901005306;29173.85413072921;31348;37675.62324376721;38052.809735951145;38670.41994370143;32890.83554582212;34596.82701586476;34626.82686586551;35275.82362088173;35367.93896183118;25562.872185638953;26024.479510410063;26065.609015864396;26333.4733305329;26424.603630945934 14:48:03 INFO - PROCESS | 1651 | |2;jquery.html;316.7687588060716;377.3603741657889;378.71974738693376;388.29912008824095;398.98458423312667;18946.24215031399;19391.709124363148;20247.392578222676;20406.795932040695;20726.68909966348;18390.35633752819;19109.617807643874;19815.5046123847;20286.782793032427;20349.59300813983;5272.31459910213;5360.490753378443;5410.810621628234;5461.781528738866;5482.91775623366;5306.204069389584;5333.946660533403;5441.156620723794;5452.563794896399;5460.5085542301185;5286.894262114774;5297.17893726473;5443.374011988612;5470.015397228497;5489.39616642169;5953.404659534033;5968.074948383008;5985.431384018555;6038.822429626224;6041.516678665718;5130.819911420394;5204.9739751301;5326.98787230425;5328.17413300939;5335.946640533583;13038.41327140281;13195.472181112744;13243.271620060892;13335.933320333434;20840.47898802527;2271.8864056797092;2352.882355882199;2422.8061755059553;2913.242556935212;2946.9243726040054;7858.253465920729;9791.951040244825;10022.59909603615;10033.849492257623;10321.277510574262;1803.0894398328892;1856.8700190986635;1872.7190921361769;1893.8958357290344;1909.5894382707645;117134;119987.400063;121407;121648;122770.15844762335;11406.771864562663;11707.941460292644;11833.88166118345;11842.348670823187;11894.524219031315;14508.911831612671;14785.186814725294;14788;14850.777238341434;14873.851261487463;8585.957070214734;8605.827883442422;8646.308295336357;8747.518886461306;8816.911830881738;8478.788030299293;8488.278496327881;8663.48019118855;8723.825523489495;8724.389292749574;4478.888027799331;4548.204064288736;4552.658550608718;4659.673822832369;4691.906161876744;1952.6582848001542;1963.2245263120988;1986.2452268138304;1986.3246496191364;1990.9701354479694;834.5159807311744;841.8526757817358;918.3250311021394;980.7057882635181;1012.8075665623508;19543.413697589094;20309.593808123755;20703.171873124906;21190;21275.78894848447;932.6595792535811;954.4464210757744;973.5132433783108;996.5465713100522;1014.8021135878433;8342.958285208535;8517.74446766598;9521.952390238004;10822;11560.537578496765;483597;486704;490063;530056;547788;96377;146773.26613366866;147151;148896;149633.25183374013;923.7690577355661;956.7273327101603;969.8351280282369;970.5583959298643;970.8203982263162;18899.338523151622;19395;19584;19645.803541964968;19684.01579921027;42012;56013;56072.719636401554;58614.4138558626;58672;82021;82751.5862420684;84165.73751393857;84873.15126848653;85172;6656.667166641745;6778.593284402951;8064.717734879251;8090.11008789021;8114.959425202836;12015.219010764273;12689.936550317188;13009.959203263526;13097.279649618982;13180.934095329845;11065.778684426428;11214.990650841137;11250.324980501196;11437.542498299976;11659.18385713026;10909.836352454879;10972.067374272958;11208.775824483302;11232.213745037769;11324.943375283401;10206.846897296398;10836.970487803646;11249.606263780728;11415.714607134889;11820.70448238801;6822.215445223863;7849.803754906173;7964.601769911597;8226.42415030966;8315.667373305;11103.16726245551;11198.328100314007;11296;11641.6507504775;11670.008049315564 14:48:03 INFO - PROCESS | 1651 | |3;mootools.html;1347.4138749643905;1524.8627623513883;1706.7866516685415;1811.420345489444;1856.4152292028018;8029.558374289411;8113.8782918256275;8339.833203335937;8952.104789521045;9022.684206052782;8528.744137675863;8630.136986301366;8650.653973841054;8886.86669699955;8896.1103889611;2377.643353496972;2409.373562873648;2414.0705828256073;2414.3360575841607;2417.407735104902;2363.657269695893;2381.95236095278;2415.251272105644;2427.2596857958315;2431.6474111253856;2361.7992470640015;2371.7509661485556;2401.687780588521;2424.599941009731;2424.781769640732;2363.775441333079;2380.4286971126976;2386.319898828834;2397.2209032064648;2402.2913240594066;2012.7685316188679;2375.6340104440014;2387.403149212697;2388.737238903719;2388.8924998375114;8842.381033327669;8849.823003539957;9025.05236950124;9027.548622568911;9059.411138275991;5228;5351.224072509464;5393.1370980643305;5403.081476149025;5430.728463576806;3611.079174810433;3640.5995340512522;3652.853885844563;3679.0066681995977;3701.370766969622;1081.9513121909533;1086.7446150154708;1086.8152414089623;1100.5377741348652;1112.2214449885112;11654.650360489199;11728.706782330424;11805.40972951349;11814.23207491519;11821.94089029558;4742.170120228946;4748.358971538798;4804.66390811941;4859.878503037452;4923.729194894315;9891.258155638356;9991.250656200815;10018.048285412875;10028.64899728506;10066.345687530287;5387.488188622075;5387.649802762808;5389.434109418533;5396.298481197419;5404.108322126884;4458.9554104459185;4480.663950203748;4667.346571479996;4799.656096293043;4933.309336692866;3453.637368076316;3572.6427357264065;3610.205754733954;3702.4631428443263;3968.1071758854027;1238.3189245914712;1323.5499930023645;1326.2241588670543;1349.7772867476756;1356.2879488268738;760.1828034862434;805.5086397297644;897.4211633496358;911.4121391702315;921.9443736921188;5521.834344969658;5677.078135914629;5732.799352022659;5821.52050627112;6022.939770602326;895.9955200223957;914.8170365926841;927.7866090799154;937.0395344771528;975.2295686407658;3625.1118475973553;3959.524857017119;3961.029547760817;3987.3620220764537;3996.800159991989;8840.911590884138;10122.848157277647;10651.98806113418;10677.039066484054;10701.892981070245;10018.949905250427;10252.743681408025;10275.537600807982;10584.629537966135;10601.893981060091;7904.407169462198;7957.045154581371;8013.759587212393;8126.390520710852;8154.306883914815;5867.911981320198;5875.735591898289;5949.940500595112;5991.131285963424;6095.05526643371;9518.809623807347;9713.465759383302;9874.85187722199;9934.850977235203;9971.800563988825;8602.78493037679;8825.338099642424;10139.543720532447;10178.745531361776;10197.184225261813;7017.403520700797;7117.857642847218;7375.446841486802;7536.811579710551;7544.09470863478;8053.637586308513;8438.493690378597;8474.491530508189;8485.490870547786;8503.574821259035;7349.530093981119;7525;7540.773776786705;7554.169041405331;7603.7338693145475;7337.046183996046;7337.449691273283;7374.299441553044;7376;7507.624618769149;6897.3447522485285;7026.508144429841;7028.543144695578;7030.156381234285;7046;4868.561829435368;4898.020395920759;4933.260010998379;4944.381952255968;5063.113955057924;4270.850520231777;4969.35398398206;5031.094403007347;5125.128728116155;5128.79484820603 14:48:03 INFO - PROCESS | 1651 | |4;prototype.html;291.69663549908097;296.91389497045856;304.97102775236345;306.6427611832216;307.19055289312655;4839.975800120995;5481.588880833939;5489.517830185858;5582.692951887645;5611.607187496872;4431.8670439886855;5192.92210616841;5368.248445217663;5414.945850541493;5433.582055985088;3268.084936217863;3828.8659896903614;4005.1388951375448;4111.506619205699;4205.465005273084;3738.084169378506;3989.68082553395;4195.895102622429;4196.559361267069;4219.282721937278;4046.8381264749373;4106.77412742299;4130.153318569701;4147.81334839933;4147.9927052886715;3584.5160903277983;4146.357314616239;4161.105362347094;4165.708400411972;4175.728577642443;3577.731670124751;3644.922394235287;3647.246329021572;3648.72634552407;3669.3578623741005;4935.679180853269;5280.287161233261;5385.892282154374;5386;5392.865178370533;4144.295469770146;4762.809487620491;4779.378680771478;4781.947971446276;4785.880352991168;4408.25059739845;4763.95236047642;5146.768395422215;5201.751579620902;5361.463853614647;3667.7982710950887;3876.7286289959716;3895.7081266329906;3903.882883513499;3911.804409779528;4866.172750632366;5236.633435659505;5488;6075.33171351151;6173.259208894917;3713.424419215026;3975.185087057146;3977.204559088194;3990.3216453202444;4004.2592120457807;3903.1998440319667;3969.7816620085596;4048.6963477739287;4053.777042262645;4063.817128229237;3883.1943146437043;4458.464984201916;4710.788014539354;4712.882177945578;4737.294573953374;5145.691258524501;5205.375354957354;5879.911801322984;5940.31686356066;5965.791197308074;1041.031840388446;1211.3700875544844;1341.7651910915552;1355.5662188099714;1356.819566976717;855.8288342331558;902.4540153207346;917.2982668258787;920.9263258939269;921.4102974096584;4791.880202994953;4959.2809042688605;5079.8984020319385;5399.541039011649;5422.48486393792;5184.459614788801;5215.217717342353;5924.6149000314845;5926.259217597801;5932.970335148297;4793.472718001017;4834.540718631724;4942.851714448572;5091.465396133352;5381;2320.3271051395245;2620.375367272265;2648.576227803542;2649.0132400699476;2656.694480134809;4389.517153113155;5196.428392876781;5199.350081239845;5235.712035838065;5256.845892464567;4594.554084436672;4625.606823419979;4926.852194434101;5187.844364669066;5259.105951988171;5193;5332.413434522277;5491.615586908878;5919.3192782829665;6279.654618995999;4795.304680821331;5687.9523371585365;6002.429769171922;6098;6115.602485838406;4493.59557639814;5031;5822.758238078455;5841.883162336814;5895.557833162616;6212.844678883064;6242.219722534684;6269.247690277196;6333.809985700436;6348.238211414659;3821.636944490269;3903.330124169915;3968.66266367362;3981.8407263710287;3985.6612187964347;5556.333240011225;5694.971525142348;5905.52755779528;6013.458788708862;6018.4583387493585;5635.802746903839;5729.4843464088435;5741.712914354349;5807.796727114531;5849.356570777126;5767.7404516796005;5791.218185544897;5806;5806.387125793325;5818.2436283282905;4714.481407045154;5347.973260133675;5652.3217213934595;5692.356891589303;5747.166660834072;5011.97254562821;5323.30796996388;5831.1836342912875;5883.882322353615;5887.087501437284;4693.765311734332;4937.77779999908;5621;5729.427057294237;5737.8565535861935 14:48:03 INFO - PROCESS | 1651 | |5;yui.html;728.4427413029033;771.9614019299033;775.3758224629171;808.7250334886138;829.133555434571;15097.320620572073;15112.319945602447;15244.771328430083;15402.152881591535;15444.996075255101;13954.720905581908;14013.579592612212;14039.157650540948;14058.015938884257;14058.578242652711;818.9918100818975;825.0511911301991;853.3770347646222;858.5235194467068;860.6987554355987;813.4590497319305;815.6859609050499;816.7958010497375;818.7953011747063;849.7068511363569;877.1272583779148;891.3671293381707;898.2589363774879;899.2131884600974;901.4185850126664;858.1461445861346;867.7440155154245;869.148234729965;895.359817730326;895.789489469974;575.7955925646377;587.9118132280149;638.2118084166051;639.3638329861817;655.9540832141752;14956.40174393023;15110.54668359951;15215.543533694006;15228.923855380763;15265.771013434807;13824.377902994289;13991;14087.295635218197;14189.78715319271;14190.148591084464;11862.52549898003;11899.464524096436;11939.10456715741;12166.878331216663;12248.755024899541;3240;3764.4917936078555;3791.907744506397;3820.0449887528116;3828.9042773930873;112473.43763281131;117881.23178152334;119517.40241298825;120140;123697;10541.262111652264;10820.815903215069;10937.070349020423;11061.502232399562;11286.717832054264;22041.669374959387;22066.558668826532;22140.778592213872;22199.556008879732;22217.77782222157;7786.377089832799;7983.481073730305;7986.920130798734;8004.799880003046;8124.228198321268;3687.9078023049638;4424.159409712144;4487.6634252431195;4524.506912718795;4525.298578720303;3635.9818200908826;3734.8319325630414;3769.208466222124;3775.754575952554;3783.281176576442;632.8987362022054;668.2014992084412;677.7085853083123;684.6782012454139;687.0107045854054;535.6839464715758;541.8347404041726;674.8123302986778;675.3887731602907;696.9163700355888;7332.790089635258;8355.373346999;8611;8689.78343031976;9441.386309889835;657.9769708060195;666.9699863506154;677.0994577212296;679.3172861274486;692.1106378303855;4523.2988886722615;4669.276262179367;4686;4704.129735998783;4721.598664113589;89635;167743;168004;170041;177275.11362443105;113708.29437558443;147133.26433367978;147154;147157.52842471653;153555.2322238404;98984.01015989891;109951;122903;126471.47057058808;129451;8986.82026359456;9032.14194651507;9050.909490905007;9051.683191088543;9259.76850578741;68097;68358;69080.30919690739;70412.64793676203;71853.92219116613;106081;107087;108513.45743271233;110219;110836;11636.650900473;11785.057195424517;11921.940390297994;11939.343336116597;11947.940260298643;12724.554640587905;12874.806877896652;12925;13077.215367078006;13198.538051168163;11699.824502632297;11818.349990750592;12347.69130771738;12364.134510584172;12731.490740370651;11954.76090478203;12495.062870284582;12653.177543460013;12767.61697149087;12768.36158192068;11283.830742539032;11632.651020469399;12012.63962081139;12118.212316199419;12296.938515307365;9928.25538084661;10127.341722787995;10320.948395257976;10715.517801698787;10843.67468975932;9366.438013719198;10085.949570252102;10633.521491533054;10655.57377704883;10688.732781680521 14:48:03 INFO - PROCESS | 1651 | __end_tp_report 14:48:03 INFO - PROCESS | 1651 | __start_cc_report 14:48:03 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,363 14:48:03 INFO - PROCESS | 1651 | __end_cc_report 14:48:03 INFO - PROCESS | 1651 | __startTimestamp1476913683255__endTimestamp 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | ------- Summary: start ------- 14:48:03 INFO - PROCESS | 1651 | Number of tests: 6 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5751.08 Median:5975.64 stddev:652.49 (10.9%) stddev-sans-first:621.19 14:48:03 INFO - PROCESS | 1651 | Values: 3127.7 3359.8 3368.4 3391.2 3424.7 5807.2 5811.9 5825.0 5842.3 5861.2 5670.7 5839.6 5862.7 5881.5 5886.4 5260.2 5296.9 5307.7 5351.1 5353.3 5322.3 5351.0 5367.4 5372.5 5374.5 5171.4 5230.2 5261.9 5353.7 5358.8 5284.7 5362.1 5365.1 5372.5 5427.1 5165.6 5328.4 5329.4 5356.6 5367.6 5644.4 5689.1 5757.7 5852.4 6002.7 5666.7 6154.3 6177.3 6177.8 6185.4 4349.5 6236.7 6266.2 6271.1 6284.3 5799.5 5865.2 5914.0 5916.2 5927.2 5372.5 6148.9 6191.4 6193.2 6309.0 5178.3 6255.0 6257.1 6260.8 6270.7 5990.0 6253.7 6278.2 6279.7 6281.2 4957.9 6068.7 6209.6 6217.7 6252.7 6220.9 6223.1 6235.4 6237.2 6267.5 4981.8 4991.7 4997.2 5001.9 5008.6 4352.3 4388.5 4398.0 4422.7 4434.0 5733.1 5826.8 5948.7 5967.6 5985.9 6183.9 6215.4 6223.2 6227.8 6240.4 5853.2 5917.7 5961.6 5975.6 6055.8 5456.7 5479.1 5486.7 5513.1 5514.7 6401.3 6401.6 6420.3 6424.1 6445.1 6126.7 6135.1 6178.6 6221.9 6230.4 6324.8 6333.3 6338.2 6339.0 6353.6 4836.7 6219.7 6248.2 6264.3 6289.6 4814.6 5947.4 6172.8 6228.5 6244.1 6119.6 6135.3 6187.7 6203.4 6224.1 6148.5 6180.5 6196.6 6206.8 6227.1 5128.3 5753.6 5915.4 6033.2 6060.0 6114.7 6132.7 6148.0 6151.4 6193.0 6018.6 6021.5 6033.2 6045.8 6065.1 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:73150.64 Median:40231.37 stddev:165500.20 (411.4%) stddev-sans-first:165874.53 14:48:03 INFO - PROCESS | 1651 | Values: 480.0 514.2 525.8 528.5 534.9 38441.6 42405.5 42637.6 44268.0 44373.9 43320.4 43558.0 43688.9 43841.0 43967.3 7591.7 8251.5 8549.0 8893.2 9907.8 9711.0 9746.0 9820.3 9874.7 9877.3 9828.3 9866.3 9879.1 9917.0 9939.9 8220.5 9835.2 9848.6 9854.1 9887.6 9691.6 9709.8 9730.3 9747.0 9806.2 40465.6 41278.6 41300.6 41542.4 41697.2 3238.8 3439.4 3451.5 3827.2 4194.3 29776.0 30424.0 30903.4 31372.0 31417.4 3205.6 3217.7 3298.8 3307.8 3320.2 520282.0 532386.0 532802.0 533206.3 536529.0 61284.7 61489.0 61831.7 62015.7 62032.0 34709.0 35682.6 35693.5 36707.8 36730.4 16228.3 17006.7 17080.3 17108.0 17161.5 12895.2 13039.5 13166.5 13166.9 13180.9 19116.2 19133.5 19492.8 19579.0 19604.4 6963.9 7240.6 7946.3 7983.2 7995.3 823.9 859.3 954.5 954.8 1090.5 29533.6 29714.3 29966.6 30292.5 30486.8 1003.5 1008.8 1025.0 1067.1 1087.5 12855.4 15333.6 15373.8 15584.3 15673.4 710395.0 710599.0 720331.0 720910.0 721423.0 55967.2 57031.7 57291.7 57742.0 57893.7 1182.8 1338.6 1362.0 1368.2 1383.3 28654.3 29205.7 29545.6 29642.4 30029.0 49916.8 50449.0 50551.7 50734.0 50856.2 545165.0 594161.0 599508.0 601793.0 607099.0 26330.5 26350.3 26742.7 26757.9 26772.3 35359.0 39437.8 45507.0 46679.3 46917.5 32179.0 38753.0 39485.6 40242.9 40282.8 38726.4 39866.6 39904.0 40073.0 40219.8 29173.9 31348.0 37675.6 38052.8 38670.4 32890.8 34596.8 34626.8 35275.8 35367.9 25562.9 26024.5 26065.6 26333.5 26424.6 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:32676.20 Median:1631.85 stddev:86424.45 (5296.1%) stddev-sans-first:86632.74 14:48:03 INFO - PROCESS | 1651 | Values: 316.8 377.4 378.7 388.3 399.0 18946.2 19391.7 20247.4 20406.8 20726.7 18390.4 19109.6 19815.5 20286.8 20349.6 5272.3 5360.5 5410.8 5461.8 5482.9 5306.2 5333.9 5441.2 5452.6 5460.5 5286.9 5297.2 5443.4 5470.0 5489.4 5953.4 5968.1 5985.4 6038.8 6041.5 5130.8 5205.0 5327.0 5328.2 5335.9 13038.4 13195.5 13243.3 13335.9 20840.5 2271.9 2352.9 2422.8 2913.2 2946.9 7858.3 9792.0 10022.6 10033.8 10321.3 1803.1 1856.9 1872.7 1893.9 1909.6 117134.0 119987.4 121407.0 121648.0 122770.2 11406.8 11707.9 11833.9 11842.3 11894.5 14508.9 14785.2 14788.0 14850.8 14873.9 8586.0 8605.8 8646.3 8747.5 8816.9 8478.8 8488.3 8663.5 8723.8 8724.4 4478.9 4548.2 4552.7 4659.7 4691.9 1952.7 1963.2 1986.2 1986.3 1991.0 834.5 841.9 918.3 980.7 1012.8 19543.4 20309.6 20703.2 21190.0 21275.8 932.7 954.4 973.5 996.5 1014.8 8343.0 8517.7 9522.0 10822.0 11560.5 483597.0 486704.0 490063.0 530056.0 547788.0 96377.0 146773.3 147151.0 148896.0 149633.3 923.8 956.7 969.8 970.6 970.8 18899.3 19395.0 19584.0 19645.8 19684.0 42012.0 56013.0 56072.7 58614.4 58672.0 82021.0 82751.6 84165.7 84873.2 85172.0 6656.7 6778.6 8064.7 8090.1 8115.0 12015.2 12689.9 13010.0 13097.3 13180.9 11065.8 11215.0 11250.3 11437.5 11659.2 10909.8 10972.1 11208.8 11232.2 11324.9 10206.8 10837.0 11249.6 11415.7 11820.7 6822.2 7849.8 7964.6 8226.4 8315.7 11103.2 11198.3 11296.0 11641.7 11670.0 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5674.87 Median:5000.22 stddev:3146.32 (62.9%) stddev-sans-first:3138.34 14:48:03 INFO - PROCESS | 1651 | Values: 1347.4 1524.9 1706.8 1811.4 1856.4 8029.6 8113.9 8339.8 8952.1 9022.7 8528.7 8630.1 8650.7 8886.9 8896.1 2377.6 2409.4 2414.1 2414.3 2417.4 2363.7 2382.0 2415.3 2427.3 2431.6 2361.8 2371.8 2401.7 2424.6 2424.8 2363.8 2380.4 2386.3 2397.2 2402.3 2012.8 2375.6 2387.4 2388.7 2388.9 8842.4 8849.8 9025.1 9027.5 9059.4 5228.0 5351.2 5393.1 5403.1 5430.7 3611.1 3640.6 3652.9 3679.0 3701.4 1082.0 1086.7 1086.8 1100.5 1112.2 11654.7 11728.7 11805.4 11814.2 11821.9 4742.2 4748.4 4804.7 4859.9 4923.7 9891.3 9991.3 10018.0 10028.6 10066.3 5387.5 5387.6 5389.4 5396.3 5404.1 4459.0 4480.7 4667.3 4799.7 4933.3 3453.6 3572.6 3610.2 3702.5 3968.1 1238.3 1323.5 1326.2 1349.8 1356.3 760.2 805.5 897.4 911.4 921.9 5521.8 5677.1 5732.8 5821.5 6022.9 896.0 914.8 927.8 937.0 975.2 3625.1 3959.5 3961.0 3987.4 3996.8 8840.9 10122.8 10652.0 10677.0 10701.9 10018.9 10252.7 10275.5 10584.6 10601.9 7904.4 7957.0 8013.8 8126.4 8154.3 5867.9 5875.7 5949.9 5991.1 6095.1 9518.8 9713.5 9874.9 9934.9 9971.8 8602.8 8825.3 10139.5 10178.7 10197.2 7017.4 7117.9 7375.4 7536.8 7544.1 8053.6 8438.5 8474.5 8485.5 8503.6 7349.5 7525.0 7540.8 7554.2 7603.7 7337.0 7337.4 7374.3 7376.0 7507.6 6897.3 7026.5 7028.5 7030.2 7046.0 4868.6 4898.0 4933.3 4944.4 5063.1 4270.9 4969.4 5031.1 5125.1 5128.8 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4563.10 Median:5021.49 stddev:1418.45 (28.2%) stddev-sans-first:1385.73 14:48:03 INFO - PROCESS | 1651 | Values: 291.7 296.9 305.0 306.6 307.2 4840.0 5481.6 5489.5 5582.7 5611.6 4431.9 5192.9 5368.2 5414.9 5433.6 3268.1 3828.9 4005.1 4111.5 4205.5 3738.1 3989.7 4195.9 4196.6 4219.3 4046.8 4106.8 4130.2 4147.8 4148.0 3584.5 4146.4 4161.1 4165.7 4175.7 3577.7 3644.9 3647.2 3648.7 3669.4 4935.7 5280.3 5385.9 5386.0 5392.9 4144.3 4762.8 4779.4 4781.9 4785.9 4408.3 4764.0 5146.8 5201.8 5361.5 3667.8 3876.7 3895.7 3903.9 3911.8 4866.2 5236.6 5488.0 6075.3 6173.3 3713.4 3975.2 3977.2 3990.3 4004.3 3903.2 3969.8 4048.7 4053.8 4063.8 3883.2 4458.5 4710.8 4712.9 4737.3 5145.7 5205.4 5879.9 5940.3 5965.8 1041.0 1211.4 1341.8 1355.6 1356.8 855.8 902.5 917.3 920.9 921.4 4791.9 4959.3 5079.9 5399.5 5422.5 5184.5 5215.2 5924.6 5926.3 5933.0 4793.5 4834.5 4942.9 5091.5 5381.0 2320.3 2620.4 2648.6 2649.0 2656.7 4389.5 5196.4 5199.4 5235.7 5256.8 4594.6 4625.6 4926.9 5187.8 5259.1 5193.0 5332.4 5491.6 5919.3 6279.7 4795.3 5688.0 6002.4 6098.0 6115.6 4493.6 5031.0 5822.8 5841.9 5895.6 6212.8 6242.2 6269.2 6333.8 6348.2 3821.6 3903.3 3968.7 3981.8 3985.7 5556.3 5695.0 5905.5 6013.5 6018.5 5635.8 5729.5 5741.7 5807.8 5849.4 5767.7 5791.2 5806.0 5806.4 5818.2 4714.5 5348.0 5652.3 5692.4 5747.2 5012.0 5323.3 5831.2 5883.9 5887.1 4693.8 4937.8 5621.0 5729.4 5737.9 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:26252.84 Median:12728.89 stddev:43579.31 (342.4%) stddev-sans-first:43659.42 14:48:03 INFO - PROCESS | 1651 | Values: 728.4 772.0 775.4 808.7 829.1 15097.3 15112.3 15244.8 15402.2 15445.0 13954.7 14013.6 14039.2 14058.0 14058.6 819.0 825.1 853.4 858.5 860.7 813.5 815.7 816.8 818.8 849.7 877.1 891.4 898.3 899.2 901.4 858.1 867.7 869.1 895.4 895.8 575.8 587.9 638.2 639.4 656.0 14956.4 15110.5 15215.5 15228.9 15265.8 13824.4 13991.0 14087.3 14189.8 14190.1 11862.5 11899.5 11939.1 12166.9 12248.8 3240.0 3764.5 3791.9 3820.0 3828.9 112473.4 117881.2 119517.4 120140.0 123697.0 10541.3 10820.8 10937.1 11061.5 11286.7 22041.7 22066.6 22140.8 22199.6 22217.8 7786.4 7983.5 7986.9 8004.8 8124.2 3687.9 4424.2 4487.7 4524.5 4525.3 3636.0 3734.8 3769.2 3775.8 3783.3 632.9 668.2 677.7 684.7 687.0 535.7 541.8 674.8 675.4 696.9 7332.8 8355.4 8611.0 8689.8 9441.4 658.0 667.0 677.1 679.3 692.1 4523.3 4669.3 4686.0 4704.1 4721.6 89635.0 167743.0 168004.0 170041.0 177275.1 113708.3 147133.3 147154.0 147157.5 153555.2 98984.0 109951.0 122903.0 126471.5 129451.0 8986.8 9032.1 9050.9 9051.7 9259.8 68097.0 68358.0 69080.3 70412.6 71853.9 106081.0 107087.0 108513.5 110219.0 110836.0 11636.7 11785.1 11921.9 11939.3 11947.9 12724.6 12874.8 12925.0 13077.2 13198.5 11699.8 11818.3 12347.7 12364.1 12731.5 11954.8 12495.1 12653.2 12767.6 12768.4 11283.8 11632.7 12012.6 12118.2 12296.9 9928.3 10127.3 10320.9 10715.5 10843.7 9366.4 10085.9 10633.5 10655.6 10688.7 14:48:03 INFO - PROCESS | 1651 | -------- Summary: end -------- 14:48:03 INFO - PROCESS | 1651 | 14:48:03 INFO - TEST-INFO | 1651: exit 0 14:48:03 INFO - TEST-OK | dromaeo_css | took 1112948ms 14:48:03 INFO - TEST-START | kraken 14:48:03 INFO - operating with platform_type : mac_ 14:48:03 INFO - Initialising browser for kraken test... 14:48:03 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpog7vXO/profile http://localhost:49283/getInfo.html) 14:48:06 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 14:48:06 INFO - PROCESS | 1663 | colorDepth:24 14:48:06 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 14:48:06 INFO - PROCESS | 1663 | __metrics 14:48:06 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 14:48:07 INFO - TEST-INFO | 1663: exit 0 14:48:07 INFO - Browser initialized. 14:48:07 INFO - Running cycle 1/1 for kraken test... 14:48:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpog7vXO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:19 INFO - PROCESS | 1665 | RSS: Main: 225112064 14:48:19 INFO - PROCESS | 1665 | 14:48:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:23 INFO - PROCESS | 1665 | RSS: Main: 237514752 14:48:23 INFO - PROCESS | 1665 | 14:48:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 14:48:26 INFO - PROCESS | 1665 | RSS: Main: 244908032 14:48:26 INFO - PROCESS | 1665 | 14:48:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 14:48:30 INFO - PROCESS | 1665 | RSS: Main: 246898688 14:48:30 INFO - PROCESS | 1665 | 14:48:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 14:48:33 INFO - PROCESS | 1665 | RSS: Main: 249618432 14:48:33 INFO - PROCESS | 1665 | 14:48:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:35 INFO - PROCESS | 1665 | RSS: Main: 249950208 14:48:35 INFO - PROCESS | 1665 | 14:48:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:39 INFO - PROCESS | 1665 | RSS: Main: 251097088 14:48:39 INFO - PROCESS | 1665 | 14:48:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:42 INFO - PROCESS | 1665 | RSS: Main: 251252736 14:48:42 INFO - PROCESS | 1665 | 14:48:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 14:48:46 INFO - PROCESS | 1665 | RSS: Main: 251535360 14:48:46 INFO - PROCESS | 1665 | 14:48:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:48 INFO - PROCESS | 1665 | RSS: Main: 250806272 14:48:48 INFO - PROCESS | 1665 | 14:48:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:51 INFO - PROCESS | 1665 | RSS: Main: 250703872 14:48:51 INFO - PROCESS | 1665 | 14:48:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:54 INFO - PROCESS | 1665 | RSS: Main: 250724352 14:48:54 INFO - PROCESS | 1665 | 14:48:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:57 INFO - PROCESS | 1665 | RSS: Main: 251084800 14:48:57 INFO - PROCESS | 1665 | 14:49:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:49:01 INFO - PROCESS | 1665 | RSS: Main: 251154432 14:49:01 INFO - PROCESS | 1665 | 14:49:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 14:49:03 INFO - PROCESS | 1665 | RSS: Main: 252907520 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | __start_tp_report 14:49:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:49:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:49:03 INFO - PROCESS | 1665 | |i|pagename|runs| 14:49:03 INFO - PROCESS | 1665 | |0;ai-astar;106;120;118;118;119;142;175;154;120;117 14:49:03 INFO - PROCESS | 1665 | |1;audio-beat-detection;142;109;108;144;110;112;133;141;154;110 14:49:03 INFO - PROCESS | 1665 | |2;audio-dft;214;170;247;274;191;274;267;218;189;264 14:49:03 INFO - PROCESS | 1665 | |3;audio-fft;70;59;59;81;59;57;58;63;98;82 14:49:03 INFO - PROCESS | 1665 | |4;audio-oscillator;84;71;87;73;70;68;89;68;70;85 14:49:03 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;92;88;92;87;137;111;92;89;93;88 14:49:03 INFO - PROCESS | 1665 | |6;imaging-darkroom;103;96;97;97;105;152;120;97;97;97 14:49:03 INFO - PROCESS | 1665 | |7;imaging-desaturate;94;81;153;123;91;92;95;125;143;91 14:49:03 INFO - PROCESS | 1665 | |8;json-parse-financial;56;56;55;58;61;60;59;83;55;58 14:49:03 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;70;72;78;76;76;74;70;72;73;70 14:49:03 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;84;84;85;84;84;83;87;85;83;83 14:49:03 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;158;157;147;136;135;139;142;163;208;140 14:49:03 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;165;164;165;168;164;165;163;168;166;163 14:49:03 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;89;66;70;68;66;65;69;66;67;67 14:49:03 INFO - PROCESS | 1665 | __end_tp_report 14:49:03 INFO - PROCESS | 1665 | __start_cc_report 14:49:03 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,925 14:49:03 INFO - PROCESS | 1665 | __end_cc_report 14:49:03 INFO - PROCESS | 1665 | __startTimestamp1476913743186__endTimestamp 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:49:03 INFO - PROCESS | 1665 | Number of tests: 14 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:128.90 Median:120.00 stddev:21.31 (17.8%) stddev-sans-first:20.93 14:49:03 INFO - PROCESS | 1665 | Values: 106.0 120.0 118.0 118.0 119.0 142.0 175.0 154.0 120.0 117.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:137.00 stddev:18.13 (13.2%) stddev-sans-first:18.32 14:49:03 INFO - PROCESS | 1665 | Values: 142.0 109.0 108.0 144.0 110.0 112.0 133.0 141.0 154.0 110.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:230.80 Median:255.50 stddev:39.27 (15.4%) stddev-sans-first:41.18 14:49:03 INFO - PROCESS | 1665 | Values: 214.0 170.0 247.0 274.0 191.0 274.0 267.0 218.0 189.0 264.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:68.60 Median:66.50 stddev:13.96 (21.0%) stddev-sans-first:14.80 14:49:03 INFO - PROCESS | 1665 | Values: 70.0 59.0 59.0 81.0 59.0 57.0 58.0 63.0 98.0 82.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:78.50 stddev:8.61 (11.0%) stddev-sans-first:8.69 14:49:03 INFO - PROCESS | 1665 | Values: 84.0 71.0 87.0 73.0 70.0 68.0 89.0 68.0 70.0 85.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:90.50 stddev:15.68 (17.3%) stddev-sans-first:16.53 14:49:03 INFO - PROCESS | 1665 | Values: 92.0 88.0 92.0 87.0 137.0 111.0 92.0 89.0 93.0 88.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:97.00 stddev:17.72 (18.3%) stddev-sans-first:18.76 14:49:03 INFO - PROCESS | 1665 | Values: 103.0 96.0 97.0 97.0 105.0 152.0 120.0 97.0 97.0 97.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:108.80 Median:91.00 stddev:25.13 (27.6%) stddev-sans-first:26.08 14:49:03 INFO - PROCESS | 1665 | Values: 94.0 81.0 153.0 123.0 91.0 92.0 95.0 125.0 143.0 91.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:58.50 stddev:8.31 (14.2%) stddev-sans-first:8.68 14:49:03 INFO - PROCESS | 1665 | Values: 56.0 56.0 55.0 58.0 61.0 60.0 59.0 83.0 55.0 58.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:73.50 stddev:2.85 (3.9%) stddev-sans-first:2.79 14:49:03 INFO - PROCESS | 1665 | Values: 70.0 72.0 78.0 76.0 76.0 74.0 70.0 72.0 73.0 70.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 14:49:03 INFO - PROCESS | 1665 | Values: 84.0 84.0 85.0 84.0 84.0 83.0 87.0 85.0 83.0 83.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:152.00 stddev:21.85 (14.4%) stddev-sans-first:23.09 14:49:03 INFO - PROCESS | 1665 | Values: 158.0 157.0 147.0 136.0 135.0 139.0 142.0 163.0 208.0 140.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 14:49:03 INFO - PROCESS | 1665 | Values: 165.0 164.0 165.0 168.0 164.0 165.0 163.0 168.0 166.0 163.0 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:67.50 stddev:7.09 (10.5%) stddev-sans-first:1.62 14:49:03 INFO - PROCESS | 1665 | Values: 89.0 66.0 70.0 68.0 66.0 65.0 69.0 66.0 67.0 67.0 14:49:03 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:49:03 INFO - PROCESS | 1665 | 14:49:03 INFO - TEST-INFO | 1665: exit 0 14:49:04 INFO - TEST-OK | kraken | took 60067ms 14:49:04 INFO - SUITE-END | took 1173s 14:49:04 INFO - Completed test suite (00:19:33) 14:49:04 INFO - javascript benchmark 14:49:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7327.951665493165, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.6715944825796, 3359.781614195077, 3368.3936891359576, 3391.236971681372, 3424.726021918246, 5807.245058142441, 5811.912821307684, 5824.970875145629, 5842.298924129105, 5861.238039054928, 5670.659760414378, 5839.591228613998, 5862.73617687204, 5881.500072493843, 5886.411358864122, 5260.210968354749, 5296.894062118756, 5307.681539107666, 5351.117065684158, 5353.250544923714, 5322.254884316179, 5351.0, 5367.382750983647, 5372.516473517383, 5374.4894235047805, 5171.405288391846, 5230.2416149658275, 5261.86845328866, 5353.678779273256, 5358.758855851496, 5284.709340986245, 5362.142057270857, 5365.061114304981, 5372.543333816591, 5427.0773968425065, 5165.612579056586, 5328.387235467932, 5329.387120481156, 5356.571474282048, 5367.597430192751, 5644.350899646511, 5689.061304884689, 5757.740901659436, 5852.444017818343, 6002.669853158074, 5666.688332141731, 6154.292256390528, 6177.289611694668, 6177.81466556004, 6185.41238582334, 4349.499807522144, 6236.719347629368, 6266.154069200691, 6271.122042913996, 6284.34014428483, 5799.507041901401, 5865.237519122486, 5914.0, 5916.230889984317, 5927.170196172539, 5372.462753724596, 6148.907766383508, 6191.442770150708, 6193.163922870355, 6309.022101574264, 5178.300929374562, 6254.999200127958, 6257.092721555349, 6260.780872669435, 6270.717817698123, 5989.970050149721, 6253.74985000604, 6278.183836101369, 6279.686015699197, 6281.2462504498835, 4957.876053098701, 6068.726907289094, 6209.59637623553, 6217.658028808459, 6252.749890004349, 6220.942439785247, 6223.066540018943, 6235.438810507076, 6237.157983672146, 6267.4986001119805, 4981.8329026873425, 4991.700497970133, 4997.150484417658, 5001.924971125436, 5008.64939454242, 4352.303631418958, 4388.4733831940375, 4398.0, 4422.71252368595, 4434.024514606781, 5733.0540460823495, 5826.82519524415, 5948.702564871739, 5967.6121052131475, 5985.880282394328, 6183.938160618426, 6215.440610345091, 6223.190985171898, 6227.813165605039, 6240.4071613196675, 5853.239078919713, 5917.733701983421, 5961.552883533753, 5975.641461512323, 6055.848603784941, 5456.672599644034, 5479.068558345091, 5486.725663716798, 5513.062779327443, 5514.6691198528215, 6401.29585745577, 6401.583897046677, 6420.293767685551, 6424.100625912376, 6445.065465507569, 6126.670355029888, 6135.07955838608, 6178.62928224308, 6221.9377806221355, 6230.376962303733, 6324.778632747832, 6333.334999824952, 6338.176037115146, 6338.968305158444, 6353.555251132377, 4836.733979631154, 6219.689015549295, 6248.187735594343, 6264.279607844974, 6289.622622642656, 4814.5907597853175, 5947.375525569926, 6172.814815555541, 6228.532860035425, 6244.132393184529, 6119.571629985859, 6135.325114237341, 6187.690615469119, 6203.4416902479, 6224.128621993015, 6148.50811935053, 6180.4746596538, 6196.628202307876, 6206.844828879133, 6227.1282020516255, 5128.282040514257, 5753.597248192586, 5915.438033386821, 6033.155358249936, 6060.000099983454, 6114.69277300208, 6132.722655450899, 6148.0, 6151.354107818794, 6192.969035154795, 6018.638881667114, 6021.548383871314, 6033.215681961317, 6045.788397406246, 6065.059915713072], "value": 5712.478039292815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.0159672671023, 514.2466286889706, 525.7634064670898, 528.4741682026385, 534.8582625604215, 38441.615583844155, 42405.515806946765, 42637.57362426375, 44268.0, 44373.890652733695, 43320.3501947471, 43558.0, 43688.9077773055, 43841.0, 43967.340489892675, 7591.658375373094, 8251.504909705407, 8548.999999999984, 8893.155150260714, 9907.801843963116, 9711.0, 9745.951270243675, 9820.312578119534, 9874.703758887208, 9877.259205559576, 9828.312018158696, 9866.309358344883, 9879.110880020797, 9916.95041524795, 9939.850902236472, 8220.547869867154, 9835.164011059069, 9848.60605575776, 9854.113129818279, 9887.55506002228, 9691.563879625433, 9709.805803883954, 9730.270229732798, 9746.951265243628, 9806.16647584956, 40465.59534404648, 41278.58721412777, 41300.58699413027, 41542.37686434706, 41697.166056679, 3238.805671659708, 3439.3637177122314, 3451.4995325677887, 3827.158025234444, 4194.30793919003, 29775.957841475443, 30424.0, 30903.381932361226, 31372.0, 31417.37165256705, 3205.6153261608524, 3217.7264932480766, 3298.802071875671, 3307.834608269601, 3320.2197483591335, 520282.0, 532386.0, 532802.0, 533206.3339683316, 536529.0, 61284.693576531834, 61489.0, 61831.690841545504, 62015.6899215501, 62032.0, 34709.0, 35682.64317356845, 35693.46459803105, 36707.81646091752, 36730.44904326437, 16228.269727862275, 17006.744898826528, 17080.316787328367, 17107.973521588745, 17161.485155445356, 12895.161814482217, 13039.543615973396, 13166.539171128965, 13166.868331316564, 13180.868191317964, 19116.203919391737, 19133.521661958282, 19492.769854899212, 19579.00101427486, 19604.411867643994, 6963.8607227855155, 7240.637968101574, 7946.284834364935, 7983.20167983197, 7995.320397766255, 823.9258466738022, 859.3426029087752, 954.5275088831073, 954.8424509955919, 1090.5038207615517, 29533.556996645068, 29714.257143571584, 29966.55050174249, 30292.54561181584, 30486.84756576203, 1003.5333569890037, 1008.8486726990864, 1024.9846252306222, 1067.1409515340226, 1087.526925787285, 12855.357232138356, 15333.616659583377, 15373.846961477933, 15584.298706558233, 15673.373065077498, 710395.0, 710599.0, 720331.0, 720910.0, 721423.0, 55967.160492592644, 57031.71484142636, 57291.71354143286, 57742.0, 57893.710531447075, 1182.7752726981846, 1338.6184937292826, 1361.9591412257648, 1368.1790925444654, 1383.3429121167364, 28654.28364290826, 29205.7079429203, 29545.556816648197, 29642.407151857275, 30029.0, 49916.75041624768, 50448.991020178655, 50551.74724126356, 50734.0, 50856.237156441945, 545165.0, 594161.0, 599508.0, 601793.0, 607099.0, 26330.473390532465, 26350.341241468348, 26742.732572674024, 26757.86621066882, 26772.330691732863, 35359.0, 39437.80281098576, 45507.0, 46679.29981050355, 46917.53082469268, 32179.0, 38753.03117422087, 39485.605143948196, 40242.93319337206, 40282.79858600688, 38726.419103712906, 39866.60133398745, 39904.0, 40073.0, 40219.798901005306, 29173.85413072921, 31348.0, 37675.62324376721, 38052.809735951145, 38670.41994370143, 32890.83554582212, 34596.82701586476, 34626.82686586551, 35275.82362088173, 35367.93896183118, 25562.872185638953, 26024.479510410063, 26065.609015864396, 26333.4733305329, 26424.603630945934], "value": 19814.82227549521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.7687588060716, 377.3603741657889, 378.71974738693376, 388.29912008824095, 398.98458423312667, 18946.24215031399, 19391.709124363148, 20247.392578222676, 20406.795932040695, 20726.68909966348, 18390.35633752819, 19109.617807643874, 19815.5046123847, 20286.782793032427, 20349.59300813983, 5272.31459910213, 5360.490753378443, 5410.810621628234, 5461.781528738866, 5482.91775623366, 5306.204069389584, 5333.946660533403, 5441.156620723794, 5452.563794896399, 5460.5085542301185, 5286.894262114774, 5297.17893726473, 5443.374011988612, 5470.015397228497, 5489.39616642169, 5953.404659534033, 5968.074948383008, 5985.431384018555, 6038.822429626224, 6041.516678665718, 5130.819911420394, 5204.9739751301, 5326.98787230425, 5328.17413300939, 5335.946640533583, 13038.41327140281, 13195.472181112744, 13243.271620060892, 13335.933320333434, 20840.47898802527, 2271.8864056797092, 2352.882355882199, 2422.8061755059553, 2913.242556935212, 2946.9243726040054, 7858.253465920729, 9791.951040244825, 10022.59909603615, 10033.849492257623, 10321.277510574262, 1803.0894398328892, 1856.8700190986635, 1872.7190921361769, 1893.8958357290344, 1909.5894382707645, 117134.0, 119987.400063, 121407.0, 121648.0, 122770.15844762335, 11406.771864562663, 11707.941460292644, 11833.88166118345, 11842.348670823187, 11894.524219031315, 14508.911831612671, 14785.186814725294, 14788.0, 14850.777238341434, 14873.851261487463, 8585.957070214734, 8605.827883442422, 8646.308295336357, 8747.518886461306, 8816.911830881738, 8478.788030299293, 8488.278496327881, 8663.48019118855, 8723.825523489495, 8724.389292749574, 4478.888027799331, 4548.204064288736, 4552.658550608718, 4659.673822832369, 4691.906161876744, 1952.6582848001542, 1963.2245263120988, 1986.2452268138304, 1986.3246496191364, 1990.9701354479694, 834.5159807311744, 841.8526757817358, 918.3250311021394, 980.7057882635181, 1012.8075665623508, 19543.413697589094, 20309.593808123755, 20703.171873124906, 21190.0, 21275.78894848447, 932.6595792535811, 954.4464210757744, 973.5132433783108, 996.5465713100522, 1014.8021135878433, 8342.958285208535, 8517.74446766598, 9521.952390238004, 10822.0, 11560.537578496765, 483597.0, 486704.0, 490063.0, 530056.0, 547788.0, 96377.0, 146773.26613366866, 147151.0, 148896.0, 149633.25183374013, 923.7690577355661, 956.7273327101603, 969.8351280282369, 970.5583959298643, 970.8203982263162, 18899.338523151622, 19395.0, 19584.0, 19645.803541964968, 19684.01579921027, 42012.0, 56013.0, 56072.719636401554, 58614.4138558626, 58672.0, 82021.0, 82751.5862420684, 84165.73751393857, 84873.15126848653, 85172.0, 6656.667166641745, 6778.593284402951, 8064.717734879251, 8090.11008789021, 8114.959425202836, 12015.219010764273, 12689.936550317188, 13009.959203263526, 13097.279649618982, 13180.934095329845, 11065.778684426428, 11214.990650841137, 11250.324980501196, 11437.542498299976, 11659.18385713026, 10909.836352454879, 10972.067374272958, 11208.775824483302, 11232.213745037769, 11324.943375283401, 10206.846897296398, 10836.970487803646, 11249.606263780728, 11415.714607134889, 11820.70448238801, 6822.215445223863, 7849.803754906173, 7964.601769911597, 8226.42415030966, 8315.667373305, 11103.16726245551, 11198.328100314007, 11296.0, 11641.6507504775, 11670.008049315564], "value": 9353.068167970745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.4138749643905, 1524.8627623513883, 1706.7866516685415, 1811.420345489444, 1856.4152292028018, 8029.558374289411, 8113.8782918256275, 8339.833203335937, 8952.104789521045, 9022.684206052782, 8528.744137675863, 8630.136986301366, 8650.653973841054, 8886.86669699955, 8896.1103889611, 2377.643353496972, 2409.373562873648, 2414.0705828256073, 2414.3360575841607, 2417.407735104902, 2363.657269695893, 2381.95236095278, 2415.251272105644, 2427.2596857958315, 2431.6474111253856, 2361.7992470640015, 2371.7509661485556, 2401.687780588521, 2424.599941009731, 2424.781769640732, 2363.775441333079, 2380.4286971126976, 2386.319898828834, 2397.2209032064648, 2402.2913240594066, 2012.7685316188679, 2375.6340104440014, 2387.403149212697, 2388.737238903719, 2388.8924998375114, 8842.381033327669, 8849.823003539957, 9025.05236950124, 9027.548622568911, 9059.411138275991, 5228.0, 5351.224072509464, 5393.1370980643305, 5403.081476149025, 5430.728463576806, 3611.079174810433, 3640.5995340512522, 3652.853885844563, 3679.0066681995977, 3701.370766969622, 1081.9513121909533, 1086.7446150154708, 1086.8152414089623, 1100.5377741348652, 1112.2214449885112, 11654.650360489199, 11728.706782330424, 11805.40972951349, 11814.23207491519, 11821.94089029558, 4742.170120228946, 4748.358971538798, 4804.66390811941, 4859.878503037452, 4923.729194894315, 9891.258155638356, 9991.250656200815, 10018.048285412875, 10028.64899728506, 10066.345687530287, 5387.488188622075, 5387.649802762808, 5389.434109418533, 5396.298481197419, 5404.108322126884, 4458.9554104459185, 4480.663950203748, 4667.346571479996, 4799.656096293043, 4933.309336692866, 3453.637368076316, 3572.6427357264065, 3610.205754733954, 3702.4631428443263, 3968.1071758854027, 1238.3189245914712, 1323.5499930023645, 1326.2241588670543, 1349.7772867476756, 1356.2879488268738, 760.1828034862434, 805.5086397297644, 897.4211633496358, 911.4121391702315, 921.9443736921188, 5521.834344969658, 5677.078135914629, 5732.799352022659, 5821.52050627112, 6022.939770602326, 895.9955200223957, 914.8170365926841, 927.7866090799154, 937.0395344771528, 975.2295686407658, 3625.1118475973553, 3959.524857017119, 3961.029547760817, 3987.3620220764537, 3996.800159991989, 8840.911590884138, 10122.848157277647, 10651.98806113418, 10677.039066484054, 10701.892981070245, 10018.949905250427, 10252.743681408025, 10275.537600807982, 10584.629537966135, 10601.893981060091, 7904.407169462198, 7957.045154581371, 8013.759587212393, 8126.390520710852, 8154.306883914815, 5867.911981320198, 5875.735591898289, 5949.940500595112, 5991.131285963424, 6095.05526643371, 9518.809623807347, 9713.465759383302, 9874.85187722199, 9934.850977235203, 9971.800563988825, 8602.78493037679, 8825.338099642424, 10139.543720532447, 10178.745531361776, 10197.184225261813, 7017.403520700797, 7117.857642847218, 7375.446841486802, 7536.811579710551, 7544.09470863478, 8053.637586308513, 8438.493690378597, 8474.491530508189, 8485.490870547786, 8503.574821259035, 7349.530093981119, 7525.0, 7540.773776786705, 7554.169041405331, 7603.7338693145475, 7337.046183996046, 7337.449691273283, 7374.299441553044, 7376.0, 7507.624618769149, 6897.3447522485285, 7026.508144429841, 7028.543144695578, 7030.156381234285, 7046.0, 4868.561829435368, 4898.020395920759, 4933.260010998379, 4944.381952255968, 5063.113955057924, 4270.850520231777, 4969.35398398206, 5031.094403007347, 5125.128728116155, 5128.79484820603], "value": 4578.55540742925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.69663549908097, 296.91389497045856, 304.97102775236345, 306.6427611832216, 307.19055289312655, 4839.975800120995, 5481.588880833939, 5489.517830185858, 5582.692951887645, 5611.607187496872, 4431.8670439886855, 5192.92210616841, 5368.248445217663, 5414.945850541493, 5433.582055985088, 3268.084936217863, 3828.8659896903614, 4005.1388951375448, 4111.506619205699, 4205.465005273084, 3738.084169378506, 3989.68082553395, 4195.895102622429, 4196.559361267069, 4219.282721937278, 4046.8381264749373, 4106.77412742299, 4130.153318569701, 4147.81334839933, 4147.9927052886715, 3584.5160903277983, 4146.357314616239, 4161.105362347094, 4165.708400411972, 4175.728577642443, 3577.731670124751, 3644.922394235287, 3647.246329021572, 3648.72634552407, 3669.3578623741005, 4935.679180853269, 5280.287161233261, 5385.892282154374, 5386.0, 5392.865178370533, 4144.295469770146, 4762.809487620491, 4779.378680771478, 4781.947971446276, 4785.880352991168, 4408.25059739845, 4763.95236047642, 5146.768395422215, 5201.751579620902, 5361.463853614647, 3667.7982710950887, 3876.7286289959716, 3895.7081266329906, 3903.882883513499, 3911.804409779528, 4866.172750632366, 5236.633435659505, 5488.0, 6075.33171351151, 6173.259208894917, 3713.424419215026, 3975.185087057146, 3977.204559088194, 3990.3216453202444, 4004.2592120457807, 3903.1998440319667, 3969.7816620085596, 4048.6963477739287, 4053.777042262645, 4063.817128229237, 3883.1943146437043, 4458.464984201916, 4710.788014539354, 4712.882177945578, 4737.294573953374, 5145.691258524501, 5205.375354957354, 5879.911801322984, 5940.31686356066, 5965.791197308074, 1041.031840388446, 1211.3700875544844, 1341.7651910915552, 1355.5662188099714, 1356.819566976717, 855.8288342331558, 902.4540153207346, 917.2982668258787, 920.9263258939269, 921.4102974096584, 4791.880202994953, 4959.2809042688605, 5079.8984020319385, 5399.541039011649, 5422.48486393792, 5184.459614788801, 5215.217717342353, 5924.6149000314845, 5926.259217597801, 5932.970335148297, 4793.472718001017, 4834.540718631724, 4942.851714448572, 5091.465396133352, 5381.0, 2320.3271051395245, 2620.375367272265, 2648.576227803542, 2649.0132400699476, 2656.694480134809, 4389.517153113155, 5196.428392876781, 5199.350081239845, 5235.712035838065, 5256.845892464567, 4594.554084436672, 4625.606823419979, 4926.852194434101, 5187.844364669066, 5259.105951988171, 5193.0, 5332.413434522277, 5491.615586908878, 5919.3192782829665, 6279.654618995999, 4795.304680821331, 5687.9523371585365, 6002.429769171922, 6098.0, 6115.602485838406, 4493.59557639814, 5031.0, 5822.758238078455, 5841.883162336814, 5895.557833162616, 6212.844678883064, 6242.219722534684, 6269.247690277196, 6333.809985700436, 6348.238211414659, 3821.636944490269, 3903.330124169915, 3968.66266367362, 3981.8407263710287, 3985.6612187964347, 5556.333240011225, 5694.971525142348, 5905.52755779528, 6013.458788708862, 6018.4583387493585, 5635.802746903839, 5729.4843464088435, 5741.712914354349, 5807.796727114531, 5849.356570777126, 5767.7404516796005, 5791.218185544897, 5806.0, 5806.387125793325, 5818.2436283282905, 4714.481407045154, 5347.973260133675, 5652.3217213934595, 5692.356891589303, 5747.166660834072, 5011.97254562821, 5323.30796996388, 5831.1836342912875, 5883.882322353615, 5887.087501437284, 4693.765311734332, 4937.77779999908, 5621.0, 5729.427057294237, 5737.8565535861935], "value": 4107.225516552976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.4427413029033, 771.9614019299033, 775.3758224629171, 808.7250334886138, 829.133555434571, 15097.320620572073, 15112.319945602447, 15244.771328430083, 15402.152881591535, 15444.996075255101, 13954.720905581908, 14013.579592612212, 14039.157650540948, 14058.015938884257, 14058.578242652711, 818.9918100818975, 825.0511911301991, 853.3770347646222, 858.5235194467068, 860.6987554355987, 813.4590497319305, 815.6859609050499, 816.7958010497375, 818.7953011747063, 849.7068511363569, 877.1272583779148, 891.3671293381707, 898.2589363774879, 899.2131884600974, 901.4185850126664, 858.1461445861346, 867.7440155154245, 869.148234729965, 895.359817730326, 895.789489469974, 575.7955925646377, 587.9118132280149, 638.2118084166051, 639.3638329861817, 655.9540832141752, 14956.40174393023, 15110.54668359951, 15215.543533694006, 15228.923855380763, 15265.771013434807, 13824.377902994289, 13991.0, 14087.295635218197, 14189.78715319271, 14190.148591084464, 11862.52549898003, 11899.464524096436, 11939.10456715741, 12166.878331216663, 12248.755024899541, 3240.0, 3764.4917936078555, 3791.907744506397, 3820.0449887528116, 3828.9042773930873, 112473.43763281131, 117881.23178152334, 119517.40241298825, 120140.0, 123697.0, 10541.262111652264, 10820.815903215069, 10937.070349020423, 11061.502232399562, 11286.717832054264, 22041.669374959387, 22066.558668826532, 22140.778592213872, 22199.556008879732, 22217.77782222157, 7786.377089832799, 7983.481073730305, 7986.920130798734, 8004.799880003046, 8124.228198321268, 3687.9078023049638, 4424.159409712144, 4487.6634252431195, 4524.506912718795, 4525.298578720303, 3635.9818200908826, 3734.8319325630414, 3769.208466222124, 3775.754575952554, 3783.281176576442, 632.8987362022054, 668.2014992084412, 677.7085853083123, 684.6782012454139, 687.0107045854054, 535.6839464715758, 541.8347404041726, 674.8123302986778, 675.3887731602907, 696.9163700355888, 7332.790089635258, 8355.373346999, 8611.0, 8689.78343031976, 9441.386309889835, 657.9769708060195, 666.9699863506154, 677.0994577212296, 679.3172861274486, 692.1106378303855, 4523.2988886722615, 4669.276262179367, 4686.0, 4704.129735998783, 4721.598664113589, 89635.0, 167743.0, 168004.0, 170041.0, 177275.11362443105, 113708.29437558443, 147133.26433367978, 147154.0, 147157.52842471653, 153555.2322238404, 98984.01015989891, 109951.0, 122903.0, 126471.47057058808, 129451.0, 8986.82026359456, 9032.14194651507, 9050.909490905007, 9051.683191088543, 9259.76850578741, 68097.0, 68358.0, 69080.30919690739, 70412.64793676203, 71853.92219116613, 106081.0, 107087.0, 108513.45743271233, 110219.0, 110836.0, 11636.650900473, 11785.057195424517, 11921.940390297994, 11939.343336116597, 11947.940260298643, 12724.554640587905, 12874.806877896652, 12925.0, 13077.215367078006, 13198.538051168163, 11699.824502632297, 11818.349990750592, 12347.69130771738, 12364.134510584172, 12731.490740370651, 11954.76090478203, 12495.062870284582, 12653.177543460013, 12767.61697149087, 12768.36158192068, 11283.830742539032, 11632.651020469399, 12012.63962081139, 12118.212316199419, 12296.938515307365, 9928.25538084661, 10127.341722787995, 10320.948395257976, 10715.517801698787, 10843.67468975932, 9366.438013719198, 10085.949570252102, 10633.521491533054, 10655.57377704883, 10688.732781680521], "value": 7776.864271306147, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 118.0, 118.0, 119.0, 142.0, 175.0, 154.0, 120.0, 117.0], "value": 128.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 144.0, 110.0, 112.0, 133.0, 141.0, 154.0, 110.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 170.0, 247.0, 274.0, 191.0, 274.0, 267.0, 218.0, 189.0, 264.0], "value": 230.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 59.0, 59.0, 81.0, 59.0, 57.0, 58.0, 63.0, 98.0, 82.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 87.0, 73.0, 70.0, 68.0, 89.0, 68.0, 70.0, 85.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 92.0, 87.0, 137.0, 111.0, 92.0, 89.0, 93.0, 88.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 96.0, 97.0, 97.0, 105.0, 152.0, 120.0, 97.0, 97.0, 97.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 81.0, 153.0, 123.0, 91.0, 92.0, 95.0, 125.0, 143.0, 91.0], "value": 108.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 58.0, 61.0, 60.0, 59.0, 83.0, 55.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 78.0, 76.0, 76.0, 74.0, 70.0, 72.0, 73.0, 70.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 83.0, 87.0, 85.0, 83.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 147.0, 136.0, 135.0, 139.0, 142.0, 163.0, 208.0, 140.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 168.0, 164.0, 165.0, 163.0, 168.0, 166.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 66.0, 70.0, 68.0, 66.0, 65.0, 69.0, 66.0, 67.0, 67.0], "value": 69.3, "unit": "score"}]}]} 14:49:04 INFO - Return code: 0 14:49:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:49:04 ERROR - # TBPL SUCCESS # 14:49:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:49:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:49:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:49:04 INFO - 2016-10-19 14:49:04.516 screenresolution[1670:10887] starting screenresolution argv=screenresolution get 14:49:04 INFO - 2016-10-19 14:49:04.519 screenresolution[1670:10887] Display 0: 1600x1200x32@60 14:49:04 INFO - 2016-10-19 14:49:04.525 screenresolution[1671:10890] starting screenresolution argv=screenresolution list 14:49:04 INFO - Available Modes on Display 0 14:49:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:49:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:49:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:49:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:49:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:49:04 INFO - Intel Iris: 14:49:04 INFO - Chipset Model: Intel Iris 14:49:04 INFO - Type: GPU 14:49:04 INFO - Bus: Built-In 14:49:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:49:04 INFO - Vendor: Intel (0x8086) 14:49:04 INFO - Device ID: 0x0a2e 14:49:04 INFO - Revision ID: 0x0009 14:49:04 INFO - Displays: 14:49:04 INFO - Display: 14:49:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:49:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:49:04 INFO - Display Serial Number: 1600x1200 60 14:49:04 INFO - Main Display: Yes 14:49:04 INFO - Mirror: Off 14:49:04 INFO - Online: Yes 14:49:04 INFO - Rotation: Supported 14:49:04 INFO - Return code: 0 14:49:04 INFO - Running post-action listener: _resource_record_post_action 14:49:04 INFO - [mozharness: 2016-10-19 21:49:04.758241Z] Finished run-tests step (success) 14:49:04 INFO - Running post-run listener: _resource_record_post_run 14:49:04 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 38540288; Write bytes: 666585088; Read time: 376; Write time: 1906 14:49:04 INFO - TinderboxPrint: CPU usage
54.4% 14:49:04 INFO - TinderboxPrint: I/O read bytes / time
38,540,288 / 376 14:49:04 INFO - TinderboxPrint: I/O write bytes / time
666,585,088 / 1,906 14:49:04 INFO - TinderboxPrint: CPU idle
2,199.0 (45.6%) 14:49:04 INFO - TinderboxPrint: CPU system
978.3 (20.3%) 14:49:04 INFO - TinderboxPrint: CPU user
1,648.4 (34.2%) 14:49:04 INFO - TinderboxPrint: Swap in / out
401,854,464 / 0 14:49:04 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 354609664; Write bytes: 354043904; Read time: 27637; Write time: 670 14:49:04 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 37561344; Write bytes: 299798528; Read time: 360; Write time: 1187 14:49:05 INFO - Running post-run listener: _upload_blobber_files 14:49:05 INFO - Blob upload gear active. 14:49:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:49:05 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 14:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:49:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:06 INFO - (blobuploader) - INFO - Done attempting. 14:49:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:49:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:49:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:07 INFO - (blobuploader) - INFO - Done attempting. 14:49:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:49:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:09 INFO - (blobuploader) - INFO - Done attempting. 14:49:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:09 INFO - Return code: 0 14:49:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:49:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb76f353cbf2f2a42290344642e2eaf157c52369d2d4e414ae48defa19e222e7093ee41206d2932dfedf1432172d9b07b73ab425145e7d7339a2d78a0f48e331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6f3583ea9dc6ed1b07ba05350354231c4fa645471f564f3bab3c03fa57a2b1de04b104ee4755ba57c9f20fc9f6a47246a6bc3d1956f3135b91124d383b50c65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e4c52b19a8fbec1ed8fbe6687e34237ff187a4f782ebbd35edac3ad5fc32e8f047fa882ec87c8f6881f52ca7f00c766f69228814401b5b30dad21056a9bf9bd"} 14:49:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:49:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:49:09 INFO - Contents: 14:49:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb76f353cbf2f2a42290344642e2eaf157c52369d2d4e414ae48defa19e222e7093ee41206d2932dfedf1432172d9b07b73ab425145e7d7339a2d78a0f48e331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6f3583ea9dc6ed1b07ba05350354231c4fa645471f564f3bab3c03fa57a2b1de04b104ee4755ba57c9f20fc9f6a47246a6bc3d1956f3135b91124d383b50c65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e4c52b19a8fbec1ed8fbe6687e34237ff187a4f782ebbd35edac3ad5fc32e8f047fa882ec87c8f6881f52ca7f00c766f69228814401b5b30dad21056a9bf9bd"} 14:49:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:09 INFO - Copying logs to upload dir... 14:49:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:49:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.335630 ========= master_lag: -0.47 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-19 14:49:09.492851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 14:49:09.497638) ========= 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.qNDHsufBdn/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.1B1OZBIycr/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb76f353cbf2f2a42290344642e2eaf157c52369d2d4e414ae48defa19e222e7093ee41206d2932dfedf1432172d9b07b73ab425145e7d7339a2d78a0f48e331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6f3583ea9dc6ed1b07ba05350354231c4fa645471f564f3bab3c03fa57a2b1de04b104ee4755ba57c9f20fc9f6a47246a6bc3d1956f3135b91124d383b50c65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e4c52b19a8fbec1ed8fbe6687e34237ff187a4f782ebbd35edac3ad5fc32e8f047fa882ec87c8f6881f52ca7f00c766f69228814401b5b30dad21056a9bf9bd"} build_url:https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/VfD6zJ6FTn2DcdLsncv30A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb76f353cbf2f2a42290344642e2eaf157c52369d2d4e414ae48defa19e222e7093ee41206d2932dfedf1432172d9b07b73ab425145e7d7339a2d78a0f48e331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6f3583ea9dc6ed1b07ba05350354231c4fa645471f564f3bab3c03fa57a2b1de04b104ee4755ba57c9f20fc9f6a47246a6bc3d1956f3135b91124d383b50c65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e4c52b19a8fbec1ed8fbe6687e34237ff187a4f782ebbd35edac3ad5fc32e8f047fa882ec87c8f6881f52ca7f00c766f69228814401b5b30dad21056a9bf9bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 14:49:09.530031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:49:09.530363) ========= 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.qNDHsufBdn/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.1B1OZBIycr/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005037 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:49:09.581832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 14:49:09.582132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 14:49:09.585479) ========= ========= Total master_lag: -0.34 =========