builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0354 starttime: 1477309641.32 results: success (0) buildid: 20161024022822 builduid: 7985bbe54bbe4e5a9c452fe44e125175 revision: 1ec527fde116a5e705db035f379afdb45529fbb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.318274) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.318743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.319020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.343064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.343407) ========= 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.FrPafseKqn/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.EMoQsy5bdh/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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-24 04:47:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-10-24 04:47:21 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.536870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.537178) ========= 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.FrPafseKqn/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.EMoQsy5bdh/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.027119 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:21.588528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-24 04:47:21.591891) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ec527fde116a5e705db035f379afdb45529fbb0 --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 1ec527fde116a5e705db035f379afdb45529fbb0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FrPafseKqn/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.EMoQsy5bdh/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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-24 04:47:21,675 truncating revision to first 12 chars 2016-10-24 04:47:21,675 Setting DEBUG logging. 2016-10-24 04:47:21,675 attempt 1/10 2016-10-24 04:47:21,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1ec527fde116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 04:47:23,826 unpacking tar archive at: mozilla-aurora-1ec527fde116/testing/mozharness/ program finished with exit code 0 elapsedTime=2.431874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-24 04:47:24.045301) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:24.045619) ========= script_repo_revision: 1ec527fde116a5e705db035f379afdb45529fbb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:24.049655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:24.050349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 04:47:24.073194) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-24 04:47:24.073459) ========= /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.FrPafseKqn/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.EMoQsy5bdh/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:47:24 INFO - MultiFileLogger online at 20161024 04:47:24 in /builds/slave/test 04:47:24 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 04:47:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:47:24 INFO - {'append_to_log': False, 04:47:24 INFO - 'base_work_dir': '/builds/slave/test', 04:47:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:47:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:47:24 INFO - 'branch': 'Mozilla-Aurora', 04:47:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:47:24 INFO - 'config_files': ('talos/mac_config.py',), 04:47:24 INFO - 'default_actions': ('clobber', 04:47:24 INFO - 'read-buildbot-config', 04:47:24 INFO - 'download-and-extract', 04:47:24 INFO - 'populate-webroot', 04:47:24 INFO - 'create-virtualenv', 04:47:24 INFO - 'install', 04:47:24 INFO - 'run-tests'), 04:47:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:47:24 INFO - 'download_minidump_stackwalk': True, 04:47:24 INFO - 'download_symbols': 'ondemand', 04:47:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:47:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:47:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:47:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:47:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:47:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:47:24 INFO - 'installer_path': 'installer.exe', 04:47:24 INFO - 'log_level': 'info', 04:47:24 INFO - 'log_name': 'talos', 04:47:24 INFO - 'log_to_console': True, 04:47:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:47:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:47:24 INFO - 'opt_config_files': (), 04:47:24 INFO - 'pip_index': False, 04:47:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:47:24 INFO - 'cmd': ('bash', 04:47:24 INFO - '-c', 04:47:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:47:24 INFO - 'enabled': True, 04:47:24 INFO - 'halt_on_failure': False, 04:47:24 INFO - 'name': 'check_screen_resolution'},), 04:47:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:47:24 INFO - 'cmd': ('bash', 04:47:24 INFO - '-c', 04:47:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:47:24 INFO - 'enabled': True, 04:47:24 INFO - 'halt_on_failure': False, 04:47:24 INFO - 'name': 'check_screen_resolution'},), 04:47:24 INFO - 'run_cmd_checks_enabled': True, 04:47:24 INFO - 'sps_profile': False, 04:47:24 INFO - 'sps_profile_interval': 0, 04:47:24 INFO - 'suite': 'dromaeojs', 04:47:24 INFO - 'system_bits': '32', 04:47:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:47:24 INFO - 'title': 't-yosemite-r7-0354', 04:47:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:47:24 INFO - 'use_talos_json': True, 04:47:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:47:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:47:24 INFO - 'work_dir': 'build'} 04:47:24 INFO - [mozharness: 2016-10-24 11:47:24.269782Z] Running clobber step. 04:47:24 INFO - Running pre-action listener: _resource_record_pre_action 04:47:24 INFO - Running main action method: clobber 04:47:24 INFO - rmtree: /builds/slave/test/build 04:47:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:47:26 INFO - Running post-action listener: _resource_record_post_action 04:47:26 INFO - [mozharness: 2016-10-24 11:47:26.288640Z] Finished clobber step (success) 04:47:26 INFO - [mozharness: 2016-10-24 11:47:26.288805Z] Running read-buildbot-config step. 04:47:26 INFO - Running pre-action listener: _resource_record_pre_action 04:47:26 INFO - Running main action method: read_buildbot_config 04:47:26 INFO - Using buildbot properties: 04:47:26 INFO - { 04:47:26 INFO - "project": "", 04:47:26 INFO - "product": "firefox", 04:47:26 INFO - "script_repo_revision": "production", 04:47:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:47:26 INFO - "repository": "", 04:47:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:47:26 INFO - "buildid": "20161024022822", 04:47:26 INFO - "pgo_build": "False", 04:47:26 INFO - "basedir": "/builds/slave/test", 04:47:26 INFO - "buildnumber": 105, 04:47:26 INFO - "slavename": "t-yosemite-r7-0354", 04:47:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:47:26 INFO - "platform": "yosemite_r7", 04:47:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:47:26 INFO - "branch": "mozilla-aurora", 04:47:26 INFO - "repo_path": "releases/mozilla-aurora", 04:47:26 INFO - "revision": "1ec527fde116a5e705db035f379afdb45529fbb0", 04:47:26 INFO - "stage_platform": "macosx64", 04:47:26 INFO - "builduid": "7985bbe54bbe4e5a9c452fe44e125175", 04:47:26 INFO - "slavebuilddir": "test" 04:47:26 INFO - } 04:47:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 04:47:26 INFO - Running post-action listener: _resource_record_post_action 04:47:26 INFO - [mozharness: 2016-10-24 11:47:26.292464Z] Finished read-buildbot-config step (success) 04:47:26 INFO - [mozharness: 2016-10-24 11:47:26.292741Z] Running download-and-extract step. 04:47:26 INFO - Running pre-action listener: _resource_record_pre_action 04:47:26 INFO - Running main action method: download_and_extract 04:47:26 INFO - mkdir: /builds/slave/test/build/tests 04:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:26 INFO - trying https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 04:47:26 INFO - Downloading https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/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 04:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/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 04:47:27 INFO - Downloaded 1199 bytes. 04:47:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 04:47:27 INFO - Using the following test package requirements: 04:47:27 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:47:27 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 04:47:27 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 04:47:27 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'jsshell-mac.zip'], 04:47:27 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 04:47:27 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:47:27 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 04:47:27 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 04:47:27 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 04:47:27 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:47:27 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 04:47:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:47:28 INFO - Expected file size: 16438075 04:47:35 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 04:47:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:47:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:47:35 INFO - Fetch https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:47:35 INFO - Expected file size: 16438075 04:47:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 04:47:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:47:42 INFO - Fetch https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 04:47:43 INFO - Expected file size: 14414081 04:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:44 INFO - trying https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:47:44 INFO - Downloading https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 04:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/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 04:47:47 INFO - Downloaded 115432779 bytes. 04:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:47:47 INFO - mkdir: /builds/slave/test/properties 04:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:47 INFO - Contents: 04:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:47:47 INFO - Running post-action listener: _resource_record_post_action 04:47:47 INFO - Running post-action listener: set_extra_try_arguments 04:47:47 INFO - [mozharness: 2016-10-24 11:47:47.847919Z] Finished download-and-extract step (success) 04:47:47 INFO - [mozharness: 2016-10-24 11:47:47.848057Z] Running populate-webroot step. 04:47:47 INFO - Running pre-action listener: _resource_record_pre_action 04:47:47 INFO - Running main action method: populate_webroot 04:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:47 INFO - '--tppagecycles', 04:47:47 INFO - '7'], 04:47:47 INFO - 'tests': ['tsvgm']}}, 04:47:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['damp', 'tps']}, 04:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'tests': ['damp', 'tps']}, 04:47:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['dromaeo_dom']}, 04:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['basic_compositor_video']}, 04:47:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:47:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['a11yr', 04:47:47 INFO - 'ts_paint', 04:47:47 INFO - 'tpaint', 04:47:47 INFO - 'sessionrestore', 04:47:47 INFO - 'sessionrestore_no_auto_restore', 04:47:47 INFO - 'tabpaint']}, 04:47:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:47 INFO - 'ts_paint', 04:47:47 INFO - 'tpaint', 04:47:47 INFO - 'sessionrestore', 04:47:47 INFO - 'sessionrestore_no_auto_restore', 04:47:47 INFO - 'tabpaint']}, 04:47:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:47 INFO - 'ts_paint', 04:47:47 INFO - 'tpaint', 04:47:47 INFO - 'sessionrestore', 04:47:47 INFO - 'sessionrestore_no_auto_restore', 04:47:47 INFO - 'tabpaint']}, 04:47:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:47 INFO - 'ts_paint', 04:47:47 INFO - 'tpaint', 04:47:47 INFO - 'sessionrestore', 04:47:47 INFO - 'sessionrestore_no_auto_restore', 04:47:47 INFO - 'tabpaint']}, 04:47:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['a11yr', 04:47:47 INFO - 'ts_paint', 04:47:47 INFO - 'tpaint', 04:47:47 INFO - 'sessionrestore', 04:47:47 INFO - 'sessionrestore_no_auto_restore', 04:47:47 INFO - 'tabpaint']}, 04:47:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['a11yr', 04:47:47 INFO - 'ts_paint', 04:47:47 INFO - 'tpaint', 04:47:47 INFO - 'sessionrestore', 04:47:47 INFO - 'sessionrestore_no_auto_restore', 04:47:47 INFO - 'tabpaint']}, 04:47:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['tsvgx', 04:47:47 INFO - 'tsvgr_opacity', 04:47:47 INFO - 'tart', 04:47:47 INFO - 'tscrollx', 04:47:47 INFO - 'cart']}, 04:47:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:47 INFO - 'tsvgr_opacity', 04:47:47 INFO - 'tart', 04:47:47 INFO - 'tscrollx', 04:47:47 INFO - 'cart']}, 04:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'talos_options': ['--disable-e10s'], 04:47:47 INFO - 'tests': ['tp5o']}, 04:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'tests': ['tp5o']}, 04:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'talos_options': ['--disable-e10s', 04:47:47 INFO - '--xperf_path', 04:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:47 INFO - 'tests': ['tp5n']}, 04:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:47 INFO - 'talos_options': ['--xperf_path', 04:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:47 INFO - 'tests': ['tp5n']}}, 04:47:47 INFO - 'talos.zip': {'path': '', 04:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:47 INFO - Running post-action listener: _resource_record_post_action 04:47:47 INFO - [mozharness: 2016-10-24 11:47:47.866693Z] Finished populate-webroot step (success) 04:47:47 INFO - [mozharness: 2016-10-24 11:47:47.866796Z] Running create-virtualenv step. 04:47:47 INFO - Running pre-action listener: _resource_record_pre_action 04:47:47 INFO - Running main action method: create_virtualenv 04:47:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:47 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 04:47:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:47 INFO - Using real prefix '/tools/python27' 04:47:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:51 INFO - Installing pip.................done. 04:47:51 INFO - Return code: 0 04:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:47:51 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 04:47:51 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 04:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:51 INFO - 'HOME': '/Users/cltbld', 04:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PAGER': '/bin/cat', 04:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:47:51 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - 'XPC_FLAGS': '0x0', 04:47:51 INFO - 'XPC_SERVICE_NAME': '0', 04:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:51 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 04:47:51 INFO - Cleaning up... 04:47:51 INFO - Return code: 0 04:47:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:47:51 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 04:47:51 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 04:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:51 INFO - 'HOME': '/Users/cltbld', 04:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PAGER': '/bin/cat', 04:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:47:51 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - 'XPC_FLAGS': '0x0', 04:47:51 INFO - 'XPC_SERVICE_NAME': '0', 04:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:52 INFO - Downloading/unpacking psutil>=3.1.1 04:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:55 INFO - Installing collected packages: psutil 04:47:55 INFO - Running setup.py install for psutil 04:47:55 INFO - building 'psutil._psutil_osx' extension 04:47:55 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 04:47:55 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 04:47:55 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 04:47:55 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 04:47:56 INFO - building 'psutil._psutil_posix' extension 04:47:56 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 04:47:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:47:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:47:56 INFO - ^ 04:47:56 INFO - 1 warning generated. 04:47:56 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 04:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:56 INFO - Successfully installed psutil 04:47:56 INFO - Cleaning up... 04:47:56 INFO - Return code: 0 04:47:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:47:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:56 INFO - 'HOME': '/Users/cltbld', 04:47:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:56 INFO - 'LOGNAME': 'cltbld', 04:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:56 INFO - 'MOZ_NO_REMOTE': '1', 04:47:56 INFO - 'NO_EM_RESTART': '1', 04:47:56 INFO - 'PAGER': '/bin/cat', 04:47:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:56 INFO - 'PWD': '/builds/slave/test', 04:47:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:56 INFO - 'SHELL': '/bin/bash', 04:47:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:47:56 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:47:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:56 INFO - 'USER': 'cltbld', 04:47:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:56 INFO - 'XPC_FLAGS': '0x0', 04:47:56 INFO - 'XPC_SERVICE_NAME': '0', 04:47:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:56 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 04:47:56 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 04:47:56 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 04:47:56 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 04:47:56 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 04:47:56 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 04:47:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:59 INFO - Installing collected packages: mozsystemmonitor 04:47:59 INFO - Running setup.py install for mozsystemmonitor 04:47:59 INFO - Successfully installed mozsystemmonitor 04:47:59 INFO - Cleaning up... 04:47:59 INFO - Return code: 0 04:47:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:47: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==2.5.1'] in /builds/slave/test/build 04:47: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==2.5.1 04:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:59 INFO - 'HOME': '/Users/cltbld', 04:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:59 INFO - 'LOGNAME': 'cltbld', 04:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:59 INFO - 'MOZ_NO_REMOTE': '1', 04:47:59 INFO - 'NO_EM_RESTART': '1', 04:47:59 INFO - 'PAGER': '/bin/cat', 04:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:59 INFO - 'PWD': '/builds/slave/test', 04:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:59 INFO - 'SHELL': '/bin/bash', 04:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:47:59 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:59 INFO - 'USER': 'cltbld', 04:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:59 INFO - 'XPC_FLAGS': '0x0', 04:47:59 INFO - 'XPC_SERVICE_NAME': '0', 04:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:59 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 04:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:48:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:48:02 INFO - warning: no files found matching '*.txt' 04:48:02 INFO - no previously-included directories found matching 'build' 04:48:02 INFO - no previously-included directories found matching 'dist' 04:48:02 INFO - no previously-included directories found matching '.git*' 04:48:02 INFO - Installing collected packages: jsonschema, functools32 04:48:02 INFO - Running setup.py install for functools32 04:48:02 INFO - warning: no files found matching '*.txt' 04:48:02 INFO - no previously-included directories found matching 'build' 04:48:02 INFO - no previously-included directories found matching 'dist' 04:48:02 INFO - no previously-included directories found matching '.git*' 04:48:02 INFO - Successfully installed jsonschema functools32 04:48:02 INFO - Cleaning up... 04:48:03 INFO - Return code: 0 04:48:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:48:03 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')]} 04:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:03 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')]} 04:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:03 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:48:03 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 04:48:03 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 04:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:03 INFO - 'HOME': '/Users/cltbld', 04:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:03 INFO - 'LOGNAME': 'cltbld', 04:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:03 INFO - 'MOZ_NO_REMOTE': '1', 04:48:03 INFO - 'NO_EM_RESTART': '1', 04:48:03 INFO - 'PAGER': '/bin/cat', 04:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:03 INFO - 'PWD': '/builds/slave/test', 04:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:03 INFO - 'SHELL': '/bin/bash', 04:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:03 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:03 INFO - 'USER': 'cltbld', 04:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:03 INFO - 'XPC_FLAGS': '0x0', 04:48:03 INFO - 'XPC_SERVICE_NAME': '0', 04:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:48:03 INFO - Cleaning up... 04:48:03 INFO - Return code: 0 04:48:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:48:03 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')]} 04:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:03 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')]} 04:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:03 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:48:03 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 04:48:03 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 04:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:03 INFO - 'HOME': '/Users/cltbld', 04:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:03 INFO - 'LOGNAME': 'cltbld', 04:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:03 INFO - 'MOZ_NO_REMOTE': '1', 04:48:03 INFO - 'NO_EM_RESTART': '1', 04:48:03 INFO - 'PAGER': '/bin/cat', 04:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:03 INFO - 'PWD': '/builds/slave/test', 04:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:03 INFO - 'SHELL': '/bin/bash', 04:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:03 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:03 INFO - 'USER': 'cltbld', 04:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:03 INFO - 'XPC_FLAGS': '0x0', 04:48:03 INFO - 'XPC_SERVICE_NAME': '0', 04:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:48:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:48:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:06 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 04:48:07 INFO - Downloading docopt-0.6.1.tar.gz 04:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:48:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:48:07 INFO - Running setup.py install for blobuploader 04:48:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:48:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:48:07 INFO - Running setup.py install for requests 04:48:07 INFO - Running setup.py install for docopt 04:48:08 INFO - Successfully installed blobuploader requests docopt 04:48:08 INFO - Cleaning up... 04:48:08 INFO - Return code: 0 04:48:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:08 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')]} 04:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:08 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')]} 04:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:08 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:48:08 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 04:48:08 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 04:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:08 INFO - 'HOME': '/Users/cltbld', 04:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:08 INFO - 'LOGNAME': 'cltbld', 04:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:08 INFO - 'MOZ_NO_REMOTE': '1', 04:48:08 INFO - 'NO_EM_RESTART': '1', 04:48:08 INFO - 'PAGER': '/bin/cat', 04:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:08 INFO - 'PWD': '/builds/slave/test', 04:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:08 INFO - 'SHELL': '/bin/bash', 04:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:08 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:08 INFO - 'USER': 'cltbld', 04:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:08 INFO - 'XPC_FLAGS': '0x0', 04:48:08 INFO - 'XPC_SERVICE_NAME': '0', 04:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:08 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-x4dVdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:08 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Ts2HM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:08 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-AKJb7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:08 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-6aX6VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:08 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-CK1rtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:08 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-KyXJVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-pDk1e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-rNcpnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-SlmSDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-V0zsNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-IkmzJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-M7TPvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Da6YF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-GpLkdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:09 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-4fMVVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:10 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-wKIXbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:10 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Iab5QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:48:10 INFO - Running setup.py install for manifestparser 04:48:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:48:10 INFO - Running setup.py install for mozcrash 04:48:10 INFO - Running setup.py install for mozdebug 04:48:10 INFO - Running setup.py install for mozdevice 04:48:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:48:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:48:10 INFO - Running setup.py install for mozfile 04:48:10 INFO - Running setup.py install for mozhttpd 04:48:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Running setup.py install for mozinfo 04:48:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Running setup.py install for mozInstall 04:48:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Running setup.py install for mozleak 04:48:11 INFO - Running setup.py install for mozlog 04:48:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Running setup.py install for moznetwork 04:48:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:48:11 INFO - Running setup.py install for mozprocess 04:48:12 INFO - Running setup.py install for mozprofile 04:48:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:48:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:48:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:48:12 INFO - Running setup.py install for mozrunner 04:48:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:48:12 INFO - Running setup.py install for mozscreenshot 04:48:12 INFO - Running setup.py install for moztest 04:48:12 INFO - Running setup.py install for mozversion 04:48:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:48:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:48:12 INFO - Cleaning up... 04:48:12 INFO - Return code: 0 04:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:12 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')]} 04:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:12 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')]} 04:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:12 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:48:12 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 04:48:12 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 04:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:12 INFO - 'HOME': '/Users/cltbld', 04:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:12 INFO - 'LOGNAME': 'cltbld', 04:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:12 INFO - 'MOZ_NO_REMOTE': '1', 04:48:12 INFO - 'NO_EM_RESTART': '1', 04:48:12 INFO - 'PAGER': '/bin/cat', 04:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:12 INFO - 'PWD': '/builds/slave/test', 04:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:12 INFO - 'SHELL': '/bin/bash', 04:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:12 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:12 INFO - 'USER': 'cltbld', 04:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:12 INFO - 'XPC_FLAGS': '0x0', 04:48:12 INFO - 'XPC_SERVICE_NAME': '0', 04:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-eikVy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-HpnlYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-vQriy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-N4fDKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-WtzG95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-_MCiMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-dLznfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-6GFAYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:13 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)) 04:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:13 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-P9LrG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-OEiBOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Q_a6QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-YzD3Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-DlnOq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-IrQIYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5SKqQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-KuP7Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:14 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)) 04:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:14 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-HuGUnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:14 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)) 04:48:14 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)) 04:48:14 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)) 04:48:14 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)) 04:48:14 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)) 04:48:14 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)) 04:48:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:14 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 04:48:14 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 04:48:14 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 04:48:14 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 04:48:14 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 04:48:14 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 04:48:17 INFO - Downloading blessings-1.6.tar.gz 04:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:48:17 INFO - Installing collected packages: blessings 04:48:17 INFO - Running setup.py install for blessings 04:48:17 INFO - Successfully installed blessings 04:48:17 INFO - Cleaning up... 04:48:17 INFO - Return code: 0 04:48:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:48:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:18 INFO - Reading from file tmpfile_stdout 04:48:18 INFO - Current package versions: 04:48:18 INFO - blessings == 1.6 04:48:18 INFO - blobuploader == 1.2.4 04:48:18 INFO - docopt == 0.6.1 04:48:18 INFO - functools32 == 3.2.3-2 04:48:18 INFO - jsonschema == 2.5.1 04:48:18 INFO - manifestparser == 1.1 04:48:18 INFO - mozInstall == 1.12 04:48:18 INFO - mozcrash == 0.17 04:48:18 INFO - mozdebug == 0.1 04:48:18 INFO - mozdevice == 0.48 04:48:18 INFO - mozfile == 1.2 04:48:18 INFO - mozhttpd == 0.7 04:48:18 INFO - mozinfo == 0.9 04:48:18 INFO - mozleak == 0.1 04:48:18 INFO - mozlog == 3.4 04:48:18 INFO - moznetwork == 0.27 04:48:18 INFO - mozprocess == 0.23 04:48:18 INFO - mozprofile == 0.28 04:48:18 INFO - mozrunner == 6.12 04:48:18 INFO - mozscreenshot == 0.1 04:48:18 INFO - mozsystemmonitor == 0.3 04:48:18 INFO - moztest == 0.7 04:48:18 INFO - mozversion == 1.4 04:48:18 INFO - psutil == 3.1.1 04:48:18 INFO - requests == 1.2.3 04:48:18 INFO - wsgiref == 0.1.2 04:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:18 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')]} 04:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:18 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')]} 04:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:18 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:48:18 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 04:48:18 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 04:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:18 INFO - 'HOME': '/Users/cltbld', 04:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:18 INFO - 'LOGNAME': 'cltbld', 04:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:18 INFO - 'MOZ_NO_REMOTE': '1', 04:48:18 INFO - 'NO_EM_RESTART': '1', 04:48:18 INFO - 'PAGER': '/bin/cat', 04:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:18 INFO - 'PWD': '/builds/slave/test', 04:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:18 INFO - 'SHELL': '/bin/bash', 04:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:18 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:18 INFO - 'USER': 'cltbld', 04:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:18 INFO - 'XPC_FLAGS': '0x0', 04:48:18 INFO - 'XPC_SERVICE_NAME': '0', 04:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 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)) 04:48:18 INFO - Cleaning up... 04:48:18 INFO - Return code: 0 04:48:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:48:18 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')]} 04:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:18 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')]} 04:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:18 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 0x10bc16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb8c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0d84b1140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, '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.FrPafseKqn/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.EMoQsy5bdh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 04:48:18 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 04:48:18 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 04:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:18 INFO - 'HOME': '/Users/cltbld', 04:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:18 INFO - 'LOGNAME': 'cltbld', 04:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:18 INFO - 'MOZ_NO_REMOTE': '1', 04:48:18 INFO - 'NO_EM_RESTART': '1', 04:48:18 INFO - 'PAGER': '/bin/cat', 04:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:18 INFO - 'PWD': '/builds/slave/test', 04:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:18 INFO - 'SHELL': '/bin/bash', 04:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:18 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:18 INFO - 'USER': 'cltbld', 04:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:18 INFO - 'XPC_FLAGS': '0x0', 04:48:18 INFO - 'XPC_SERVICE_NAME': '0', 04:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:48:18 INFO - Cleaning up... 04:48:18 INFO - Return code: 0 04:48:18 INFO - Running post-action listener: _resource_record_post_action 04:48:18 INFO - Running post-action listener: _start_resource_monitoring 04:48:18 INFO - Starting resource monitoring. 04:48:18 INFO - [mozharness: 2016-10-24 11:48:18.595132Z] Finished create-virtualenv step (success) 04:48:18 INFO - [mozharness: 2016-10-24 11:48:18.596069Z] Running install step. 04:48:18 INFO - Running pre-action listener: _resource_record_pre_action 04:48:18 INFO - Running main action method: install 04:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:18 INFO - Reading from file tmpfile_stdout 04:48:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:48:18 INFO - Reading from file tmpfile_stdout 04:48:18 INFO - Output received: 04:48:18 INFO - Usage: mozinstall [options] installer 04:48:18 INFO - Options: 04:48:18 INFO - -h, --help show this help message and exit 04:48:18 INFO - -d DEST, --destination=DEST 04:48:18 INFO - Directory to install application into. [default: 04:48:18 INFO - "/builds/slave/test"] 04:48:18 INFO - --app=APP Application being installed. [default: firefox] 04:48:18 INFO - mkdir: /builds/slave/test/build/application 04:48:18 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'] 04:48:18 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 04:48:51 INFO - Reading from file tmpfile_stdout 04:48:51 INFO - Output received: 04:48:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:48:51 INFO - Running post-action listener: _resource_record_post_action 04:48:51 INFO - [mozharness: 2016-10-24 11:48:51.705280Z] Finished install step (success) 04:48:51 INFO - [mozharness: 2016-10-24 11:48:51.705421Z] Running run-tests step. 04:48:51 INFO - Running pre-action listener: _resource_record_pre_action 04:48:51 INFO - Running main action method: run_tests 04:48:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:48:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:48:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:48:51 INFO - 2016-10-24 04:48:51.720 screenresolution[1639:7404] starting screenresolution argv=screenresolution get 04:48:51 INFO - 2016-10-24 04:48:51.722 screenresolution[1639:7404] Display 0: 1600x1200x32@60 04:48:51 INFO - 2016-10-24 04:48:51.728 screenresolution[1640:7406] starting screenresolution argv=screenresolution list 04:48:51 INFO - Available Modes on Display 0 04:48:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:48:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:48:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:48:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:48:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:48:51 INFO - Intel Iris: 04:48:51 INFO - Chipset Model: Intel Iris 04:48:51 INFO - Type: GPU 04:48:51 INFO - Bus: Built-In 04:48:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:48:51 INFO - Vendor: Intel (0x8086) 04:48:51 INFO - Device ID: 0x0a2e 04:48:51 INFO - Revision ID: 0x0009 04:48:51 INFO - Displays: 04:48:51 INFO - Display: 04:48:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:48:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:48:51 INFO - Display Serial Number: 1600x1200 60 04:48:51 INFO - Main Display: Yes 04:48:51 INFO - Mirror: Off 04:48:51 INFO - Online: Yes 04:48:51 INFO - Rotation: Supported 04:48:51 INFO - Return code: 0 04:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:48:51 INFO - Python 2.7.3 04:48:51 INFO - Return code: 0 04:48:51 INFO - grabbing minidump binary from tooltool 04:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:51 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 0x10ba2ad30>, '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 0x10b890db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba22b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:48:51 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 04:48:51 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 04:48:51 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 04:48:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:48:52 INFO - Return code: 0 04:48:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:48:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:48:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:48:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:48:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:48:52 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/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--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 04:48:52 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/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --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 04:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FrPafseKqn/Render', 04:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:52 INFO - 'HOME': '/Users/cltbld', 04:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:52 INFO - 'LOGNAME': 'cltbld', 04:48:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:48:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:52 INFO - 'MOZ_NO_REMOTE': '1', 04:48:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:48:52 INFO - 'NO_EM_RESTART': '1', 04:48:52 INFO - 'PAGER': '/bin/cat', 04:48:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:52 INFO - 'PWD': '/builds/slave/test', 04:48:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:52 INFO - 'SHELL': '/bin/bash', 04:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMoQsy5bdh/Listeners', 04:48:52 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 04:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:52 INFO - 'USER': 'cltbld', 04:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:52 INFO - 'XPC_FLAGS': '0x0', 04:48:52 INFO - 'XPC_SERVICE_NAME': '0', 04:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:52 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/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--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 04:48:52 INFO - mozversion application_buildid: 20161024022822 04:48:52 INFO - mozversion application_changeset: 1ec527fde116a5e705db035f379afdb45529fbb0 04:48:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:48:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:48:52 INFO - mozversion application_name: Firefox 04:48:52 INFO - mozversion application_remotingname: firefox-dev 04:48:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:48:52 INFO - mozversion application_vendor: Mozilla 04:48:52 INFO - mozversion application_version: 51.0a2 04:48:52 INFO - mozversion platform_buildid: 20161024022822 04:48:52 INFO - mozversion platform_changeset: 1ec527fde116a5e705db035f379afdb45529fbb0 04:48:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:48:52 INFO - mozversion platform_version: 51.0a2 04:48:52 INFO - using testdate: 1477309732 04:48:52 INFO - actual date: 1477309732 04:48:52 INFO - starting webserver on 'localhost:49276' 04:48:52 INFO - SUITE-START | Running 2 tests 04:48:52 INFO - TEST-START | dromaeo_css 04:48:52 INFO - operating with platform_type : mac_ 04:48:52 INFO - Initialising browser for dromaeo_css test... 04:48:52 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpGsMPXL/profile http://localhost:49276/getInfo.html) 04:48:54 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 04:48:54 INFO - PROCESS | 1650 | colorDepth:24 04:48:54 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 04:48:54 INFO - PROCESS | 1650 | __metrics 04:48:54 INFO - PROCESS | 1650 | 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" 04:48:54 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:48:55 INFO - TEST-INFO | 1650: exit 0 04:48:55 INFO - Browser initialized. 04:48:55 INFO - Running cycle 1/1 for dromaeo_css test... 04:48:55 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpGsMPXL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:07 INFO - PROCESS | 1652 | RSS: Main: 219680768 04:49:07 INFO - PROCESS | 1652 | 04:49:59 INFO - PROCESS | 1652 | 1477309799077 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] 04:52:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 04:52:11 INFO - PROCESS | 1652 | RSS: Main: 367095808 04:52:11 INFO - PROCESS | 1652 | 04:55:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 04:55:15 INFO - PROCESS | 1652 | RSS: Main: 353894400 04:55:15 INFO - PROCESS | 1652 | 04:58:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 04:58:18 INFO - PROCESS | 1652 | RSS: Main: 315813888 04:58:18 INFO - PROCESS | 1652 | 05:01:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:01:21 INFO - PROCESS | 1652 | RSS: Main: 320409600 05:01:21 INFO - PROCESS | 1652 | 05:04:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:04:25 INFO - PROCESS | 1652 | RSS: Main: 311476224 05:04:25 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:07:28 INFO - PROCESS | 1652 | RSS: Main: 476672000 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | __start_tp_report 05:07:28 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:07:28 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:07:28 INFO - PROCESS | 1652 | |i|pagename|runs| 05:07:28 INFO - PROCESS | 1652 | |0;dojo.html;3333.083402064433;3341.883034093807;3376.476646119849;3398.966010339896;3412.6075501317355;5586.888262234753;5622.128570071645;5643.463870932255;5682.630629009117;5688.715564221783;5574.888502229963;5654.802081927133;5668.829935101943;5684.914726279098;5696.829095127143;5137.691738495683;5149.021685879689;5161.27742116104;5206.323177986876;5216.191490319006;5138.922916156242;5139.897202055957;5152.278680984665;5166.380034395859;5265.76304066318;5191.480851914816;5236.973815130938;5241.266222728802;5244.318238628973;5261.421243663194;5203.19350500673;5226.372835259793;5242.79028838846;5245.527902488756;5263.921041184385;4992.800287988476;5107.055194788976;5161.354830646169;5167.457416971201;5176.922346164811;5527.917081243784;5605.467480589337;5611.915821262684;5647.830565083054;5683.744231509592;5996.460318571306;6056.788012419588;6062.060380641008;6157.599756015845;6166.445019948226;6180.3201647818705;6213.689066201222;6215.533834962396;6244.094606282064;6273.12176295319;5578.44215578447;5630.831075067755;5646.378898321182;5660.5471562274915;5756.194132821408;6298.086777417248;6313.463355614732;6352.491800656029;6395.6482393468805;6402.039694045838;6051.243594550681;6054.182685337423;6056.909146362808;6058.939410605837;6060.090986352083;6051.364606716232;6089.908651370233;6217.813465596039;6222.81331560054;6240.500759939194;5995.790147344909;6045.274567051982;6054.939450605438;6100.54245931548;6162.969185154046;6150.323464418911;6153.784617538365;6171.228596425447;6177.81466556004;6187.721552530147;4847.491013443538;4849.102915960559;4879.585235254972;4880.438749543777;4908.680935739166;4303.956960430418;4312;4330.891727706769;4369.847055353048;4388.210122177975;5727.39862314451;5745.597808153473;5747.48272655463;5763.510101641407;5793.246877905845;6242.500599951993;6245.937540624626;6270.7805226816845;6281.905771413432;6285.497160227263;5561.165825126182;5668.943310566841;5673.489385955284;5709.086546152679;5726.914096288559;5321.813736519203;5359.330083739533;5359.678419294854;5365.463453654681;5384.515393614593;6330.082138090043;6338.714757835908;6346.397092276226;6358.586691865014;6361.236651601837;6030.638161710312;6238.91705587049;6280;6288.339724329063;6308.179936608395;6281.528885333527;6313.842153946188;6352.047192921099;6352.0789485525265;6354.904676429765;6002.579819412599;6052.546059045501;6055.636661800306;6059.545534085049;6091.664958427329;6101;6123;6168.383161683796;6168.537359697951;6181.783637572664;5799.2750906136735;5855.268091488564;5948.732307046107;5953.940460595339;5977.940220597912;6026.337102918763;6030.185924900258;6033.939660603338;6038.456538911519;6075.453209211192;5698.772049117989;5852.648841069549;5875.882482350415;5892.528597712087;5916.615419997686;5727;5781.8554536136935;5938.61399009063;5998.670073146019;6031.215941927521;5213.556847667991;5775.768969241183;5840.474357307863;5841.883162336644;5863.73613187399 05:07:28 INFO - PROCESS | 1652 | |1;ext.html;493.73091665042546;505.89376230991513;515.7750342935528;518.6188151708494;566.7591273708673;28964.420711585783;38607.42088868669;39733.99999999996;39783.80108099463;42349.7882510587;41004.79497602508;41454.7927260364;41542.79228603853;41549.16901661965;41655.79172104135;8615.138486151365;9627.422354658725;9808.901910980905;9812.803743925117;9814.018598140165;8653.307735381155;11038.503267352948;11962.940185299105;11974.640760777147;12188.817167742447;11873.465694043745;11952.462139203757;11955.282683039002;11962.222455540406;11966.401679916013;11936.045116390667;12001.579944701982;12005.159638825286;12010.03919686423;12015.519379224821;10354.585816567329;11516.1362897783;11805.114616403718;11809.996150327232;11831.645050648494;39144.60855391438;39313.60686393128;39354.60645393538;39363.01592460183;39449.81650550488;3338.8163650999186;3342.983285083559;3349.112485191426;3519.3489204496996;3572.821358932043;29525.40949181004;29756.958506452385;29841.95553155651;30751.077467675783;30958.91643792479;3173.508106243536;3212.9196770080703;3223.613166420021;3258.9185270368193;3352.6479719629333;495732;496988;497044;499928;500293.4955975627;56976.71511642415;57321.133943302666;57340;57362;57392;34308.48537271943;34801.65198348035;35017.474737878954;36177.095572610895;36289.818550907075;16650.916745416438;16825.831741682672;16877.32490700358;16878.902871313327;16881.915590422213;11383.601573944872;11645.068394528418;11656.242344247597;12632.2420654761;12753.298568578632;16364.181790910407;16509.17454127289;18627.627447450974;19084.61830763377;19117.426477205707;7918.524888506708;8044.758657240292;8061.395395345373;8072.273495385326;8126.634301456449;845.2688424512875;895.4045559702724;936.5832204668993;1083.4203701020074;1092.4210168610648;26994.5950810738;29036.854815725786;29089.854550727534;29662.55506167409;30164.396712065634;921.4056933277998;1004.1414590525142;1050.9211809114347;1054.699410667956;1062.7024433158729;13265.801012984813;14009.509667161601;14816.62958426048;14948.551543453714;15733.370665173494;712625;717985;720257;720471;724345;57502;57682;57691.71154144286;57749.13376299359;57874.131888021715;1252.154795513025;1273.2487832178874;1375.1199232491015;1378.372840357635;1409.2178840743486;28764.280892977844;29947.401051979276;30132.69867301299;30180.24549386283;30968;47970.76014619905;48508;48535.75732121458;48684.513154868;48813.51186488232;459261;599013;605120;605559;606077;40275;40762.38856417097;41185.38221926733;41223.793881030404;41374.96562585959;44929.55070449384;45454.86362840823;45548;46124.84687882695;46342;38198.618013819505;38586;39068;40214;40263.59736402598;38216.42675359816;38358;38749.6125038746;39663.40504892371;39937;37212.81425881849;37304.62695373011;37918.431223531115;38139.80930095332;38563.45746170122;26362.736372636027;34583.13542161466;34692.653073468944;34736.65263347334;34776.65223347734;23392.766072339058;23592.88203558971;24279.635805463284;25160.874195628905;25925.481490369708 05:07:28 INFO - PROCESS | 1652 | |2;jquery.html;352.32002235685115;373.65810283590497;376.92461507698465;386.93615553433676;403.3344980781712;15164.84835151648;15175.54473365798;17222.827771722295;20559.38321850343;20969.00794424531;20308.69536956947;20735.896320518375;20918.790812091873;20922.686159707617;21182.57634847302;5730;5803.007376111776;5869.383714709958;6009.1286763419275;6010.218671572689;5713.542916566686;5908.113782932552;5917.585768996172;5937.228160339171;5939.1388248704125;4112.753234805907;4233.8094785734565;4350.695451318409;4353.912921741563;6321.494280457552;6421.582597131218;6569.178852643419;6617.139771829631;6691.665416729168;6723.529352945296;5757.337906140764;5759.107338362519;5761.193432919395;5763.596548241625;5797.391273916221;24553.50892982148;25003.49993000148;25188.370290742696;25224.621630675556;26120.8693956529;2287.622542280522;2409.024345140221;2436.3056528889183;2711.3492761737043;2796.566532187514;14407.135571865721;15823.525294241192;16110.11394373309;16113.516594502184;16187.83812161875;1822.3894995176631;1853.6107417442354;1905.285517930776;1907.9141438635295;1908.3130073173647;117307.413462933;117407.41296293549;120052.19921701094;122474;123318;9822.410655360702;10611.522481488351;10643.680689579325;10675.946620267005;11105.666829995112;12611.93694031524;12914.160579562298;13827.377768000262;13831.585052448443;13832.861671383158;8364.58177091143;8600.279944011223;8640.567971601395;8715.738527844049;8764.5179515126;8716.607752651145;8740.475571465733;8764.824703505894;8887.066857979948;8903.19871211581;6584.76953306632;6662.167229096363;6711.664416779142;6713.496487763339;6731.697073631698;1833.8899666020081;1867.7120527353882;1868.271374164077;1872.8220819022172;1877.6244751049844;849.9277561407226;929.6467342409976;964.7973925475588;1037.5123691864812;1055.4089709762404;21953.890230549063;22202.55594888093;22458.98934547949;22463.101475941105;22507.549849003255;813.7070654564352;891.153404265937;899.2940541674753;981.3179840011267;1011.8279892418307;11062.889371106186;11511.300843822917;11579.710507237387;11690.941545292219;11786.88213117875;613382;630379;640608;641649;644440;69184.65407672929;69278;114568;116096.41951790356;122023;834.2241715204917;939.8308304505255;986.063239922077;991.1674193677345;1017.1811691588342;18890.7166392507;19218.903905480383;19675.31136410219;19711.01444927719;19714.014299285267;48804.779880501854;49234.01531969269;52842.73578632082;53169.468305318;53911.73044134754;69476;73855.52288954084;74409;78605;85393.86515337166;7565.848683026198;7626.771196864103;7676.501027433199;8015.679372825021;8085.757427277191;9252.352335336462;12154.696132596755;12205.511779528719;12216.572419965258;12352.691182720504;10625.9468702656;10626.36241825493;10895.727606809893;10964.28732132409;10993.505292262027;8978.461292322481;9808.166305863797;10505.842412363667;10556.261061725605;10711.08955738771;10922.798492166014;10940.288881223014;11137.554497819996;11146.832797508207;11391.772164556829;7032.648367581703;7896.09194942589;7966.203379661987;7993.8401231976195;8184.140665230065;9339.865961621057;10011.199104071802;11187.384693841917;11296.49165787558;11586.826197607212 05:07:28 INFO - PROCESS | 1652 | |3;mootools.html;1235.7899157143286;1364.1883079567656;1527.419580559387;1658.601935535471;1687.5359276199044;6693.196816382035;8495.277901378382;8853.955730221347;9055.547222638874;9071.410358326704;8875.979262384828;8971.102889711026;8975.506347150904;8977.192052715254;8992.550372481366;2383.4279772854566;2414.0343862454984;2417.190241269177;2419.4314336130997;2421.007386971342;2305.4927915858566;2375.8455700379504;2402.4474370894704;2413.2760171948344;2422.551827911842;1815.5824160443105;2359.716833979925;2383.6901202843605;2392.605220138675;2401.255610760661;2344.2029709898716;2368.7631236876346;2374.513224788923;2377.6314671225987;2384.7376788553247;2341.637046257833;2373.6202207646866;2377.8216633752363;2384.7615238476187;2387.7612238776155;8948.910510894873;8954.462732236087;9011.279097672235;9019.143181397756;9025.909740902638;5268.631195816294;5452.591055670801;5469.343678758534;5504.532114770249;5519.116941289374;3489.092835862694;3529.9233733711208;3601.45978103284;3603.963960360415;3651.4887915691825;1089.9509522071526;1100.5542755184163;1102.2780079048237;1117.4245263689206;1128.1257025804985;11921.821172682417;11952.342621155833;12061.758764824743;12062.698432539257;12064.698382540419;4470.731756094645;4473.507914129443;4618.076384723002;4621.353010578522;4731.621470282369;9341.486218257925;9352.719418417459;9355.06449355059;9357.251419886392;9377.062293770705;5288.762005709752;5294.444083371268;5303.761330740126;5306.018386598492;5307.15085586312;3931.312020396419;3950.683945284428;4118.585325509041;4560;4961.03259864323;3577.695895848882;3907.628775266345;3909.7263191576885;3910.2570511602703;3911.6870650347905;1141.686036340013;1162.3258510064143;1165.6561314412268;1174.1370092981651;1174.8590169179754;802.5505716798612;838.8842839024084;936.9718908432758;937.9390339627903;938.6996161228342;4627.838025669153;5726.169705392695;5862.325832529228;5864.510611213913;6080.543959203077;426.91888541177076;430.1332814379029;441.4944888103104;443.62070429782716;457.6384656121627;4016.618421250035;4026.939595906064;4032.334664780278;4038.192361527706;4113.568075352105;10716.624918127829;10999.61501347449;11115.055220306365;11129.610463633733;11141.944290278496;10232;10678.679639610824;11031.724206894893;11040.834387484034;11054.336739795637;8221.383396245186;8438.451500652438;8454.492730436194;8462.153784621489;8475.194856488624;5977.282726072899;6066.241719785027;6144.293406258337;6162.028150991819;6186.907196392148;9753.122219000325;10140.898591013995;10294.330868493524;10335;10453.372797631862;9519.57161927701;10334.689959301233;10437.269391142547;10468.319559228627;10515.842262366225;7166.426685865223;7344.853102937805;8004.479708818908;8224.958875205586;8371;8140.430169888288;8319.126491718525;8397.244248017707;8411.4112012161;8546.871796923175;7455.217202193909;7551.697932082655;7572.5835079068975;7581;7587;7348.485606007742;7387.704491820267;7401.22287159862;7420.257974202536;7478.6260686966525;6889.965550172217;7033.859322813618;7044.15470143586;7120.501564890616;7133.536320139382;3747.7938713371027;3806.105565192233;4369.672274579356;4369.868903932887;4382.693211475166;4400.317950717644;4976.825811096594;4987.700737955734;5044.747762611928;5099.694018358762 05:07:28 INFO - PROCESS | 1652 | |4;prototype.html;273.7440493138915;302.9606151200344;305.0695379093763;307.477288609364;308.5680047932892;5143.588512918966;5221.347331583557;5223.250211179255;5227.849873027937;5282.709450980195;4479.372887795711;5118.795248190068;5120.414190833633;5163.974180129104;5175.482451754822;3631.893501768968;3782.3380908341;3785.5835858055593;3931.601722949013;4034.314166591672;3899.610038996092;3935;3967.7420967637154;3985.8405663773415;4008.859689910854;3311.536384906115;3932.8820135395986;3945.1123497213184;3945.3490174121234;3979.8010099495054;3476.947845782315;3539.4159963605975;3994.4407782910416;3995.7602543847315;4015.19696060789;3056.449839028974;3447.9827600862086;3463.7786858221843;3471.3577988072034;3486.8430920608635;5051.348042277834;5066.265391518209;5068.5691716204165;5068.797248110071;5073.909109541466;4407.449068866392;4510.684252102355;4538.500764915857;4545.272756359;4553.632111302104;4242.560527696556;5277.551408130314;5395.974764794676;5418.214358917974;5436.592255580847;3532.788032718045;3604.441311596707;3683.7421380503374;3796.2787070456525;3808.9619103808886;4652.953470465286;5137.178051511778;5493.23094766733;5647.80232691858;5754.625949313281;3270.8201048942537;3361.1598199521363;3844.942325865114;3845.480860083853;3877.6703980161437;3902.9804850975565;3911.7457365271734;3919.6668283195677;3937.27160475313;3950.5654378018394;4537.795799189044;4540.296254080623;4543.091381723669;4562.863114106516;4574.336721175478;4604.953950460519;5032.572231360376;5390.730463476811;5464.9453505464435;5530.5852061095575;1255.234307072685;1290.993545032269;1316.7162017033315;1320.491610729876;1323.6558494791423;664.7673314339943;701.6106061136119;733.7211859493358;789.5183937797939;804.2520455975881;3476.791392516457;3914.432407300925;4907.705537667752;5125.461826508237;5151.871203219875;5468.250159948858;5592.7762889484775;5624.1159211663735;5642.774289028475;5714.428557144335;4889.843632912068;5137.794488220504;5205.8764741155;5248.976449592293;5257.605679574047;2413.3604594782396;2453.791427728663;2521.308730582255;2840.247334456371;2946.882124714987;5784.971075144597;5798.971005144947;5840.737166827503;5841.649501029951;5873.236479257669;5285.68285902847;5619.6347237430255;5685.317761868602;5719.542436605062;5755.3381361143165;4627.768611569408;5362.31884057971;5755.510781583613;5890.440408161217;5898.262717160355;4999.750062484379;5508.256385388082;5630.184907546227;5660.603757736919;5727.198192253005;5205.193195054772;5560.88782243561;5577.3786320429335;5580.274564306615;5609.326880774333;4931.580815630568;5855.912161317498;5875.6474611523445;5886.469517925285;5920.79277225295;3044.8477576120663;3235.9191020224685;3476.513288139713;3794.658480736747;3844.2503711777053;5527.8894422112135;5617.5505959522325;5697.062998580503;5698.6010979232715;5703.116017017369;5426.67439953604;5462.235287059894;5494.615376923577;5502.504774570308;5505.9724701376235;5214.739263036757;5462.426445223353;5504.192861640512;5513.228148059355;5542.925949427248;4411.845585404495;5340.305760251143;5390.919136213039;5392.946070539245;5406.378266499403;5233.424323324355;5406.78372865081;5490.858565159511;5502.284702988586;5502.697351645698;4964.950350496593;5249.13389290778;5278.788848446019;5403.730123420914;5405.378381486179 05:07:28 INFO - PROCESS | 1652 | |5;yui.html;702.4450683959669;706.4772068669184;758.707897459478;758.7487615567292;811.2658044469757;13227.801582976263;14837.925810370947;15623.765643515357;15702.528924132266;15715.685686286268;12850.678733031678;13804.723905521883;14150.292485375741;14363.35364908579;14380.856191438108;659.1826135591856;677.485111315399;683.7470136049668;808.7533302342783;829.1956801902176;825.9297959673435;853.1766844994579;853.2960307746134;855.8758979947904;860.8966923969101;901.1349104859343;905.266733945503;905.3662436294587;906.9818603627923;906.9977674669494;684.3464491410691;701.2741812224324;866.5104216117874;901.8692289618001;902.7923577577161;651.6285717141232;664.6709878610119;664.9202095748493;665.7170702451439;666.7999600119945;14444;14513.05665131763;14520.782188267185;14527.128372297697;14534.200618965953;13563;13745.793813092812;13797.586072417744;13843.653908652264;13904.51334203298;12175.695607609792;12501.624951251477;12533.623991280276;12618.81071783924;12930.224186548838;4469.08383781324;4482.664346961601;4523.208438523246;4551.453825540956;4676.719396836201;102786;107357.46321268422;117173;123383;129080.7091929078;10551;10824.242303038869;10912.672619821418;10929.344239345664;11038.724031899106;21326.680099798516;21335.893320533298;21361.67957480639;21443.463913401978;21465.356039318845;7589.620518974029;7593.202713715091;7754.883676744853;7772.52322058807;7846.058472983279;4313.439252897166;4373.781310934504;4447.666425018137;4464.486584042812;4600.079984003212;3398.3543126805826;3534.0988048047584;3536.929261414757;3540.592831824322;3546.8935931922083;630.9242890853127;637.4103953842676;642.2966851297822;648.8734696734092;657.917760279965;540.4109520622541;595.3451203675921;613.8342647485154;627.8712863862988;632.4908448698842;8984.146506081912;9125.908740912506;9126.726198214064;9144.679936202334;9147.679831205876;559.6054781379117;613.96009259398;621.3599992008238;634.4511997122456;637.3562701671252;4335.978320108379;4402.625776809007;4432.268675668543;4449.28811390176;4554.88612784683;154009;158194;160604;162848;168130;106170.46914765377;113614;121343.78656213502;124612.37693811655;139939.30030349782;72460;106239;112223;120688.39655801666;121405;9140.588673509576;9371.875374955049;9577.377470464398;9925.10945350267;9989.300748947504;57947.4205257942;63316.36683633105;63532.68233658802;63990;65756;92527.53736231275;98549.01450985685;100401;101106;102613.48693256486;12915.076027978605;13019.479220831061;13047.869521304665;13164.275964821643;13363.064585478924;14082.577522674335;14277.286135692966;14593.708125837637;15036.699266014837;15572.688546228785;12921.32874960815;13284.402201900744;13681.796245714904;13831.654208644462;13989.020768546105;13218.60344189676;13414.12808167466;13488;14230.288485575888;14441.638959026108;10653.627123050655;12465.439055242718;12835;13626.250556219504;13686;9449.622015119317;10760.40817755031;11027.944860275647;11189.160812938899;11218.831717524406;11414.771704565695;11588.710282243012;11718.296902185895;11719.12106592026;11856.288622682667 05:07:28 INFO - PROCESS | 1652 | __end_tp_report 05:07:28 INFO - PROCESS | 1652 | __start_cc_report 05:07:28 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1395 05:07:28 INFO - PROCESS | 1652 | __end_cc_report 05:07:28 INFO - PROCESS | 1652 | __startTimestamp1477310848482__endTimestamp 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:07:28 INFO - PROCESS | 1652 | Number of tests: 6 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5690.17 Median:5841.88 stddev:630.89 (10.8%) stddev-sans-first:605.12 05:07:28 INFO - PROCESS | 1652 | Values: 3333.1 3341.9 3376.5 3399.0 3412.6 5586.9 5622.1 5643.5 5682.6 5688.7 5574.9 5654.8 5668.8 5684.9 5696.8 5137.7 5149.0 5161.3 5206.3 5216.2 5138.9 5139.9 5152.3 5166.4 5265.8 5191.5 5237.0 5241.3 5244.3 5261.4 5203.2 5226.4 5242.8 5245.5 5263.9 4992.8 5107.1 5161.4 5167.5 5176.9 5527.9 5605.5 5611.9 5647.8 5683.7 5996.5 6056.8 6062.1 6157.6 6166.4 6180.3 6213.7 6215.5 6244.1 6273.1 5578.4 5630.8 5646.4 5660.5 5756.2 6298.1 6313.5 6352.5 6395.6 6402.0 6051.2 6054.2 6056.9 6058.9 6060.1 6051.4 6089.9 6217.8 6222.8 6240.5 5995.8 6045.3 6054.9 6100.5 6163.0 6150.3 6153.8 6171.2 6177.8 6187.7 4847.5 4849.1 4879.6 4880.4 4908.7 4304.0 4312.0 4330.9 4369.8 4388.2 5727.4 5745.6 5747.5 5763.5 5793.2 6242.5 6245.9 6270.8 6281.9 6285.5 5561.2 5668.9 5673.5 5709.1 5726.9 5321.8 5359.3 5359.7 5365.5 5384.5 6330.1 6338.7 6346.4 6358.6 6361.2 6030.6 6238.9 6280.0 6288.3 6308.2 6281.5 6313.8 6352.0 6352.1 6354.9 6002.6 6052.5 6055.6 6059.5 6091.7 6101.0 6123.0 6168.4 6168.5 6181.8 5799.3 5855.3 5948.7 5953.9 5977.9 6026.3 6030.2 6033.9 6038.5 6075.5 5698.8 5852.6 5875.9 5892.5 5916.6 5727.0 5781.9 5938.6 5998.7 6031.2 5213.6 5775.8 5840.5 5841.9 5863.7 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:72082.34 Median:36751.32 stddev:162156.25 (441.2%) stddev-sans-first:162522.06 05:07:28 INFO - PROCESS | 1652 | Values: 493.7 505.9 515.8 518.6 566.8 28964.4 38607.4 39734.0 39783.8 42349.8 41004.8 41454.8 41542.8 41549.2 41655.8 8615.1 9627.4 9808.9 9812.8 9814.0 8653.3 11038.5 11962.9 11974.6 12188.8 11873.5 11952.5 11955.3 11962.2 11966.4 11936.0 12001.6 12005.2 12010.0 12015.5 10354.6 11516.1 11805.1 11810.0 11831.6 39144.6 39313.6 39354.6 39363.0 39449.8 3338.8 3343.0 3349.1 3519.3 3572.8 29525.4 29757.0 29842.0 30751.1 30958.9 3173.5 3212.9 3223.6 3258.9 3352.6 495732.0 496988.0 497044.0 499928.0 500293.5 56976.7 57321.1 57340.0 57362.0 57392.0 34308.5 34801.7 35017.5 36177.1 36289.8 16650.9 16825.8 16877.3 16878.9 16881.9 11383.6 11645.1 11656.2 12632.2 12753.3 16364.2 16509.2 18627.6 19084.6 19117.4 7918.5 8044.8 8061.4 8072.3 8126.6 845.3 895.4 936.6 1083.4 1092.4 26994.6 29036.9 29089.9 29662.6 30164.4 921.4 1004.1 1050.9 1054.7 1062.7 13265.8 14009.5 14816.6 14948.6 15733.4 712625.0 717985.0 720257.0 720471.0 724345.0 57502.0 57682.0 57691.7 57749.1 57874.1 1252.2 1273.2 1375.1 1378.4 1409.2 28764.3 29947.4 30132.7 30180.2 30968.0 47970.8 48508.0 48535.8 48684.5 48813.5 459261.0 599013.0 605120.0 605559.0 606077.0 40275.0 40762.4 41185.4 41223.8 41375.0 44929.6 45454.9 45548.0 46124.8 46342.0 38198.6 38586.0 39068.0 40214.0 40263.6 38216.4 38358.0 38749.6 39663.4 39937.0 37212.8 37304.6 37918.4 38139.8 38563.5 26362.7 34583.1 34692.7 34736.7 34776.7 23392.8 23592.9 24279.6 25160.9 25925.5 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35266.38 Median:2753.96 stddev:104992.94 (3812.4%) stddev-sans-first:105254.74 05:07:28 INFO - PROCESS | 1652 | Values: 352.3 373.7 376.9 386.9 403.3 15164.8 15175.5 17222.8 20559.4 20969.0 20308.7 20735.9 20918.8 20922.7 21182.6 5730.0 5803.0 5869.4 6009.1 6010.2 5713.5 5908.1 5917.6 5937.2 5939.1 4112.8 4233.8 4350.7 4353.9 6321.5 6421.6 6569.2 6617.1 6691.7 6723.5 5757.3 5759.1 5761.2 5763.6 5797.4 24553.5 25003.5 25188.4 25224.6 26120.9 2287.6 2409.0 2436.3 2711.3 2796.6 14407.1 15823.5 16110.1 16113.5 16187.8 1822.4 1853.6 1905.3 1907.9 1908.3 117307.4 117407.4 120052.2 122474.0 123318.0 9822.4 10611.5 10643.7 10675.9 11105.7 12611.9 12914.2 13827.4 13831.6 13832.9 8364.6 8600.3 8640.6 8715.7 8764.5 8716.6 8740.5 8764.8 8887.1 8903.2 6584.8 6662.2 6711.7 6713.5 6731.7 1833.9 1867.7 1868.3 1872.8 1877.6 849.9 929.6 964.8 1037.5 1055.4 21953.9 22202.6 22459.0 22463.1 22507.5 813.7 891.2 899.3 981.3 1011.8 11062.9 11511.3 11579.7 11690.9 11786.9 613382.0 630379.0 640608.0 641649.0 644440.0 69184.7 69278.0 114568.0 116096.4 122023.0 834.2 939.8 986.1 991.2 1017.2 18890.7 19218.9 19675.3 19711.0 19714.0 48804.8 49234.0 52842.7 53169.5 53911.7 69476.0 73855.5 74409.0 78605.0 85393.9 7565.8 7626.8 7676.5 8015.7 8085.8 9252.4 12154.7 12205.5 12216.6 12352.7 10625.9 10626.4 10895.7 10964.3 10993.5 8978.5 9808.2 10505.8 10556.3 10711.1 10922.8 10940.3 11137.6 11146.8 11391.8 7032.6 7896.1 7966.2 7993.8 8184.1 9339.9 10011.2 11187.4 11296.5 11586.8 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5705.72 Median:2457.18 stddev:3300.39 (134.3%) stddev-sans-first:3292.55 05:07:28 INFO - PROCESS | 1652 | Values: 1235.8 1364.2 1527.4 1658.6 1687.5 6693.2 8495.3 8854.0 9055.5 9071.4 8876.0 8971.1 8975.5 8977.2 8992.6 2383.4 2414.0 2417.2 2419.4 2421.0 2305.5 2375.8 2402.4 2413.3 2422.6 1815.6 2359.7 2383.7 2392.6 2401.3 2344.2 2368.8 2374.5 2377.6 2384.7 2341.6 2373.6 2377.8 2384.8 2387.8 8948.9 8954.5 9011.3 9019.1 9025.9 5268.6 5452.6 5469.3 5504.5 5519.1 3489.1 3529.9 3601.5 3604.0 3651.5 1090.0 1100.6 1102.3 1117.4 1128.1 11921.8 11952.3 12061.8 12062.7 12064.7 4470.7 4473.5 4618.1 4621.4 4731.6 9341.5 9352.7 9355.1 9357.3 9377.1 5288.8 5294.4 5303.8 5306.0 5307.2 3931.3 3950.7 4118.6 4560.0 4961.0 3577.7 3907.6 3909.7 3910.3 3911.7 1141.7 1162.3 1165.7 1174.1 1174.9 802.6 838.9 937.0 937.9 938.7 4627.8 5726.2 5862.3 5864.5 6080.5 426.9 430.1 441.5 443.6 457.6 4016.6 4026.9 4032.3 4038.2 4113.6 10716.6 10999.6 11115.1 11129.6 11141.9 10232.0 10678.7 11031.7 11040.8 11054.3 8221.4 8438.5 8454.5 8462.2 8475.2 5977.3 6066.2 6144.3 6162.0 6186.9 9753.1 10140.9 10294.3 10335.0 10453.4 9519.6 10334.7 10437.3 10468.3 10515.8 7166.4 7344.9 8004.5 8225.0 8371.0 8140.4 8319.1 8397.2 8411.4 8546.9 7455.2 7551.7 7572.6 7581.0 7587.0 7348.5 7387.7 7401.2 7420.3 7478.6 6890.0 7033.9 7044.2 7120.5 7133.5 3747.8 3806.1 4369.7 4369.9 4382.7 4400.3 4976.8 4987.7 5044.7 5099.7 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4442.81 Median:5122.94 stddev:1400.16 (27.3%) stddev-sans-first:1368.67 05:07:28 INFO - PROCESS | 1652 | Values: 273.7 303.0 305.1 307.5 308.6 5143.6 5221.3 5223.3 5227.8 5282.7 4479.4 5118.8 5120.4 5164.0 5175.5 3631.9 3782.3 3785.6 3931.6 4034.3 3899.6 3935.0 3967.7 3985.8 4008.9 3311.5 3932.9 3945.1 3945.3 3979.8 3476.9 3539.4 3994.4 3995.8 4015.2 3056.4 3448.0 3463.8 3471.4 3486.8 5051.3 5066.3 5068.6 5068.8 5073.9 4407.4 4510.7 4538.5 4545.3 4553.6 4242.6 5277.6 5396.0 5418.2 5436.6 3532.8 3604.4 3683.7 3796.3 3809.0 4653.0 5137.2 5493.2 5647.8 5754.6 3270.8 3361.2 3844.9 3845.5 3877.7 3903.0 3911.7 3919.7 3937.3 3950.6 4537.8 4540.3 4543.1 4562.9 4574.3 4605.0 5032.6 5390.7 5464.9 5530.6 1255.2 1291.0 1316.7 1320.5 1323.7 664.8 701.6 733.7 789.5 804.3 3476.8 3914.4 4907.7 5125.5 5151.9 5468.3 5592.8 5624.1 5642.8 5714.4 4889.8 5137.8 5205.9 5249.0 5257.6 2413.4 2453.8 2521.3 2840.2 2946.9 5785.0 5799.0 5840.7 5841.6 5873.2 5285.7 5619.6 5685.3 5719.5 5755.3 4627.8 5362.3 5755.5 5890.4 5898.3 4999.8 5508.3 5630.2 5660.6 5727.2 5205.2 5560.9 5577.4 5580.3 5609.3 4931.6 5855.9 5875.6 5886.5 5920.8 3044.8 3235.9 3476.5 3794.7 3844.3 5527.9 5617.6 5697.1 5698.6 5703.1 5426.7 5462.2 5494.6 5502.5 5506.0 5214.7 5462.4 5504.2 5513.2 5542.9 4411.8 5340.3 5390.9 5392.9 5406.4 5233.4 5406.8 5490.9 5502.3 5502.7 4965.0 5249.1 5278.8 5403.7 5405.4 05:07:28 INFO - PROCESS | 1652 | 05:07:28 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25235.24 Median:12431.86 stddev:40869.06 (328.7%) stddev-sans-first:40942.20 05:07:28 INFO - PROCESS | 1652 | Values: 702.4 706.5 758.7 758.7 811.3 13227.8 14837.9 15623.8 15702.5 15715.7 12850.7 13804.7 14150.3 14363.4 14380.9 659.2 677.5 683.7 808.8 829.2 825.9 853.2 853.3 855.9 860.9 901.1 905.3 905.4 907.0 907.0 684.3 701.3 866.5 901.9 902.8 651.6 664.7 664.9 665.7 666.8 14444.0 14513.1 14520.8 14527.1 14534.2 13563.0 13745.8 13797.6 13843.7 13904.5 12175.7 12501.6 12533.6 12618.8 12930.2 4469.1 4482.7 4523.2 4551.5 4676.7 102786.0 107357.5 117173.0 123383.0 129080.7 10551.0 10824.2 10912.7 10929.3 11038.7 21326.7 21335.9 21361.7 21443.5 21465.4 7589.6 7593.2 7754.9 7772.5 7846.1 4313.4 4373.8 4447.7 4464.5 4600.1 3398.4 3534.1 3536.9 3540.6 3546.9 630.9 637.4 642.3 648.9 657.9 540.4 595.3 613.8 627.9 632.5 8984.1 9125.9 9126.7 9144.7 9147.7 559.6 614.0 621.4 634.5 637.4 4336.0 4402.6 4432.3 4449.3 4554.9 154009.0 158194.0 160604.0 162848.0 168130.0 106170.5 113614.0 121343.8 124612.4 139939.3 72460.0 106239.0 112223.0 120688.4 121405.0 9140.6 9371.9 9577.4 9925.1 9989.3 57947.4 63316.4 63532.7 63990.0 65756.0 92527.5 98549.0 100401.0 101106.0 102613.5 12915.1 13019.5 13047.9 13164.3 13363.1 14082.6 14277.3 14593.7 15036.7 15572.7 12921.3 13284.4 13681.8 13831.7 13989.0 13218.6 13414.1 13488.0 14230.3 14441.6 10653.6 12465.4 12835.0 13626.3 13686.0 9449.6 10760.4 11027.9 11189.2 11218.8 11414.8 11588.7 11718.3 11719.1 11856.3 05:07:28 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:07:28 INFO - PROCESS | 1652 | 05:07:29 INFO - TEST-INFO | 1652: exit 0 05:07:29 INFO - TEST-OK | dromaeo_css | took 1116863ms 05:07:29 INFO - TEST-START | kraken 05:07:29 INFO - operating with platform_type : mac_ 05:07:29 INFO - Initialising browser for kraken test... 05:07:29 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmp53gQVj/profile http://localhost:49276/getInfo.html) 05:07:31 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:07:31 INFO - PROCESS | 1662 | colorDepth:24 05:07:31 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:07:31 INFO - PROCESS | 1662 | __metrics 05:07:31 INFO - PROCESS | 1662 | 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" 05:07:31 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:07:32 INFO - TEST-INFO | 1662: exit 0 05:07:32 INFO - Browser initialized. 05:07:32 INFO - Running cycle 1/1 for kraken test... 05:07:32 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmp53gQVj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:43 INFO - PROCESS | 1663 | RSS: Main: 219844608 05:07:43 INFO - PROCESS | 1663 | 05:07:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:07:47 INFO - PROCESS | 1663 | RSS: Main: 269385728 05:07:47 INFO - PROCESS | 1663 | 05:07:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:07:51 INFO - PROCESS | 1663 | RSS: Main: 279871488 05:07:51 INFO - PROCESS | 1663 | 05:07:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:07:54 INFO - PROCESS | 1663 | RSS: Main: 376352768 05:07:54 INFO - PROCESS | 1663 | 05:07:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:07:57 INFO - PROCESS | 1663 | RSS: Main: 280309760 05:07:57 INFO - PROCESS | 1663 | 05:07:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:00 INFO - PROCESS | 1663 | RSS: Main: 280678400 05:08:00 INFO - PROCESS | 1663 | 05:08:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:08:03 INFO - PROCESS | 1663 | RSS: Main: 318455808 05:08:03 INFO - PROCESS | 1663 | 05:08:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:08:06 INFO - PROCESS | 1663 | RSS: Main: 321290240 05:08:06 INFO - PROCESS | 1663 | 05:08:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:08:10 INFO - PROCESS | 1663 | RSS: Main: 317390848 05:08:10 INFO - PROCESS | 1663 | 05:08:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:08:12 INFO - PROCESS | 1663 | RSS: Main: 289824768 05:08:12 INFO - PROCESS | 1663 | 05:08:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:08:15 INFO - PROCESS | 1663 | RSS: Main: 296869888 05:08:15 INFO - PROCESS | 1663 | 05:08:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:08:18 INFO - PROCESS | 1663 | RSS: Main: 302075904 05:08:18 INFO - PROCESS | 1663 | 05:08:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:08:21 INFO - PROCESS | 1663 | RSS: Main: 310161408 05:08:21 INFO - PROCESS | 1663 | 05:08:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:08:24 INFO - PROCESS | 1663 | RSS: Main: 310099968 05:08:24 INFO - PROCESS | 1663 | 05:08:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:08:27 INFO - PROCESS | 1663 | RSS: Main: 353710080 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | __start_tp_report 05:08:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:08:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:08:27 INFO - PROCESS | 1663 | |i|pagename|runs| 05:08:27 INFO - PROCESS | 1663 | |0;ai-astar;115;114;115;114;113;114;114;113;114;113 05:08:27 INFO - PROCESS | 1663 | |1;audio-beat-detection;142;110;111;144;133;138;137;115;139;109 05:08:27 INFO - PROCESS | 1663 | |2;audio-dft;185;183;184;177;184;182;184;183;184;183 05:08:27 INFO - PROCESS | 1663 | |3;audio-fft;84;61;61;89;62;61;57;59;80;58 05:08:27 INFO - PROCESS | 1663 | |4;audio-oscillator;87;72;95;72;68;71;113;69;69;90 05:08:27 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;86;89;85;90;86;90;87;88;85 05:08:27 INFO - PROCESS | 1663 | |6;imaging-darkroom;98;97;95;98;97;97;97;98;150;165 05:08:27 INFO - PROCESS | 1663 | |7;imaging-desaturate;86;116;112;136;142;84;85;83;84;81 05:08:27 INFO - PROCESS | 1663 | |8;json-parse-financial;58;53;54;52;55;57;58;56;59;59 05:08:27 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;72;70;83;75;75;74;70;70;71 05:08:27 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;83;86;82;84;82;84;84;85;83;84 05:08:27 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;137;138;136;134;134;141;138;169;140 05:08:27 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;162;163;162;163;161;165;164;162;164;167 05:08:27 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;65;65;67;71;83;86;83;84;66 05:08:27 INFO - PROCESS | 1663 | __end_tp_report 05:08:27 INFO - PROCESS | 1663 | __start_cc_report 05:08:27 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1974 05:08:27 INFO - PROCESS | 1663 | __end_cc_report 05:08:27 INFO - PROCESS | 1663 | __startTimestamp1477310907009__endTimestamp 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:08:27 INFO - PROCESS | 1663 | Number of tests: 14 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 05:08:27 INFO - PROCESS | 1663 | Values: 115.0 114.0 115.0 114.0 113.0 114.0 114.0 113.0 114.0 113.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:137.50 stddev:14.61 (10.6%) stddev-sans-first:14.57 05:08:27 INFO - PROCESS | 1663 | Values: 142.0 110.0 111.0 144.0 133.0 138.0 137.0 115.0 139.0 109.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:182.90 Median:184.00 stddev:2.23 (1.2%) stddev-sans-first:2.24 05:08:27 INFO - PROCESS | 1663 | Values: 185.0 183.0 184.0 177.0 184.0 182.0 184.0 183.0 184.0 183.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.50 stddev:12.11 (19.7%) stddev-sans-first:11.21 05:08:27 INFO - PROCESS | 1663 | Values: 84.0 61.0 61.0 89.0 62.0 61.0 57.0 59.0 80.0 58.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:72.00 stddev:15.11 (21.0%) stddev-sans-first:15.85 05:08:27 INFO - PROCESS | 1663 | Values: 87.0 72.0 95.0 72.0 68.0 71.0 113.0 69.0 69.0 90.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.96 (2.2%) stddev-sans-first:2.00 05:08:27 INFO - PROCESS | 1663 | Values: 89.0 86.0 89.0 85.0 90.0 86.0 90.0 87.0 88.0 85.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:97.00 stddev:25.72 (26.5%) stddev-sans-first:26.95 05:08:27 INFO - PROCESS | 1663 | Values: 98.0 97.0 95.0 98.0 97.0 97.0 97.0 98.0 150.0 165.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:100.90 Median:83.50 stddev:23.65 (28.3%) stddev-sans-first:24.46 05:08:27 INFO - PROCESS | 1663 | Values: 86.0 116.0 112.0 136.0 142.0 84.0 85.0 83.0 84.0 81.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.50 stddev:2.51 (4.4%) stddev-sans-first:2.57 05:08:27 INFO - PROCESS | 1663 | Values: 58.0 53.0 54.0 52.0 55.0 57.0 58.0 56.0 59.0 59.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:4.74 (6.5%) stddev-sans-first:4.18 05:08:27 INFO - PROCESS | 1663 | Values: 65.0 72.0 70.0 83.0 75.0 75.0 74.0 70.0 70.0 71.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.25 (1.5%) stddev-sans-first:1.30 05:08:27 INFO - PROCESS | 1663 | Values: 83.0 86.0 82.0 84.0 82.0 84.0 84.0 85.0 83.0 84.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:138.50 stddev:10.24 (7.4%) stddev-sans-first:10.85 05:08:27 INFO - PROCESS | 1663 | Values: 139.0 137.0 138.0 136.0 134.0 134.0 141.0 138.0 169.0 140.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.50 stddev:1.77 (1.1%) stddev-sans-first:1.81 05:08:27 INFO - PROCESS | 1663 | Values: 162.0 163.0 162.0 163.0 161.0 165.0 164.0 162.0 164.0 167.0 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:77.00 stddev:9.06 (11.8%) stddev-sans-first:9.28 05:08:27 INFO - PROCESS | 1663 | Values: 67.0 65.0 65.0 67.0 71.0 83.0 86.0 83.0 84.0 66.0 05:08:27 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:08:27 INFO - PROCESS | 1663 | 05:08:27 INFO - TEST-INFO | 1663: exit 0 05:08:27 INFO - TEST-OK | kraken | took 58703ms 05:08:27 INFO - SUITE-END | took 1175s 05:08:28 INFO - Completed test suite (00:19:35) 05:08:28 INFO - javascript benchmark 05:08:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.083402064433, 3341.883034093807, 3376.476646119849, 3398.966010339896, 3412.6075501317355, 5586.888262234753, 5622.128570071645, 5643.463870932255, 5682.630629009117, 5688.715564221783, 5574.888502229963, 5654.802081927133, 5668.829935101943, 5684.914726279098, 5696.829095127143, 5137.691738495683, 5149.021685879689, 5161.27742116104, 5206.323177986876, 5216.191490319006, 5138.922916156242, 5139.897202055957, 5152.278680984665, 5166.380034395859, 5265.76304066318, 5191.480851914816, 5236.973815130938, 5241.266222728802, 5244.318238628973, 5261.421243663194, 5203.19350500673, 5226.372835259793, 5242.79028838846, 5245.527902488756, 5263.921041184385, 4992.800287988476, 5107.055194788976, 5161.354830646169, 5167.457416971201, 5176.922346164811, 5527.917081243784, 5605.467480589337, 5611.915821262684, 5647.830565083054, 5683.744231509592, 5996.460318571306, 6056.788012419588, 6062.060380641008, 6157.599756015845, 6166.445019948226, 6180.3201647818705, 6213.689066201222, 6215.533834962396, 6244.094606282064, 6273.12176295319, 5578.44215578447, 5630.831075067755, 5646.378898321182, 5660.5471562274915, 5756.194132821408, 6298.086777417248, 6313.463355614732, 6352.491800656029, 6395.6482393468805, 6402.039694045838, 6051.243594550681, 6054.182685337423, 6056.909146362808, 6058.939410605837, 6060.090986352083, 6051.364606716232, 6089.908651370233, 6217.813465596039, 6222.81331560054, 6240.500759939194, 5995.790147344909, 6045.274567051982, 6054.939450605438, 6100.54245931548, 6162.969185154046, 6150.323464418911, 6153.784617538365, 6171.228596425447, 6177.81466556004, 6187.721552530147, 4847.491013443538, 4849.102915960559, 4879.585235254972, 4880.438749543777, 4908.680935739166, 4303.956960430418, 4312.0, 4330.891727706769, 4369.847055353048, 4388.210122177975, 5727.39862314451, 5745.597808153473, 5747.48272655463, 5763.510101641407, 5793.246877905845, 6242.500599951993, 6245.937540624626, 6270.7805226816845, 6281.905771413432, 6285.497160227263, 5561.165825126182, 5668.943310566841, 5673.489385955284, 5709.086546152679, 5726.914096288559, 5321.813736519203, 5359.330083739533, 5359.678419294854, 5365.463453654681, 5384.515393614593, 6330.082138090043, 6338.714757835908, 6346.397092276226, 6358.586691865014, 6361.236651601837, 6030.638161710312, 6238.91705587049, 6280.0, 6288.339724329063, 6308.179936608395, 6281.528885333527, 6313.842153946188, 6352.047192921099, 6352.0789485525265, 6354.904676429765, 6002.579819412599, 6052.546059045501, 6055.636661800306, 6059.545534085049, 6091.664958427329, 6101.0, 6123.0, 6168.383161683796, 6168.537359697951, 6181.783637572664, 5799.2750906136735, 5855.268091488564, 5948.732307046107, 5953.940460595339, 5977.940220597912, 6026.337102918763, 6030.185924900258, 6033.939660603338, 6038.456538911519, 6075.453209211192, 5698.772049117989, 5852.648841069549, 5875.882482350415, 5892.528597712087, 5916.615419997686, 5727.0, 5781.8554536136935, 5938.61399009063, 5998.670073146019, 6031.215941927521, 5213.556847667991, 5775.768969241183, 5840.474357307863, 5841.883162336644, 5863.73613187399], "value": 5649.490034047132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.73091665042546, 505.89376230991513, 515.7750342935528, 518.6188151708494, 566.7591273708673, 28964.420711585783, 38607.42088868669, 39733.99999999996, 39783.80108099463, 42349.7882510587, 41004.79497602508, 41454.7927260364, 41542.79228603853, 41549.16901661965, 41655.79172104135, 8615.138486151365, 9627.422354658725, 9808.901910980905, 9812.803743925117, 9814.018598140165, 8653.307735381155, 11038.503267352948, 11962.940185299105, 11974.640760777147, 12188.817167742447, 11873.465694043745, 11952.462139203757, 11955.282683039002, 11962.222455540406, 11966.401679916013, 11936.045116390667, 12001.579944701982, 12005.159638825286, 12010.03919686423, 12015.519379224821, 10354.585816567329, 11516.1362897783, 11805.114616403718, 11809.996150327232, 11831.645050648494, 39144.60855391438, 39313.60686393128, 39354.60645393538, 39363.01592460183, 39449.81650550488, 3338.8163650999186, 3342.983285083559, 3349.112485191426, 3519.3489204496996, 3572.821358932043, 29525.40949181004, 29756.958506452385, 29841.95553155651, 30751.077467675783, 30958.91643792479, 3173.508106243536, 3212.9196770080703, 3223.613166420021, 3258.9185270368193, 3352.6479719629333, 495732.0, 496988.0, 497044.0, 499928.0, 500293.4955975627, 56976.71511642415, 57321.133943302666, 57340.0, 57362.0, 57392.0, 34308.48537271943, 34801.65198348035, 35017.474737878954, 36177.095572610895, 36289.818550907075, 16650.916745416438, 16825.831741682672, 16877.32490700358, 16878.902871313327, 16881.915590422213, 11383.601573944872, 11645.068394528418, 11656.242344247597, 12632.2420654761, 12753.298568578632, 16364.181790910407, 16509.17454127289, 18627.627447450974, 19084.61830763377, 19117.426477205707, 7918.524888506708, 8044.758657240292, 8061.395395345373, 8072.273495385326, 8126.634301456449, 845.2688424512875, 895.4045559702724, 936.5832204668993, 1083.4203701020074, 1092.4210168610648, 26994.5950810738, 29036.854815725786, 29089.854550727534, 29662.55506167409, 30164.396712065634, 921.4056933277998, 1004.1414590525142, 1050.9211809114347, 1054.699410667956, 1062.7024433158729, 13265.801012984813, 14009.509667161601, 14816.62958426048, 14948.551543453714, 15733.370665173494, 712625.0, 717985.0, 720257.0, 720471.0, 724345.0, 57502.0, 57682.0, 57691.71154144286, 57749.13376299359, 57874.131888021715, 1252.154795513025, 1273.2487832178874, 1375.1199232491015, 1378.372840357635, 1409.2178840743486, 28764.280892977844, 29947.401051979276, 30132.69867301299, 30180.24549386283, 30968.0, 47970.76014619905, 48508.0, 48535.75732121458, 48684.513154868, 48813.51186488232, 459261.0, 599013.0, 605120.0, 605559.0, 606077.0, 40275.0, 40762.38856417097, 41185.38221926733, 41223.793881030404, 41374.96562585959, 44929.55070449384, 45454.86362840823, 45548.0, 46124.84687882695, 46342.0, 38198.618013819505, 38586.0, 39068.0, 40214.0, 40263.59736402598, 38216.42675359816, 38358.0, 38749.6125038746, 39663.40504892371, 39937.0, 37212.81425881849, 37304.62695373011, 37918.431223531115, 38139.80930095332, 38563.45746170122, 26362.736372636027, 34583.13542161466, 34692.653073468944, 34736.65263347334, 34776.65223347734, 23392.766072339058, 23592.88203558971, 24279.635805463284, 25160.874195628905, 25925.481490369708], "value": 20176.429069798287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.32002235685115, 373.65810283590497, 376.92461507698465, 386.93615553433676, 403.3344980781712, 15164.84835151648, 15175.54473365798, 17222.827771722295, 20559.38321850343, 20969.00794424531, 20308.69536956947, 20735.896320518375, 20918.790812091873, 20922.686159707617, 21182.57634847302, 5730.0, 5803.007376111776, 5869.383714709958, 6009.1286763419275, 6010.218671572689, 5713.542916566686, 5908.113782932552, 5917.585768996172, 5937.228160339171, 5939.1388248704125, 4112.753234805907, 4233.8094785734565, 4350.695451318409, 4353.912921741563, 6321.494280457552, 6421.582597131218, 6569.178852643419, 6617.139771829631, 6691.665416729168, 6723.529352945296, 5757.337906140764, 5759.107338362519, 5761.193432919395, 5763.596548241625, 5797.391273916221, 24553.50892982148, 25003.49993000148, 25188.370290742696, 25224.621630675556, 26120.8693956529, 2287.622542280522, 2409.024345140221, 2436.3056528889183, 2711.3492761737043, 2796.566532187514, 14407.135571865721, 15823.525294241192, 16110.11394373309, 16113.516594502184, 16187.83812161875, 1822.3894995176631, 1853.6107417442354, 1905.285517930776, 1907.9141438635295, 1908.3130073173647, 117307.413462933, 117407.41296293549, 120052.19921701094, 122474.0, 123318.0, 9822.410655360702, 10611.522481488351, 10643.680689579325, 10675.946620267005, 11105.666829995112, 12611.93694031524, 12914.160579562298, 13827.377768000262, 13831.585052448443, 13832.861671383158, 8364.58177091143, 8600.279944011223, 8640.567971601395, 8715.738527844049, 8764.5179515126, 8716.607752651145, 8740.475571465733, 8764.824703505894, 8887.066857979948, 8903.19871211581, 6584.76953306632, 6662.167229096363, 6711.664416779142, 6713.496487763339, 6731.697073631698, 1833.8899666020081, 1867.7120527353882, 1868.271374164077, 1872.8220819022172, 1877.6244751049844, 849.9277561407226, 929.6467342409976, 964.7973925475588, 1037.5123691864812, 1055.4089709762404, 21953.890230549063, 22202.55594888093, 22458.98934547949, 22463.101475941105, 22507.549849003255, 813.7070654564352, 891.153404265937, 899.2940541674753, 981.3179840011267, 1011.8279892418307, 11062.889371106186, 11511.300843822917, 11579.710507237387, 11690.941545292219, 11786.88213117875, 613382.0, 630379.0, 640608.0, 641649.0, 644440.0, 69184.65407672929, 69278.0, 114568.0, 116096.41951790356, 122023.0, 834.2241715204917, 939.8308304505255, 986.063239922077, 991.1674193677345, 1017.1811691588342, 18890.7166392507, 19218.903905480383, 19675.31136410219, 19711.01444927719, 19714.014299285267, 48804.779880501854, 49234.01531969269, 52842.73578632082, 53169.468305318, 53911.73044134754, 69476.0, 73855.52288954084, 74409.0, 78605.0, 85393.86515337166, 7565.848683026198, 7626.771196864103, 7676.501027433199, 8015.679372825021, 8085.757427277191, 9252.352335336462, 12154.696132596755, 12205.511779528719, 12216.572419965258, 12352.691182720504, 10625.9468702656, 10626.36241825493, 10895.727606809893, 10964.28732132409, 10993.505292262027, 8978.461292322481, 9808.166305863797, 10505.842412363667, 10556.261061725605, 10711.08955738771, 10922.798492166014, 10940.288881223014, 11137.554497819996, 11146.832797508207, 11391.772164556829, 7032.648367581703, 7896.09194942589, 7966.203379661987, 7993.8401231976195, 8184.140665230065, 9339.865961621057, 10011.199104071802, 11187.384693841917, 11296.49165787558, 11586.826197607212], "value": 9625.262602607938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.7899157143286, 1364.1883079567656, 1527.419580559387, 1658.601935535471, 1687.5359276199044, 6693.196816382035, 8495.277901378382, 8853.955730221347, 9055.547222638874, 9071.410358326704, 8875.979262384828, 8971.102889711026, 8975.506347150904, 8977.192052715254, 8992.550372481366, 2383.4279772854566, 2414.0343862454984, 2417.190241269177, 2419.4314336130997, 2421.007386971342, 2305.4927915858566, 2375.8455700379504, 2402.4474370894704, 2413.2760171948344, 2422.551827911842, 1815.5824160443105, 2359.716833979925, 2383.6901202843605, 2392.605220138675, 2401.255610760661, 2344.2029709898716, 2368.7631236876346, 2374.513224788923, 2377.6314671225987, 2384.7376788553247, 2341.637046257833, 2373.6202207646866, 2377.8216633752363, 2384.7615238476187, 2387.7612238776155, 8948.910510894873, 8954.462732236087, 9011.279097672235, 9019.143181397756, 9025.909740902638, 5268.631195816294, 5452.591055670801, 5469.343678758534, 5504.532114770249, 5519.116941289374, 3489.092835862694, 3529.9233733711208, 3601.45978103284, 3603.963960360415, 3651.4887915691825, 1089.9509522071526, 1100.5542755184163, 1102.2780079048237, 1117.4245263689206, 1128.1257025804985, 11921.821172682417, 11952.342621155833, 12061.758764824743, 12062.698432539257, 12064.698382540419, 4470.731756094645, 4473.507914129443, 4618.076384723002, 4621.353010578522, 4731.621470282369, 9341.486218257925, 9352.719418417459, 9355.06449355059, 9357.251419886392, 9377.062293770705, 5288.762005709752, 5294.444083371268, 5303.761330740126, 5306.018386598492, 5307.15085586312, 3931.312020396419, 3950.683945284428, 4118.585325509041, 4560.0, 4961.03259864323, 3577.695895848882, 3907.628775266345, 3909.7263191576885, 3910.2570511602703, 3911.6870650347905, 1141.686036340013, 1162.3258510064143, 1165.6561314412268, 1174.1370092981651, 1174.8590169179754, 802.5505716798612, 838.8842839024084, 936.9718908432758, 937.9390339627903, 938.6996161228342, 4627.838025669153, 5726.169705392695, 5862.325832529228, 5864.510611213913, 6080.543959203077, 426.91888541177076, 430.1332814379029, 441.4944888103104, 443.62070429782716, 457.6384656121627, 4016.618421250035, 4026.939595906064, 4032.334664780278, 4038.192361527706, 4113.568075352105, 10716.624918127829, 10999.61501347449, 11115.055220306365, 11129.610463633733, 11141.944290278496, 10232.0, 10678.679639610824, 11031.724206894893, 11040.834387484034, 11054.336739795637, 8221.383396245186, 8438.451500652438, 8454.492730436194, 8462.153784621489, 8475.194856488624, 5977.282726072899, 6066.241719785027, 6144.293406258337, 6162.028150991819, 6186.907196392148, 9753.122219000325, 10140.898591013995, 10294.330868493524, 10335.0, 10453.372797631862, 9519.57161927701, 10334.689959301233, 10437.269391142547, 10468.319559228627, 10515.842262366225, 7166.426685865223, 7344.853102937805, 8004.479708818908, 8224.958875205586, 8371.0, 8140.430169888288, 8319.126491718525, 8397.244248017707, 8411.4112012161, 8546.871796923175, 7455.217202193909, 7551.697932082655, 7572.5835079068975, 7581.0, 7587.0, 7348.485606007742, 7387.704491820267, 7401.22287159862, 7420.257974202536, 7478.6260686966525, 6889.965550172217, 7033.859322813618, 7044.15470143586, 7120.501564890616, 7133.536320139382, 3747.7938713371027, 3806.105565192233, 4369.672274579356, 4369.868903932887, 4382.693211475166, 4400.317950717644, 4976.825811096594, 4987.700737955734, 5044.747762611928, 5099.694018358762], "value": 4467.739306031588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.7440493138915, 302.9606151200344, 305.0695379093763, 307.477288609364, 308.5680047932892, 5143.588512918966, 5221.347331583557, 5223.250211179255, 5227.849873027937, 5282.709450980195, 4479.372887795711, 5118.795248190068, 5120.414190833633, 5163.974180129104, 5175.482451754822, 3631.893501768968, 3782.3380908341, 3785.5835858055593, 3931.601722949013, 4034.314166591672, 3899.610038996092, 3935.0, 3967.7420967637154, 3985.8405663773415, 4008.859689910854, 3311.536384906115, 3932.8820135395986, 3945.1123497213184, 3945.3490174121234, 3979.8010099495054, 3476.947845782315, 3539.4159963605975, 3994.4407782910416, 3995.7602543847315, 4015.19696060789, 3056.449839028974, 3447.9827600862086, 3463.7786858221843, 3471.3577988072034, 3486.8430920608635, 5051.348042277834, 5066.265391518209, 5068.5691716204165, 5068.797248110071, 5073.909109541466, 4407.449068866392, 4510.684252102355, 4538.500764915857, 4545.272756359, 4553.632111302104, 4242.560527696556, 5277.551408130314, 5395.974764794676, 5418.214358917974, 5436.592255580847, 3532.788032718045, 3604.441311596707, 3683.7421380503374, 3796.2787070456525, 3808.9619103808886, 4652.953470465286, 5137.178051511778, 5493.23094766733, 5647.80232691858, 5754.625949313281, 3270.8201048942537, 3361.1598199521363, 3844.942325865114, 3845.480860083853, 3877.6703980161437, 3902.9804850975565, 3911.7457365271734, 3919.6668283195677, 3937.27160475313, 3950.5654378018394, 4537.795799189044, 4540.296254080623, 4543.091381723669, 4562.863114106516, 4574.336721175478, 4604.953950460519, 5032.572231360376, 5390.730463476811, 5464.9453505464435, 5530.5852061095575, 1255.234307072685, 1290.993545032269, 1316.7162017033315, 1320.491610729876, 1323.6558494791423, 664.7673314339943, 701.6106061136119, 733.7211859493358, 789.5183937797939, 804.2520455975881, 3476.791392516457, 3914.432407300925, 4907.705537667752, 5125.461826508237, 5151.871203219875, 5468.250159948858, 5592.7762889484775, 5624.1159211663735, 5642.774289028475, 5714.428557144335, 4889.843632912068, 5137.794488220504, 5205.8764741155, 5248.976449592293, 5257.605679574047, 2413.3604594782396, 2453.791427728663, 2521.308730582255, 2840.247334456371, 2946.882124714987, 5784.971075144597, 5798.971005144947, 5840.737166827503, 5841.649501029951, 5873.236479257669, 5285.68285902847, 5619.6347237430255, 5685.317761868602, 5719.542436605062, 5755.3381361143165, 4627.768611569408, 5362.31884057971, 5755.510781583613, 5890.440408161217, 5898.262717160355, 4999.750062484379, 5508.256385388082, 5630.184907546227, 5660.603757736919, 5727.198192253005, 5205.193195054772, 5560.88782243561, 5577.3786320429335, 5580.274564306615, 5609.326880774333, 4931.580815630568, 5855.912161317498, 5875.6474611523445, 5886.469517925285, 5920.79277225295, 3044.8477576120663, 3235.9191020224685, 3476.513288139713, 3794.658480736747, 3844.2503711777053, 5527.8894422112135, 5617.5505959522325, 5697.062998580503, 5698.6010979232715, 5703.116017017369, 5426.67439953604, 5462.235287059894, 5494.615376923577, 5502.504774570308, 5505.9724701376235, 5214.739263036757, 5462.426445223353, 5504.192861640512, 5513.228148059355, 5542.925949427248, 4411.845585404495, 5340.305760251143, 5390.919136213039, 5392.946070539245, 5406.378266499403, 5233.424323324355, 5406.78372865081, 5490.858565159511, 5502.284702988586, 5502.697351645698, 4964.950350496593, 5249.13389290778, 5278.788848446019, 5403.730123420914, 5405.378381486179], "value": 3984.633573753035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.4450683959669, 706.4772068669184, 758.707897459478, 758.7487615567292, 811.2658044469757, 13227.801582976263, 14837.925810370947, 15623.765643515357, 15702.528924132266, 15715.685686286268, 12850.678733031678, 13804.723905521883, 14150.292485375741, 14363.35364908579, 14380.856191438108, 659.1826135591856, 677.485111315399, 683.7470136049668, 808.7533302342783, 829.1956801902176, 825.9297959673435, 853.1766844994579, 853.2960307746134, 855.8758979947904, 860.8966923969101, 901.1349104859343, 905.266733945503, 905.3662436294587, 906.9818603627923, 906.9977674669494, 684.3464491410691, 701.2741812224324, 866.5104216117874, 901.8692289618001, 902.7923577577161, 651.6285717141232, 664.6709878610119, 664.9202095748493, 665.7170702451439, 666.7999600119945, 14444.0, 14513.05665131763, 14520.782188267185, 14527.128372297697, 14534.200618965953, 13563.0, 13745.793813092812, 13797.586072417744, 13843.653908652264, 13904.51334203298, 12175.695607609792, 12501.624951251477, 12533.623991280276, 12618.81071783924, 12930.224186548838, 4469.08383781324, 4482.664346961601, 4523.208438523246, 4551.453825540956, 4676.719396836201, 102786.0, 107357.46321268422, 117173.0, 123383.0, 129080.7091929078, 10551.0, 10824.242303038869, 10912.672619821418, 10929.344239345664, 11038.724031899106, 21326.680099798516, 21335.893320533298, 21361.67957480639, 21443.463913401978, 21465.356039318845, 7589.620518974029, 7593.202713715091, 7754.883676744853, 7772.52322058807, 7846.058472983279, 4313.439252897166, 4373.781310934504, 4447.666425018137, 4464.486584042812, 4600.079984003212, 3398.3543126805826, 3534.0988048047584, 3536.929261414757, 3540.592831824322, 3546.8935931922083, 630.9242890853127, 637.4103953842676, 642.2966851297822, 648.8734696734092, 657.917760279965, 540.4109520622541, 595.3451203675921, 613.8342647485154, 627.8712863862988, 632.4908448698842, 8984.146506081912, 9125.908740912506, 9126.726198214064, 9144.679936202334, 9147.679831205876, 559.6054781379117, 613.96009259398, 621.3599992008238, 634.4511997122456, 637.3562701671252, 4335.978320108379, 4402.625776809007, 4432.268675668543, 4449.28811390176, 4554.88612784683, 154009.0, 158194.0, 160604.0, 162848.0, 168130.0, 106170.46914765377, 113614.0, 121343.78656213502, 124612.37693811655, 139939.30030349782, 72460.0, 106239.0, 112223.0, 120688.39655801666, 121405.0, 9140.588673509576, 9371.875374955049, 9577.377470464398, 9925.10945350267, 9989.300748947504, 57947.4205257942, 63316.36683633105, 63532.68233658802, 63990.0, 65756.0, 92527.53736231275, 98549.01450985685, 100401.0, 101106.0, 102613.48693256486, 12915.076027978605, 13019.479220831061, 13047.869521304665, 13164.275964821643, 13363.064585478924, 14082.577522674335, 14277.286135692966, 14593.708125837637, 15036.699266014837, 15572.688546228785, 12921.32874960815, 13284.402201900744, 13681.796245714904, 13831.654208644462, 13989.020768546105, 13218.60344189676, 13414.12808167466, 13488.0, 14230.288485575888, 14441.638959026108, 10653.627123050655, 12465.439055242718, 12835.0, 13626.250556219504, 13686.0, 9449.622015119317, 10760.40817755031, 11027.944860275647, 11189.160812938899, 11218.831717524406, 11414.771704565695, 11588.710282243012, 11718.296902185895, 11719.12106592026, 11856.288622682667], "value": 7780.454096328433, "unit": "score"}], "name": "dromaeo_css", "value": 7305.209693773054, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 111.0, 144.0, 133.0, 138.0, 137.0, 115.0, 139.0, 109.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 184.0, 177.0, 184.0, 182.0, 184.0, 183.0, 184.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 61.0, 89.0, 62.0, 61.0, 57.0, 59.0, 80.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 95.0, 72.0, 68.0, 71.0, 113.0, 69.0, 69.0, 90.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 90.0, 86.0, 90.0, 87.0, 88.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 95.0, 98.0, 97.0, 97.0, 97.0, 98.0, 150.0, 165.0], "value": 109.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 116.0, 112.0, 136.0, 142.0, 84.0, 85.0, 83.0, 84.0, 81.0], "value": 100.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 52.0, 55.0, 57.0, 58.0, 56.0, 59.0, 59.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 70.0, 83.0, 75.0, 75.0, 74.0, 70.0, 70.0, 71.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 82.0, 84.0, 82.0, 84.0, 84.0, 85.0, 83.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 138.0, 136.0, 134.0, 134.0, 141.0, 138.0, 169.0, 140.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 161.0, 165.0, 164.0, 162.0, 164.0, 167.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 67.0, 71.0, 83.0, 86.0, 83.0, 84.0, 66.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1459.8999999999999, "alertThreshold": 2.0}]} 05:08:28 INFO - Return code: 0 05:08:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:08:28 INFO - # TBPL SUCCESS # 05:08:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:08:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:08:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:08:28 INFO - 2016-10-24 05:08:28.315 screenresolution[1667:9822] starting screenresolution argv=screenresolution get 05:08:28 INFO - 2016-10-24 05:08:28.318 screenresolution[1667:9822] Display 0: 1600x1200x32@60 05:08:28 INFO - 2016-10-24 05:08:28.324 screenresolution[1668:9825] starting screenresolution argv=screenresolution list 05:08:28 INFO - Available Modes on Display 0 05:08:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:08:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:08:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:08:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:08:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:08:28 INFO - Intel Iris: 05:08:28 INFO - Chipset Model: Intel Iris 05:08:28 INFO - Type: GPU 05:08:28 INFO - Bus: Built-In 05:08:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:08:28 INFO - Vendor: Intel (0x8086) 05:08:28 INFO - Device ID: 0x0a2e 05:08:28 INFO - Revision ID: 0x0009 05:08:28 INFO - Displays: 05:08:28 INFO - Display: 05:08:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:08:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:08:28 INFO - Display Serial Number: 1600x1200 60 05:08:28 INFO - Main Display: Yes 05:08:28 INFO - Mirror: Off 05:08:28 INFO - Online: Yes 05:08:28 INFO - Rotation: Supported 05:08:28 INFO - Return code: 0 05:08:28 INFO - Running post-action listener: _resource_record_post_action 05:08:28 INFO - [mozharness: 2016-10-24 12:08:28.557936Z] Finished run-tests step (success) 05:08:28 INFO - Running post-run listener: _resource_record_post_run 05:08:28 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37508096; Write bytes: 663741440; Read time: 239; Write time: 1904 05:08:28 INFO - TinderboxPrint: CPU usage
53.3% 05:08:28 INFO - TinderboxPrint: I/O read bytes / time
37,508,096 / 239 05:08:28 INFO - TinderboxPrint: I/O write bytes / time
663,741,440 / 1,904 05:08:28 INFO - TinderboxPrint: CPU idle
2,259.7 (46.7%) 05:08:28 INFO - TinderboxPrint: CPU system
969.3 (20.0%) 05:08:28 INFO - TinderboxPrint: CPU user
1,608.6 (33.3%) 05:08:28 INFO - TinderboxPrint: Swap in / out
400,998,400 / 0 05:08:28 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 364556800; Write bytes: 367040512; Read time: 28619; Write time: 806 05:08:28 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34501632; Write bytes: 295136256; Read time: 216; Write time: 1091 05:08:29 INFO - Running post-run listener: _upload_blobber_files 05:08:29 INFO - Blob upload gear active. 05:08:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:08:29 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 05:08:29 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'] 05:08:29 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 05:08:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:30 INFO - (blobuploader) - INFO - Done attempting. 05:08:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:08:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:31 INFO - (blobuploader) - INFO - Done attempting. 05:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:08:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:33 INFO - (blobuploader) - INFO - Done attempting. 05:08:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:08:33 INFO - Return code: 0 05:08:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:08:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:08:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cc09f630a59c2f8826702391aebb0739e92d8e2d2c430328996b701489175591bf8725024e2b63ac890848620b6331464d6f979bd6c9beda73d74d31a440f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ed8bd9d4fd846adc8b812148f37e31b4e67713f95e5eed045563f35d2070422df326c5b3150e184c0d2c3ef87e9720a2e9eb4a5d98fa5d83b668a07d92d0ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e6ec20ab1738d086d73cb3c1552f00bb7bb141b629f73c3ee52401be5a2bba2ff6e7edc08a413f78801fed55a9207882d934c0782e8c4e2588518be9a29da18"} 05:08:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:08:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:08:33 INFO - Contents: 05:08:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cc09f630a59c2f8826702391aebb0739e92d8e2d2c430328996b701489175591bf8725024e2b63ac890848620b6331464d6f979bd6c9beda73d74d31a440f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ed8bd9d4fd846adc8b812148f37e31b4e67713f95e5eed045563f35d2070422df326c5b3150e184c0d2c3ef87e9720a2e9eb4a5d98fa5d83b668a07d92d0ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e6ec20ab1738d086d73cb3c1552f00bb7bb141b629f73c3ee52401be5a2bba2ff6e7edc08a413f78801fed55a9207882d934c0782e8c4e2588518be9a29da18"} 05:08:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:08:33 INFO - Copying logs to upload dir... 05:08:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:08:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.528474 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-24 05:08:33.651655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 05:08:33.656104) ========= 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.FrPafseKqn/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.EMoQsy5bdh/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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/2cc09f630a59c2f8826702391aebb0739e92d8e2d2c430328996b701489175591bf8725024e2b63ac890848620b6331464d6f979bd6c9beda73d74d31a440f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ed8bd9d4fd846adc8b812148f37e31b4e67713f95e5eed045563f35d2070422df326c5b3150e184c0d2c3ef87e9720a2e9eb4a5d98fa5d83b668a07d92d0ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e6ec20ab1738d086d73cb3c1552f00bb7bb141b629f73c3ee52401be5a2bba2ff6e7edc08a413f78801fed55a9207882d934c0782e8c4e2588518be9a29da18"} build_url:https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/aEFFGr9NSsuZY1tL7P3o8Q/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/2cc09f630a59c2f8826702391aebb0739e92d8e2d2c430328996b701489175591bf8725024e2b63ac890848620b6331464d6f979bd6c9beda73d74d31a440f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ed8bd9d4fd846adc8b812148f37e31b4e67713f95e5eed045563f35d2070422df326c5b3150e184c0d2c3ef87e9720a2e9eb4a5d98fa5d83b668a07d92d0ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e6ec20ab1738d086d73cb3c1552f00bb7bb141b629f73c3ee52401be5a2bba2ff6e7edc08a413f78801fed55a9207882d934c0782e8c4e2588518be9a29da18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 05:08:33.688358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:08:33.688687) ========= 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.FrPafseKqn/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.EMoQsy5bdh/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.005388 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:08:33.739191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 05:08:33.739481) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 05:08:33.739785) ========= ========= Total master_lag: 0.18 =========