builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0069 starttime: 1476694923.49 results: success (0) buildid: 20161017004013 builduid: b9216e44ebc0410ba2ee5820fc93c205 revision: a205468e405c9225f0d72303e10ce72559f7f6b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.489478) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.490228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.490497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.668194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.668507) ========= 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.QuNsCaz655/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.obhfSbw7R2/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-17 02:02:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-10-17 02:02:03 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123540 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.820584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.820871) ========= 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.QuNsCaz655/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.obhfSbw7R2/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.019781 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:03.894037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 02:02:03.894373) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a205468e405c9225f0d72303e10ce72559f7f6b4 --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 a205468e405c9225f0d72303e10ce72559f7f6b4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QuNsCaz655/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.obhfSbw7R2/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-17 02:02:03,965 truncating revision to first 12 chars 2016-10-17 02:02:03,965 Setting DEBUG logging. 2016-10-17 02:02:03,965 attempt 1/10 2016-10-17 02:02:03,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a205468e405c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 02:02:04,678 unpacking tar archive at: mozilla-aurora-a205468e405c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997318 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 02:02:04.920977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:04.921282) ========= script_repo_revision: a205468e405c9225f0d72303e10ce72559f7f6b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:04.921672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:04.921945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 02:02:04.944071) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-17 02:02:04.944395) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.QuNsCaz655/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.obhfSbw7R2/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:05 INFO - MultiFileLogger online at 20161017 02:02:05 in /builds/slave/test 02:02:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:02:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:05 INFO - {'append_to_log': False, 02:02:05 INFO - 'base_work_dir': '/builds/slave/test', 02:02:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:02:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:05 INFO - 'branch': 'Mozilla-Aurora', 02:02:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:05 INFO - 'config_files': ('talos/mac_config.py',), 02:02:05 INFO - 'default_actions': ('clobber', 02:02:05 INFO - 'read-buildbot-config', 02:02:05 INFO - 'download-and-extract', 02:02:05 INFO - 'populate-webroot', 02:02:05 INFO - 'create-virtualenv', 02:02:05 INFO - 'install', 02:02:05 INFO - 'run-tests'), 02:02:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:05 INFO - 'download_minidump_stackwalk': True, 02:02:05 INFO - 'download_symbols': 'ondemand', 02:02:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:05 INFO - 'installer_path': 'installer.exe', 02:02:05 INFO - 'log_level': 'info', 02:02:05 INFO - 'log_name': 'talos', 02:02:05 INFO - 'log_to_console': True, 02:02:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:02:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:02:05 INFO - 'opt_config_files': (), 02:02:05 INFO - 'pip_index': False, 02:02:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:02:05 INFO - 'cmd': ('bash', 02:02:05 INFO - '-c', 02:02:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:02:05 INFO - 'enabled': True, 02:02:05 INFO - 'halt_on_failure': False, 02:02:05 INFO - 'name': 'check_screen_resolution'},), 02:02:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:02:05 INFO - 'cmd': ('bash', 02:02:05 INFO - '-c', 02:02:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:02:05 INFO - 'enabled': True, 02:02:05 INFO - 'halt_on_failure': False, 02:02:05 INFO - 'name': 'check_screen_resolution'},), 02:02:05 INFO - 'run_cmd_checks_enabled': True, 02:02:05 INFO - 'sps_profile': False, 02:02:05 INFO - 'sps_profile_interval': 0, 02:02:05 INFO - 'suite': 'dromaeojs', 02:02:05 INFO - 'system_bits': '32', 02:02:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:05 INFO - 'title': 't-yosemite-r7-0069', 02:02:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:05 INFO - 'use_talos_json': True, 02:02:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:05 INFO - 'work_dir': 'build'} 02:02:05 INFO - [mozharness: 2016-10-17 09:02:05.144388Z] Running clobber step. 02:02:05 INFO - Running pre-action listener: _resource_record_pre_action 02:02:05 INFO - Running main action method: clobber 02:02:05 INFO - rmtree: /builds/slave/test/build 02:02:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:06 INFO - Running post-action listener: _resource_record_post_action 02:02:06 INFO - [mozharness: 2016-10-17 09:02:06.861583Z] Finished clobber step (success) 02:02:06 INFO - [mozharness: 2016-10-17 09:02:06.861709Z] Running read-buildbot-config step. 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: read_buildbot_config 02:02:06 INFO - Using buildbot properties: 02:02:06 INFO - { 02:02:06 INFO - "project": "", 02:02:06 INFO - "product": "firefox", 02:02:06 INFO - "script_repo_revision": "production", 02:02:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:02:06 INFO - "repository": "", 02:02:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:02:06 INFO - "buildid": "20161017004013", 02:02:06 INFO - "stage_platform": "macosx64", 02:02:06 INFO - "basedir": "/builds/slave/test", 02:02:06 INFO - "nightly_build": "True", 02:02:06 INFO - "buildnumber": 88, 02:02:06 INFO - "slavename": "t-yosemite-r7-0069", 02:02:06 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:02:06 INFO - "platform": "yosemite_r7", 02:02:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:02:06 INFO - "branch": "mozilla-aurora", 02:02:06 INFO - "repo_path": "releases/mozilla-aurora", 02:02:06 INFO - "revision": "a205468e405c9225f0d72303e10ce72559f7f6b4", 02:02:06 INFO - "pgo_build": "False", 02:02:06 INFO - "builduid": "b9216e44ebc0410ba2ee5820fc93c205", 02:02:06 INFO - "slavebuilddir": "test" 02:02:06 INFO - } 02:02:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:02:06 INFO - Running post-action listener: _resource_record_post_action 02:02:06 INFO - [mozharness: 2016-10-17 09:02:06.865063Z] Finished read-buildbot-config step (success) 02:02:06 INFO - [mozharness: 2016-10-17 09:02:06.865169Z] Running download-and-extract step. 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: download_and_extract 02:02:06 INFO - mkdir: /builds/slave/test/build/tests 02:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:06 INFO - trying https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:02:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/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 02:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/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 02:02:07 INFO - Downloaded 1199 bytes. 02:02:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:02:07 INFO - Using the following test package requirements: 02:02:07 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:02:07 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:02:07 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:02:07 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'jsshell-mac.zip'], 02:02:07 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:02:07 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:02:07 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:02:07 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:02:07 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:02:07 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:02:07 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:02:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:02:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:02:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:02:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:02:08 INFO - Expected file size: 16435241 02:02:15 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 02:02:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:02:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:02:15 INFO - Fetch https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:02:16 INFO - Expected file size: 16435241 02:02:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:02:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:02:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:02:23 INFO - Expected file size: 14414081 02:02:24 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')]} 02:02:24 INFO - trying https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:02:24 INFO - Downloading https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/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 02:02:27 INFO - Downloaded 115575237 bytes. 02:02:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:02:27 INFO - mkdir: /builds/slave/test/properties 02:02:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:27 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:27 INFO - Contents: 02:02:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:02:27 INFO - Running post-action listener: _resource_record_post_action 02:02:27 INFO - Running post-action listener: set_extra_try_arguments 02:02:27 INFO - [mozharness: 2016-10-17 09:02:27.951116Z] Finished download-and-extract step (success) 02:02:27 INFO - [mozharness: 2016-10-17 09:02:27.951263Z] Running populate-webroot step. 02:02:27 INFO - Running pre-action listener: _resource_record_pre_action 02:02:27 INFO - Running main action method: populate_webroot 02:02:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:27 INFO - '--tppagecycles', 02:02:27 INFO - '7'], 02:02:27 INFO - 'tests': ['tsvgm']}}, 02:02:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:02:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:02:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:02:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['damp', 'tps']}, 02:02:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'tests': ['damp', 'tps']}, 02:02:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['dromaeo_dom']}, 02:02:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['basic_compositor_video']}, 02:02:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:02:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['a11yr', 02:02:27 INFO - 'ts_paint', 02:02:27 INFO - 'tpaint', 02:02:27 INFO - 'sessionrestore', 02:02:27 INFO - 'sessionrestore_no_auto_restore', 02:02:27 INFO - 'tabpaint']}, 02:02:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:02:27 INFO - 'ts_paint', 02:02:27 INFO - 'tpaint', 02:02:27 INFO - 'sessionrestore', 02:02:27 INFO - 'sessionrestore_no_auto_restore', 02:02:27 INFO - 'tabpaint']}, 02:02:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:02:27 INFO - 'ts_paint', 02:02:27 INFO - 'tpaint', 02:02:27 INFO - 'sessionrestore', 02:02:27 INFO - 'sessionrestore_no_auto_restore', 02:02:27 INFO - 'tabpaint']}, 02:02:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:02:27 INFO - 'ts_paint', 02:02:27 INFO - 'tpaint', 02:02:27 INFO - 'sessionrestore', 02:02:27 INFO - 'sessionrestore_no_auto_restore', 02:02:27 INFO - 'tabpaint']}, 02:02:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['a11yr', 02:02:27 INFO - 'ts_paint', 02:02:27 INFO - 'tpaint', 02:02:27 INFO - 'sessionrestore', 02:02:27 INFO - 'sessionrestore_no_auto_restore', 02:02:27 INFO - 'tabpaint']}, 02:02:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['a11yr', 02:02:27 INFO - 'ts_paint', 02:02:27 INFO - 'tpaint', 02:02:27 INFO - 'sessionrestore', 02:02:27 INFO - 'sessionrestore_no_auto_restore', 02:02:27 INFO - 'tabpaint']}, 02:02:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['tsvgx', 02:02:27 INFO - 'tsvgr_opacity', 02:02:27 INFO - 'tart', 02:02:27 INFO - 'tscrollx', 02:02:27 INFO - 'cart']}, 02:02:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:02:27 INFO - 'tsvgr_opacity', 02:02:27 INFO - 'tart', 02:02:27 INFO - 'tscrollx', 02:02:27 INFO - 'cart']}, 02:02:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'talos_options': ['--disable-e10s'], 02:02:27 INFO - 'tests': ['tp5o']}, 02:02:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'tests': ['tp5o']}, 02:02:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'talos_options': ['--disable-e10s', 02:02:27 INFO - '--xperf_path', 02:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:27 INFO - 'tests': ['tp5n']}, 02:02:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:27 INFO - 'talos_options': ['--xperf_path', 02:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:27 INFO - 'tests': ['tp5n']}}, 02:02:27 INFO - 'talos.zip': {'path': '', 02:02:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:27 INFO - Running post-action listener: _resource_record_post_action 02:02:27 INFO - [mozharness: 2016-10-17 09:02:27.969830Z] Finished populate-webroot step (success) 02:02:27 INFO - [mozharness: 2016-10-17 09:02:27.969942Z] Running create-virtualenv step. 02:02:27 INFO - Running pre-action listener: _resource_record_pre_action 02:02:27 INFO - Running main action method: create_virtualenv 02:02:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:27 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 02:02:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:28 INFO - Using real prefix '/tools/python27' 02:02:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:31 INFO - Installing pip.................done. 02:02:31 INFO - Return code: 0 02:02:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:31 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')]} 02:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 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')]} 02:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:31 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 02:02:31 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 02:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:31 INFO - 'HOME': '/Users/cltbld', 02:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:31 INFO - 'LOGNAME': 'cltbld', 02:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:31 INFO - 'MOZ_NO_REMOTE': '1', 02:02:31 INFO - 'NO_EM_RESTART': '1', 02:02:31 INFO - 'PAGER': '/bin/cat', 02:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:31 INFO - 'PWD': '/builds/slave/test', 02:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:31 INFO - 'SHELL': '/bin/bash', 02:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:31 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:31 INFO - 'USER': 'cltbld', 02:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:31 INFO - 'XPC_FLAGS': '0x0', 02:02:31 INFO - 'XPC_SERVICE_NAME': '0', 02:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:31 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 02:02:31 INFO - Cleaning up... 02:02:31 INFO - Return code: 0 02:02:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:02:31 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')]} 02:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 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')]} 02:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:31 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 02:02:31 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 02:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:31 INFO - 'HOME': '/Users/cltbld', 02:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:31 INFO - 'LOGNAME': 'cltbld', 02:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:31 INFO - 'MOZ_NO_REMOTE': '1', 02:02:31 INFO - 'NO_EM_RESTART': '1', 02:02:31 INFO - 'PAGER': '/bin/cat', 02:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:31 INFO - 'PWD': '/builds/slave/test', 02:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:31 INFO - 'SHELL': '/bin/bash', 02:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:31 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:31 INFO - 'USER': 'cltbld', 02:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:31 INFO - 'XPC_FLAGS': '0x0', 02:02:31 INFO - 'XPC_SERVICE_NAME': '0', 02:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:32 INFO - Downloading/unpacking psutil>=3.1.1 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:36 INFO - Installing collected packages: psutil 02:02:36 INFO - Running setup.py install for psutil 02:02:36 INFO - building 'psutil._psutil_osx' extension 02:02:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:02:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:02:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:02:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:02:36 INFO - building 'psutil._psutil_posix' extension 02:02:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:02:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:02:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:02:36 INFO - ^ 02:02:36 INFO - 1 warning generated. 02:02:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:02:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:36 INFO - Successfully installed psutil 02:02:36 INFO - Cleaning up... 02:02:37 INFO - Return code: 0 02:02:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:37 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:37 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 02:02:37 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 02:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:37 INFO - 'HOME': '/Users/cltbld', 02:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:37 INFO - 'LOGNAME': 'cltbld', 02:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:37 INFO - 'MOZ_NO_REMOTE': '1', 02:02:37 INFO - 'NO_EM_RESTART': '1', 02:02:37 INFO - 'PAGER': '/bin/cat', 02:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:37 INFO - 'PWD': '/builds/slave/test', 02:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:37 INFO - 'SHELL': '/bin/bash', 02:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:37 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:37 INFO - 'USER': 'cltbld', 02:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:37 INFO - 'XPC_FLAGS': '0x0', 02:02:37 INFO - 'XPC_SERVICE_NAME': '0', 02:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:02:39 INFO - Installing collected packages: mozsystemmonitor 02:02:39 INFO - Running setup.py install for mozsystemmonitor 02:02:40 INFO - Successfully installed mozsystemmonitor 02:02:40 INFO - Cleaning up... 02:02:40 INFO - Return code: 0 02:02:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:40 INFO - 'HOME': '/Users/cltbld', 02:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:40 INFO - 'LOGNAME': 'cltbld', 02:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:40 INFO - 'MOZ_NO_REMOTE': '1', 02:02:40 INFO - 'NO_EM_RESTART': '1', 02:02:40 INFO - 'PAGER': '/bin/cat', 02:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:40 INFO - 'PWD': '/builds/slave/test', 02:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:40 INFO - 'SHELL': '/bin/bash', 02:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:40 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:40 INFO - 'USER': 'cltbld', 02:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:40 INFO - 'XPC_FLAGS': '0x0', 02:02:40 INFO - 'XPC_SERVICE_NAME': '0', 02:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:40 INFO - Downloading/unpacking jsonschema==2.5.1 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:43 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:43 INFO - warning: no files found matching '*.txt' 02:02:43 INFO - no previously-included directories found matching 'build' 02:02:43 INFO - no previously-included directories found matching 'dist' 02:02:43 INFO - no previously-included directories found matching '.git*' 02:02:43 INFO - Installing collected packages: jsonschema, functools32 02:02:43 INFO - Running setup.py install for functools32 02:02:43 INFO - warning: no files found matching '*.txt' 02:02:43 INFO - no previously-included directories found matching 'build' 02:02:43 INFO - no previously-included directories found matching 'dist' 02:02:43 INFO - no previously-included directories found matching '.git*' 02:02:43 INFO - Successfully installed jsonschema functools32 02:02:43 INFO - Cleaning up... 02:02:43 INFO - Return code: 0 02:02:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:43 INFO - 'HOME': '/Users/cltbld', 02:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:43 INFO - 'LOGNAME': 'cltbld', 02:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:43 INFO - 'MOZ_NO_REMOTE': '1', 02:02:43 INFO - 'NO_EM_RESTART': '1', 02:02:43 INFO - 'PAGER': '/bin/cat', 02:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:43 INFO - 'PWD': '/builds/slave/test', 02:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:43 INFO - 'SHELL': '/bin/bash', 02:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:43 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:43 INFO - 'USER': 'cltbld', 02:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:43 INFO - 'XPC_FLAGS': '0x0', 02:02:43 INFO - 'XPC_SERVICE_NAME': '0', 02:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:02:43 INFO - Cleaning up... 02:02:43 INFO - Return code: 0 02:02:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:43 INFO - 'HOME': '/Users/cltbld', 02:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:43 INFO - 'LOGNAME': 'cltbld', 02:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:43 INFO - 'MOZ_NO_REMOTE': '1', 02:02:43 INFO - 'NO_EM_RESTART': '1', 02:02:43 INFO - 'PAGER': '/bin/cat', 02:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:43 INFO - 'PWD': '/builds/slave/test', 02:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:43 INFO - 'SHELL': '/bin/bash', 02:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:43 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:43 INFO - 'USER': 'cltbld', 02:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:43 INFO - 'XPC_FLAGS': '0x0', 02:02:43 INFO - 'XPC_SERVICE_NAME': '0', 02:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:47 INFO - Downloading docopt-0.6.1.tar.gz 02:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:48 INFO - Running setup.py install for blobuploader 02:02:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:48 INFO - Running setup.py install for requests 02:02:48 INFO - Running setup.py install for docopt 02:02:48 INFO - Successfully installed blobuploader requests docopt 02:02:48 INFO - Cleaning up... 02:02:48 INFO - Return code: 0 02:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:48 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')]} 02:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 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')]} 02:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:48 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:48 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 02:02:48 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 02:02:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:48 INFO - 'HOME': '/Users/cltbld', 02:02:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:48 INFO - 'LOGNAME': 'cltbld', 02:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:48 INFO - 'MOZ_NO_REMOTE': '1', 02:02:48 INFO - 'NO_EM_RESTART': '1', 02:02:48 INFO - 'PAGER': '/bin/cat', 02:02:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:48 INFO - 'PWD': '/builds/slave/test', 02:02:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:48 INFO - 'SHELL': '/bin/bash', 02:02:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:48 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:48 INFO - 'USER': 'cltbld', 02:02:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:48 INFO - 'XPC_FLAGS': '0x0', 02:02:48 INFO - 'XPC_SERVICE_NAME': '0', 02:02:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-QDHxFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-k2o2H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-9ZwgWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-8aNQMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Wqv1vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-rIJr0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-wNcPjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:49 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Neoxfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-R320bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-DiS4sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-wkT9K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-m_A_SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-NKt6Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-E09ekQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-MttNDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-nJqJLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:50 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-7HFxyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:51 INFO - Running setup.py install for manifestparser 02:02:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:51 INFO - Running setup.py install for mozcrash 02:02:51 INFO - Running setup.py install for mozdebug 02:02:51 INFO - Running setup.py install for mozdevice 02:02:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:51 INFO - Running setup.py install for mozfile 02:02:51 INFO - Running setup.py install for mozhttpd 02:02:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:51 INFO - Running setup.py install for mozinfo 02:02:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Running setup.py install for mozInstall 02:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Running setup.py install for mozleak 02:02:52 INFO - Running setup.py install for mozlog 02:02:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Running setup.py install for moznetwork 02:02:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Running setup.py install for mozprocess 02:02:52 INFO - Running setup.py install for mozprofile 02:02:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:53 INFO - Running setup.py install for mozrunner 02:02:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:53 INFO - Running setup.py install for mozscreenshot 02:02:53 INFO - Running setup.py install for moztest 02:02:53 INFO - Running setup.py install for mozversion 02:02:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:53 INFO - Cleaning up... 02:02:53 INFO - Return code: 0 02:02:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:53 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')]} 02:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:53 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')]} 02:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:53 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:53 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 02:02:53 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 02:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:53 INFO - 'HOME': '/Users/cltbld', 02:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:53 INFO - 'LOGNAME': 'cltbld', 02:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:53 INFO - 'MOZ_NO_REMOTE': '1', 02:02:53 INFO - 'NO_EM_RESTART': '1', 02:02:53 INFO - 'PAGER': '/bin/cat', 02:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:53 INFO - 'PWD': '/builds/slave/test', 02:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:53 INFO - 'SHELL': '/bin/bash', 02:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:53 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:53 INFO - 'USER': 'cltbld', 02:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:53 INFO - 'XPC_FLAGS': '0x0', 02:02:53 INFO - 'XPC_SERVICE_NAME': '0', 02:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:53 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-rCBKEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-H_KHa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-oiyPrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-DKDrf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-iwuK9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ILBkmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-rgxMDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-VFET1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-PiZkVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:54 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)) 02:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:54 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-uuYPwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-sfyRfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-iywDTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-A8joMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-dHtd3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-7TBzw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-fMFB5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:55 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)) 02:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:55 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-9Pnhrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:55 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)) 02:02:55 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)) 02:02:55 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)) 02:02:55 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)) 02:02:55 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)) 02:02:55 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)) 02:02:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:58 INFO - Downloading blessings-1.6.tar.gz 02:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:58 INFO - Installing collected packages: blessings 02:02:58 INFO - Running setup.py install for blessings 02:02:58 INFO - Successfully installed blessings 02:02:58 INFO - Cleaning up... 02:02:58 INFO - Return code: 0 02:02:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:58 INFO - Reading from file tmpfile_stdout 02:02:58 INFO - Current package versions: 02:02:58 INFO - blessings == 1.6 02:02:58 INFO - blobuploader == 1.2.4 02:02:58 INFO - docopt == 0.6.1 02:02:58 INFO - functools32 == 3.2.3-2 02:02:58 INFO - jsonschema == 2.5.1 02:02:58 INFO - manifestparser == 1.1 02:02:58 INFO - mozInstall == 1.12 02:02:58 INFO - mozcrash == 0.17 02:02:58 INFO - mozdebug == 0.1 02:02:58 INFO - mozdevice == 0.48 02:02:58 INFO - mozfile == 1.2 02:02:58 INFO - mozhttpd == 0.7 02:02:58 INFO - mozinfo == 0.9 02:02:58 INFO - mozleak == 0.1 02:02:58 INFO - mozlog == 3.4 02:02:58 INFO - moznetwork == 0.27 02:02:58 INFO - mozprocess == 0.23 02:02:58 INFO - mozprofile == 0.28 02:02:58 INFO - mozrunner == 6.12 02:02:58 INFO - mozscreenshot == 0.1 02:02:58 INFO - mozsystemmonitor == 0.3 02:02:58 INFO - moztest == 0.7 02:02:58 INFO - mozversion == 1.4 02:02:58 INFO - psutil == 3.1.1 02:02:58 INFO - requests == 1.2.3 02:02:58 INFO - wsgiref == 0.1.2 02:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:58 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:58 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 02:02:58 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 02:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:58 INFO - 'HOME': '/Users/cltbld', 02:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:58 INFO - 'LOGNAME': 'cltbld', 02:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:58 INFO - 'MOZ_NO_REMOTE': '1', 02:02:58 INFO - 'NO_EM_RESTART': '1', 02:02:58 INFO - 'PAGER': '/bin/cat', 02:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:58 INFO - 'PWD': '/builds/slave/test', 02:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:58 INFO - 'SHELL': '/bin/bash', 02:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:58 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:58 INFO - 'USER': 'cltbld', 02:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:58 INFO - 'XPC_FLAGS': '0x0', 02:02:58 INFO - 'XPC_SERVICE_NAME': '0', 02:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 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)) 02:02:59 INFO - Cleaning up... 02:02:59 INFO - Return code: 0 02:02:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:59 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')]} 02:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:59 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')]} 02:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:59 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 0x102e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d51d8f920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.QuNsCaz655/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.obhfSbw7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 02:02:59 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 02:02:59 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 02:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:59 INFO - 'HOME': '/Users/cltbld', 02:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:59 INFO - 'LOGNAME': 'cltbld', 02:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:59 INFO - 'MOZ_NO_REMOTE': '1', 02:02:59 INFO - 'NO_EM_RESTART': '1', 02:02:59 INFO - 'PAGER': '/bin/cat', 02:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:59 INFO - 'PWD': '/builds/slave/test', 02:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:59 INFO - 'SHELL': '/bin/bash', 02:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:02:59 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:59 INFO - 'USER': 'cltbld', 02:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:59 INFO - 'XPC_FLAGS': '0x0', 02:02:59 INFO - 'XPC_SERVICE_NAME': '0', 02:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:59 INFO - Cleaning up... 02:02:59 INFO - Return code: 0 02:02:59 INFO - Running post-action listener: _resource_record_post_action 02:02:59 INFO - Running post-action listener: _start_resource_monitoring 02:02:59 INFO - Starting resource monitoring. 02:02:59 INFO - [mozharness: 2016-10-17 09:02:59.522195Z] Finished create-virtualenv step (success) 02:02:59 INFO - [mozharness: 2016-10-17 09:02:59.523213Z] Running install step. 02:02:59 INFO - Running pre-action listener: _resource_record_pre_action 02:02:59 INFO - Running main action method: install 02:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:59 INFO - Reading from file tmpfile_stdout 02:02:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:59 INFO - Reading from file tmpfile_stdout 02:02:59 INFO - Output received: 02:02:59 INFO - Usage: mozinstall [options] installer 02:02:59 INFO - Options: 02:02:59 INFO - -h, --help show this help message and exit 02:02:59 INFO - -d DEST, --destination=DEST 02:02:59 INFO - Directory to install application into. [default: 02:02:59 INFO - "/builds/slave/test"] 02:02:59 INFO - --app=APP Application being installed. [default: firefox] 02:02:59 INFO - mkdir: /builds/slave/test/build/application 02:02:59 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'] 02:02:59 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 02:03:32 INFO - Reading from file tmpfile_stdout 02:03:32 INFO - Output received: 02:03:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:03:32 INFO - Running post-action listener: _resource_record_post_action 02:03:32 INFO - [mozharness: 2016-10-17 09:03:32.740638Z] Finished install step (success) 02:03:32 INFO - [mozharness: 2016-10-17 09:03:32.740849Z] Running run-tests step. 02:03:32 INFO - Running pre-action listener: _resource_record_pre_action 02:03:32 INFO - Running main action method: run_tests 02:03:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:03:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:03:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:03:32 INFO - 2016-10-17 02:03:32.753 screenresolution[2931:42183] starting screenresolution argv=screenresolution get 02:03:32 INFO - 2016-10-17 02:03:32.755 screenresolution[2931:42183] Display 0: 1600x1200x32@60 02:03:32 INFO - 2016-10-17 02:03:32.760 screenresolution[2932:42186] starting screenresolution argv=screenresolution list 02:03:32 INFO - Available Modes on Display 0 02:03:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:03:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:03:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:03:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:03:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:03:32 INFO - Intel Iris: 02:03:32 INFO - Chipset Model: Intel Iris 02:03:32 INFO - Type: GPU 02:03:32 INFO - Bus: Built-In 02:03:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:03:32 INFO - Vendor: Intel (0x8086) 02:03:32 INFO - Device ID: 0x0a2e 02:03:32 INFO - Revision ID: 0x0009 02:03:32 INFO - Displays: 02:03:32 INFO - Display: 02:03:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:03:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:03:32 INFO - Display Serial Number: 1600x1200 60 02:03:32 INFO - Main Display: Yes 02:03:32 INFO - Mirror: Off 02:03:32 INFO - Online: Yes 02:03:32 INFO - Rotation: Supported 02:03:33 INFO - Return code: 0 02:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:33 INFO - Python 2.7.3 02:03:33 INFO - Return code: 0 02:03:33 INFO - grabbing minidump binary from tooltool 02:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:03:33 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 0x102c8dd30>, '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 0x102af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:33 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 02:03:33 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 02:03:33 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 02:03:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:33 INFO - Return code: 0 02:03:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:03:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:03:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:33 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:03:33 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QuNsCaz655/Render', 02:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:03:33 INFO - 'HOME': '/Users/cltbld', 02:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:03:33 INFO - 'LOGNAME': 'cltbld', 02:03:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:33 INFO - 'MOZ_NO_REMOTE': '1', 02:03:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:33 INFO - 'NO_EM_RESTART': '1', 02:03:33 INFO - 'PAGER': '/bin/cat', 02:03:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:33 INFO - 'PWD': '/builds/slave/test', 02:03:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:03:33 INFO - 'SHELL': '/bin/bash', 02:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obhfSbw7R2/Listeners', 02:03:33 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 02:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:03:33 INFO - 'USER': 'cltbld', 02:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:33 INFO - 'XPC_FLAGS': '0x0', 02:03:33 INFO - 'XPC_SERVICE_NAME': '0', 02:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:03:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:03:33 INFO - mozversion application_buildid: 20161017004013 02:03:33 INFO - mozversion application_changeset: a205468e405c9225f0d72303e10ce72559f7f6b4 02:03:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:03:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:33 INFO - mozversion application_name: Firefox 02:03:33 INFO - mozversion application_remotingname: firefox-dev 02:03:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:03:33 INFO - mozversion application_vendor: Mozilla 02:03:33 INFO - mozversion application_version: 51.0a2 02:03:33 INFO - mozversion platform_buildid: 20161017004013 02:03:33 INFO - mozversion platform_changeset: a205468e405c9225f0d72303e10ce72559f7f6b4 02:03:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:03:33 INFO - mozversion platform_version: 51.0a2 02:03:33 INFO - using testdate: 1476695013 02:03:33 INFO - actual date: 1476695013 02:03:33 INFO - starting webserver on 'localhost:59380' 02:03:33 INFO - SUITE-START | Running 2 tests 02:03:33 INFO - TEST-START | dromaeo_css 02:03:33 INFO - operating with platform_type : mac_ 02:03:33 INFO - Initialising browser for dromaeo_css test... 02:03:33 INFO - TEST-INFO | started process 2942 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpE3uQx6/profile http://localhost:59380/getInfo.html) 02:03:35 INFO - PROCESS | 2942 | __metrics Screen width/height:1600/1200 02:03:35 INFO - PROCESS | 2942 | colorDepth:24 02:03:35 INFO - PROCESS | 2942 | Browser inner width/height: 1024/689 02:03:35 INFO - PROCESS | 2942 | __metrics 02:03:36 INFO - PROCESS | 2942 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:03:36 INFO - PROCESS | 2942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:03:36 INFO - TEST-INFO | 2942: exit 0 02:03:36 INFO - Browser initialized. 02:03:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:36 INFO - TEST-INFO | started process 2945 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpE3uQx6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:48 INFO - PROCESS | 2945 | RSS: Main: 220008448 02:03:48 INFO - PROCESS | 2945 | 02:04:39 INFO - PROCESS | 2945 | 1476695079905 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] 02:06:52 INFO - PROCESS | 2945 | Cycle 1(1): loaded http://localhost:59380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59380/tests/dromaeo/cssquery-ext.html) 02:06:54 INFO - PROCESS | 2945 | RSS: Main: 349171712 02:06:54 INFO - PROCESS | 2945 | 02:09:57 INFO - PROCESS | 2945 | Cycle 1(1): loaded http://localhost:59380/tests/dromaeo/cssquery-ext.html (next: http://localhost:59380/tests/dromaeo/cssquery-jquery.html) 02:09:57 INFO - PROCESS | 2945 | RSS: Main: 350281728 02:09:57 INFO - PROCESS | 2945 | 02:13:00 INFO - PROCESS | 2945 | Cycle 1(1): loaded http://localhost:59380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59380/tests/dromaeo/cssquery-mootools.html) 02:13:00 INFO - PROCESS | 2945 | RSS: Main: 318177280 02:13:00 INFO - PROCESS | 2945 | 02:16:03 INFO - PROCESS | 2945 | Cycle 1(1): loaded http://localhost:59380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59380/tests/dromaeo/cssquery-prototype.html) 02:16:03 INFO - PROCESS | 2945 | RSS: Main: 322256896 02:16:03 INFO - PROCESS | 2945 | 02:19:07 INFO - PROCESS | 2945 | Cycle 1(1): loaded http://localhost:59380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59380/tests/dromaeo/cssquery-yui.html) 02:19:07 INFO - PROCESS | 2945 | RSS: Main: 311169024 02:19:07 INFO - PROCESS | 2945 | 02:22:10 INFO - PROCESS | 2945 | Cycle 1(1): loaded http://localhost:59380/tests/dromaeo/cssquery-yui.html (next: http://localhost:59380/tests/dromaeo/cssquery-dojo.html) 02:22:11 INFO - PROCESS | 2945 | RSS: Main: 417308672 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | __start_tp_report 02:22:11 INFO - PROCESS | 2945 | _x_x_mozilla_page_load 02:22:11 INFO - PROCESS | 2945 | _x_x_mozilla_page_load_details 02:22:11 INFO - PROCESS | 2945 | |i|pagename|runs| 02:22:11 INFO - PROCESS | 2945 | |0;dojo.html;3301.240714635633;3310.3048359844433;3317.7014068733815;3335.4163021471236;3368.5115658229556;5677.886442271158;5755.942440575593;5767.740451679674;5831.7958871439505;5852.20995165653;5733.713314334277;5783.739731712072;5828.650280983134;5840.036393994997;5843.941560584393;5254.737263136837;5308.177232528964;5318.414974352818;5327.467253274661;5367.194920761878;4560.384348112995;4637.5623556697365;5369.060414427459;5387.865303367408;5394.811181608645;5319.281896943921;5376.542993845528;5376.650517716355;5384.973075134619;5388.164834450647;5344.198370244456;5359.437259087798;5367.302250707422;5371.140617501181;5387.057264978613;5197.610179236573;5290.576753859682;5301.0723123453245;5310.150375939831;5329.173978033411;5862.325832529271;5865.178874957467;5882.147088672162;5882.205902203191;5884.6469211847425;6147.801178770142;6174.660393678346;6198.101275315054;6216.720247588869;6218.440340369389;6229.937700622981;6289.119523266746;6289.748410063592;6294.496440284812;6307.400796924285;5751.223584816038;5788.565857560699;5790.189373487715;5796.50729687977;5853.853653658693;6227.1282020517165;6285.214348206474;6288.402601752826;6296.212973378328;6322;6060.727267272983;6109.34393638171;6165.260168779775;6240.5319601030105;6249.7187626556915;6313.715882785285;6327.715252813635;6332.968335158294;6336.398042185985;6350.714217860207;6118.95422233728;6195.628262304276;6298.590591611623;6299.338569450142;6321.810345689637;6138.48821116479;6249.812505624838;6262.436380725757;6295.905561416583;6312.147860038928;4224.556421575752;4947.851564453073;4951.133551628451;4972.801087956514;4983.950160498421;4325.7620830853975;4369.235383807884;4405.647548196137;4456.821727130879;4487.057717879216;5601.80393686219;5698.344690360579;5703.914441283384;5713.143028545668;5719.342275638355;6267.2479302484;6306.653134077578;6312.495000399957;6312.810615681537;6332.810015699536;5829.387914268941;5835.620684655484;5838.12428135783;5858.326292476335;5890.057590785454;5438.5377242934;5465.289512363367;5497.175423686399;5507.5593952483705;5514.145307477347;5122.257272695513;6264.248290205022;6266.467350275278;6299.307076221704;6380.585261957958;6265.8120256392385;6280.685965701605;6292.182016337847;6297.370262973666;6304.243490781136;6366.681665916593;6440.871182576416;6460.806175814733;6468.288488266193;6479.611223326616;5096.949030509648;6131.202943617302;6132.4166970161305;6285.1515045470105;6286.119943207863;6216.689165541615;6219;6286.402791734778;6326.272478665012;6334.904976425265;6145.600535965148;6155.753769849156;6192.349803270592;6198.132261483486;6200.720967556561;6019.398060193946;6088.117223002551;6092.695365231632;6167.321594624498;6179.969100154471;5832.096025116114;5869.6771677558145;5994.730237139426;6028.4272994065495;6033.336333003278;6119.694015299307;6172.753089876354;6174.104754810437;6176.907346389898;6179.351168127282;5868.2664666916635;5945.078512830518;5951.583389162717;5962.850928726816;5986.880262394815 02:22:11 INFO - PROCESS | 2945 | |1;ext.html;463.1917304303988;469.3312030356741;473.53356943410733;510.6374474123372;517.5730022731248;26004.609930851053;30404.087877363658;32181.71273149074;32360.838195809018;41843.58156418435;42324.78837605807;42776.57223427765;42836.35745463821;42860.78569607148;42902;9816.312858099918;9984.800303993916;9992.800143997116;10004.049615286536;10008.99910008997;8842.159994800484;9093;9738.1235688788;9851.458169800659;9856.50717464124;12029.639110826689;12301.138920275584;12336.81494777579;12506.93691036263;12526.248425094478;12207.755844883097;12318.692032699164;12325.69185770354;12331.321777302244;12357.135000549964;8772.12278772124;9027.4132181408;11773.529058837636;11953.880461195364;12059.457324420422;38947;40666.59333406658;40683;40692.389614155814;40754.59245407538;2837.787165962561;3409.454487282023;3443.9827800861085;3473.6873681368547;3698.9630103698887;29467;29840.96539598836;30000.099996999907;31519.84240078808;31633.32918171628;3130.671279515641;3140.8586613602442;3264.4940034294723;3391.2369716813764;3427.3316703242876;496499;501345;504575;504926;510973.4451327757;53138.46861531412;62706.372936270964;63534.682326588074;64151.679241604426;64200;66103.66948165228;66236;66303.33696662972;66318;66402.33597664058;17089.145542722814;17331.133443327784;17366.305347785947;17368.47894563165;17408.21663025167;13190.538331158363;13270.203787772765;13274.73450530984;13279.136856104322;13316.600501984956;15836.812239081884;16391;16427.83572164287;17799.021053842163;18169.909150454165;6385.808425747235;7214.531055481377;7217.2421895701245;7276;7291.161516425573;872.5637181409295;889.2308153447221;1059.2691043180182;1074.3714926767927;1108.0969010256615;29172.27069323284;29991.700082999327;30202.69797301999;30601.469926503585;31056.68943310538;1039.4834444339333;1042.3120740311358;1087.9891201087887;1115.4478533126155;1138.4364739454024;15370.308336124677;15773.526794196192;15839.683206335809;15925.942524786147;16005.519834404986;669279.3072069314;670013;674200;674207;675249;51035;52161;55651.44348556543;58056;59383;1352.2359866675495;1390.21452879125;1398.1960372785688;1400.9929950350183;1410.6261840612246;30172.709937915926;31967.840160799977;31994.040178794672;32480.837595812816;32755.181120472178;52738;53083.73458132685;53202.46797531975;53215.4678453226;53304.002199835944;622342;625558;626892;626905;628222;40773.79613101915;40938;41864.581354187285;42171.7891410541;42198.367024494044;46582.53417465917;47271.29093063676;48013;50102;50343;40149;40492;40594.59405405908;40860.38709419421;42141.36787948122;39767.00582485461;40167.1966560673;40185;41384;41738.16523669449;38256.426153607164;38509.844704658906;38638.80680596579;38653;39035.6096439032;24625;33699;35873.82063089668;35940.28119437649;36006.45990310095;25432.364190895376;25894.61158082668;26041.869790651683;26175.476490470464;26885.731142689106 02:22:11 INFO - PROCESS | 2945 | |2;jquery.html;332.8864946753113;364.9087728067983;376.76452217364147;381.38787246469406;403.9111395492992;14082.084664496813;14304.856951430482;20676.89661551694;21231.893840530814;22224.88887555564;18135.365262215793;20183.29358472454;20684.172633094695;21184.25855095072;21502.569948601056;5833.329167145779;6167.105769663396;6167.229096362955;6169.10547970544;6172;4225.450691410112;4433.9778301108445;6043.4560889519935;6803.183617965827;6831.282715314895;6569.211694596655;6868.690908909086;6886.414654754352;6890.896636550456;6911.447084233249;6796.524243302971;6846.931530684679;6862.005009273652;6877.2091209510545;6879.931200687979;5701.71491425427;5888.4700376966275;5949.434803693643;5950.97024514879;5973.581849270553;26036;26951.843852491755;27022.86488567564;27102.5934610981;27409.862950685318;2288.622377307742;2293.9885300573555;2354.3172479980785;2847.501687204731;3051.450738867003;15913.204339782964;16019.599510012227;16130.758038629312;16396.75404868928;16909.23908424124;1856;1906.1708156951631;1927.180948097053;1957.1779852461857;2049.6925461180795;116611.41694291474;117913.41043294729;119167.2124918127;119349;126333.36833315867;9920.660710804093;10776;10904.34573925567;11217.32696038224;11233.269837460539;12344.81482777759;13036.608901732963;13057.28184949837;13386.464541418234;13396.531121410704;7734.690612375554;8325.666973321;8337.95831020853;8508.234258916727;8947.821043579092;7165.713371465187;8669.479831210021;8818.33862460318;8924.55377231136;9114.088591140833;4537.77311134442;4562.429696287964;4562.657800664963;4563.771811409416;4615;1743.6861364954177;1783.6415692950613;1825.607494388713;1871.4666320098706;1919.654462196818;823.736404350602;826.8718348655968;870.7083127152348;878.2359347367703;959.6161535385902;16832.74750878738;21652.35042948714;22074;22108.447288817908;22169.778302217095;883.6951251818112;922.1838672774643;925.472480686016;944.6646440513656;957.7174733453647;11053.28153670009;11474.386192771653;11551.711207219887;11568.479418426192;11646.068314534818;534288;587251;596171;613698;626986;136053.95919061222;140552.29723851316;143019;147385.26307368395;148125.25937370458;939.1031564855683;943.6225509796136;1012.3419777144915;1018.9286749927583;1024.6004058417222;19404.417867464;19570.31503897414;20201.292954746514;20213.191472340943;20238.696419554013;42002.78998604987;56052.71973640106;56349.43650563606;58720.70639646774;58794.7060264696;82418.58790706008;83414.58292708498;84209;84947.5752621233;87363.12636873804;8082.757517274491;8173.836523269621;8255.587220639065;8455.534945578052;8489.95755021221;11172.497237624164;12131.75736485283;12247.713990031274;13135.934320328337;13588;10988.340699558052;11313.773724525628;11561.30632162073;11565.768684626091;11616.12879034059;11302;11344.773104538028;11419.771604567695;11428.428578571204;11434.085273178292;11619.128565357463;11704.531818727497;11842.348670823187;12058.216215945935;12073.396330183632;6691.732330706717;8100.756977290691;8257;8424.536650484282;8483.024452188078;9363.14424100656;11311.830322545333;11326.886731132583;11659.825102623638;11771.352575608424 02:22:11 INFO - PROCESS | 2945 | |3;mootools.html;1498.82014158301;1523.7638166084257;1613.5320756980477;1706.9573260668483;1876.512106852218;8508.574571271443;9064.954675226614;9092.545372731362;9105.135012173841;9113.954430227855;7840.607969601511;8130.634121464534;8133.471324363913;8243.464174828632;8263.008438987315;2045.3250427358935;2141.2719675310354;2360.7639236076343;2405.0620258099357;2425.50277193175;2038.3986723916405;2392.210570511727;2412.2280870121567;2425.866577338246;2426.454047839231;2385.260569223546;2432.720237172721;2433.9756602434013;2437.122635851101;2439.8536087834786;2388.295452841425;2404.1825779235055;2416.2630397728685;2416.540857237137;2422.358075110097;2382.309130352196;2389.2832150354825;2405.482821193434;2418.1415597462824;2425.7938075263623;8830.249428798496;8908.51003194824;8959.552022398853;8962.82074358509;8988.191062804379;5210.270562121306;5364.785408583652;5382.91925621116;5386.165144402585;5390.110631745757;3112.750979921601;3350.8994730158133;3515.5605549306338;3543.2303343405993;3626.0934766308424;1055.5883205549842;1102.063246240697;1128.3342827731597;1129.0177545535355;1133.472935085181;10151.593936242542;12000.87999120015;12030.398480075874;12038.69903252417;12054.337011464366;4668.298805484425;4694.460137084211;4744.857654270309;4835.854924352205;4893.755312234374;10005.549750261256;10012.649557265606;10017.04838040385;10026.849597256047;10055.044770746767;5297.761600727977;5389.299391079213;5391.757370918318;5401.270828438111;5403.108487099585;4722.079194557097;4848.418189817174;4950.554450099508;4958.107540642719;4965.602751779849;3570;3692.593814680383;3700.685441737429;3750.7937063461773;3875.2443273561385;1159.7970355187977;1161.9070474362031;1169.7542117644682;1175.1432736276663;1178.8880056394628;760.4752720622753;781.5818537082633;889.4663202078831;899.8110396816742;928.2573940847295;5456.61803673739;5501.669899806025;5711.286089238845;5829.950608890355;6250.218722659668;854.4531499840107;974.907383798538;1019.37308555238;1039.8024375368657;1079.0019232210175;3843.327417701891;3870.9806450968126;3904.863329783444;3927.842886284574;4052.7163098582814;10746.462676866126;11013.724656883642;11192.664220073411;11197.44012799373;11204.383758893176;9514.524273786283;10956.12351011917;11071.889281107247;11138.941800528937;11153.10775137987;8124.350051995826;8282;8311.625976830936;8447.66209351619;8452.1547845215;5785.652860828363;5810.215620891126;5887.911681324698;5904.291485021653;6070.119832624333;10157;10257.128144107834;10259.94870025675;10342.689719308433;10406.375617462976;9572.994835542167;9891.406515609087;9901.702948911545;10129.797404052026;10284.2801003929;7631.3513351365755;7661.310482056641;7764.145943946274;7772.494787838772;7784.727534536264;7634.541927484369;7850.136484986533;7860.960695196487;8017.559034253172;8361.372897032625;6493.610383377012;7511.399088073051;7515.13575938774;7521.0974683038385;7561.584112873625;7417.851642967218;7444.218357072429;7493.4379921505015;7502.399808015455;7616.69533218665;6949.51353405277;6950.131233595801;7012.964935175291;7028.051213086168;7036.979637952571;4132.669386449017;4762.9285560715925;4915;4939.777710003131;5139.152039913522;4648.395708557866;4934.851954441372;4946.752662366939;4997.300377947163;5119.129747942933 02:22:11 INFO - PROCESS | 2945 | |4;prototype.html;300.2209266952259;303.8632615323105;308.8409469123401;312.6295340022074;314.54391132857364;5197.336852207295;5509.504144626982;5581.604598850287;5586.798838249775;5622.297212848394;4707.764611769407;4966.279889416041;5102.372278276681;5196.752779332961;5298.1522956327;3952.881413557598;4055.858044968427;4073.3279008963486;4103.569125241851;4205.642520385755;4182.895427614303;4190.937135942963;4218.4516012918275;4231.344141658048;4233.788310584474;4014.9799251003706;4128.277551428503;4146.232946904817;4184.8744537663915;4207.957920420788;4170.4995400551825;4184.288670925919;4187.136724157751;4191.874243772691;4220.388043733657;3034.6965303469697;3604.4052731299303;3604.936543719609;3609.458581212839;3620.3664358737115;5068.467810879842;5172.861970366514;5366.409694933554;5395.406505284415;5430.3755068167275;4749.715017098985;4759.405074365704;4763.285507173917;4825.227963525854;4826.855194344175;5015.4953513945675;5326.280952071459;5828.125781132821;5836.941630583682;5844.094165404369;3665.6517630825297;3711.758735682172;3912.217556488714;4006.939895901564;4053.898652533681;5068.82259120929;5366.087765079946;5731.398203188647;6085.208922840003;6094.750576131926;3364.4616861302075;3696.77819330841;3750.818492174956;3962.385830196324;4015.2170326785995;3533.6643018913164;3900.258950799339;4016.4577781999055;4027.335489644176;4036.677065834785;4121.876343709693;4690.835820746326;4692.507286734912;4708.670393072521;4738.857834264978;5451.618386712971;5586.653605485706;5754.424557544212;5876.647401155944;5937.406259374115;1190.8451901252781;1196.8623608285159;1332.6135420728074;1371.1772936238178;1372.293268966483;849.2865992566274;884.1335491218641;903.4145075392775;907.6702630646136;919.9126083022102;5298.867528311823;5316.441773613792;5317.8404647860625;5333.893322133536;5350.946490535045;5133.535902766618;5236.685798852005;5902.4097590240635;5909.70451477433;6016.639001659914;4718.386609740712;5086.5422112009355;5108.642395032386;5477.507733981029;5613.950907918662;3094.381123775254;3175.7300629446295;3185.633652129988;3193.6965988231545;3194.961637467832;5879.294484661782;6245;6284.685765711696;6293.653849038255;6367.681615919186;5595.664260144405;5609.242752228479;6205.007198848162;6212.161358216583;6213.763045303687;5469.480399362054;5985.551083668655;6221.657808820558;6222.688865556795;6294.65379404128;5301.814436494704;6021.849453763691;6048.153258543895;6049.848753781191;6054.39456054391;5660.320761508646;5867.559933005127;5900.734466948912;5915.319738230159;5928.970355148197;5907.793227237026;6250.218722659668;6264.776004518512;6308.810735677937;6335.556511044183;3454.758166928291;3832.559255685632;3957.8614748483665;3980.124372638015;4001.699872509515;6002.819915402545;6033.621172143614;6041.607295525777;6049.909251361145;6063.998320831217;5146.845594632167;5160.819371321985;5511.559075273888;5855.121731740273;5924.9703751480965;5310.99091172676;5376.865578360573;5490.486088903185;5942.553319075013;5961.642301461926;4426.44669416323;5186.683649259539;5649.745761440663;5755.971220143872;5797.159411885169;5364.7049412282695;5862.237909071793;5921.822345329647;5928.407159284037;5971.611845230046;4511.390962220058;5361.38344090419;5737.536928083312;5741.224934633771;5787.826365209051 02:22:11 INFO - PROCESS | 2945 | |5;yui.html;609.93900609939;743.5612988336887;764.7438108233741;813.2111851504043;834.7036801935312;14850;16107.516774496784;16116.677666446663;17180.484585462425;17691.203895824685;16595.751063734053;16951.406700765474;16976.74534881978;16987.91506042471;17194.914025429887;669.6752075243503;833.3583140981441;851.9872201916976;855.0124606079987;855.6491838346279;685.4002747595854;693.5595896605641;818.292177266663;839.9836198200185;844.3287586368851;885.4731434796319;897.7441429192681;898.9955050224739;900.0954041188596;902.9954850225739;892.9821403571925;893.9016708162097;894.172890076683;894.9776255593662;895.6730793260413;508.26809394471843;525.3984188104599;626.3923993726079;647.0197650559406;660.4716227018366;15636.92181539085;15754.842451575452;15772;15783.210839457981;15835.920820395824;13476.932615336958;13699.726005479934;13826.861731382758;13907.304634768221;13976.014299551636;12414;12598.937005315007;12781.808272875915;12968.870311296861;13578.660533486644;4038.8788336349958;4527.366168736379;4540.18276710192;4541.318802179667;4732.810687572493;107511.38732919091;122047;126030;126934.36532817277;128292;10905;11000.559977600806;11311.773764524827;11414.657560273205;11475.713107172387;21015.474613134487;22160.667589986162;22192.445188870406;22221.555568888856;22335.329940101823;7579.279968402993;7722.691092356243;7777.844443111106;7961.203879611992;7976.521408715495;4398.186335527937;4417.889552761207;4424.690271680952;4462.062966776948;4653.441587009513;3638.9818050909576;3799.886003419902;3799.981000094982;3803.6196380361744;3803.6386543278345;667.7796327212009;675.0785178231679;690.4717890813532;699.6396855619361;705.8623568404215;581.8603535151533;650.8926027205553;659.3274859643137;660.8182749743859;665.9433948114367;8332.791680208044;8921.795557599771;9594.520273986273;9798.510074496247;9896.25778066648;592.5822295281816;667.9899801502982;672.909157263773;680.904673345732;688.3460712323213;4420.602145806893;4527.84152554659;4602.746848923274;4735.345690141994;4777.784999675023;155070;162921;163852;168221;177384;88971.55514222388;95895;146934;156510;159642;122691.77308226803;128449.71550284377;129598.99999999811;133197.33401332932;133539.33230333982;8629.22336989674;9005.729828105168;9090.045545217657;9115.635374584943;9268.119528644767;60248;64936.675316623114;66882.66558667175;67344;68569.97145042729;66365;69639.65180174066;71464.28535714577;88521.22957540942;92536.53731731298;13124.606261812161;13273.469061237829;13403.32983350848;13521.323933803467;13527.188368697909;14243.430262789372;14635.92682036583;14692.265386730407;15038.323275452412;15937;13175.60473185806;13850.16898986064;13856.168629882239;14238.430462781373;14867.702645947236;13669.589912302647;13812.516561920285;14276.286185690882;14385.104658275322;14617.784087500733;13357.065005449525;13527.256000920044;13685;13973.301334933416;14329.426822926966;11134.88865111371;11220.551177953117;11372.43137843088;11471.4264286787;12029.699257518632;11540.192186546861;11583.725790163244;11610.230118040132;11696.35670038122;11758.529658813552 02:22:11 INFO - PROCESS | 2945 | __end_tp_report 02:22:11 INFO - PROCESS | 2945 | __start_cc_report 02:22:11 INFO - PROCESS | 2945 | _x_x_mozilla_cycle_collect,1697 02:22:11 INFO - PROCESS | 2945 | __end_cc_report 02:22:11 INFO - PROCESS | 2945 | __startTimestamp1476696131149__endTimestamp 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | ------- Summary: start ------- 02:22:11 INFO - PROCESS | 2945 | Number of tests: 6 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | [#0] dojo.html Cycles:165 Average:5778.84 Median:5962.85 stddev:661.38 (11.1%) stddev-sans-first:634.21 02:22:11 INFO - PROCESS | 2945 | Values: 3301.2 3310.3 3317.7 3335.4 3368.5 5677.9 5755.9 5767.7 5831.8 5852.2 5733.7 5783.7 5828.7 5840.0 5843.9 5254.7 5308.2 5318.4 5327.5 5367.2 4560.4 4637.6 5369.1 5387.9 5394.8 5319.3 5376.5 5376.7 5385.0 5388.2 5344.2 5359.4 5367.3 5371.1 5387.1 5197.6 5290.6 5301.1 5310.2 5329.2 5862.3 5865.2 5882.1 5882.2 5884.6 6147.8 6174.7 6198.1 6216.7 6218.4 6229.9 6289.1 6289.7 6294.5 6307.4 5751.2 5788.6 5790.2 5796.5 5853.9 6227.1 6285.2 6288.4 6296.2 6322.0 6060.7 6109.3 6165.3 6240.5 6249.7 6313.7 6327.7 6333.0 6336.4 6350.7 6119.0 6195.6 6298.6 6299.3 6321.8 6138.5 6249.8 6262.4 6295.9 6312.1 4224.6 4947.9 4951.1 4972.8 4984.0 4325.8 4369.2 4405.6 4456.8 4487.1 5601.8 5698.3 5703.9 5713.1 5719.3 6267.2 6306.7 6312.5 6312.8 6332.8 5829.4 5835.6 5838.1 5858.3 5890.1 5438.5 5465.3 5497.2 5507.6 5514.1 5122.3 6264.2 6266.5 6299.3 6380.6 6265.8 6280.7 6292.2 6297.4 6304.2 6366.7 6440.9 6460.8 6468.3 6479.6 5096.9 6131.2 6132.4 6285.2 6286.1 6216.7 6219.0 6286.4 6326.3 6334.9 6145.6 6155.8 6192.3 6198.1 6200.7 6019.4 6088.1 6092.7 6167.3 6180.0 5832.1 5869.7 5994.7 6028.4 6033.3 6119.7 6172.8 6174.1 6176.9 6179.4 5868.3 5945.1 5951.6 5962.9 5986.9 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | [#1] ext.html Cycles:180 Average:73663.77 Median:38800.00 stddev:161736.01 (416.8%) stddev-sans-first:162096.34 02:22:11 INFO - PROCESS | 2945 | Values: 463.2 469.3 473.5 510.6 517.6 26004.6 30404.1 32181.7 32360.8 41843.6 42324.8 42776.6 42836.4 42860.8 42902.0 9816.3 9984.8 9992.8 10004.0 10009.0 8842.2 9093.0 9738.1 9851.5 9856.5 12029.6 12301.1 12336.8 12506.9 12526.2 12207.8 12318.7 12325.7 12331.3 12357.1 8772.1 9027.4 11773.5 11953.9 12059.5 38947.0 40666.6 40683.0 40692.4 40754.6 2837.8 3409.5 3444.0 3473.7 3699.0 29467.0 29841.0 30000.1 31519.8 31633.3 3130.7 3140.9 3264.5 3391.2 3427.3 496499.0 501345.0 504575.0 504926.0 510973.4 53138.5 62706.4 63534.7 64151.7 64200.0 66103.7 66236.0 66303.3 66318.0 66402.3 17089.1 17331.1 17366.3 17368.5 17408.2 13190.5 13270.2 13274.7 13279.1 13316.6 15836.8 16391.0 16427.8 17799.0 18169.9 6385.8 7214.5 7217.2 7276.0 7291.2 872.6 889.2 1059.3 1074.4 1108.1 29172.3 29991.7 30202.7 30601.5 31056.7 1039.5 1042.3 1088.0 1115.4 1138.4 15370.3 15773.5 15839.7 15925.9 16005.5 669279.3 670013.0 674200.0 674207.0 675249.0 51035.0 52161.0 55651.4 58056.0 59383.0 1352.2 1390.2 1398.2 1401.0 1410.6 30172.7 31967.8 31994.0 32480.8 32755.2 52738.0 53083.7 53202.5 53215.5 53304.0 622342.0 625558.0 626892.0 626905.0 628222.0 40773.8 40938.0 41864.6 42171.8 42198.4 46582.5 47271.3 48013.0 50102.0 50343.0 40149.0 40492.0 40594.6 40860.4 42141.4 39767.0 40167.2 40185.0 41384.0 41738.2 38256.4 38509.8 38638.8 38653.0 39035.6 24625.0 33699.0 35873.8 35940.3 36006.5 25432.4 25894.6 26041.9 26175.5 26885.7 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | [#2] jquery.html Cycles:180 Average:35790.35 Median:26987.35 stddev:99466.19 (368.6%) stddev-sans-first:99709.59 02:22:11 INFO - PROCESS | 2945 | Values: 332.9 364.9 376.8 381.4 403.9 14082.1 14304.9 20676.9 21231.9 22224.9 18135.4 20183.3 20684.2 21184.3 21502.6 5833.3 6167.1 6167.2 6169.1 6172.0 4225.5 4434.0 6043.5 6803.2 6831.3 6569.2 6868.7 6886.4 6890.9 6911.4 6796.5 6846.9 6862.0 6877.2 6879.9 5701.7 5888.5 5949.4 5951.0 5973.6 26036.0 26951.8 27022.9 27102.6 27409.9 2288.6 2294.0 2354.3 2847.5 3051.5 15913.2 16019.6 16130.8 16396.8 16909.2 1856.0 1906.2 1927.2 1957.2 2049.7 116611.4 117913.4 119167.2 119349.0 126333.4 9920.7 10776.0 10904.3 11217.3 11233.3 12344.8 13036.6 13057.3 13386.5 13396.5 7734.7 8325.7 8338.0 8508.2 8947.8 7165.7 8669.5 8818.3 8924.6 9114.1 4537.8 4562.4 4562.7 4563.8 4615.0 1743.7 1783.6 1825.6 1871.5 1919.7 823.7 826.9 870.7 878.2 959.6 16832.7 21652.4 22074.0 22108.4 22169.8 883.7 922.2 925.5 944.7 957.7 11053.3 11474.4 11551.7 11568.5 11646.1 534288.0 587251.0 596171.0 613698.0 626986.0 136054.0 140552.3 143019.0 147385.3 148125.3 939.1 943.6 1012.3 1018.9 1024.6 19404.4 19570.3 20201.3 20213.2 20238.7 42002.8 56052.7 56349.4 58720.7 58794.7 82418.6 83414.6 84209.0 84947.6 87363.1 8082.8 8173.8 8255.6 8455.5 8490.0 11172.5 12131.8 12247.7 13135.9 13588.0 10988.3 11313.8 11561.3 11565.8 11616.1 11302.0 11344.8 11419.8 11428.4 11434.1 11619.1 11704.5 11842.3 12058.2 12073.4 6691.7 8100.8 8257.0 8424.5 8483.0 9363.1 11311.8 11326.9 11659.8 11771.4 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | [#3] mootools.html Cycles:180 Average:5722.42 Median:4799.39 stddev:3235.53 (67.4%) stddev-sans-first:3229.04 02:22:11 INFO - PROCESS | 2945 | Values: 1498.8 1523.8 1613.5 1707.0 1876.5 8508.6 9065.0 9092.5 9105.1 9114.0 7840.6 8130.6 8133.5 8243.5 8263.0 2045.3 2141.3 2360.8 2405.1 2425.5 2038.4 2392.2 2412.2 2425.9 2426.5 2385.3 2432.7 2434.0 2437.1 2439.9 2388.3 2404.2 2416.3 2416.5 2422.4 2382.3 2389.3 2405.5 2418.1 2425.8 8830.2 8908.5 8959.6 8962.8 8988.2 5210.3 5364.8 5382.9 5386.2 5390.1 3112.8 3350.9 3515.6 3543.2 3626.1 1055.6 1102.1 1128.3 1129.0 1133.5 10151.6 12000.9 12030.4 12038.7 12054.3 4668.3 4694.5 4744.9 4835.9 4893.8 10005.5 10012.6 10017.0 10026.8 10055.0 5297.8 5389.3 5391.8 5401.3 5403.1 4722.1 4848.4 4950.6 4958.1 4965.6 3570.0 3692.6 3700.7 3750.8 3875.2 1159.8 1161.9 1169.8 1175.1 1178.9 760.5 781.6 889.5 899.8 928.3 5456.6 5501.7 5711.3 5830.0 6250.2 854.5 974.9 1019.4 1039.8 1079.0 3843.3 3871.0 3904.9 3927.8 4052.7 10746.5 11013.7 11192.7 11197.4 11204.4 9514.5 10956.1 11071.9 11138.9 11153.1 8124.4 8282.0 8311.6 8447.7 8452.2 5785.7 5810.2 5887.9 5904.3 6070.1 10157.0 10257.1 10259.9 10342.7 10406.4 9573.0 9891.4 9901.7 10129.8 10284.3 7631.4 7661.3 7764.1 7772.5 7784.7 7634.5 7850.1 7861.0 8017.6 8361.4 6493.6 7511.4 7515.1 7521.1 7561.6 7417.9 7444.2 7493.4 7502.4 7616.7 6949.5 6950.1 7013.0 7028.1 7037.0 4132.7 4762.9 4915.0 4939.8 5139.2 4648.4 4934.9 4946.8 4997.3 5119.1 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | [#4] prototype.html Cycles:180 Average:4706.96 Median:5300.34 stddev:1466.24 (27.7%) stddev-sans-first:1432.56 02:22:11 INFO - PROCESS | 2945 | Values: 300.2 303.9 308.8 312.6 314.5 5197.3 5509.5 5581.6 5586.8 5622.3 4707.8 4966.3 5102.4 5196.8 5298.2 3952.9 4055.9 4073.3 4103.6 4205.6 4182.9 4190.9 4218.5 4231.3 4233.8 4015.0 4128.3 4146.2 4184.9 4208.0 4170.5 4184.3 4187.1 4191.9 4220.4 3034.7 3604.4 3604.9 3609.5 3620.4 5068.5 5172.9 5366.4 5395.4 5430.4 4749.7 4759.4 4763.3 4825.2 4826.9 5015.5 5326.3 5828.1 5836.9 5844.1 3665.7 3711.8 3912.2 4006.9 4053.9 5068.8 5366.1 5731.4 6085.2 6094.8 3364.5 3696.8 3750.8 3962.4 4015.2 3533.7 3900.3 4016.5 4027.3 4036.7 4121.9 4690.8 4692.5 4708.7 4738.9 5451.6 5586.7 5754.4 5876.6 5937.4 1190.8 1196.9 1332.6 1371.2 1372.3 849.3 884.1 903.4 907.7 919.9 5298.9 5316.4 5317.8 5333.9 5350.9 5133.5 5236.7 5902.4 5909.7 6016.6 4718.4 5086.5 5108.6 5477.5 5614.0 3094.4 3175.7 3185.6 3193.7 3195.0 5879.3 6245.0 6284.7 6293.7 6367.7 5595.7 5609.2 6205.0 6212.2 6213.8 5469.5 5985.6 6221.7 6222.7 6294.7 5301.8 6021.8 6048.2 6049.8 6054.4 5660.3 5867.6 5900.7 5915.3 5929.0 5907.8 6250.2 6264.8 6308.8 6335.6 3454.8 3832.6 3957.9 3980.1 4001.7 6002.8 6033.6 6041.6 6049.9 6064.0 5146.8 5160.8 5511.6 5855.1 5925.0 5311.0 5376.9 5490.5 5942.6 5961.6 4426.4 5186.7 5649.7 5756.0 5797.2 5364.7 5862.2 5921.8 5928.4 5971.6 4511.4 5361.4 5737.5 5741.2 5787.8 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - PROCESS | 2945 | [#5] yui.html Cycles:180 Average:26179.17 Median:3801.80 stddev:42959.13 (1130.0%) stddev-sans-first:43036.74 02:22:11 INFO - PROCESS | 2945 | Values: 609.9 743.6 764.7 813.2 834.7 14850.0 16107.5 16116.7 17180.5 17691.2 16595.8 16951.4 16976.7 16987.9 17194.9 669.7 833.4 852.0 855.0 855.6 685.4 693.6 818.3 840.0 844.3 885.5 897.7 899.0 900.1 903.0 893.0 893.9 894.2 895.0 895.7 508.3 525.4 626.4 647.0 660.5 15636.9 15754.8 15772.0 15783.2 15835.9 13476.9 13699.7 13826.9 13907.3 13976.0 12414.0 12598.9 12781.8 12968.9 13578.7 4038.9 4527.4 4540.2 4541.3 4732.8 107511.4 122047.0 126030.0 126934.4 128292.0 10905.0 11000.6 11311.8 11414.7 11475.7 21015.5 22160.7 22192.4 22221.6 22335.3 7579.3 7722.7 7777.8 7961.2 7976.5 4398.2 4417.9 4424.7 4462.1 4653.4 3639.0 3799.9 3800.0 3803.6 3803.6 667.8 675.1 690.5 699.6 705.9 581.9 650.9 659.3 660.8 665.9 8332.8 8921.8 9594.5 9798.5 9896.3 592.6 668.0 672.9 680.9 688.3 4420.6 4527.8 4602.7 4735.3 4777.8 155070.0 162921.0 163852.0 168221.0 177384.0 88971.6 95895.0 146934.0 156510.0 159642.0 122691.8 128449.7 129599.0 133197.3 133539.3 8629.2 9005.7 9090.0 9115.6 9268.1 60248.0 64936.7 66882.7 67344.0 68570.0 66365.0 69639.7 71464.3 88521.2 92536.5 13124.6 13273.5 13403.3 13521.3 13527.2 14243.4 14635.9 14692.3 15038.3 15937.0 13175.6 13850.2 13856.2 14238.4 14867.7 13669.6 13812.5 14276.3 14385.1 14617.8 13357.1 13527.3 13685.0 13973.3 14329.4 11134.9 11220.6 11372.4 11471.4 12029.7 11540.2 11583.7 11610.2 11696.4 11758.5 02:22:11 INFO - PROCESS | 2945 | -------- Summary: end -------- 02:22:11 INFO - PROCESS | 2945 | 02:22:11 INFO - TEST-INFO | 2945: exit 0 02:22:11 INFO - TEST-OK | dromaeo_css | took 1118450ms 02:22:11 INFO - TEST-START | kraken 02:22:11 INFO - operating with platform_type : mac_ 02:22:11 INFO - Initialising browser for kraken test... 02:22:11 INFO - TEST-INFO | started process 2947 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmp_p5zjW/profile http://localhost:59380/getInfo.html) 02:22:14 INFO - PROCESS | 2947 | __metrics Screen width/height:1600/1200 02:22:14 INFO - PROCESS | 2947 | colorDepth:24 02:22:14 INFO - PROCESS | 2947 | Browser inner width/height: 1024/689 02:22:14 INFO - PROCESS | 2947 | __metrics 02:22:14 INFO - PROCESS | 2947 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:22:14 INFO - PROCESS | 2947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:22:14 INFO - TEST-INFO | 2947: exit 0 02:22:14 INFO - Browser initialized. 02:22:14 INFO - Running cycle 1/1 for kraken test... 02:22:14 INFO - TEST-INFO | started process 2949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmp_p5zjW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:27 INFO - PROCESS | 2949 | RSS: Main: 219840512 02:22:27 INFO - PROCESS | 2949 | 02:22:29 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59380/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:30 INFO - PROCESS | 2949 | RSS: Main: 270430208 02:22:30 INFO - PROCESS | 2949 | 02:22:33 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59380/tests/kraken/driver.html?testName=audio-dft) 02:22:34 INFO - PROCESS | 2949 | RSS: Main: 283422720 02:22:34 INFO - PROCESS | 2949 | 02:22:37 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59380/tests/kraken/driver.html?testName=audio-fft) 02:22:37 INFO - PROCESS | 2949 | RSS: Main: 378146816 02:22:37 INFO - PROCESS | 2949 | 02:22:39 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59380/tests/kraken/driver.html?testName=audio-oscillator) 02:22:40 INFO - PROCESS | 2949 | RSS: Main: 279621632 02:22:40 INFO - PROCESS | 2949 | 02:22:42 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:43 INFO - PROCESS | 2949 | RSS: Main: 280915968 02:22:43 INFO - PROCESS | 2949 | 02:22:45 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59380/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:46 INFO - PROCESS | 2949 | RSS: Main: 317956096 02:22:46 INFO - PROCESS | 2949 | 02:22:49 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59380/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:50 INFO - PROCESS | 2949 | RSS: Main: 319033344 02:22:50 INFO - PROCESS | 2949 | 02:22:52 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59380/tests/kraken/driver.html?testName=json-parse-financial) 02:22:53 INFO - PROCESS | 2949 | RSS: Main: 316510208 02:22:53 INFO - PROCESS | 2949 | 02:22:54 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:55 INFO - PROCESS | 2949 | RSS: Main: 295137280 02:22:55 INFO - PROCESS | 2949 | 02:22:57 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:58 INFO - PROCESS | 2949 | RSS: Main: 298176512 02:22:58 INFO - PROCESS | 2949 | 02:23:00 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:23:00 INFO - PROCESS | 2949 | RSS: Main: 299913216 02:23:00 INFO - PROCESS | 2949 | 02:23:03 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:23:04 INFO - PROCESS | 2949 | RSS: Main: 315498496 02:23:04 INFO - PROCESS | 2949 | 02:23:07 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:23:08 INFO - PROCESS | 2949 | RSS: Main: 308916224 02:23:08 INFO - PROCESS | 2949 | 02:23:09 INFO - PROCESS | 2949 | Cycle 1(1): loaded http://localhost:59380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59380/tests/kraken/driver.html?testName=ai-astar) 02:23:10 INFO - PROCESS | 2949 | RSS: Main: 353234944 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | __start_tp_report 02:23:10 INFO - PROCESS | 2949 | _x_x_mozilla_page_load 02:23:10 INFO - PROCESS | 2949 | _x_x_mozilla_page_load_details 02:23:10 INFO - PROCESS | 2949 | |i|pagename|runs| 02:23:10 INFO - PROCESS | 2949 | |0;ai-astar;115;115;115;114;115;115;114;115;113;114 02:23:10 INFO - PROCESS | 2949 | |1;audio-beat-detection;147;111;116;146;107;92;92;117;174;146 02:23:10 INFO - PROCESS | 2949 | |2;audio-dft;184;182;184;184;185;182;182;182;185;185 02:23:10 INFO - PROCESS | 2949 | |3;audio-fft;84;60;59;91;61;59;58;61;83;57 02:23:10 INFO - PROCESS | 2949 | |4;audio-oscillator;89;70;95;69;68;68;99;97;99;122 02:23:10 INFO - PROCESS | 2949 | |5;imaging-gaussian-blur;90;87;90;87;89;86;91;88;90;87 02:23:10 INFO - PROCESS | 2949 | |6;imaging-darkroom;96;96;96;117;95;96;96;95;95;95 02:23:10 INFO - PROCESS | 2949 | |7;imaging-desaturate;84;84;83;84;84;83;84;84;85;84 02:23:10 INFO - PROCESS | 2949 | |8;json-parse-financial;54;53;53;52;56;57;56;58;57;56 02:23:10 INFO - PROCESS | 2949 | |9;json-stringify-tinderbox;64;75;67;82;75;73;71;68;70;73 02:23:10 INFO - PROCESS | 2949 | |10;stanford-crypto-aes;81;82;85;80;72;78;90;100;104;83 02:23:10 INFO - PROCESS | 2949 | |11;stanford-crypto-ccm;140;138;139;136;135;141;134;159;196;157 02:23:10 INFO - PROCESS | 2949 | |12;stanford-crypto-pbkdf2;205;225;162;165;182;163;161;163;163;164 02:23:10 INFO - PROCESS | 2949 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;67;66;68;66;65 02:23:10 INFO - PROCESS | 2949 | __end_tp_report 02:23:10 INFO - PROCESS | 2949 | __start_cc_report 02:23:10 INFO - PROCESS | 2949 | _x_x_mozilla_cycle_collect,2006 02:23:10 INFO - PROCESS | 2949 | __end_cc_report 02:23:10 INFO - PROCESS | 2949 | __startTimestamp1476696190033__endTimestamp 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | ------- Summary: start ------- 02:23:10 INFO - PROCESS | 2949 | Number of tests: 14 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 02:23:10 INFO - PROCESS | 2949 | Values: 115.0 115.0 115.0 114.0 115.0 115.0 114.0 115.0 113.0 114.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:146.50 stddev:27.10 (18.5%) stddev-sans-first:27.53 02:23:10 INFO - PROCESS | 2949 | Values: 147.0 111.0 116.0 146.0 107.0 92.0 92.0 117.0 174.0 146.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.35 (0.7%) stddev-sans-first:1.42 02:23:10 INFO - PROCESS | 2949 | Values: 184.0 182.0 184.0 184.0 185.0 182.0 182.0 182.0 185.0 185.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.00 stddev:13.12 (21.5%) stddev-sans-first:12.45 02:23:10 INFO - PROCESS | 2949 | Values: 84.0 60.0 59.0 91.0 61.0 59.0 58.0 61.0 83.0 57.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:92.00 stddev:18.30 (19.9%) stddev-sans-first:19.40 02:23:10 INFO - PROCESS | 2949 | Values: 89.0 70.0 95.0 69.0 68.0 68.0 99.0 97.0 99.0 122.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.50 stddev:1.72 (1.9%) stddev-sans-first:1.73 02:23:10 INFO - PROCESS | 2949 | Values: 90.0 87.0 90.0 87.0 89.0 86.0 91.0 88.0 90.0 87.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:96.00 stddev:6.80 (7.1%) stddev-sans-first:7.18 02:23:10 INFO - PROCESS | 2949 | Values: 96.0 96.0 96.0 117.0 95.0 96.0 96.0 95.0 95.0 95.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 02:23:10 INFO - PROCESS | 2949 | Values: 84.0 84.0 83.0 84.0 84.0 83.0 84.0 84.0 85.0 84.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:2.04 (3.6%) stddev-sans-first:2.12 02:23:10 INFO - PROCESS | 2949 | Values: 54.0 53.0 53.0 52.0 56.0 57.0 56.0 58.0 57.0 56.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:73.00 stddev:5.05 (6.9%) stddev-sans-first:4.50 02:23:10 INFO - PROCESS | 2949 | Values: 64.0 75.0 67.0 82.0 75.0 73.0 71.0 68.0 70.0 73.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:81.50 stddev:9.89 (12.1%) stddev-sans-first:10.36 02:23:10 INFO - PROCESS | 2949 | Values: 81.0 82.0 85.0 80.0 72.0 78.0 90.0 100.0 104.0 83.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:140.50 stddev:19.17 (13.6%) stddev-sans-first:20.14 02:23:10 INFO - PROCESS | 2949 | Values: 140.0 138.0 139.0 136.0 135.0 141.0 134.0 159.0 196.0 157.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:164.50 stddev:22.28 (13.5%) stddev-sans-first:20.87 02:23:10 INFO - PROCESS | 2949 | Values: 205.0 225.0 162.0 165.0 182.0 163.0 161.0 163.0 163.0 164.0 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - PROCESS | 2949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 02:23:10 INFO - PROCESS | 2949 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 66.0 68.0 66.0 65.0 02:23:10 INFO - PROCESS | 2949 | -------- Summary: end -------- 02:23:10 INFO - PROCESS | 2949 | 02:23:10 INFO - TEST-INFO | 2949: exit 0 02:23:10 INFO - TEST-OK | kraken | took 59083ms 02:23:10 INFO - SUITE-END | took 1177s 02:23:11 INFO - Completed test suite (00:19:37) 02:23:11 INFO - javascript benchmark 02:23:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.240714635633, 3310.3048359844433, 3317.7014068733815, 3335.4163021471236, 3368.5115658229556, 5677.886442271158, 5755.942440575593, 5767.740451679674, 5831.7958871439505, 5852.20995165653, 5733.713314334277, 5783.739731712072, 5828.650280983134, 5840.036393994997, 5843.941560584393, 5254.737263136837, 5308.177232528964, 5318.414974352818, 5327.467253274661, 5367.194920761878, 4560.384348112995, 4637.5623556697365, 5369.060414427459, 5387.865303367408, 5394.811181608645, 5319.281896943921, 5376.542993845528, 5376.650517716355, 5384.973075134619, 5388.164834450647, 5344.198370244456, 5359.437259087798, 5367.302250707422, 5371.140617501181, 5387.057264978613, 5197.610179236573, 5290.576753859682, 5301.0723123453245, 5310.150375939831, 5329.173978033411, 5862.325832529271, 5865.178874957467, 5882.147088672162, 5882.205902203191, 5884.6469211847425, 6147.801178770142, 6174.660393678346, 6198.101275315054, 6216.720247588869, 6218.440340369389, 6229.937700622981, 6289.119523266746, 6289.748410063592, 6294.496440284812, 6307.400796924285, 5751.223584816038, 5788.565857560699, 5790.189373487715, 5796.50729687977, 5853.853653658693, 6227.1282020517165, 6285.214348206474, 6288.402601752826, 6296.212973378328, 6322.0, 6060.727267272983, 6109.34393638171, 6165.260168779775, 6240.5319601030105, 6249.7187626556915, 6313.715882785285, 6327.715252813635, 6332.968335158294, 6336.398042185985, 6350.714217860207, 6118.95422233728, 6195.628262304276, 6298.590591611623, 6299.338569450142, 6321.810345689637, 6138.48821116479, 6249.812505624838, 6262.436380725757, 6295.905561416583, 6312.147860038928, 4224.556421575752, 4947.851564453073, 4951.133551628451, 4972.801087956514, 4983.950160498421, 4325.7620830853975, 4369.235383807884, 4405.647548196137, 4456.821727130879, 4487.057717879216, 5601.80393686219, 5698.344690360579, 5703.914441283384, 5713.143028545668, 5719.342275638355, 6267.2479302484, 6306.653134077578, 6312.495000399957, 6312.810615681537, 6332.810015699536, 5829.387914268941, 5835.620684655484, 5838.12428135783, 5858.326292476335, 5890.057590785454, 5438.5377242934, 5465.289512363367, 5497.175423686399, 5507.5593952483705, 5514.145307477347, 5122.257272695513, 6264.248290205022, 6266.467350275278, 6299.307076221704, 6380.585261957958, 6265.8120256392385, 6280.685965701605, 6292.182016337847, 6297.370262973666, 6304.243490781136, 6366.681665916593, 6440.871182576416, 6460.806175814733, 6468.288488266193, 6479.611223326616, 5096.949030509648, 6131.202943617302, 6132.4166970161305, 6285.1515045470105, 6286.119943207863, 6216.689165541615, 6219.0, 6286.402791734778, 6326.272478665012, 6334.904976425265, 6145.600535965148, 6155.753769849156, 6192.349803270592, 6198.132261483486, 6200.720967556561, 6019.398060193946, 6088.117223002551, 6092.695365231632, 6167.321594624498, 6179.969100154471, 5832.096025116114, 5869.6771677558145, 5994.730237139426, 6028.4272994065495, 6033.336333003278, 6119.694015299307, 6172.753089876354, 6174.104754810437, 6176.907346389898, 6179.351168127282, 5868.2664666916635, 5945.078512830518, 5951.583389162717, 5962.850928726816, 5986.880262394815], "value": 5735.611725247633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.1917304303988, 469.3312030356741, 473.53356943410733, 510.6374474123372, 517.5730022731248, 26004.609930851053, 30404.087877363658, 32181.71273149074, 32360.838195809018, 41843.58156418435, 42324.78837605807, 42776.57223427765, 42836.35745463821, 42860.78569607148, 42902.0, 9816.312858099918, 9984.800303993916, 9992.800143997116, 10004.049615286536, 10008.99910008997, 8842.159994800484, 9093.0, 9738.1235688788, 9851.458169800659, 9856.50717464124, 12029.639110826689, 12301.138920275584, 12336.81494777579, 12506.93691036263, 12526.248425094478, 12207.755844883097, 12318.692032699164, 12325.69185770354, 12331.321777302244, 12357.135000549964, 8772.12278772124, 9027.4132181408, 11773.529058837636, 11953.880461195364, 12059.457324420422, 38947.0, 40666.59333406658, 40683.0, 40692.389614155814, 40754.59245407538, 2837.787165962561, 3409.454487282023, 3443.9827800861085, 3473.6873681368547, 3698.9630103698887, 29467.0, 29840.96539598836, 30000.099996999907, 31519.84240078808, 31633.32918171628, 3130.671279515641, 3140.8586613602442, 3264.4940034294723, 3391.2369716813764, 3427.3316703242876, 496499.0, 501345.0, 504575.0, 504926.0, 510973.4451327757, 53138.46861531412, 62706.372936270964, 63534.682326588074, 64151.679241604426, 64200.0, 66103.66948165228, 66236.0, 66303.33696662972, 66318.0, 66402.33597664058, 17089.145542722814, 17331.133443327784, 17366.305347785947, 17368.47894563165, 17408.21663025167, 13190.538331158363, 13270.203787772765, 13274.73450530984, 13279.136856104322, 13316.600501984956, 15836.812239081884, 16391.0, 16427.83572164287, 17799.021053842163, 18169.909150454165, 6385.808425747235, 7214.531055481377, 7217.2421895701245, 7276.0, 7291.161516425573, 872.5637181409295, 889.2308153447221, 1059.2691043180182, 1074.3714926767927, 1108.0969010256615, 29172.27069323284, 29991.700082999327, 30202.69797301999, 30601.469926503585, 31056.68943310538, 1039.4834444339333, 1042.3120740311358, 1087.9891201087887, 1115.4478533126155, 1138.4364739454024, 15370.308336124677, 15773.526794196192, 15839.683206335809, 15925.942524786147, 16005.519834404986, 669279.3072069314, 670013.0, 674200.0, 674207.0, 675249.0, 51035.0, 52161.0, 55651.44348556543, 58056.0, 59383.0, 1352.2359866675495, 1390.21452879125, 1398.1960372785688, 1400.9929950350183, 1410.6261840612246, 30172.709937915926, 31967.840160799977, 31994.040178794672, 32480.837595812816, 32755.181120472178, 52738.0, 53083.73458132685, 53202.46797531975, 53215.4678453226, 53304.002199835944, 622342.0, 625558.0, 626892.0, 626905.0, 628222.0, 40773.79613101915, 40938.0, 41864.581354187285, 42171.7891410541, 42198.367024494044, 46582.53417465917, 47271.29093063676, 48013.0, 50102.0, 50343.0, 40149.0, 40492.0, 40594.59405405908, 40860.38709419421, 42141.36787948122, 39767.00582485461, 40167.1966560673, 40185.0, 41384.0, 41738.16523669449, 38256.426153607164, 38509.844704658906, 38638.80680596579, 38653.0, 39035.6096439032, 24625.0, 33699.0, 35873.82063089668, 35940.28119437649, 36006.45990310095, 25432.364190895376, 25894.61158082668, 26041.869790651683, 26175.476490470464, 26885.731142689106], "value": 20741.2789999993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8864946753113, 364.9087728067983, 376.76452217364147, 381.38787246469406, 403.9111395492992, 14082.084664496813, 14304.856951430482, 20676.89661551694, 21231.893840530814, 22224.88887555564, 18135.365262215793, 20183.29358472454, 20684.172633094695, 21184.25855095072, 21502.569948601056, 5833.329167145779, 6167.105769663396, 6167.229096362955, 6169.10547970544, 6172.0, 4225.450691410112, 4433.9778301108445, 6043.4560889519935, 6803.183617965827, 6831.282715314895, 6569.211694596655, 6868.690908909086, 6886.414654754352, 6890.896636550456, 6911.447084233249, 6796.524243302971, 6846.931530684679, 6862.005009273652, 6877.2091209510545, 6879.931200687979, 5701.71491425427, 5888.4700376966275, 5949.434803693643, 5950.97024514879, 5973.581849270553, 26036.0, 26951.843852491755, 27022.86488567564, 27102.5934610981, 27409.862950685318, 2288.622377307742, 2293.9885300573555, 2354.3172479980785, 2847.501687204731, 3051.450738867003, 15913.204339782964, 16019.599510012227, 16130.758038629312, 16396.75404868928, 16909.23908424124, 1856.0, 1906.1708156951631, 1927.180948097053, 1957.1779852461857, 2049.6925461180795, 116611.41694291474, 117913.41043294729, 119167.2124918127, 119349.0, 126333.36833315867, 9920.660710804093, 10776.0, 10904.34573925567, 11217.32696038224, 11233.269837460539, 12344.81482777759, 13036.608901732963, 13057.28184949837, 13386.464541418234, 13396.531121410704, 7734.690612375554, 8325.666973321, 8337.95831020853, 8508.234258916727, 8947.821043579092, 7165.713371465187, 8669.479831210021, 8818.33862460318, 8924.55377231136, 9114.088591140833, 4537.77311134442, 4562.429696287964, 4562.657800664963, 4563.771811409416, 4615.0, 1743.6861364954177, 1783.6415692950613, 1825.607494388713, 1871.4666320098706, 1919.654462196818, 823.736404350602, 826.8718348655968, 870.7083127152348, 878.2359347367703, 959.6161535385902, 16832.74750878738, 21652.35042948714, 22074.0, 22108.447288817908, 22169.778302217095, 883.6951251818112, 922.1838672774643, 925.472480686016, 944.6646440513656, 957.7174733453647, 11053.28153670009, 11474.386192771653, 11551.711207219887, 11568.479418426192, 11646.068314534818, 534288.0, 587251.0, 596171.0, 613698.0, 626986.0, 136053.95919061222, 140552.29723851316, 143019.0, 147385.26307368395, 148125.25937370458, 939.1031564855683, 943.6225509796136, 1012.3419777144915, 1018.9286749927583, 1024.6004058417222, 19404.417867464, 19570.31503897414, 20201.292954746514, 20213.191472340943, 20238.696419554013, 42002.78998604987, 56052.71973640106, 56349.43650563606, 58720.70639646774, 58794.7060264696, 82418.58790706008, 83414.58292708498, 84209.0, 84947.5752621233, 87363.12636873804, 8082.757517274491, 8173.836523269621, 8255.587220639065, 8455.534945578052, 8489.95755021221, 11172.497237624164, 12131.75736485283, 12247.713990031274, 13135.934320328337, 13588.0, 10988.340699558052, 11313.773724525628, 11561.30632162073, 11565.768684626091, 11616.12879034059, 11302.0, 11344.773104538028, 11419.771604567695, 11428.428578571204, 11434.085273178292, 11619.128565357463, 11704.531818727497, 11842.348670823187, 12058.216215945935, 12073.396330183632, 6691.732330706717, 8100.756977290691, 8257.0, 8424.536650484282, 8483.024452188078, 9363.14424100656, 11311.830322545333, 11326.886731132583, 11659.825102623638, 11771.352575608424], "value": 9867.408736456951, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.82014158301, 1523.7638166084257, 1613.5320756980477, 1706.9573260668483, 1876.512106852218, 8508.574571271443, 9064.954675226614, 9092.545372731362, 9105.135012173841, 9113.954430227855, 7840.607969601511, 8130.634121464534, 8133.471324363913, 8243.464174828632, 8263.008438987315, 2045.3250427358935, 2141.2719675310354, 2360.7639236076343, 2405.0620258099357, 2425.50277193175, 2038.3986723916405, 2392.210570511727, 2412.2280870121567, 2425.866577338246, 2426.454047839231, 2385.260569223546, 2432.720237172721, 2433.9756602434013, 2437.122635851101, 2439.8536087834786, 2388.295452841425, 2404.1825779235055, 2416.2630397728685, 2416.540857237137, 2422.358075110097, 2382.309130352196, 2389.2832150354825, 2405.482821193434, 2418.1415597462824, 2425.7938075263623, 8830.249428798496, 8908.51003194824, 8959.552022398853, 8962.82074358509, 8988.191062804379, 5210.270562121306, 5364.785408583652, 5382.91925621116, 5386.165144402585, 5390.110631745757, 3112.750979921601, 3350.8994730158133, 3515.5605549306338, 3543.2303343405993, 3626.0934766308424, 1055.5883205549842, 1102.063246240697, 1128.3342827731597, 1129.0177545535355, 1133.472935085181, 10151.593936242542, 12000.87999120015, 12030.398480075874, 12038.69903252417, 12054.337011464366, 4668.298805484425, 4694.460137084211, 4744.857654270309, 4835.854924352205, 4893.755312234374, 10005.549750261256, 10012.649557265606, 10017.04838040385, 10026.849597256047, 10055.044770746767, 5297.761600727977, 5389.299391079213, 5391.757370918318, 5401.270828438111, 5403.108487099585, 4722.079194557097, 4848.418189817174, 4950.554450099508, 4958.107540642719, 4965.602751779849, 3570.0, 3692.593814680383, 3700.685441737429, 3750.7937063461773, 3875.2443273561385, 1159.7970355187977, 1161.9070474362031, 1169.7542117644682, 1175.1432736276663, 1178.8880056394628, 760.4752720622753, 781.5818537082633, 889.4663202078831, 899.8110396816742, 928.2573940847295, 5456.61803673739, 5501.669899806025, 5711.286089238845, 5829.950608890355, 6250.218722659668, 854.4531499840107, 974.907383798538, 1019.37308555238, 1039.8024375368657, 1079.0019232210175, 3843.327417701891, 3870.9806450968126, 3904.863329783444, 3927.842886284574, 4052.7163098582814, 10746.462676866126, 11013.724656883642, 11192.664220073411, 11197.44012799373, 11204.383758893176, 9514.524273786283, 10956.12351011917, 11071.889281107247, 11138.941800528937, 11153.10775137987, 8124.350051995826, 8282.0, 8311.625976830936, 8447.66209351619, 8452.1547845215, 5785.652860828363, 5810.215620891126, 5887.911681324698, 5904.291485021653, 6070.119832624333, 10157.0, 10257.128144107834, 10259.94870025675, 10342.689719308433, 10406.375617462976, 9572.994835542167, 9891.406515609087, 9901.702948911545, 10129.797404052026, 10284.2801003929, 7631.3513351365755, 7661.310482056641, 7764.145943946274, 7772.494787838772, 7784.727534536264, 7634.541927484369, 7850.136484986533, 7860.960695196487, 8017.559034253172, 8361.372897032625, 6493.610383377012, 7511.399088073051, 7515.13575938774, 7521.0974683038385, 7561.584112873625, 7417.851642967218, 7444.218357072429, 7493.4379921505015, 7502.399808015455, 7616.69533218665, 6949.51353405277, 6950.131233595801, 7012.964935175291, 7028.051213086168, 7036.979637952571, 4132.669386449017, 4762.9285560715925, 4915.0, 4939.777710003131, 5139.152039913522, 4648.395708557866, 4934.851954441372, 4946.752662366939, 4997.300377947163, 5119.129747942933], "value": 4588.028889231607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2209266952259, 303.8632615323105, 308.8409469123401, 312.6295340022074, 314.54391132857364, 5197.336852207295, 5509.504144626982, 5581.604598850287, 5586.798838249775, 5622.297212848394, 4707.764611769407, 4966.279889416041, 5102.372278276681, 5196.752779332961, 5298.1522956327, 3952.881413557598, 4055.858044968427, 4073.3279008963486, 4103.569125241851, 4205.642520385755, 4182.895427614303, 4190.937135942963, 4218.4516012918275, 4231.344141658048, 4233.788310584474, 4014.9799251003706, 4128.277551428503, 4146.232946904817, 4184.8744537663915, 4207.957920420788, 4170.4995400551825, 4184.288670925919, 4187.136724157751, 4191.874243772691, 4220.388043733657, 3034.6965303469697, 3604.4052731299303, 3604.936543719609, 3609.458581212839, 3620.3664358737115, 5068.467810879842, 5172.861970366514, 5366.409694933554, 5395.406505284415, 5430.3755068167275, 4749.715017098985, 4759.405074365704, 4763.285507173917, 4825.227963525854, 4826.855194344175, 5015.4953513945675, 5326.280952071459, 5828.125781132821, 5836.941630583682, 5844.094165404369, 3665.6517630825297, 3711.758735682172, 3912.217556488714, 4006.939895901564, 4053.898652533681, 5068.82259120929, 5366.087765079946, 5731.398203188647, 6085.208922840003, 6094.750576131926, 3364.4616861302075, 3696.77819330841, 3750.818492174956, 3962.385830196324, 4015.2170326785995, 3533.6643018913164, 3900.258950799339, 4016.4577781999055, 4027.335489644176, 4036.677065834785, 4121.876343709693, 4690.835820746326, 4692.507286734912, 4708.670393072521, 4738.857834264978, 5451.618386712971, 5586.653605485706, 5754.424557544212, 5876.647401155944, 5937.406259374115, 1190.8451901252781, 1196.8623608285159, 1332.6135420728074, 1371.1772936238178, 1372.293268966483, 849.2865992566274, 884.1335491218641, 903.4145075392775, 907.6702630646136, 919.9126083022102, 5298.867528311823, 5316.441773613792, 5317.8404647860625, 5333.893322133536, 5350.946490535045, 5133.535902766618, 5236.685798852005, 5902.4097590240635, 5909.70451477433, 6016.639001659914, 4718.386609740712, 5086.5422112009355, 5108.642395032386, 5477.507733981029, 5613.950907918662, 3094.381123775254, 3175.7300629446295, 3185.633652129988, 3193.6965988231545, 3194.961637467832, 5879.294484661782, 6245.0, 6284.685765711696, 6293.653849038255, 6367.681615919186, 5595.664260144405, 5609.242752228479, 6205.007198848162, 6212.161358216583, 6213.763045303687, 5469.480399362054, 5985.551083668655, 6221.657808820558, 6222.688865556795, 6294.65379404128, 5301.814436494704, 6021.849453763691, 6048.153258543895, 6049.848753781191, 6054.39456054391, 5660.320761508646, 5867.559933005127, 5900.734466948912, 5915.319738230159, 5928.970355148197, 5907.793227237026, 6250.218722659668, 6264.776004518512, 6308.810735677937, 6335.556511044183, 3454.758166928291, 3832.559255685632, 3957.8614748483665, 3980.124372638015, 4001.699872509515, 6002.819915402545, 6033.621172143614, 6041.607295525777, 6049.909251361145, 6063.998320831217, 5146.845594632167, 5160.819371321985, 5511.559075273888, 5855.121731740273, 5924.9703751480965, 5310.99091172676, 5376.865578360573, 5490.486088903185, 5942.553319075013, 5961.642301461926, 4426.44669416323, 5186.683649259539, 5649.745761440663, 5755.971220143872, 5797.159411885169, 5364.7049412282695, 5862.237909071793, 5921.822345329647, 5928.407159284037, 5971.611845230046, 4511.390962220058, 5361.38344090419, 5737.536928083312, 5741.224934633771, 5787.826365209051], "value": 4230.695214106815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.93900609939, 743.5612988336887, 764.7438108233741, 813.2111851504043, 834.7036801935312, 14850.0, 16107.516774496784, 16116.677666446663, 17180.484585462425, 17691.203895824685, 16595.751063734053, 16951.406700765474, 16976.74534881978, 16987.91506042471, 17194.914025429887, 669.6752075243503, 833.3583140981441, 851.9872201916976, 855.0124606079987, 855.6491838346279, 685.4002747595854, 693.5595896605641, 818.292177266663, 839.9836198200185, 844.3287586368851, 885.4731434796319, 897.7441429192681, 898.9955050224739, 900.0954041188596, 902.9954850225739, 892.9821403571925, 893.9016708162097, 894.172890076683, 894.9776255593662, 895.6730793260413, 508.26809394471843, 525.3984188104599, 626.3923993726079, 647.0197650559406, 660.4716227018366, 15636.92181539085, 15754.842451575452, 15772.0, 15783.210839457981, 15835.920820395824, 13476.932615336958, 13699.726005479934, 13826.861731382758, 13907.304634768221, 13976.014299551636, 12414.0, 12598.937005315007, 12781.808272875915, 12968.870311296861, 13578.660533486644, 4038.8788336349958, 4527.366168736379, 4540.18276710192, 4541.318802179667, 4732.810687572493, 107511.38732919091, 122047.0, 126030.0, 126934.36532817277, 128292.0, 10905.0, 11000.559977600806, 11311.773764524827, 11414.657560273205, 11475.713107172387, 21015.474613134487, 22160.667589986162, 22192.445188870406, 22221.555568888856, 22335.329940101823, 7579.279968402993, 7722.691092356243, 7777.844443111106, 7961.203879611992, 7976.521408715495, 4398.186335527937, 4417.889552761207, 4424.690271680952, 4462.062966776948, 4653.441587009513, 3638.9818050909576, 3799.886003419902, 3799.981000094982, 3803.6196380361744, 3803.6386543278345, 667.7796327212009, 675.0785178231679, 690.4717890813532, 699.6396855619361, 705.8623568404215, 581.8603535151533, 650.8926027205553, 659.3274859643137, 660.8182749743859, 665.9433948114367, 8332.791680208044, 8921.795557599771, 9594.520273986273, 9798.510074496247, 9896.25778066648, 592.5822295281816, 667.9899801502982, 672.909157263773, 680.904673345732, 688.3460712323213, 4420.602145806893, 4527.84152554659, 4602.746848923274, 4735.345690141994, 4777.784999675023, 155070.0, 162921.0, 163852.0, 168221.0, 177384.0, 88971.55514222388, 95895.0, 146934.0, 156510.0, 159642.0, 122691.77308226803, 128449.71550284377, 129598.99999999811, 133197.33401332932, 133539.33230333982, 8629.22336989674, 9005.729828105168, 9090.045545217657, 9115.635374584943, 9268.119528644767, 60248.0, 64936.675316623114, 66882.66558667175, 67344.0, 68569.97145042729, 66365.0, 69639.65180174066, 71464.28535714577, 88521.22957540942, 92536.53731731298, 13124.606261812161, 13273.469061237829, 13403.32983350848, 13521.323933803467, 13527.188368697909, 14243.430262789372, 14635.92682036583, 14692.265386730407, 15038.323275452412, 15937.0, 13175.60473185806, 13850.16898986064, 13856.168629882239, 14238.430462781373, 14867.702645947236, 13669.589912302647, 13812.516561920285, 14276.286185690882, 14385.104658275322, 14617.784087500733, 13357.065005449525, 13527.256000920044, 13685.0, 13973.301334933416, 14329.426822926966, 11134.88865111371, 11220.551177953117, 11372.43137843088, 11471.4264286787, 12029.699257518632, 11540.192186546861, 11583.725790163244, 11610.230118040132, 11696.35670038122, 11758.529658813552], "value": 8026.604576997245, "unit": "score"}], "name": "dromaeo_css", "value": 7534.233247798953, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 115.0, 113.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 116.0, 146.0, 107.0, 92.0, 92.0, 117.0, 174.0, 146.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 184.0, 185.0, 182.0, 182.0, 182.0, 185.0, 185.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 59.0, 91.0, 61.0, 59.0, 58.0, 61.0, 83.0, 57.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 95.0, 69.0, 68.0, 68.0, 99.0, 97.0, 99.0, 122.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 86.0, 91.0, 88.0, 90.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 117.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 84.0, 83.0, 84.0, 84.0, 85.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 56.0, 57.0, 56.0, 58.0, 57.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 67.0, 82.0, 75.0, 73.0, 71.0, 68.0, 70.0, 73.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 85.0, 80.0, 72.0, 78.0, 90.0, 100.0, 104.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 139.0, 136.0, 135.0, 141.0, 134.0, 159.0, 196.0, 157.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 225.0, 162.0, 165.0, 182.0, 163.0, 161.0, 163.0, 163.0, 164.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1449.7, "alertThreshold": 2.0}]} 02:23:11 INFO - Return code: 0 02:23:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:23:11 INFO - # TBPL SUCCESS # 02:23:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:23:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:23:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:23:11 INFO - 2016-10-17 02:23:11.370 screenresolution[2953:44375] starting screenresolution argv=screenresolution get 02:23:11 INFO - 2016-10-17 02:23:11.373 screenresolution[2953:44375] Display 0: 1600x1200x32@60 02:23:11 INFO - 2016-10-17 02:23:11.379 screenresolution[2954:44378] starting screenresolution argv=screenresolution list 02:23:11 INFO - Available Modes on Display 0 02:23:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:23:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:23:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:23:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:23:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:23:11 INFO - Intel Iris: 02:23:11 INFO - Chipset Model: Intel Iris 02:23:11 INFO - Type: GPU 02:23:11 INFO - Bus: Built-In 02:23:11 INFO - VRAM (Dynamic, Max): 1536 MB 02:23:11 INFO - Vendor: Intel (0x8086) 02:23:11 INFO - Device ID: 0x0a2e 02:23:11 INFO - Revision ID: 0x0009 02:23:11 INFO - Displays: 02:23:11 INFO - Display: 02:23:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:23:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:23:11 INFO - Display Serial Number: 1600x1200 60 02:23:11 INFO - Main Display: Yes 02:23:11 INFO - Mirror: Off 02:23:11 INFO - Online: Yes 02:23:11 INFO - Rotation: Supported 02:23:11 INFO - Return code: 0 02:23:11 INFO - Running post-action listener: _resource_record_post_action 02:23:11 INFO - [mozharness: 2016-10-17 09:23:11.613116Z] Finished run-tests step (success) 02:23:11 INFO - Running post-run listener: _resource_record_post_run 02:23:11 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1146880; Write bytes: 663218688; Read time: 8; Write time: 1911 02:23:11 INFO - TinderboxPrint: CPU usage
53.2% 02:23:11 INFO - TinderboxPrint: I/O read bytes / time
1,146,880 / 8 02:23:11 INFO - TinderboxPrint: I/O write bytes / time
663,218,688 / 1,911 02:23:11 INFO - TinderboxPrint: CPU idle
2,267.5 (46.8%) 02:23:11 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 02:23:11 INFO - TinderboxPrint: CPU user
1,609.1 (33.2%) 02:23:11 INFO - TinderboxPrint: Swap in / out
363,843,584 / 0 02:23:11 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362496512; Write bytes: 357160448; Read time: 28811; Write time: 695 02:23:11 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 262144; Write bytes: 295736320; Read time: 3; Write time: 1174 02:23:12 INFO - Running post-run listener: _upload_blobber_files 02:23:12 INFO - Blob upload gear active. 02:23:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:23:12 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 02:23:12 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'] 02:23:12 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 02:23:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:13 INFO - (blobuploader) - INFO - Done attempting. 02:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:23:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:14 INFO - (blobuploader) - INFO - Done attempting. 02:23:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:23:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:23:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:16 INFO - (blobuploader) - INFO - Done attempting. 02:23:16 INFO - (blobuploader) - INFO - Iteration through files over. 02:23:16 INFO - Return code: 0 02:23:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:23:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:23:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bbd9fdcc4567174b9457e38f9a08b0916a7e56157baa54894ccdb4da273c97eba3b59256acfe2f3b7a86213a9e5e9deafdcd928fd1775fd76016a8a49212a41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/470793e324f5913440f7d64348677605daf400d9f2311f746a11cbe6ea728a063b6012c7aa39047fc25e779dd1163cf42cbf5b9aca21a690252ce0ccd73f30d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36180215e5b353c24c644452c230c57658fef3d90273dafbf6352e8826eaf2f9f5a09ea8eb8d11e127052462819b54d05c89275a4be9d546168acca2f060b3c9"} 02:23:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:23:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:23:16 INFO - Contents: 02:23:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bbd9fdcc4567174b9457e38f9a08b0916a7e56157baa54894ccdb4da273c97eba3b59256acfe2f3b7a86213a9e5e9deafdcd928fd1775fd76016a8a49212a41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/470793e324f5913440f7d64348677605daf400d9f2311f746a11cbe6ea728a063b6012c7aa39047fc25e779dd1163cf42cbf5b9aca21a690252ce0ccd73f30d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36180215e5b353c24c644452c230c57658fef3d90273dafbf6352e8826eaf2f9f5a09ea8eb8d11e127052462819b54d05c89275a4be9d546168acca2f060b3c9"} 02:23:16 INFO - Running post-run listener: copy_logs_to_upload_dir 02:23:16 INFO - Copying logs to upload dir... 02:23:16 INFO - mkdir: /builds/slave/test/build/upload/logs 02:23:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.041350 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-17 02:23:17.257903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 02:23:17.262368) ========= 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.QuNsCaz655/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.obhfSbw7R2/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bbd9fdcc4567174b9457e38f9a08b0916a7e56157baa54894ccdb4da273c97eba3b59256acfe2f3b7a86213a9e5e9deafdcd928fd1775fd76016a8a49212a41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/470793e324f5913440f7d64348677605daf400d9f2311f746a11cbe6ea728a063b6012c7aa39047fc25e779dd1163cf42cbf5b9aca21a690252ce0ccd73f30d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36180215e5b353c24c644452c230c57658fef3d90273dafbf6352e8826eaf2f9f5a09ea8eb8d11e127052462819b54d05c89275a4be9d546168acca2f060b3c9"} build_url:https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://queue.taskcluster.net/v1/task/LcS_Fc7jQamKtS2XnaUJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bbd9fdcc4567174b9457e38f9a08b0916a7e56157baa54894ccdb4da273c97eba3b59256acfe2f3b7a86213a9e5e9deafdcd928fd1775fd76016a8a49212a41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/470793e324f5913440f7d64348677605daf400d9f2311f746a11cbe6ea728a063b6012c7aa39047fc25e779dd1163cf42cbf5b9aca21a690252ce0ccd73f30d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36180215e5b353c24c644452c230c57658fef3d90273dafbf6352e8826eaf2f9f5a09ea8eb8d11e127052462819b54d05c89275a4be9d546168acca2f060b3c9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 02:23:17.302095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 02:23:17.302490) ========= 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.QuNsCaz655/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.obhfSbw7R2/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.005152 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 02:23:17.350821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 02:23:17.354147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 02:23:17.354462) ========= ========= Total master_lag: 0.46 =========