builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1490903393.97 results: success (0) buildid: 20170330111605 builduid: 9f0215acf923415cbcc3967c5f136c73 revision: 4a9388153442d6b27f2f7d65bcc2e4238751c3cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:53.973415) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:53.973822) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:53.974102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:54.002744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:54.003109) ========= 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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-30 12:49:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 53.3M=0s 2017-03-30 12:49:54 (53.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:54.164854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:54.165197) ========= 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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.028601 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:54.215858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-30 12:49:54.216246) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4a9388153442d6b27f2f7d65bcc2e4238751c3cc --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 4a9388153442d6b27f2f7d65bcc2e4238751c3cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jYY6dOFeh8/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.zwBlzZHp6r/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-30 12:49:54,321 truncating revision to first 12 chars 2017-03-30 12:49:54,321 Setting DEBUG logging. 2017-03-30 12:49:54,321 attempt 1/10 2017-03-30 12:49:54,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4a9388153442?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 12:49:56,204 unpacking tar archive at: mozilla-aurora-4a9388153442/testing/mozharness/ program finished with exit code 0 elapsedTime=2.151108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-30 12:49:56.390916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:56.391256) ========= script_repo_revision: 4a9388153442d6b27f2f7d65bcc2e4238751c3cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:56.391695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:56.391964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 12:49:56.411609) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-30 12:49:56.411934) ========= /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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:49:56 INFO - MultiFileLogger online at 20170330 12:49:56 in /builds/slave/test 12:49:56 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 12:49:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:49:56 INFO - {'append_to_log': False, 12:49:56 INFO - 'base_work_dir': '/builds/slave/test', 12:49:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:49:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:49:56 INFO - 'branch': 'Mozilla-Aurora', 12:49:56 INFO - 'buildbot_json_path': 'buildprops.json', 12:49:56 INFO - 'config_files': ('talos/mac_config.py',), 12:49:56 INFO - 'default_actions': ('clobber', 12:49:56 INFO - 'read-buildbot-config', 12:49:56 INFO - 'download-and-extract', 12:49:56 INFO - 'populate-webroot', 12:49:56 INFO - 'create-virtualenv', 12:49:56 INFO - 'install', 12:49:56 INFO - 'run-tests'), 12:49:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:49:56 INFO - 'download_minidump_stackwalk': True, 12:49:56 INFO - 'download_symbols': 'ondemand', 12:49:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:49:56 INFO - 'tooltool.py': '/tools/tooltool.py', 12:49:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:49:56 INFO - '/tools/misc-python/virtualenv.py')}, 12:49:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:49:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:49:56 INFO - 'gecko_profile': False, 12:49:56 INFO - 'gecko_profile_interval': 0, 12:49:56 INFO - 'installer_path': 'installer.exe', 12:49:56 INFO - 'log_level': 'info', 12:49:56 INFO - 'log_name': 'talos', 12:49:56 INFO - 'log_to_console': True, 12:49:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:49:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:49:56 INFO - 'opt_config_files': (), 12:49:56 INFO - 'pip_index': False, 12:49:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:49:56 INFO - 'cmd': ('bash', 12:49:56 INFO - '-c', 12:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:49:56 INFO - 'enabled': True, 12:49:56 INFO - 'halt_on_failure': False, 12:49:56 INFO - 'name': 'check_screen_resolution'},), 12:49:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:49:56 INFO - 'cmd': ('bash', 12:49:56 INFO - '-c', 12:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:49:56 INFO - 'enabled': True, 12:49:56 INFO - 'halt_on_failure': False, 12:49:56 INFO - 'name': 'check_screen_resolution'},), 12:49:56 INFO - 'run_cmd_checks_enabled': True, 12:49:56 INFO - 'suite': 'dromaeojs', 12:49:56 INFO - 'system_bits': '32', 12:49:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:49:56 INFO - 'title': 't-yosemite-r7-0146', 12:49:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:49:56 INFO - 'use_talos_json': True, 12:49:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:49:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:49:56 INFO - 'work_dir': 'build'} 12:49:56 INFO - [mozharness: 2017-03-30 19:49:56.629347Z] Running clobber step. 12:49:56 INFO - Running pre-action listener: _resource_record_pre_action 12:49:56 INFO - Running main action method: clobber 12:49:56 INFO - rmtree: /builds/slave/test/build 12:49:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:01 INFO - Running post-action listener: _resource_record_post_action 12:50:01 INFO - [mozharness: 2017-03-30 19:50:01.267577Z] Finished clobber step (success) 12:50:01 INFO - [mozharness: 2017-03-30 19:50:01.267739Z] Running read-buildbot-config step. 12:50:01 INFO - Running pre-action listener: _resource_record_pre_action 12:50:01 INFO - Running main action method: read_buildbot_config 12:50:01 INFO - Using buildbot properties: 12:50:01 INFO - { 12:50:01 INFO - "project": "", 12:50:01 INFO - "product": "firefox", 12:50:01 INFO - "script_repo_revision": "production", 12:50:01 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:50:01 INFO - "repository": "", 12:50:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:50:01 INFO - "buildid": "20170330111605", 12:50:01 INFO - "pgo_build": "False", 12:50:01 INFO - "basedir": "/builds/slave/test", 12:50:01 INFO - "buildnumber": 102, 12:50:01 INFO - "slavename": "t-yosemite-r7-0146", 12:50:01 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 12:50:01 INFO - "platform": "yosemite_r7", 12:50:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:50:01 INFO - "branch": "mozilla-aurora", 12:50:01 INFO - "repo_path": "releases/mozilla-aurora", 12:50:01 INFO - "revision": "4a9388153442d6b27f2f7d65bcc2e4238751c3cc", 12:50:01 INFO - "stage_platform": "macosx64", 12:50:01 INFO - "builduid": "9f0215acf923415cbcc3967c5f136c73", 12:50:01 INFO - "slavebuilddir": "test" 12:50:01 INFO - } 12:50:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 12:50:01 INFO - Running post-action listener: _resource_record_post_action 12:50:01 INFO - [mozharness: 2017-03-30 19:50:01.271100Z] Finished read-buildbot-config step (success) 12:50:01 INFO - [mozharness: 2017-03-30 19:50:01.271210Z] Running download-and-extract step. 12:50:01 INFO - Running pre-action listener: _resource_record_pre_action 12:50:01 INFO - Running main action method: download_and_extract 12:50:01 INFO - mkdir: /builds/slave/test/build/tests 12:50:01 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')]} 12:50:01 INFO - trying https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 12:50:01 INFO - Downloading https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 12:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 12:50:02 INFO - Downloaded 1199 bytes. 12:50:02 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 12:50:02 INFO - Using the following test package requirements: 12:50:02 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 12:50:02 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 12:50:02 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 12:50:02 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'jsshell-mac.zip'], 12:50:02 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 12:50:02 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 12:50:02 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 12:50:02 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 12:50:02 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 12:50:02 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 12:50:02 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 12:50:02 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:50:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 12:50:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:50:02 INFO - Fetch https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 12:50:03 INFO - Expected file size: 51789226 12:50:03 INFO - Obtained file size: 51789226 12:50:19 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:50:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 12:50:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:50:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 12:50:21 INFO - Expected file size: 51789226 12:50:21 INFO - Obtained file size: 51789226 12:50:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 12:50:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:50:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 12:50:38 INFO - Expected file size: 14404438 12:50:38 INFO - Obtained file size: 14404438 12:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:38 INFO - trying https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 12:50:38 INFO - Downloading https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 12:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 12:50:40 INFO - Downloaded 74693482 bytes. 12:50:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 12:50:40 INFO - mkdir: /builds/slave/test/properties 12:50:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:40 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:40 INFO - Contents: 12:50:40 INFO - build_url:https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 12:50:41 INFO - Running post-action listener: _resource_record_post_action 12:50:41 INFO - Running post-action listener: set_extra_try_arguments 12:50:41 INFO - [mozharness: 2017-03-30 19:50:41.177316Z] Finished download-and-extract step (success) 12:50:41 INFO - [mozharness: 2017-03-30 19:50:41.177459Z] Running populate-webroot step. 12:50:41 INFO - Running pre-action listener: _resource_record_pre_action 12:50:41 INFO - Running main action method: populate_webroot 12:50:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:41 INFO - '--tppagecycles', 12:50:41 INFO - '7'], 12:50:41 INFO - 'tests': ['tsvgm']}}, 12:50:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['damp', 'tps']}, 12:50:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'tests': ['damp', 'tps']}, 12:50:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['dromaeo_dom']}, 12:50:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['basic_compositor_video']}, 12:50:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:50:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['a11yr', 12:50:41 INFO - 'ts_paint', 12:50:41 INFO - 'tpaint', 12:50:41 INFO - 'sessionrestore', 12:50:41 INFO - 'sessionrestore_no_auto_restore', 12:50:41 INFO - 'tabpaint']}, 12:50:41 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:41 INFO - 'ts_paint', 12:50:41 INFO - 'tpaint', 12:50:41 INFO - 'sessionrestore', 12:50:41 INFO - 'sessionrestore_no_auto_restore', 12:50:41 INFO - 'tabpaint']}, 12:50:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:41 INFO - 'ts_paint', 12:50:41 INFO - 'tpaint', 12:50:41 INFO - 'sessionrestore', 12:50:41 INFO - 'sessionrestore_no_auto_restore', 12:50:41 INFO - 'tabpaint']}, 12:50:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:41 INFO - 'ts_paint', 12:50:41 INFO - 'tpaint', 12:50:41 INFO - 'sessionrestore', 12:50:41 INFO - 'sessionrestore_no_auto_restore', 12:50:41 INFO - 'tabpaint']}, 12:50:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['a11yr', 12:50:41 INFO - 'ts_paint', 12:50:41 INFO - 'tpaint', 12:50:41 INFO - 'sessionrestore', 12:50:41 INFO - 'sessionrestore_no_auto_restore', 12:50:41 INFO - 'tabpaint']}, 12:50:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['a11yr', 12:50:41 INFO - 'ts_paint', 12:50:41 INFO - 'tpaint', 12:50:41 INFO - 'sessionrestore', 12:50:41 INFO - 'sessionrestore_no_auto_restore', 12:50:41 INFO - 'tabpaint']}, 12:50:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['tsvgx', 12:50:41 INFO - 'tsvgr_opacity', 12:50:41 INFO - 'tart', 12:50:41 INFO - 'tscrollx', 12:50:41 INFO - 'cart', 12:50:41 INFO - 'tsvg_static']}, 12:50:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:41 INFO - 'tsvgr_opacity', 12:50:41 INFO - 'tart', 12:50:41 INFO - 'tscrollx', 12:50:41 INFO - 'cart', 12:50:41 INFO - 'tsvg_static']}, 12:50:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'talos_options': ['--disable-e10s'], 12:50:41 INFO - 'tests': ['tp5o']}, 12:50:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:50:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'talos_options': ['--disable-e10s', 12:50:41 INFO - '--xperf_path', 12:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:41 INFO - 'tests': ['tp5n']}, 12:50:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:50:41 INFO - 'talos_options': ['--xperf_path', 12:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:41 INFO - 'tests': ['tp5n']}}, 12:50:41 INFO - 'talos.zip': {'path': '', 12:50:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:41 INFO - Running post-action listener: _resource_record_post_action 12:50:41 INFO - [mozharness: 2017-03-30 19:50:41.195717Z] Finished populate-webroot step (success) 12:50:41 INFO - [mozharness: 2017-03-30 19:50:41.195828Z] Running create-virtualenv step. 12:50:41 INFO - Running pre-action listener: _resource_record_pre_action 12:50:41 INFO - Running main action method: create_virtualenv 12:50:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:41 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 12:50:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:41 INFO - Using real prefix '/tools/python27' 12:50:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:44 INFO - Installing pip.................done. 12:50:44 INFO - Return code: 0 12:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:50:45 INFO - Reading from file tmpfile_stdout 12:50:45 INFO - Output received: 12:50:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:50:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:45 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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:50:45 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 12:50:45 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 12:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:45 INFO - 'HOME': '/Users/cltbld', 12:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:45 INFO - 'LOGNAME': 'cltbld', 12:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:45 INFO - 'MOZ_NO_REMOTE': '1', 12:50:45 INFO - 'NO_EM_RESTART': '1', 12:50:45 INFO - 'PAGER': '/bin/cat', 12:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:45 INFO - 'PWD': '/builds/slave/test', 12:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:45 INFO - 'SHELL': '/bin/bash', 12:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:50:45 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:45 INFO - 'USER': 'cltbld', 12:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:45 INFO - 'XPC_FLAGS': '0x0', 12:50:45 INFO - 'XPC_SERVICE_NAME': '0', 12:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:45 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 12:50:45 INFO - Cleaning up... 12:50:45 INFO - Return code: 0 12:50:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:45 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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:50:45 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 12:50:45 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 12:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:45 INFO - 'HOME': '/Users/cltbld', 12:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:45 INFO - 'LOGNAME': 'cltbld', 12:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:45 INFO - 'MOZ_NO_REMOTE': '1', 12:50:45 INFO - 'NO_EM_RESTART': '1', 12:50:45 INFO - 'PAGER': '/bin/cat', 12:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:45 INFO - 'PWD': '/builds/slave/test', 12:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:45 INFO - 'SHELL': '/bin/bash', 12:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:50:45 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:45 INFO - 'USER': 'cltbld', 12:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:45 INFO - 'XPC_FLAGS': '0x0', 12:50:45 INFO - 'XPC_SERVICE_NAME': '0', 12:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:45 INFO - Downloading/unpacking psutil>=3.1.1 12:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:49 INFO - Installing collected packages: psutil 12:50:49 INFO - Running setup.py install for psutil 12:50:49 INFO - building 'psutil._psutil_osx' extension 12:50:49 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 INFO - building 'psutil._psutil_posix' extension 12:50:50 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 12:50:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:50:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:50:50 INFO - ^ 12:50:50 INFO - 1 warning generated. 12:50:50 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 12:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:50 INFO - Successfully installed psutil 12:50:50 INFO - Cleaning up... 12:50:50 INFO - Return code: 0 12:50:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:50: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:50: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 mozsystemmonitor==0.3 12:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:51 INFO - 'HOME': '/Users/cltbld', 12:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:51 INFO - 'LOGNAME': 'cltbld', 12:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:51 INFO - 'MOZ_NO_REMOTE': '1', 12:50:51 INFO - 'NO_EM_RESTART': '1', 12:50:51 INFO - 'PAGER': '/bin/cat', 12:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:51 INFO - 'PWD': '/builds/slave/test', 12:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:51 INFO - 'SHELL': '/bin/bash', 12:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:50:51 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:51 INFO - 'USER': 'cltbld', 12:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:51 INFO - 'XPC_FLAGS': '0x0', 12:50:51 INFO - 'XPC_SERVICE_NAME': '0', 12:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:50:54 INFO - Installing collected packages: mozsystemmonitor 12:50:54 INFO - Running setup.py install for mozsystemmonitor 12:50:54 INFO - Successfully installed mozsystemmonitor 12:50:54 INFO - Cleaning up... 12:50:54 INFO - Return code: 0 12:50:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:50:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:50:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:54 INFO - 'HOME': '/Users/cltbld', 12:50:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:54 INFO - 'LOGNAME': 'cltbld', 12:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:54 INFO - 'MOZ_NO_REMOTE': '1', 12:50:54 INFO - 'NO_EM_RESTART': '1', 12:50:54 INFO - 'PAGER': '/bin/cat', 12:50:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:54 INFO - 'PWD': '/builds/slave/test', 12:50:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:54 INFO - 'SHELL': '/bin/bash', 12:50:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:50:54 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:50:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:54 INFO - 'USER': 'cltbld', 12:50:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:54 INFO - 'XPC_FLAGS': '0x0', 12:50:54 INFO - 'XPC_SERVICE_NAME': '0', 12:50:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:55 INFO - Downloading/unpacking jsonschema==2.5.1 12:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:50:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:50:58 INFO - warning: no files found matching '*.txt' 12:50:58 INFO - no previously-included directories found matching 'build' 12:50:58 INFO - no previously-included directories found matching 'dist' 12:50:58 INFO - no previously-included directories found matching '.git*' 12:50:58 INFO - Installing collected packages: jsonschema, functools32 12:50:58 INFO - Running setup.py install for functools32 12:50:58 INFO - warning: no files found matching '*.txt' 12:50:58 INFO - no previously-included directories found matching 'build' 12:50:58 INFO - no previously-included directories found matching 'dist' 12:50:58 INFO - no previously-included directories found matching '.git*' 12:50:58 INFO - Successfully installed jsonschema functools32 12:50:58 INFO - Cleaning up... 12:50:58 INFO - Return code: 0 12:50:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:50:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:50:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:50:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:58 INFO - 'HOME': '/Users/cltbld', 12:50:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:58 INFO - 'LOGNAME': 'cltbld', 12:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:58 INFO - 'MOZ_NO_REMOTE': '1', 12:50:58 INFO - 'NO_EM_RESTART': '1', 12:50:58 INFO - 'PAGER': '/bin/cat', 12:50:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:58 INFO - 'PWD': '/builds/slave/test', 12:50:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:58 INFO - 'SHELL': '/bin/bash', 12:50:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:50:58 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:50:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:58 INFO - 'USER': 'cltbld', 12:50:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:58 INFO - 'XPC_FLAGS': '0x0', 12:50:58 INFO - 'XPC_SERVICE_NAME': '0', 12:50:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:50:58 INFO - Cleaning up... 12:50:58 INFO - Return code: 0 12:50:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:50:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:50:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:50:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:58 INFO - 'HOME': '/Users/cltbld', 12:50:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:58 INFO - 'LOGNAME': 'cltbld', 12:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:58 INFO - 'MOZ_NO_REMOTE': '1', 12:50:58 INFO - 'NO_EM_RESTART': '1', 12:50:58 INFO - 'PAGER': '/bin/cat', 12:50:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:58 INFO - 'PWD': '/builds/slave/test', 12:50:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:58 INFO - 'SHELL': '/bin/bash', 12:50:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:50:58 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:50:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:58 INFO - 'USER': 'cltbld', 12:50:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:58 INFO - 'XPC_FLAGS': '0x0', 12:50:58 INFO - 'XPC_SERVICE_NAME': '0', 12:50:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:01 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 12:51:01 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 12:51:01 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 12:51:01 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 12:51:01 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 12:51:01 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 12:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:03 INFO - Downloading docopt-0.6.1.tar.gz 12:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:03 INFO - Running setup.py install for blobuploader 12:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:51:03 INFO - Running setup.py install for requests 12:51:03 INFO - Running setup.py install for docopt 12:51:03 INFO - Successfully installed blobuploader requests docopt 12:51:03 INFO - Cleaning up... 12:51:04 INFO - Return code: 0 12:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:04 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')]} 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:04 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')]} 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:04 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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:51:04 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 12:51:04 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 12:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:04 INFO - 'HOME': '/Users/cltbld', 12:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:04 INFO - 'LOGNAME': 'cltbld', 12:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:04 INFO - 'MOZ_NO_REMOTE': '1', 12:51:04 INFO - 'NO_EM_RESTART': '1', 12:51:04 INFO - 'PAGER': '/bin/cat', 12:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:04 INFO - 'PWD': '/builds/slave/test', 12:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:04 INFO - 'SHELL': '/bin/bash', 12:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:51:04 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:04 INFO - 'USER': 'cltbld', 12:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:04 INFO - 'XPC_FLAGS': '0x0', 12:51:04 INFO - 'XPC_SERVICE_NAME': '0', 12:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-J6UBXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-1xGymS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-jP3zUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-eiS1US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-h9lJ0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-R7TfYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-EEDrvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-JGhTu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NJRoM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-go2JC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NHoMzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-AdSNtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ulhBeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-zuoPst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-bPxgzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-eKHFsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:06 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wk9fVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:06 INFO - Running setup.py install for manifestparser 12:51:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:06 INFO - Running setup.py install for mozcrash 12:51:06 INFO - Running setup.py install for mozdebug 12:51:06 INFO - Running setup.py install for mozdevice 12:51:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:51:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:06 INFO - Running setup.py install for mozfile 12:51:06 INFO - Running setup.py install for mozhttpd 12:51:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozinfo 12:51:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozInstall 12:51:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozleak 12:51:07 INFO - Running setup.py install for mozlog 12:51:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for moznetwork 12:51:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozprocess 12:51:07 INFO - Running setup.py install for mozprofile 12:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozrunner 12:51:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozscreenshot 12:51:08 INFO - Running setup.py install for moztest 12:51:08 INFO - Running setup.py install for mozversion 12:51:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:08 INFO - Cleaning up... 12:51:08 INFO - Return code: 0 12:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:08 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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:51:08 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 12:51:08 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 12:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:08 INFO - 'HOME': '/Users/cltbld', 12:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:08 INFO - 'LOGNAME': 'cltbld', 12:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:08 INFO - 'MOZ_NO_REMOTE': '1', 12:51:08 INFO - 'NO_EM_RESTART': '1', 12:51:08 INFO - 'PAGER': '/bin/cat', 12:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:08 INFO - 'PWD': '/builds/slave/test', 12:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:08 INFO - 'SHELL': '/bin/bash', 12:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:51:08 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:08 INFO - 'USER': 'cltbld', 12:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:08 INFO - 'XPC_FLAGS': '0x0', 12:51:08 INFO - 'XPC_SERVICE_NAME': '0', 12:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-DVgDuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-iwt3Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-l7uxqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-nDxDl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-7sJqqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Ius0JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-TOdYF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-bmpD45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-RaA6pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-J3LQMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Q8xYVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-SDKljr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Qdq2og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-0U0k5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-XFQ0q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KwZ51y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-C9NZQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:10 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)) 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:51:10 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)) 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:10 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 12:51:10 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 12:51:10 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 12:51:10 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 12:51:10 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 12:51:10 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 12:51:13 INFO - Downloading blessings-1.6.tar.gz 12:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:13 INFO - Installing collected packages: blessings 12:51:13 INFO - Running setup.py install for blessings 12:51:13 INFO - Successfully installed blessings 12:51:13 INFO - Cleaning up... 12:51:13 INFO - Return code: 0 12:51:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:14 INFO - Reading from file tmpfile_stdout 12:51:14 INFO - Current package versions: 12:51:14 INFO - blessings == 1.6 12:51:14 INFO - blobuploader == 1.2.4 12:51:14 INFO - docopt == 0.6.1 12:51:14 INFO - functools32 == 3.2.3-2 12:51:14 INFO - jsonschema == 2.5.1 12:51:14 INFO - manifestparser == 1.1 12:51:14 INFO - mozInstall == 1.12 12:51:14 INFO - mozcrash == 1.0 12:51:14 INFO - mozdebug == 0.1 12:51:14 INFO - mozdevice == 0.49 12:51:14 INFO - mozfile == 1.2 12:51:14 INFO - mozhttpd == 0.7 12:51:14 INFO - mozinfo == 0.9 12:51:14 INFO - mozleak == 0.1 12:51:14 INFO - mozlog == 3.4 12:51:14 INFO - moznetwork == 0.27 12:51:14 INFO - mozprocess == 0.25 12:51:14 INFO - mozprofile == 0.28 12:51:14 INFO - mozrunner == 6.13 12:51:14 INFO - mozscreenshot == 0.1 12:51:14 INFO - mozsystemmonitor == 0.3 12:51:14 INFO - moztest == 0.8 12:51:14 INFO - mozversion == 1.4 12:51:14 INFO - psutil == 3.1.1 12:51:14 INFO - requests == 1.2.3 12:51:14 INFO - wsgiref == 0.1.2 12:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:14 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')]} 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:14 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')]} 12:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:14 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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:51:14 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 12:51:14 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 12:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:14 INFO - 'HOME': '/Users/cltbld', 12:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:14 INFO - 'LOGNAME': 'cltbld', 12:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:14 INFO - 'MOZ_NO_REMOTE': '1', 12:51:14 INFO - 'NO_EM_RESTART': '1', 12:51:14 INFO - 'PAGER': '/bin/cat', 12:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:14 INFO - 'PWD': '/builds/slave/test', 12:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:14 INFO - 'SHELL': '/bin/bash', 12:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:51:14 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:14 INFO - 'USER': 'cltbld', 12:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:14 INFO - 'XPC_FLAGS': '0x0', 12:51:14 INFO - 'XPC_SERVICE_NAME': '0', 12:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 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)) 12:51:14 INFO - Cleaning up... 12:51:14 INFO - Return code: 0 12:51:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:14 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')]} 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:14 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')]} 12:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:14 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 0x10f31ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f31d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa218d74380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, '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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 12:51:14 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 12:51:14 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 12:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:14 INFO - 'HOME': '/Users/cltbld', 12:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:14 INFO - 'LOGNAME': 'cltbld', 12:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:14 INFO - 'MOZ_NO_REMOTE': '1', 12:51:14 INFO - 'NO_EM_RESTART': '1', 12:51:14 INFO - 'PAGER': '/bin/cat', 12:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:14 INFO - 'PWD': '/builds/slave/test', 12:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:14 INFO - 'SHELL': '/bin/bash', 12:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:51:14 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:14 INFO - 'USER': 'cltbld', 12:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:14 INFO - 'XPC_FLAGS': '0x0', 12:51:14 INFO - 'XPC_SERVICE_NAME': '0', 12:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:51:14 INFO - Cleaning up... 12:51:14 INFO - Return code: 0 12:51:14 INFO - Running post-action listener: _resource_record_post_action 12:51:14 INFO - Running post-action listener: _start_resource_monitoring 12:51:14 INFO - Starting resource monitoring. 12:51:14 INFO - [mozharness: 2017-03-30 19:51:14.717966Z] Finished create-virtualenv step (success) 12:51:14 INFO - [mozharness: 2017-03-30 19:51:14.718955Z] Running install step. 12:51:14 INFO - Running pre-action listener: _resource_record_pre_action 12:51:14 INFO - Running main action method: install 12:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:14 INFO - Reading from file tmpfile_stdout 12:51:14 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:15 INFO - Reading from file tmpfile_stdout 12:51:15 INFO - Output received: 12:51:15 INFO - Usage: mozinstall [options] installer 12:51:15 INFO - Options: 12:51:15 INFO - -h, --help show this help message and exit 12:51:15 INFO - -d DEST, --destination=DEST 12:51:15 INFO - Directory to install application into. [default: 12:51:15 INFO - "/builds/slave/test"] 12:51:15 INFO - --app=APP Application being installed. [default: firefox] 12:51:15 INFO - mkdir: /builds/slave/test/build/application 12:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:51:35 INFO - Reading from file tmpfile_stdout 12:51:35 INFO - Output received: 12:51:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:51:35 INFO - Running post-action listener: _resource_record_post_action 12:51:35 INFO - [mozharness: 2017-03-30 19:51:35.366617Z] Finished install step (success) 12:51:35 INFO - [mozharness: 2017-03-30 19:51:35.366779Z] Running run-tests step. 12:51:35 INFO - Running pre-action listener: _resource_record_pre_action 12:51:35 INFO - Running main action method: run_tests 12:51:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:51:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:51:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:51:35 INFO - 2017-03-30 12:51:35.381 screenresolution[1617:7391] starting screenresolution argv=screenresolution get 12:51:35 INFO - 2017-03-30 12:51:35.384 screenresolution[1617:7391] Display 0: 1600x1200x32@60 12:51:35 INFO - 2017-03-30 12:51:35.390 screenresolution[1618:7394] starting screenresolution argv=screenresolution list 12:51:35 INFO - Available Modes on Display 0 12:51:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:51:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:51:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:51:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:51:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:51:35 INFO - Intel Iris: 12:51:35 INFO - Chipset Model: Intel Iris 12:51:35 INFO - Type: GPU 12:51:35 INFO - Bus: Built-In 12:51:35 INFO - VRAM (Dynamic, Max): 1536 MB 12:51:35 INFO - Vendor: Intel (0x8086) 12:51:35 INFO - Device ID: 0x0a2e 12:51:35 INFO - Revision ID: 0x0009 12:51:35 INFO - Displays: 12:51:35 INFO - Display: 12:51:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:51:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:51:35 INFO - Display Serial Number: 1600x1200 60 12:51:35 INFO - Main Display: Yes 12:51:35 INFO - Mirror: Off 12:51:35 INFO - Online: Yes 12:51:35 INFO - Rotation: Supported 12:51:35 INFO - Return code: 0 12:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:35 INFO - Python 2.7.3 12:51:35 INFO - Return code: 0 12:51:35 INFO - grabbing minidump binary from tooltool 12:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:35 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 0x10f0f8d30>, '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 0x10f01fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0edbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:35 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 12:51:35 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 12:51:35 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 12:51:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:35 INFO - Return code: 0 12:51:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:51:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:35 INFO - ENV: RUST_BACKTRACE is now 1 12:51:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:51:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:35 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/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 12:51:35 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/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 12:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jYY6dOFeh8/Render', 12:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:35 INFO - 'HOME': '/Users/cltbld', 12:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:35 INFO - 'LOGNAME': 'cltbld', 12:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:35 INFO - 'MOZ_NO_REMOTE': '1', 12:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:35 INFO - 'NO_EM_RESTART': '1', 12:51:35 INFO - 'PAGER': '/bin/cat', 12:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:35 INFO - 'PWD': '/builds/slave/test', 12:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:35 INFO - 'RUST_BACKTRACE': '1', 12:51:35 INFO - 'SHELL': '/bin/bash', 12:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zwBlzZHp6r/Listeners', 12:51:35 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:35 INFO - 'USER': 'cltbld', 12:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:35 INFO - 'XPC_FLAGS': '0x0', 12:51:35 INFO - 'XPC_SERVICE_NAME': '0', 12:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:35 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/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 12:51:35 INFO - mozversion application_buildid: 20170330111605 12:51:35 INFO - mozversion application_changeset: 4a9388153442d6b27f2f7d65bcc2e4238751c3cc 12:51:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:51:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:35 INFO - mozversion application_name: Firefox 12:51:35 INFO - mozversion application_remotingname: firefox-dev 12:51:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:51:35 INFO - mozversion application_vendor: Mozilla 12:51:35 INFO - mozversion application_version: 54.0a2 12:51:35 INFO - mozversion platform_buildid: 20170330111605 12:51:35 INFO - mozversion platform_changeset: 4a9388153442d6b27f2f7d65bcc2e4238751c3cc 12:51:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:51:35 INFO - mozversion platform_version: 54.0a2 12:51:35 INFO - using testdate: 1490903495 12:51:35 INFO - actual date: 1490903495 12:51:35 INFO - starting webserver on 'localhost:49240' 12:51:35 INFO - SUITE-START | Running 2 tests 12:51:35 INFO - TEST-START | dromaeo_css 12:51:35 INFO - operating with platform_type : mac_ 12:51:35 INFO - Initialising browser for dromaeo_css test... 12:51:35 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpgUXgYZ/profile http://localhost:49240/getInfo.html) 12:51:38 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 12:51:38 INFO - PROCESS | 1628 | colorDepth:24 12:51:38 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 12:51:38 INFO - PROCESS | 1628 | __metrics 12:51:38 INFO - PROCESS | 1628 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:51:38 INFO - PROCESS | 1628 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:51:39 INFO - TEST-INFO | 1628: exit 0 12:51:39 INFO - Browser initialized. 12:51:39 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:39 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpgUXgYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:51 INFO - PROCESS | 1630 | RSS: Main: 214777856 12:51:51 INFO - PROCESS | 1630 | 12:54:56 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 12:54:58 INFO - PROCESS | 1630 | RSS: Main: 349057024 12:54:58 INFO - PROCESS | 1630 | 12:56:41 INFO - PROCESS | 1630 | ************************* 12:56:41 INFO - PROCESS | 1630 | A coding exception was thrown and uncaught in a Task. 12:56:41 INFO - PROCESS | 1630 | 12:56:41 ERROR - PROCESS | 1630 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:56:41 INFO - PROCESS | 1630 | Full stack: 12:56:41 INFO - PROCESS | 1630 | ************************* 12:58:01 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 12:58:01 INFO - PROCESS | 1630 | RSS: Main: 352247808 12:58:01 INFO - PROCESS | 1630 | 13:01:04 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:01:04 INFO - PROCESS | 1630 | RSS: Main: 347054080 13:01:04 INFO - PROCESS | 1630 | 13:04:07 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:04:08 INFO - PROCESS | 1630 | RSS: Main: 319291392 13:04:08 INFO - PROCESS | 1630 | 13:07:11 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:07:12 INFO - PROCESS | 1630 | RSS: Main: 321994752 13:07:12 INFO - PROCESS | 1630 | 13:10:15 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:10:15 INFO - PROCESS | 1630 | RSS: Main: 417456128 13:10:15 INFO - PROCESS | 1630 | 13:10:15 INFO - PROCESS | 1630 | __start_tp_report 13:10:15 INFO - PROCESS | 1630 | _x_x_mozilla_page_load 13:10:15 INFO - PROCESS | 1630 | _x_x_mozilla_page_load_details 13:10:15 INFO - PROCESS | 1630 | |i|pagename|runs| 13:10:15 INFO - PROCESS | 1630 | |0;dojo.html;3390.6948374646277;3408.897733068008;3411.9147021324466;3423.1442139465116;3464.722822174226;6051.42368907346;6062.909056364147;6066.30237522685;6120.52777597912;6124.938750612499;6011;6091.543134264937;6113.755449782015;6118.510519158468;6126;5402.216678581613;5437.429069947658;5455.536279416255;5465.480779325958;5571.693556854371;5351.518363347298;5369.087255166631;5423.267858839065;5551.472610102034;5575.609707320489;5448.182772584105;5478.698671573062;5479.972600137014;5483.259759932418;5493.121100623881;5457.972710136463;5472.7263636818;5475.4524547545325;5482.095454250044;5491.643043202219;5266.368035835686;5339.41266460689;5404.5676345892625;5415.83752487426;5447.046766815792;6107.816765497042;6109.633421994695;6117.96941015292;6125.969370153165;6137.3862613738265;6299.842503937392;6319.115323854664;6344.206974128234;6350.872982540323;6359.618422894595;6291.905621415683;6296.181496405438;6372.267189273247;6382.744690212386;6446.9355306446805;4545.386372839657;6113.23584551931;6138.508919286446;6143.078538219258;6146.569740118193;6146.969265153645;6555.082288479522;6604.603723776589;6607.1080404145305;6611.900821487681;5663.546916246691;6232.594881332699;6309.9588567885785;6339.890519159221;6340.397662222082;6371.776987805404;6410.102585638015;6412.743490260337;6420.6468644225015;6424.196975378078;5125.769340379692;6352.364763523703;6360.332165122595;6371.585846919936;6374.521910856704;6191.783287584913;6317.431431171217;6333.556651034383;6361.300256971729;6397;5138.717370544656;5148.768305426265;5150.021495915764;5155.278261043457;5155.613329000265;3681.466187402865;4581.496035436166;4595.241785105421;4605.309203619417;4706.035262771124;5138.58891288696;6097.146399504073;6108.450239478469;6125.785597504066;6130.77659829192;6231.252249729971;6275.278342990523;6479.870402591921;6497.252815926229;6520.0871877937125;5946.167536544887;6026.216591843032;6045.697715114226;6097.420745029215;6137.539684523678;5716.485516303469;5725.227094342211;5730.455606717355;5741.684207368635;5741.827745167651;6639.236487803964;6651.37041424854;6676.198856137295;6693.464522838064;6717;6236.501079913687;6291.716872740646;6295.055741638791;6319.936800631935;6444.097826304415;6688.398044176048;6704.229013663491;6716.529842910949;6728.932710672831;6733.562318449285;5329.280547126088;6329.208848893888;6348.079528468438;6361;6392.137061496638;6121.087175196906;6288.056791481132;6459.967700161657;6460.45086167681;6471.4499267560905;6239.407256310643;6261;6307.526935479949;6341.048842673636;6342.524310676626;6313.526485513697;6331.5251356147555;6334.113224148715;6335.113084168128;6338.714757836001;5244.685318880726;6044.637321760709;6148.385161483816;6295.181626388723;6331.92357299251;6234.906476402948;6257.4994000480765;6309.873802523832;6310.495160387066;6323.399277068671;6324.335944725922;6327.019312006646;6330.715117819617;6334.556581039283;6342.841428964312 13:10:15 INFO - PROCESS | 1630 | |1;ext.html;774.976750697479;793.1077537770007;862.6376921692893;878.113105763179;879.7184900831736;39210.019749506275;40060.799696001515;40150.79547613576;40173.59826401735;40317.79841100794;40898.386524202164;41262;41290.380644290286;41392;41433;7361.558306501627;9224.169824715775;9413.246940244764;9415.199708024826;9421.858672119924;7454.068241469817;11081.27971681838;11296.096312294996;11421.086313094933;11428.371439570821;11233.26983746058;11262.662120136409;11278.492467838967;11279.605213817518;11285.605003824869;6278.937210627927;6652.733890644368;11207.383593902332;11215.934486223796;11220.719482012933;10773.515191816308;11078;11135.443227838576;11165;11174.776504469946;38631;38783.806080969414;38822;38943.8052809737;39003.60996390056;3764.9811750941344;3784.829682664287;3822.2546603412347;3883.1457079442475;3942.6451619354107;27555.724442755516;27589.58615620767;27664.170074897786;27910.441791164267;29024.984125555504;3060.3573249617607;3098.984505077483;3100.55042018906;3139.1681204480833;3149.102505785863;342550;343990.9999999975;345700;346296.2685186558;346350.2682486597;42320;43054;52351.95296094133;52591.21113183305;52642.47357526376;45031.77484112624;51714.70713232199;52460.73769631128;55206.17190742142;55486.44513554894;14674.266286685623;14677.486287980082;14707.044042137228;14733;14752.778708319383;12713.93643031779;12722.745545089047;12723.872761272269;12739.936300318439;12746.681332966564;8799.824003520022;12405.813912791315;12416.068794840423;12438.675899003805;12533.37333133358;5124.795008199705;5442.91835622466;5705.942940570541;5709.831043770664;5752.922186630133;1073.221914112278;1073.393532654048;1114.4706264524448;1119.5409881948362;1182.846229990113;26328.078517251804;26612;26852.59721104185;26853.597196042076;27125.728742712716;1169.4620474581618;1253.6239128261484;1259.5276771210797;1287.4077924154806;1311.895048396126;14403.207823569805;14513.201773902325;14517.637059073608;14652.780208296885;14804.481843135438;460160.3983960184;481912;482138;482865;483230.5838470785;46911.296330555066;47097.29354059692;47204.291935620306;47207;47404.288935665994;1323.430924702368;1388.3960477192454;1390.0547627613118;1395.3023488255872;1396.8393634731933;25683;26381.736182637927;26521.734782652697;26539.601905971038;27110;39509.2098158041;39657.810265692075;39680.801595991834;39686.404703928885;39702.60297396989;429382;429933;430145;430440;431259;23075.653865192373;24249.757502425455;28486.860525578744;28623.570646439905;28777;36722.63277367299;36950;37817;37990.43014354842;38101.66644167441;26946.865265673547;27021.86489067542;27090.864545677145;27520.724792751815;28047.158585242476;26981.730182698706;27923;28036.71963280341;28061.017864374648;28277.57583636206;31784.205394865312;31828.68171318257;32069.51895721613;32110.839445802623;32261;22667.093316267823;25841.095561655253;26886;27978.860105699343;28300.575491367235;18162.81837181664;19942.50143746418;22085.33743987683;22483.66274505851;22533.774662253167 13:10:15 INFO - PROCESS | 1630 | |2;jquery.html;384.8037154826617;409.8667932921799;424.3210862619808;429.48461845785056;453.48755905826414;14210;19939.105784950425;21270.468238294052;21660.675089873665;21882.452938676503;21114;21802.89098554509;22166.335009949726;22394.99222534986;22659.886700566516;6726.29373915738;6897.517173797836;7000.579965202079;7115.324044215817;7423.369013633821;4095.4061661059127;7545.132309784362;7600.7339743109005;7610.771676849703;7612.7335543255995;4329.826806927719;4426.690131690783;7533.058367704037;7550.9622451887935;7609.467337286392;7350.889736653901;7568.470207085506;7597.544147351149;7624.237576242359;7670.002899623069;7161.713531458736;7440.441966852453;7441.181470038291;7444.032275804165;7465.216152304039;25160.874195628905;25311.493770124678;25425.872870635714;25566.233013009638;26080.86959565209;2392.629142482918;2863.141057682687;2864.6705628852533;2885.1633026422314;2893.291143669793;15261.771073433907;16176.595585110348;16304.918475407665;16310.75533866993;16870.915645421817;1953.7310975518396;1983.0679580597096;1986.3445063129134;2033.2476983516046;2042.7957204279453;135134.75999980213;135674.32162839122;139978;162241;172029.13985429992;14501.534739094168;18501.259949601867;18891.43325700231;19775.30786422497;19882.403527894185;26925.461490770467;27074.05240816562;29387.41225175527;30107.849460752557;30598.082057537864;9925;10236.928921323723;10465.162786977024;10474.842877356845;10564.102051325723;7953.5227886327;8126.984126984127;8691.435056721293;8698.565071746514;8859;9293.628254869729;9327.673531426368;9407;9440;9457.716268511957;3521.80258712034;3846.382556987116;3919;3963.841446342114;4000.399940009022;863.3395452478859;866.4671227195356;894.8165626046645;899.59967814322;923.8845144356956;19389.90305048494;20126;21792.45518862041;22781;24089.397765056015;998.5207100591757;1004.924630652704;1005.3666190300064;1035.034625797086;1036.4921188617675;6505.251896031922;6637.834054148589;7040.718371265194;7184.928150718531;7312.085989251344;614610;633128.8343558345;747996.2600187073;749532;754519;152428.71356929655;153529.23235383976;154402;156264;157186;1189.2091758980355;1244.6203907808206;1288.9613311600478;1289.4068728385048;1298.9610311690665;19602.019899005278;19898.801011989694;20409.387718368474;20434.59130817405;20461;38839;62627;64293.35706642874;64707;65183.67408162929;87877.56061219909;88220;88943.66584501367;88999;90820.54589727009;8542.74371768848;10938.195197792274;11278.60524881658;11360.261582997078;11401.372924489233;12148.696282593006;12330;12587.87412125867;12670.493180273055;12961.740765184832;10430.165586753194;10639.468026598484;10641;10790.67627971162;10821.026107650348;10301.639442619473;10353.4305613192;10354;10586.258961872903;10708.785824283626;10996.725081873017;11126.388048657402;11136.777264454504;11141.16441266892;11451.083913287084;11248.88751112511;11291.266067705574;11302.83045754298;11338.659840204808;11679.240849344766;10716;10770.569177232823;10903.29128606638;10964.616238431936;11033.393163375771 13:10:15 INFO - PROCESS | 1630 | |3;mootools.html;1310.7968264918939;1519.6124988128026;1547.512533551931;1573.0561663002193;1595.688840676068;10531.473426328692;11150.442477876115;11166.553337866486;11177.105831533489;11179.385133817637;10504.422256775873;10891.455427228626;10911.399873006982;11005.339679619228;11048.834267485974;2035.7760646328966;2362.551115288094;2398.8560686358787;2408.771166739166;2413.758624137581;2313.178821518362;2381.166591692911;2403.9399015024587;2410.3612542676206;2412.2280870121567;2316.7799059089443;2383.6067048936907;2384.4277373430336;2399.8560086394873;2407.614781634939;2316.143027079974;2361.3034154924253;2368.964465533027;2369.6919400478;2379.892904819287;2321.593721098801;2347.835651504395;2352.5530149271585;2354.9411264718347;2359.823013273994;10777.78444431107;11000.449977501174;11026.944865275622;11039.227254092217;11075.280106793032;4761.857144285677;5818.069108942591;5833.300003999505;5838.2118414013985;5860.652050028517;3297.917552061194;3383.678550537695;3444.4144495435835;3457.4122399192197;3463.705585025276;1105.7346236903165;1118.2619471149003;1138.573035111833;1152.5389844062358;1163.5229555882047;13400.597982060553;13726.176429414267;13986.230757308344;15215.61960950974;15244.923775381163;4070.776107314126;4541.841035563805;4664.137134630104;4742.099001189763;4888.2178851383605;11724.824127638092;11741.706457338634;11767.23512971654;11775.823362649568;11785.764284714258;4748.240281554935;4904.950950490521;4936.136176169156;5283.656562323436;5485;5141.640085194075;5167.58659307262;5249.238860365302;5276.366835979707;5290.206469029677;3807.8667246646232;3848.461215429842;3929.31237033518;3932.390479475686;3938.7439816412416;869.9173578510031;1000.9740016483017;1005.7629116186985;1014.7463134216446;1015.9796804063877;952.842780941137;960.7406000379858;966.1401352796017;977.0961860279214;992.6698224379222;5883.3234178069215;6488.643124628096;6508.511861610398;6654.6672666366485;6772.458203343721;975.6975337645353;1014.5485259059648;1061.2995423020923;1075.8219749374423;1080.9081228095542;3788.8295026723863;3913.412988051758;4256.59562341577;4427.269500532376;4429.557044295545;13052.34738263083;13614.18314901109;13650.180989140683;13654.04421690492;13656.04407691452;12948.15836970594;13519.918406527455;13533;13543.729125417436;13563.457461701619;9312.813743725223;9875.703728888146;10027.147692446224;10332.276740628235;10339.224558158168;6520.282768895323;6787.864242715217;6826.653430946768;6923.826904327432;6999;12066.577669781516;12118.818217726564;12203.572874949334;12225.960793332311;12229.69425764363;12326.876731232931;12444.128910976146;12476.625701228977;12581.370931453574;12723;8874.378793484653;9250.861237081584;9270.44377337362;9473.24214062887;9485.525723713648;10487.423191724529;10498.632547860789;10589.364638121737;10598.417087060287;10608.946955265174;8843.734687959372;8874.467531948103;8884.244839188741;8918.063603321818;8942.284617230476;8508.91491085106;8675.91324086751;8741.125887411208;8778.078301778221;8895.777605559913;7855.489393189425;7877.369810415267;8022.759317220492;8035.598220088856;8056.597170141352;5916.822495325147;5934.525237980864;5980.073088671263;5981.252343457068;6045.516358691206;5595.272614560244;5623.831285061455;5687.8862422752145;5886.970565147147;6129.816105516842 13:10:15 INFO - PROCESS | 1630 | |4;prototype.html;373.67676959430094;376.91142581493364;376.9981150094249;386.2930836569077;387.1656580069949;4673.6261099112035;4837.709737415753;4876.1954277544255;4931.950680493194;5244.39689435715;4605.79273932673;4677.415323084614;5089.720065396402;5119.590432765379;5179.989901969117;3751.917685684444;4117.876463706094;4237.173751118533;4260.977365432305;4296.591823776744;4117.608827161415;4227.808004956254;4237.6186143247105;4239.9576004240025;4252.957470425287;3418.384690755663;3808.371618682914;3906.0234941264684;4250.404943307939;4251.06476575153;3702.666759991587;3889.961100388988;3987.282289187945;4055.9454541819046;4090.284200264957;3279.932883224808;3551.928961420783;3891.416287556861;3918.45141680165;3922.5685174630767;4407.382966384709;4828.830990915301;4983.676061056056;5002.59979201663;5039.748012599355;4351.347297905308;4396.538363471854;4510.8421205257655;4789.37738094049;4809.567138957475;4723.583449474752;4911.919377736892;5353.518183363516;5431.456854314576;5431.891362172734;3915.882523524299;3922.901927451808;4311.417958575584;4324.848630297956;4329.047609525931;4671.672982891199;4892.461829198785;5397.892042159135;5820.854478638025;5989.341172471025;3941.797751685706;4112.794360281974;4144.730592511477;4291.785410729451;4313.352997050468;4252;4348.717333373321;4418.403515525427;4438.467383913951;4620.745858977722;4495.820167193276;4520.95479045212;4751.980408326447;4912.557869791736;4934.802607895644;4872.9512704873205;4889.975550122226;5076.771545280471;5166.5866730661455;5506.421825708323;1287.7810772168755;1471.661517850879;1544.3166948026706;1562.1252098824696;1562.9059658239278;1062.644014255233;1099.3074363151322;1111.7331840358418;1184.3604453595135;1202.406810975461;4394.340848872631;4423.0048239145935;4648.445108095793;5087.287779710843;5184.637075404761;5693.971530142406;5756.833741442274;5790.40994583361;5838.299404071538;5891.646501209942;4345.045369148946;4566.611837993742;4603.332516785047;5057.772400241998;5246.449122842047;2604.5442047641586;2722.8081394477636;2930.7508861746564;2959.8520073996215;2985.925351866177;4919.877003074952;5466.262054622654;5550.889822035609;5875.588708790344;5914.526837852962;5259.894802103937;5603.427100425418;5621.297337832771;5657.161422537692;5870.383609721003;5527.834164975057;5538.280023596987;5593.524550413261;5661.830145095653;5870.473676843966;5221.556167725786;5756.65460072397;5763.769449221984;5783.698667799879;5803.86824569205;5097.413797413196;5447.9104179165115;5450.727463626724;5517.537852469019;5779.2198053263955;5505.752241149078;5725.307176870978;5925.466707996301;6017.638941663514;6024.819255422344;3911.9804400977814;4477.238869392146;4500.482444518791;4503.234450143549;4504.34686970394;5008.697738587921;5305.84302340107;5391.541718953933;5548;5785.033088749845;5093.439721630543;5485.75314110858;5522.834314970557;5535.529479994246;5563.916541251965;4805.5972013993005;5159.664621799571;5402.407399079568;5460.863478413072;5636.408177141341;4952.900941981212;5391.312165665104;5399.676019438846;5411.809401931569;5523.944760552343;5055.87360315995;5235.65968212065;5538.83684426275;5543.473370029841;5575;4895.996320754166;4963.780786331589;5090.949090509048;5096.43939166684;5375.623706340519 13:10:15 INFO - PROCESS | 1630 | |5;yui.html;743.6467677853017;756.5196100476196;769.2691942654479;825.3809642767924;837.3259526081501;13730.519431819888;15171.6965660687;15443.69112617747;15446;15497.69004619907;13516.93241533791;13519;13619.455221791117;13961.022728409016;14035;851.2083762101244;916.3677062826662;941.9811603767955;945.1965829045325;945.4185675809397;786.9252421019994;926.9814603707922;932.5849996751448;937.8499440089587;939.4175611121115;985.9950700246488;987.244757760314;987.7629368951436;988.7478692933292;989.7476143583376;979.5396163803001;981.8036392721484;983.4050399508266;983.6360546597733;984.7685793838442;724.4023680463639;727.2291371146601;727.7671145233527;728.5046168605346;728.7412968396196;14965.952383333171;15108.924455377763;15151.393944242218;15263.542093737206;15313.770293445607;12831.422585983653;12910.548130815376;13105.737885242337;13235.470581176742;13460.326983650779;10686.893131068746;10800.891991080067;11049.839348427126;11251.040386825753;11426.028787553068;3348.715359194447;3363.730901527872;3363.9663603363897;3388.6950174484414;3398.8130652814084;108921;112039.43980280128;112213.43893280481;112829.43585282021;112880.4355978223;9758.414495130315;9816.263780216512;9876.654317098866;10070.69787906364;10176.13502852251;20668;20793.376198714064;20968.79031209699;20998.265060722802;21053.684194737092;6895.965520172467;6957.567086922405;7015.088038555057;7077.044598979175;7325.487215894943;3804.239152169577;3839.1361943562474;3860.131470419133;3903.8048097595006;3953.9802300988886;3045.3148041690883;3086.3672947046252;3112.564241006261;3113.1438854314792;3124;592.7451195985682;594.1355327997753;604.1119554255238;609.2932198649545;617.6232498176109;619.4946280538335;642.842503586615;645.2966266769245;655.8032590222914;662.5693299355457;7999;9088.681896133603;9244.768880778034;9497;9692.127708506268;644.3298969072113;660.867826434715;672.4116398151617;691.3466773898718;703.1491894807239;4212;4314.59418467737;4321.114171594815;4380.474343078788;4766;101049;102595;103423.4828825851;104575;107568.46215768871;88522.67215991765;89957.65063524053;90331.54834225787;90513.54743226242;91725.78959736378;59853;61173.69413152906;61878;62021.68989155025;63737;8704.956475217583;8718;8722.607482663423;8816;8839.204471597586;50293.24560131674;50510.74744626253;51219.74390128026;51320.230196547825;52833.94332113413;64184;64424.35575644184;65877.67061164664;66307.34231644247;66596.3350916231;10016.098551130433;10220;10286.382817030702;10362.896371036193;10659;11439.313641181556;11569.247998880046;11625.709357266136;11656.242344247597;11811.291322520676;11073.50169242402;11093.778124437627;11261.949149180888;11353.54585816558;11478.02436792882;10880.782384352427;10946.835797462885;11098.833517497405;11636.243644163102;11717.531298748296;10585.4707264638;11092.423594040923;11103.000729934345;11120.777584448428;11254.402088096514;7920.405969552422;8193.303569196685;8265.4627449218;8275;8332.416730828783;8923.687670931486;9040.63837446521;9101.954490227772;9284.442933423747;9403.43579385239 13:10:16 INFO - PROCESS | 1630 | __end_tp_report 13:10:16 INFO - PROCESS | 1630 | __start_cc_report 13:10:16 INFO - PROCESS | 1630 | _x_x_mozilla_cycle_collect,1808 13:10:16 INFO - PROCESS | 1630 | __end_cc_report 13:10:16 INFO - PROCESS | 1630 | __startTimestamp1490904615985__endTimestamp 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | ------- Summary: start ------- 13:10:16 INFO - PROCESS | 1630 | Number of tests: 6 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | [#0] dojo.html Cycles:165 Average:5944.52 Median:6148.39 stddev:685.87 (11.2%) stddev-sans-first:658.06 13:10:16 INFO - PROCESS | 1630 | Values: 3390.7 3408.9 3411.9 3423.1 3464.7 6051.4 6062.9 6066.3 6120.5 6124.9 6011.0 6091.5 6113.8 6118.5 6126.0 5402.2 5437.4 5455.5 5465.5 5571.7 5351.5 5369.1 5423.3 5551.5 5575.6 5448.2 5478.7 5480.0 5483.3 5493.1 5458.0 5472.7 5475.5 5482.1 5491.6 5266.4 5339.4 5404.6 5415.8 5447.0 6107.8 6109.6 6118.0 6126.0 6137.4 6299.8 6319.1 6344.2 6350.9 6359.6 6291.9 6296.2 6372.3 6382.7 6446.9 4545.4 6113.2 6138.5 6143.1 6146.6 6147.0 6555.1 6604.6 6607.1 6611.9 5663.5 6232.6 6310.0 6339.9 6340.4 6371.8 6410.1 6412.7 6420.6 6424.2 5125.8 6352.4 6360.3 6371.6 6374.5 6191.8 6317.4 6333.6 6361.3 6397.0 5138.7 5148.8 5150.0 5155.3 5155.6 3681.5 4581.5 4595.2 4605.3 4706.0 5138.6 6097.1 6108.5 6125.8 6130.8 6231.3 6275.3 6479.9 6497.3 6520.1 5946.2 6026.2 6045.7 6097.4 6137.5 5716.5 5725.2 5730.5 5741.7 5741.8 6639.2 6651.4 6676.2 6693.5 6717.0 6236.5 6291.7 6295.1 6319.9 6444.1 6688.4 6704.2 6716.5 6728.9 6733.6 5329.3 6329.2 6348.1 6361.0 6392.1 6121.1 6288.1 6460.0 6460.5 6471.4 6239.4 6261.0 6307.5 6341.0 6342.5 6313.5 6331.5 6334.1 6335.1 6338.7 5244.7 6044.6 6148.4 6295.2 6331.9 6234.9 6257.5 6309.9 6310.5 6323.4 6324.3 6327.0 6330.7 6334.6 6342.8 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | [#1] ext.html Cycles:180 Average:54516.02 Median:16042.67 stddev:111964.13 (697.9%) stddev-sans-first:112205.52 13:10:16 INFO - PROCESS | 1630 | Values: 775.0 793.1 862.6 878.1 879.7 39210.0 40060.8 40150.8 40173.6 40317.8 40898.4 41262.0 41290.4 41392.0 41433.0 7361.6 9224.2 9413.2 9415.2 9421.9 7454.1 11081.3 11296.1 11421.1 11428.4 11233.3 11262.7 11278.5 11279.6 11285.6 6278.9 6652.7 11207.4 11215.9 11220.7 10773.5 11078.0 11135.4 11165.0 11174.8 38631.0 38783.8 38822.0 38943.8 39003.6 3765.0 3784.8 3822.3 3883.1 3942.6 27555.7 27589.6 27664.2 27910.4 29025.0 3060.4 3099.0 3100.6 3139.2 3149.1 342550.0 343991.0 345700.0 346296.3 346350.3 42320.0 43054.0 52352.0 52591.2 52642.5 45031.8 51714.7 52460.7 55206.2 55486.4 14674.3 14677.5 14707.0 14733.0 14752.8 12713.9 12722.7 12723.9 12739.9 12746.7 8799.8 12405.8 12416.1 12438.7 12533.4 5124.8 5442.9 5705.9 5709.8 5752.9 1073.2 1073.4 1114.5 1119.5 1182.8 26328.1 26612.0 26852.6 26853.6 27125.7 1169.5 1253.6 1259.5 1287.4 1311.9 14403.2 14513.2 14517.6 14652.8 14804.5 460160.4 481912.0 482138.0 482865.0 483230.6 46911.3 47097.3 47204.3 47207.0 47404.3 1323.4 1388.4 1390.1 1395.3 1396.8 25683.0 26381.7 26521.7 26539.6 27110.0 39509.2 39657.8 39680.8 39686.4 39702.6 429382.0 429933.0 430145.0 430440.0 431259.0 23075.7 24249.8 28486.9 28623.6 28777.0 36722.6 36950.0 37817.0 37990.4 38101.7 26946.9 27021.9 27090.9 27520.7 28047.2 26981.7 27923.0 28036.7 28061.0 28277.6 31784.2 31828.7 32069.5 32110.8 32261.0 22667.1 25841.1 26886.0 27978.9 28300.6 18162.8 19942.5 22085.3 22483.7 22533.8 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | [#2] jquery.html Cycles:180 Average:41238.04 Median:12586.81 stddev:117687.22 (935.0%) stddev-sans-first:117977.38 13:10:16 INFO - PROCESS | 1630 | Values: 384.8 409.9 424.3 429.5 453.5 14210.0 19939.1 21270.5 21660.7 21882.5 21114.0 21802.9 22166.3 22395.0 22659.9 6726.3 6897.5 7000.6 7115.3 7423.4 4095.4 7545.1 7600.7 7610.8 7612.7 4329.8 4426.7 7533.1 7551.0 7609.5 7350.9 7568.5 7597.5 7624.2 7670.0 7161.7 7440.4 7441.2 7444.0 7465.2 25160.9 25311.5 25425.9 25566.2 26080.9 2392.6 2863.1 2864.7 2885.2 2893.3 15261.8 16176.6 16304.9 16310.8 16870.9 1953.7 1983.1 1986.3 2033.2 2042.8 135134.8 135674.3 139978.0 162241.0 172029.1 14501.5 18501.3 18891.4 19775.3 19882.4 26925.5 27074.1 29387.4 30107.8 30598.1 9925.0 10236.9 10465.2 10474.8 10564.1 7953.5 8127.0 8691.4 8698.6 8859.0 9293.6 9327.7 9407.0 9440.0 9457.7 3521.8 3846.4 3919.0 3963.8 4000.4 863.3 866.5 894.8 899.6 923.9 19389.9 20126.0 21792.5 22781.0 24089.4 998.5 1004.9 1005.4 1035.0 1036.5 6505.3 6637.8 7040.7 7184.9 7312.1 614610.0 633128.8 747996.3 749532.0 754519.0 152428.7 153529.2 154402.0 156264.0 157186.0 1189.2 1244.6 1289.0 1289.4 1299.0 19602.0 19898.8 20409.4 20434.6 20461.0 38839.0 62627.0 64293.4 64707.0 65183.7 87877.6 88220.0 88943.7 88999.0 90820.5 8542.7 10938.2 11278.6 11360.3 11401.4 12148.7 12330.0 12587.9 12670.5 12961.7 10430.2 10639.5 10641.0 10790.7 10821.0 10301.6 10353.4 10354.0 10586.3 10708.8 10996.7 11126.4 11136.8 11141.2 11451.1 11248.9 11291.3 11302.8 11338.7 11679.2 10716.0 10770.6 10903.3 10964.6 11033.4 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | [#3] mootools.html Cycles:180 Average:6678.04 Median:2405.78 stddev:4177.51 (173.6%) stddev-sans-first:4169.76 13:10:16 INFO - PROCESS | 1630 | Values: 1310.8 1519.6 1547.5 1573.1 1595.7 10531.5 11150.4 11166.6 11177.1 11179.4 10504.4 10891.5 10911.4 11005.3 11048.8 2035.8 2362.6 2398.9 2408.8 2413.8 2313.2 2381.2 2403.9 2410.4 2412.2 2316.8 2383.6 2384.4 2399.9 2407.6 2316.1 2361.3 2369.0 2369.7 2379.9 2321.6 2347.8 2352.6 2354.9 2359.8 10777.8 11000.4 11026.9 11039.2 11075.3 4761.9 5818.1 5833.3 5838.2 5860.7 3297.9 3383.7 3444.4 3457.4 3463.7 1105.7 1118.3 1138.6 1152.5 1163.5 13400.6 13726.2 13986.2 15215.6 15244.9 4070.8 4541.8 4664.1 4742.1 4888.2 11724.8 11741.7 11767.2 11775.8 11785.8 4748.2 4905.0 4936.1 5283.7 5485.0 5141.6 5167.6 5249.2 5276.4 5290.2 3807.9 3848.5 3929.3 3932.4 3938.7 869.9 1001.0 1005.8 1014.7 1016.0 952.8 960.7 966.1 977.1 992.7 5883.3 6488.6 6508.5 6654.7 6772.5 975.7 1014.5 1061.3 1075.8 1080.9 3788.8 3913.4 4256.6 4427.3 4429.6 13052.3 13614.2 13650.2 13654.0 13656.0 12948.2 13519.9 13533.0 13543.7 13563.5 9312.8 9875.7 10027.1 10332.3 10339.2 6520.3 6787.9 6826.7 6923.8 6999.0 12066.6 12118.8 12203.6 12226.0 12229.7 12326.9 12444.1 12476.6 12581.4 12723.0 8874.4 9250.9 9270.4 9473.2 9485.5 10487.4 10498.6 10589.4 10598.4 10608.9 8843.7 8874.5 8884.2 8918.1 8942.3 8508.9 8675.9 8741.1 8778.1 8895.8 7855.5 7877.4 8022.8 8035.6 8056.6 5916.8 5934.5 5980.1 5981.3 6045.5 5595.3 5623.8 5687.9 5887.0 6129.8 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | [#4] prototype.html Cycles:180 Average:4542.17 Median:4891.22 stddev:1288.00 (26.3%) stddev-sans-first:1253.03 13:10:16 INFO - PROCESS | 1630 | Values: 373.7 376.9 377.0 386.3 387.2 4673.6 4837.7 4876.2 4932.0 5244.4 4605.8 4677.4 5089.7 5119.6 5180.0 3751.9 4117.9 4237.2 4261.0 4296.6 4117.6 4227.8 4237.6 4240.0 4253.0 3418.4 3808.4 3906.0 4250.4 4251.1 3702.7 3890.0 3987.3 4055.9 4090.3 3279.9 3551.9 3891.4 3918.5 3922.6 4407.4 4828.8 4983.7 5002.6 5039.7 4351.3 4396.5 4510.8 4789.4 4809.6 4723.6 4911.9 5353.5 5431.5 5431.9 3915.9 3922.9 4311.4 4324.8 4329.0 4671.7 4892.5 5397.9 5820.9 5989.3 3941.8 4112.8 4144.7 4291.8 4313.4 4252.0 4348.7 4418.4 4438.5 4620.7 4495.8 4521.0 4752.0 4912.6 4934.8 4873.0 4890.0 5076.8 5166.6 5506.4 1287.8 1471.7 1544.3 1562.1 1562.9 1062.6 1099.3 1111.7 1184.4 1202.4 4394.3 4423.0 4648.4 5087.3 5184.6 5694.0 5756.8 5790.4 5838.3 5891.6 4345.0 4566.6 4603.3 5057.8 5246.4 2604.5 2722.8 2930.8 2959.9 2985.9 4919.9 5466.3 5550.9 5875.6 5914.5 5259.9 5603.4 5621.3 5657.2 5870.4 5527.8 5538.3 5593.5 5661.8 5870.5 5221.6 5756.7 5763.8 5783.7 5803.9 5097.4 5447.9 5450.7 5517.5 5779.2 5505.8 5725.3 5925.5 6017.6 6024.8 3912.0 4477.2 4500.5 4503.2 4504.3 5008.7 5305.8 5391.5 5548.0 5785.0 5093.4 5485.8 5522.8 5535.5 5563.9 4805.6 5159.7 5402.4 5460.9 5636.4 4952.9 5391.3 5399.7 5411.8 5523.9 5055.9 5235.7 5538.8 5543.5 5575.0 4896.0 4963.8 5090.9 5096.4 5375.6 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - PROCESS | 1630 | [#5] yui.html Cycles:180 Average:19525.55 Median:52077.09 stddev:29397.42 (56.4%) stddev-sans-first:29446.06 13:10:16 INFO - PROCESS | 1630 | Values: 743.6 756.5 769.3 825.4 837.3 13730.5 15171.7 15443.7 15446.0 15497.7 13516.9 13519.0 13619.5 13961.0 14035.0 851.2 916.4 942.0 945.2 945.4 786.9 927.0 932.6 937.8 939.4 986.0 987.2 987.8 988.7 989.7 979.5 981.8 983.4 983.6 984.8 724.4 727.2 727.8 728.5 728.7 14966.0 15108.9 15151.4 15263.5 15313.8 12831.4 12910.5 13105.7 13235.5 13460.3 10686.9 10800.9 11049.8 11251.0 11426.0 3348.7 3363.7 3364.0 3388.7 3398.8 108921.0 112039.4 112213.4 112829.4 112880.4 9758.4 9816.3 9876.7 10070.7 10176.1 20668.0 20793.4 20968.8 20998.3 21053.7 6896.0 6957.6 7015.1 7077.0 7325.5 3804.2 3839.1 3860.1 3903.8 3954.0 3045.3 3086.4 3112.6 3113.1 3124.0 592.7 594.1 604.1 609.3 617.6 619.5 642.8 645.3 655.8 662.6 7999.0 9088.7 9244.8 9497.0 9692.1 644.3 660.9 672.4 691.3 703.1 4212.0 4314.6 4321.1 4380.5 4766.0 101049.0 102595.0 103423.5 104575.0 107568.5 88522.7 89957.7 90331.5 90513.5 91725.8 59853.0 61173.7 61878.0 62021.7 63737.0 8705.0 8718.0 8722.6 8816.0 8839.2 50293.2 50510.7 51219.7 51320.2 52833.9 64184.0 64424.4 65877.7 66307.3 66596.3 10016.1 10220.0 10286.4 10362.9 10659.0 11439.3 11569.2 11625.7 11656.2 11811.3 11073.5 11093.8 11261.9 11353.5 11478.0 10880.8 10946.8 11098.8 11636.2 11717.5 10585.5 11092.4 11103.0 11120.8 11254.4 7920.4 8193.3 8265.5 8275.0 8332.4 8923.7 9040.6 9102.0 9284.4 9403.4 13:10:16 INFO - PROCESS | 1630 | -------- Summary: end -------- 13:10:16 INFO - PROCESS | 1630 | 13:10:16 INFO - TEST-INFO | 1630: exit 0 13:10:16 INFO - TEST-OK | dromaeo_css | took 1120723ms 13:10:16 INFO - TEST-START | kraken 13:10:16 INFO - operating with platform_type : mac_ 13:10:16 INFO - Initialising browser for kraken test... 13:10:16 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmplKPZLe/profile http://localhost:49240/getInfo.html) 13:10:18 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 13:10:18 INFO - PROCESS | 1639 | colorDepth:24 13:10:18 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 13:10:18 INFO - PROCESS | 1639 | __metrics 13:10:19 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:10:19 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:19 INFO - TEST-INFO | 1639: exit 0 13:10:19 INFO - Browser initialized. 13:10:19 INFO - Running cycle 1/1 for kraken test... 13:10:19 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmplKPZLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:32 INFO - PROCESS | 1640 | RSS: Main: 215314432 13:10:32 INFO - PROCESS | 1640 | 13:10:34 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:35 INFO - PROCESS | 1640 | RSS: Main: 267292672 13:10:35 INFO - PROCESS | 1640 | 13:10:38 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:10:38 INFO - PROCESS | 1640 | RSS: Main: 279437312 13:10:38 INFO - PROCESS | 1640 | 13:10:42 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:10:42 INFO - PROCESS | 1640 | RSS: Main: 375767040 13:10:42 INFO - PROCESS | 1640 | 13:10:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:10:45 INFO - PROCESS | 1640 | RSS: Main: 278827008 13:10:45 INFO - PROCESS | 1640 | 13:10:47 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:47 INFO - PROCESS | 1640 | RSS: Main: 280551424 13:10:47 INFO - PROCESS | 1640 | 13:10:50 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:51 INFO - PROCESS | 1640 | RSS: Main: 319602688 13:10:51 INFO - PROCESS | 1640 | 13:10:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:55 INFO - PROCESS | 1640 | RSS: Main: 320622592 13:10:55 INFO - PROCESS | 1640 | 13:10:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:10:58 INFO - PROCESS | 1640 | RSS: Main: 317341696 13:10:58 INFO - PROCESS | 1640 | 13:11:00 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:01 INFO - PROCESS | 1640 | RSS: Main: 294301696 13:11:01 INFO - PROCESS | 1640 | 13:11:02 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:03 INFO - PROCESS | 1640 | RSS: Main: 298979328 13:11:03 INFO - PROCESS | 1640 | 13:11:05 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:06 INFO - PROCESS | 1640 | RSS: Main: 307023872 13:11:06 INFO - PROCESS | 1640 | 13:11:09 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:10 INFO - PROCESS | 1640 | RSS: Main: 320573440 13:11:10 INFO - PROCESS | 1640 | 13:11:12 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:13 INFO - PROCESS | 1640 | RSS: Main: 314400768 13:11:13 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:11:15 INFO - PROCESS | 1640 | RSS: Main: 359215104 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | __start_tp_report 13:11:15 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 13:11:15 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 13:11:15 INFO - PROCESS | 1640 | |i|pagename|runs| 13:11:15 INFO - PROCESS | 1640 | |0;ai-astar;117;117;115;114;116;117;124;122;114;116 13:11:15 INFO - PROCESS | 1640 | |1;audio-beat-detection;141;109;110;142;110;109;108;108;127;106 13:11:15 INFO - PROCESS | 1640 | |2;audio-dft;186;186;186;185;184;185;184;186;186;183 13:11:15 INFO - PROCESS | 1640 | |3;audio-fft;85;59;62;94;61;61;63;62;74;61 13:11:15 INFO - PROCESS | 1640 | |4;audio-oscillator;86;68;87;69;68;70;82;69;69;84 13:11:15 INFO - PROCESS | 1640 | |5;imaging-gaussian-blur;95;88;89;89;89;89;89;90;89;89 13:11:15 INFO - PROCESS | 1640 | |6;imaging-darkroom;96;96;96;97;97;97;97;97;96;129 13:11:15 INFO - PROCESS | 1640 | |7;imaging-desaturate;87;87;86;85;86;85;87;88;87;84 13:11:15 INFO - PROCESS | 1640 | |8;json-parse-financial;61;61;60;60;64;63;63;64;63;62 13:11:15 INFO - PROCESS | 1640 | |9;json-stringify-tinderbox;56;66;69;62;60;57;58;56;57;57 13:11:15 INFO - PROCESS | 1640 | |10;stanford-crypto-aes;83;94;100;87;87;84;82;87;89;90 13:11:15 INFO - PROCESS | 1640 | |11;stanford-crypto-ccm;135;137;137;136;133;138;138;138;185;171 13:11:15 INFO - PROCESS | 1640 | |12;stanford-crypto-pbkdf2;164;167;165;166;165;166;164;168;167;219 13:11:15 INFO - PROCESS | 1640 | |13;stanford-crypto-sha256-iterative;65;64;64;66;66;65;64;63;64;68 13:11:15 INFO - PROCESS | 1640 | __end_tp_report 13:11:15 INFO - PROCESS | 1640 | __start_cc_report 13:11:15 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2186 13:11:15 INFO - PROCESS | 1640 | __end_cc_report 13:11:15 INFO - PROCESS | 1640 | __startTimestamp1490904675577__endTimestamp 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | ------- Summary: start ------- 13:11:15 INFO - PROCESS | 1640 | Number of tests: 14 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#0] ai-astar Cycles:10 Average:117.20 Median:117.00 stddev:3.29 (2.8%) stddev-sans-first:3.49 13:11:15 INFO - PROCESS | 1640 | Values: 117.0 117.0 115.0 114.0 116.0 117.0 124.0 122.0 114.0 116.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:110.00 stddev:14.18 (12.9%) stddev-sans-first:12.09 13:11:15 INFO - PROCESS | 1640 | Values: 141.0 109.0 110.0 142.0 110.0 109.0 108.0 108.0 127.0 106.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#2] audio-dft Cycles:10 Average:185.10 Median:186.00 stddev:1.10 (0.6%) stddev-sans-first:1.12 13:11:15 INFO - PROCESS | 1640 | Values: 186.0 186.0 186.0 185.0 184.0 185.0 184.0 186.0 186.0 183.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#3] audio-fft Cycles:10 Average:68.20 Median:62.50 stddev:12.14 (19.4%) stddev-sans-first:11.25 13:11:15 INFO - PROCESS | 1640 | Values: 85.0 59.0 62.0 94.0 61.0 61.0 63.0 62.0 74.0 61.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:8.34 (11.0%) stddev-sans-first:7.87 13:11:15 INFO - PROCESS | 1640 | Values: 86.0 68.0 87.0 69.0 68.0 70.0 82.0 69.0 69.0 84.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:89.00 stddev:1.96 (2.2%) stddev-sans-first:0.50 13:11:15 INFO - PROCESS | 1640 | Values: 95.0 88.0 89.0 89.0 89.0 89.0 89.0 90.0 89.0 89.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:97.00 stddev:10.27 (10.6%) stddev-sans-first:10.80 13:11:15 INFO - PROCESS | 1640 | Values: 96.0 96.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 129.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:87.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 13:11:15 INFO - PROCESS | 1640 | Values: 87.0 87.0 86.0 85.0 86.0 85.0 87.0 88.0 87.0 84.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.56 13:11:15 INFO - PROCESS | 1640 | Values: 61.0 61.0 60.0 60.0 64.0 63.0 63.0 64.0 63.0 62.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:4.52 (7.7%) stddev-sans-first:4.58 13:11:15 INFO - PROCESS | 1640 | Values: 56.0 66.0 69.0 62.0 60.0 57.0 58.0 56.0 57.0 57.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:87.00 stddev:5.42 (6.2%) stddev-sans-first:5.40 13:11:15 INFO - PROCESS | 1640 | Values: 83.0 94.0 100.0 87.0 87.0 84.0 82.0 87.0 89.0 90.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:138.00 stddev:17.87 (13.0%) stddev-sans-first:18.60 13:11:15 INFO - PROCESS | 1640 | Values: 135.0 137.0 137.0 136.0 133.0 138.0 138.0 138.0 185.0 171.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:166.50 stddev:16.88 (10.1%) stddev-sans-first:17.71 13:11:15 INFO - PROCESS | 1640 | Values: 164.0 167.0 165.0 166.0 165.0 166.0 164.0 168.0 167.0 219.0 13:11:15 INFO - PROCESS | 1640 | 13:11:15 INFO - PROCESS | 1640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.54 13:11:15 INFO - PROCESS | 1640 | Values: 65.0 64.0 64.0 66.0 66.0 65.0 64.0 63.0 64.0 68.0 13:11:15 INFO - PROCESS | 1640 | -------- Summary: end -------- 13:11:15 INFO - PROCESS | 1640 | 13:11:16 INFO - TEST-INFO | 1640: exit 0 13:11:16 INFO - TEST-OK | kraken | took 59826ms 13:11:16 INFO - SUITE-END | took 1180s 13:11:16 INFO - Completed test suite (00:19:40) 13:11:16 INFO - javascript benchmark 13:11:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7513.948049696692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.6948374646277, 3408.897733068008, 3411.9147021324466, 3423.1442139465116, 3464.722822174226, 6051.42368907346, 6062.909056364147, 6066.30237522685, 6120.52777597912, 6124.938750612499, 6011.0, 6091.543134264937, 6113.755449782015, 6118.510519158468, 6126.0, 5402.216678581613, 5437.429069947658, 5455.536279416255, 5465.480779325958, 5571.693556854371, 5351.518363347298, 5369.087255166631, 5423.267858839065, 5551.472610102034, 5575.609707320489, 5448.182772584105, 5478.698671573062, 5479.972600137014, 5483.259759932418, 5493.121100623881, 5457.972710136463, 5472.7263636818, 5475.4524547545325, 5482.095454250044, 5491.643043202219, 5266.368035835686, 5339.41266460689, 5404.5676345892625, 5415.83752487426, 5447.046766815792, 6107.816765497042, 6109.633421994695, 6117.96941015292, 6125.969370153165, 6137.3862613738265, 6299.842503937392, 6319.115323854664, 6344.206974128234, 6350.872982540323, 6359.618422894595, 6291.905621415683, 6296.181496405438, 6372.267189273247, 6382.744690212386, 6446.9355306446805, 4545.386372839657, 6113.23584551931, 6138.508919286446, 6143.078538219258, 6146.569740118193, 6146.969265153645, 6555.082288479522, 6604.603723776589, 6607.1080404145305, 6611.900821487681, 5663.546916246691, 6232.594881332699, 6309.9588567885785, 6339.890519159221, 6340.397662222082, 6371.776987805404, 6410.102585638015, 6412.743490260337, 6420.6468644225015, 6424.196975378078, 5125.769340379692, 6352.364763523703, 6360.332165122595, 6371.585846919936, 6374.521910856704, 6191.783287584913, 6317.431431171217, 6333.556651034383, 6361.300256971729, 6397.0, 5138.717370544656, 5148.768305426265, 5150.021495915764, 5155.278261043457, 5155.613329000265, 3681.466187402865, 4581.496035436166, 4595.241785105421, 4605.309203619417, 4706.035262771124, 5138.58891288696, 6097.146399504073, 6108.450239478469, 6125.785597504066, 6130.77659829192, 6231.252249729971, 6275.278342990523, 6479.870402591921, 6497.252815926229, 6520.0871877937125, 5946.167536544887, 6026.216591843032, 6045.697715114226, 6097.420745029215, 6137.539684523678, 5716.485516303469, 5725.227094342211, 5730.455606717355, 5741.684207368635, 5741.827745167651, 6639.236487803964, 6651.37041424854, 6676.198856137295, 6693.464522838064, 6717.0, 6236.501079913687, 6291.716872740646, 6295.055741638791, 6319.936800631935, 6444.097826304415, 6688.398044176048, 6704.229013663491, 6716.529842910949, 6728.932710672831, 6733.562318449285, 5329.280547126088, 6329.208848893888, 6348.079528468438, 6361.0, 6392.137061496638, 6121.087175196906, 6288.056791481132, 6459.967700161657, 6460.45086167681, 6471.4499267560905, 6239.407256310643, 6261.0, 6307.526935479949, 6341.048842673636, 6342.524310676626, 6313.526485513697, 6331.5251356147555, 6334.113224148715, 6335.113084168128, 6338.714757836001, 5244.685318880726, 6044.637321760709, 6148.385161483816, 6295.181626388723, 6331.92357299251, 6234.906476402948, 6257.4994000480765, 6309.873802523832, 6310.495160387066, 6323.399277068671, 6324.335944725922, 6327.019312006646, 6330.715117819617, 6334.556581039283, 6342.841428964312], "value": 5901.11117841548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.976750697479, 793.1077537770007, 862.6376921692893, 878.113105763179, 879.7184900831736, 39210.019749506275, 40060.799696001515, 40150.79547613576, 40173.59826401735, 40317.79841100794, 40898.386524202164, 41262.0, 41290.380644290286, 41392.0, 41433.0, 7361.558306501627, 9224.169824715775, 9413.246940244764, 9415.199708024826, 9421.858672119924, 7454.068241469817, 11081.27971681838, 11296.096312294996, 11421.086313094933, 11428.371439570821, 11233.26983746058, 11262.662120136409, 11278.492467838967, 11279.605213817518, 11285.605003824869, 6278.937210627927, 6652.733890644368, 11207.383593902332, 11215.934486223796, 11220.719482012933, 10773.515191816308, 11078.0, 11135.443227838576, 11165.0, 11174.776504469946, 38631.0, 38783.806080969414, 38822.0, 38943.8052809737, 39003.60996390056, 3764.9811750941344, 3784.829682664287, 3822.2546603412347, 3883.1457079442475, 3942.6451619354107, 27555.724442755516, 27589.58615620767, 27664.170074897786, 27910.441791164267, 29024.984125555504, 3060.3573249617607, 3098.984505077483, 3100.55042018906, 3139.1681204480833, 3149.102505785863, 342550.0, 343990.9999999975, 345700.0, 346296.2685186558, 346350.2682486597, 42320.0, 43054.0, 52351.95296094133, 52591.21113183305, 52642.47357526376, 45031.77484112624, 51714.70713232199, 52460.73769631128, 55206.17190742142, 55486.44513554894, 14674.266286685623, 14677.486287980082, 14707.044042137228, 14733.0, 14752.778708319383, 12713.93643031779, 12722.745545089047, 12723.872761272269, 12739.936300318439, 12746.681332966564, 8799.824003520022, 12405.813912791315, 12416.068794840423, 12438.675899003805, 12533.37333133358, 5124.795008199705, 5442.91835622466, 5705.942940570541, 5709.831043770664, 5752.922186630133, 1073.221914112278, 1073.393532654048, 1114.4706264524448, 1119.5409881948362, 1182.846229990113, 26328.078517251804, 26612.0, 26852.59721104185, 26853.597196042076, 27125.728742712716, 1169.4620474581618, 1253.6239128261484, 1259.5276771210797, 1287.4077924154806, 1311.895048396126, 14403.207823569805, 14513.201773902325, 14517.637059073608, 14652.780208296885, 14804.481843135438, 460160.3983960184, 481912.0, 482138.0, 482865.0, 483230.5838470785, 46911.296330555066, 47097.29354059692, 47204.291935620306, 47207.0, 47404.288935665994, 1323.430924702368, 1388.3960477192454, 1390.0547627613118, 1395.3023488255872, 1396.8393634731933, 25683.0, 26381.736182637927, 26521.734782652697, 26539.601905971038, 27110.0, 39509.2098158041, 39657.810265692075, 39680.801595991834, 39686.404703928885, 39702.60297396989, 429382.0, 429933.0, 430145.0, 430440.0, 431259.0, 23075.653865192373, 24249.757502425455, 28486.860525578744, 28623.570646439905, 28777.0, 36722.63277367299, 36950.0, 37817.0, 37990.43014354842, 38101.66644167441, 26946.865265673547, 27021.86489067542, 27090.864545677145, 27520.724792751815, 28047.158585242476, 26981.730182698706, 27923.0, 28036.71963280341, 28061.017864374648, 28277.57583636206, 31784.205394865312, 31828.68171318257, 32069.51895721613, 32110.839445802623, 32261.0, 22667.093316267823, 25841.095561655253, 26886.0, 27978.860105699343, 28300.575491367235, 18162.81837181664, 19942.50143746418, 22085.33743987683, 22483.66274505851, 22533.774662253167], "value": 18167.040289676082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.8037154826617, 409.8667932921799, 424.3210862619808, 429.48461845785056, 453.48755905826414, 14210.0, 19939.105784950425, 21270.468238294052, 21660.675089873665, 21882.452938676503, 21114.0, 21802.89098554509, 22166.335009949726, 22394.99222534986, 22659.886700566516, 6726.29373915738, 6897.517173797836, 7000.579965202079, 7115.324044215817, 7423.369013633821, 4095.4061661059127, 7545.132309784362, 7600.7339743109005, 7610.771676849703, 7612.7335543255995, 4329.826806927719, 4426.690131690783, 7533.058367704037, 7550.9622451887935, 7609.467337286392, 7350.889736653901, 7568.470207085506, 7597.544147351149, 7624.237576242359, 7670.002899623069, 7161.713531458736, 7440.441966852453, 7441.181470038291, 7444.032275804165, 7465.216152304039, 25160.874195628905, 25311.493770124678, 25425.872870635714, 25566.233013009638, 26080.86959565209, 2392.629142482918, 2863.141057682687, 2864.6705628852533, 2885.1633026422314, 2893.291143669793, 15261.771073433907, 16176.595585110348, 16304.918475407665, 16310.75533866993, 16870.915645421817, 1953.7310975518396, 1983.0679580597096, 1986.3445063129134, 2033.2476983516046, 2042.7957204279453, 135134.75999980213, 135674.32162839122, 139978.0, 162241.0, 172029.13985429992, 14501.534739094168, 18501.259949601867, 18891.43325700231, 19775.30786422497, 19882.403527894185, 26925.461490770467, 27074.05240816562, 29387.41225175527, 30107.849460752557, 30598.082057537864, 9925.0, 10236.928921323723, 10465.162786977024, 10474.842877356845, 10564.102051325723, 7953.5227886327, 8126.984126984127, 8691.435056721293, 8698.565071746514, 8859.0, 9293.628254869729, 9327.673531426368, 9407.0, 9440.0, 9457.716268511957, 3521.80258712034, 3846.382556987116, 3919.0, 3963.841446342114, 4000.399940009022, 863.3395452478859, 866.4671227195356, 894.8165626046645, 899.59967814322, 923.8845144356956, 19389.90305048494, 20126.0, 21792.45518862041, 22781.0, 24089.397765056015, 998.5207100591757, 1004.924630652704, 1005.3666190300064, 1035.034625797086, 1036.4921188617675, 6505.251896031922, 6637.834054148589, 7040.718371265194, 7184.928150718531, 7312.085989251344, 614610.0, 633128.8343558345, 747996.2600187073, 749532.0, 754519.0, 152428.71356929655, 153529.23235383976, 154402.0, 156264.0, 157186.0, 1189.2091758980355, 1244.6203907808206, 1288.9613311600478, 1289.4068728385048, 1298.9610311690665, 19602.019899005278, 19898.801011989694, 20409.387718368474, 20434.59130817405, 20461.0, 38839.0, 62627.0, 64293.35706642874, 64707.0, 65183.67408162929, 87877.56061219909, 88220.0, 88943.66584501367, 88999.0, 90820.54589727009, 8542.74371768848, 10938.195197792274, 11278.60524881658, 11360.261582997078, 11401.372924489233, 12148.696282593006, 12330.0, 12587.87412125867, 12670.493180273055, 12961.740765184832, 10430.165586753194, 10639.468026598484, 10641.0, 10790.67627971162, 10821.026107650348, 10301.639442619473, 10353.4305613192, 10354.0, 10586.258961872903, 10708.785824283626, 10996.725081873017, 11126.388048657402, 11136.777264454504, 11141.16441266892, 11451.083913287084, 11248.88751112511, 11291.266067705574, 11302.83045754298, 11338.659840204808, 11679.240849344766, 10716.0, 10770.569177232823, 10903.29128606638, 10964.616238431936, 11033.393163375771], "value": 11265.412923498747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.7968264918939, 1519.6124988128026, 1547.512533551931, 1573.0561663002193, 1595.688840676068, 10531.473426328692, 11150.442477876115, 11166.553337866486, 11177.105831533489, 11179.385133817637, 10504.422256775873, 10891.455427228626, 10911.399873006982, 11005.339679619228, 11048.834267485974, 2035.7760646328966, 2362.551115288094, 2398.8560686358787, 2408.771166739166, 2413.758624137581, 2313.178821518362, 2381.166591692911, 2403.9399015024587, 2410.3612542676206, 2412.2280870121567, 2316.7799059089443, 2383.6067048936907, 2384.4277373430336, 2399.8560086394873, 2407.614781634939, 2316.143027079974, 2361.3034154924253, 2368.964465533027, 2369.6919400478, 2379.892904819287, 2321.593721098801, 2347.835651504395, 2352.5530149271585, 2354.9411264718347, 2359.823013273994, 10777.78444431107, 11000.449977501174, 11026.944865275622, 11039.227254092217, 11075.280106793032, 4761.857144285677, 5818.069108942591, 5833.300003999505, 5838.2118414013985, 5860.652050028517, 3297.917552061194, 3383.678550537695, 3444.4144495435835, 3457.4122399192197, 3463.705585025276, 1105.7346236903165, 1118.2619471149003, 1138.573035111833, 1152.5389844062358, 1163.5229555882047, 13400.597982060553, 13726.176429414267, 13986.230757308344, 15215.61960950974, 15244.923775381163, 4070.776107314126, 4541.841035563805, 4664.137134630104, 4742.099001189763, 4888.2178851383605, 11724.824127638092, 11741.706457338634, 11767.23512971654, 11775.823362649568, 11785.764284714258, 4748.240281554935, 4904.950950490521, 4936.136176169156, 5283.656562323436, 5485.0, 5141.640085194075, 5167.58659307262, 5249.238860365302, 5276.366835979707, 5290.206469029677, 3807.8667246646232, 3848.461215429842, 3929.31237033518, 3932.390479475686, 3938.7439816412416, 869.9173578510031, 1000.9740016483017, 1005.7629116186985, 1014.7463134216446, 1015.9796804063877, 952.842780941137, 960.7406000379858, 966.1401352796017, 977.0961860279214, 992.6698224379222, 5883.3234178069215, 6488.643124628096, 6508.511861610398, 6654.6672666366485, 6772.458203343721, 975.6975337645353, 1014.5485259059648, 1061.2995423020923, 1075.8219749374423, 1080.9081228095542, 3788.8295026723863, 3913.412988051758, 4256.59562341577, 4427.269500532376, 4429.557044295545, 13052.34738263083, 13614.18314901109, 13650.180989140683, 13654.04421690492, 13656.04407691452, 12948.15836970594, 13519.918406527455, 13533.0, 13543.729125417436, 13563.457461701619, 9312.813743725223, 9875.703728888146, 10027.147692446224, 10332.276740628235, 10339.224558158168, 6520.282768895323, 6787.864242715217, 6826.653430946768, 6923.826904327432, 6999.0, 12066.577669781516, 12118.818217726564, 12203.572874949334, 12225.960793332311, 12229.69425764363, 12326.876731232931, 12444.128910976146, 12476.625701228977, 12581.370931453574, 12723.0, 8874.378793484653, 9250.861237081584, 9270.44377337362, 9473.24214062887, 9485.525723713648, 10487.423191724529, 10498.632547860789, 10589.364638121737, 10598.417087060287, 10608.946955265174, 8843.734687959372, 8874.467531948103, 8884.244839188741, 8918.063603321818, 8942.284617230476, 8508.91491085106, 8675.91324086751, 8741.125887411208, 8778.078301778221, 8895.777605559913, 7855.489393189425, 7877.369810415267, 8022.759317220492, 8035.598220088856, 8056.597170141352, 5916.822495325147, 5934.525237980864, 5980.073088671263, 5981.252343457068, 6045.516358691206, 5595.272614560244, 5623.831285061455, 5687.8862422752145, 5886.970565147147, 6129.816105516842], "value": 5083.432232609721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.67676959430094, 376.91142581493364, 376.9981150094249, 386.2930836569077, 387.1656580069949, 4673.6261099112035, 4837.709737415753, 4876.1954277544255, 4931.950680493194, 5244.39689435715, 4605.79273932673, 4677.415323084614, 5089.720065396402, 5119.590432765379, 5179.989901969117, 3751.917685684444, 4117.876463706094, 4237.173751118533, 4260.977365432305, 4296.591823776744, 4117.608827161415, 4227.808004956254, 4237.6186143247105, 4239.9576004240025, 4252.957470425287, 3418.384690755663, 3808.371618682914, 3906.0234941264684, 4250.404943307939, 4251.06476575153, 3702.666759991587, 3889.961100388988, 3987.282289187945, 4055.9454541819046, 4090.284200264957, 3279.932883224808, 3551.928961420783, 3891.416287556861, 3918.45141680165, 3922.5685174630767, 4407.382966384709, 4828.830990915301, 4983.676061056056, 5002.59979201663, 5039.748012599355, 4351.347297905308, 4396.538363471854, 4510.8421205257655, 4789.37738094049, 4809.567138957475, 4723.583449474752, 4911.919377736892, 5353.518183363516, 5431.456854314576, 5431.891362172734, 3915.882523524299, 3922.901927451808, 4311.417958575584, 4324.848630297956, 4329.047609525931, 4671.672982891199, 4892.461829198785, 5397.892042159135, 5820.854478638025, 5989.341172471025, 3941.797751685706, 4112.794360281974, 4144.730592511477, 4291.785410729451, 4313.352997050468, 4252.0, 4348.717333373321, 4418.403515525427, 4438.467383913951, 4620.745858977722, 4495.820167193276, 4520.95479045212, 4751.980408326447, 4912.557869791736, 4934.802607895644, 4872.9512704873205, 4889.975550122226, 5076.771545280471, 5166.5866730661455, 5506.421825708323, 1287.7810772168755, 1471.661517850879, 1544.3166948026706, 1562.1252098824696, 1562.9059658239278, 1062.644014255233, 1099.3074363151322, 1111.7331840358418, 1184.3604453595135, 1202.406810975461, 4394.340848872631, 4423.0048239145935, 4648.445108095793, 5087.287779710843, 5184.637075404761, 5693.971530142406, 5756.833741442274, 5790.40994583361, 5838.299404071538, 5891.646501209942, 4345.045369148946, 4566.611837993742, 4603.332516785047, 5057.772400241998, 5246.449122842047, 2604.5442047641586, 2722.8081394477636, 2930.7508861746564, 2959.8520073996215, 2985.925351866177, 4919.877003074952, 5466.262054622654, 5550.889822035609, 5875.588708790344, 5914.526837852962, 5259.894802103937, 5603.427100425418, 5621.297337832771, 5657.161422537692, 5870.383609721003, 5527.834164975057, 5538.280023596987, 5593.524550413261, 5661.830145095653, 5870.473676843966, 5221.556167725786, 5756.65460072397, 5763.769449221984, 5783.698667799879, 5803.86824569205, 5097.413797413196, 5447.9104179165115, 5450.727463626724, 5517.537852469019, 5779.2198053263955, 5505.752241149078, 5725.307176870978, 5925.466707996301, 6017.638941663514, 6024.819255422344, 3911.9804400977814, 4477.238869392146, 4500.482444518791, 4503.234450143549, 4504.34686970394, 5008.697738587921, 5305.84302340107, 5391.541718953933, 5548.0, 5785.033088749845, 5093.439721630543, 5485.75314110858, 5522.834314970557, 5535.529479994246, 5563.916541251965, 4805.5972013993005, 5159.664621799571, 5402.407399079568, 5460.863478413072, 5636.408177141341, 4952.900941981212, 5391.312165665104, 5399.676019438846, 5411.809401931569, 5523.944760552343, 5055.87360315995, 5235.65968212065, 5538.83684426275, 5543.473370029841, 5575.0, 4895.996320754166, 4963.780786331589, 5090.949090509048, 5096.43939166684, 5375.623706340519], "value": 4167.6083999087095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.6467677853017, 756.5196100476196, 769.2691942654479, 825.3809642767924, 837.3259526081501, 13730.519431819888, 15171.6965660687, 15443.69112617747, 15446.0, 15497.69004619907, 13516.93241533791, 13519.0, 13619.455221791117, 13961.022728409016, 14035.0, 851.2083762101244, 916.3677062826662, 941.9811603767955, 945.1965829045325, 945.4185675809397, 786.9252421019994, 926.9814603707922, 932.5849996751448, 937.8499440089587, 939.4175611121115, 985.9950700246488, 987.244757760314, 987.7629368951436, 988.7478692933292, 989.7476143583376, 979.5396163803001, 981.8036392721484, 983.4050399508266, 983.6360546597733, 984.7685793838442, 724.4023680463639, 727.2291371146601, 727.7671145233527, 728.5046168605346, 728.7412968396196, 14965.952383333171, 15108.924455377763, 15151.393944242218, 15263.542093737206, 15313.770293445607, 12831.422585983653, 12910.548130815376, 13105.737885242337, 13235.470581176742, 13460.326983650779, 10686.893131068746, 10800.891991080067, 11049.839348427126, 11251.040386825753, 11426.028787553068, 3348.715359194447, 3363.730901527872, 3363.9663603363897, 3388.6950174484414, 3398.8130652814084, 108921.0, 112039.43980280128, 112213.43893280481, 112829.43585282021, 112880.4355978223, 9758.414495130315, 9816.263780216512, 9876.654317098866, 10070.69787906364, 10176.13502852251, 20668.0, 20793.376198714064, 20968.79031209699, 20998.265060722802, 21053.684194737092, 6895.965520172467, 6957.567086922405, 7015.088038555057, 7077.044598979175, 7325.487215894943, 3804.239152169577, 3839.1361943562474, 3860.131470419133, 3903.8048097595006, 3953.9802300988886, 3045.3148041690883, 3086.3672947046252, 3112.564241006261, 3113.1438854314792, 3124.0, 592.7451195985682, 594.1355327997753, 604.1119554255238, 609.2932198649545, 617.6232498176109, 619.4946280538335, 642.842503586615, 645.2966266769245, 655.8032590222914, 662.5693299355457, 7999.0, 9088.681896133603, 9244.768880778034, 9497.0, 9692.127708506268, 644.3298969072113, 660.867826434715, 672.4116398151617, 691.3466773898718, 703.1491894807239, 4212.0, 4314.59418467737, 4321.114171594815, 4380.474343078788, 4766.0, 101049.0, 102595.0, 103423.4828825851, 104575.0, 107568.46215768871, 88522.67215991765, 89957.65063524053, 90331.54834225787, 90513.54743226242, 91725.78959736378, 59853.0, 61173.69413152906, 61878.0, 62021.68989155025, 63737.0, 8704.956475217583, 8718.0, 8722.607482663423, 8816.0, 8839.204471597586, 50293.24560131674, 50510.74744626253, 51219.74390128026, 51320.230196547825, 52833.94332113413, 64184.0, 64424.35575644184, 65877.67061164664, 66307.34231644247, 66596.3350916231, 10016.098551130433, 10220.0, 10286.382817030702, 10362.896371036193, 10659.0, 11439.313641181556, 11569.247998880046, 11625.709357266136, 11656.242344247597, 11811.291322520676, 11073.50169242402, 11093.778124437627, 11261.949149180888, 11353.54585816558, 11478.02436792882, 10880.782384352427, 10946.835797462885, 11098.833517497405, 11636.243644163102, 11717.531298748296, 10585.4707264638, 11092.423594040923, 11103.000729934345, 11120.777584448428, 11254.402088096514, 7920.405969552422, 8193.303569196685, 8265.4627449218, 8275.0, 8332.416730828783, 8923.687670931486, 9040.63837446521, 9101.954490227772, 9284.442933423747, 9403.43579385239], "value": 7033.305061283726, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 115.0, 114.0, 116.0, 117.0, 124.0, 122.0, 114.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 110.0, 142.0, 110.0, 109.0, 108.0, 108.0, 127.0, 106.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 186.0, 185.0, 184.0, 185.0, 184.0, 186.0, 186.0, 183.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 62.0, 94.0, 61.0, 61.0, 63.0, 62.0, 74.0, 61.0], "value": 68.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 87.0, 69.0, 68.0, 70.0, 82.0, 69.0, 69.0, 84.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 89.0, 89.0, 89.0, 89.0, 89.0, 90.0, 89.0, 89.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 129.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 85.0, 86.0, 85.0, 87.0, 88.0, 87.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 64.0, 63.0, 63.0, 64.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 66.0, 69.0, 62.0, 60.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 94.0, 100.0, 87.0, 87.0, 84.0, 82.0, 87.0, 89.0, 90.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 137.0, 136.0, 133.0, 138.0, 138.0, 138.0, 185.0, 171.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 165.0, 166.0, 165.0, 166.0, 164.0, 168.0, 167.0, 219.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 66.0, 66.0, 65.0, 64.0, 63.0, 64.0, 68.0], "value": 64.9, "unit": "score"}]}]} 13:11:16 INFO - Return code: 0 13:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:11:16 ERROR - # TBPL SUCCESS # 13:11:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:11:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:11:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:11:16 INFO - 2017-03-30 13:11:16.885 screenresolution[1644:9767] starting screenresolution argv=screenresolution get 13:11:16 INFO - 2017-03-30 13:11:16.888 screenresolution[1644:9767] Display 0: 1600x1200x32@60 13:11:16 INFO - 2017-03-30 13:11:16.894 screenresolution[1645:9770] starting screenresolution argv=screenresolution list 13:11:16 INFO - Available Modes on Display 0 13:11:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:11:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:11:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:11:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:11:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:11:17 INFO - Intel Iris: 13:11:17 INFO - Chipset Model: Intel Iris 13:11:17 INFO - Type: GPU 13:11:17 INFO - Bus: Built-In 13:11:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:11:17 INFO - Vendor: Intel (0x8086) 13:11:17 INFO - Device ID: 0x0a2e 13:11:17 INFO - Revision ID: 0x0009 13:11:17 INFO - Displays: 13:11:17 INFO - Display: 13:11:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:11:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:11:17 INFO - Display Serial Number: 1600x1200 60 13:11:17 INFO - Main Display: Yes 13:11:17 INFO - Mirror: Off 13:11:17 INFO - Online: Yes 13:11:17 INFO - Rotation: Supported 13:11:17 INFO - Return code: 0 13:11:17 INFO - Running post-action listener: _resource_record_post_action 13:11:17 INFO - [mozharness: 2017-03-30 20:11:17.138687Z] Finished run-tests step (success) 13:11:17 INFO - Running post-run listener: _resource_record_post_run 13:11:17 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 49026048; Write bytes: 506715648; Read time: 678; Write time: 1676 13:11:17 INFO - TinderboxPrint: CPU usage
54.0% 13:11:17 INFO - TinderboxPrint: I/O read bytes / time
49,026,048 / 678 13:11:17 INFO - TinderboxPrint: I/O write bytes / time
506,715,648 / 1,676 13:11:17 INFO - TinderboxPrint: CPU idle
2,210.2 (46.0%) 13:11:17 INFO - TinderboxPrint: CPU system
961.6 (20.0%) 13:11:17 INFO - TinderboxPrint: CPU user
1,634.0 (34.0%) 13:11:17 INFO - TinderboxPrint: Swap in / out
252,076,032 / 0 13:11:17 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201730560; Write bytes: 200132096; Read time: 15622; Write time: 449 13:11:17 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 47125504; Write bytes: 295806976; Read time: 657; Write time: 1197 13:11:17 INFO - Running post-run listener: _upload_blobber_files 13:11:17 INFO - Blob upload gear active. 13:11:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:17 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 13:11:17 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'] 13:11:17 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 13:11:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:19 INFO - (blobuploader) - INFO - Done attempting. 13:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:20 INFO - (blobuploader) - INFO - Done attempting. 13:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:20 INFO - (blobuploader) - INFO - Done attempting. 13:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:23 INFO - (blobuploader) - INFO - Done attempting. 13:11:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:23 INFO - Return code: 0 13:11:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c652a3af36d487a86373cc80b56b0139344bd43d9e5ce3cd847260abeb598fc99a239c48cd21f85f10d0e5ef46490a03a806e4e20e0a9b1c57d71e8f3252d259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1f9c6bfa4c238d20854f7e480b74da9687381537bd02c34b77a65f481f65f70ce9076e9e8d6f27d880db47c7dd460dc2e2f6490e148a2ad58aea79672529025", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d917315382698843798dd6f665687b335fce2d45b48568055fc697f60d62874bdbcf8ceaf61bad9bba7e94e3817c65d63f4573be9a6bcd3ce382e283fcb3a402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb23df180926fd438dea900fef32680831f62ef53dd1eab775d8bd3072650e00eb2db1c6708df929128d24103926ba2d934d10c096540acda56c97fb34319050"} 13:11:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:23 INFO - Contents: 13:11:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c652a3af36d487a86373cc80b56b0139344bd43d9e5ce3cd847260abeb598fc99a239c48cd21f85f10d0e5ef46490a03a806e4e20e0a9b1c57d71e8f3252d259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1f9c6bfa4c238d20854f7e480b74da9687381537bd02c34b77a65f481f65f70ce9076e9e8d6f27d880db47c7dd460dc2e2f6490e148a2ad58aea79672529025", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d917315382698843798dd6f665687b335fce2d45b48568055fc697f60d62874bdbcf8ceaf61bad9bba7e94e3817c65d63f4573be9a6bcd3ce382e283fcb3a402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb23df180926fd438dea900fef32680831f62ef53dd1eab775d8bd3072650e00eb2db1c6708df929128d24103926ba2d934d10c096540acda56c97fb34319050"} 13:11:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:23 INFO - Copying logs to upload dir... 13:11:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.739318 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-30 13:11:23.188675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 13:11:23.192629) ========= 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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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/c652a3af36d487a86373cc80b56b0139344bd43d9e5ce3cd847260abeb598fc99a239c48cd21f85f10d0e5ef46490a03a806e4e20e0a9b1c57d71e8f3252d259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1f9c6bfa4c238d20854f7e480b74da9687381537bd02c34b77a65f481f65f70ce9076e9e8d6f27d880db47c7dd460dc2e2f6490e148a2ad58aea79672529025", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d917315382698843798dd6f665687b335fce2d45b48568055fc697f60d62874bdbcf8ceaf61bad9bba7e94e3817c65d63f4573be9a6bcd3ce382e283fcb3a402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb23df180926fd438dea900fef32680831f62ef53dd1eab775d8bd3072650e00eb2db1c6708df929128d24103926ba2d934d10c096540acda56c97fb34319050"} build_url:https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011073 build_url: 'https://queue.taskcluster.net/v1/task/WsBBKLz1T4qbyAby-mX00w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c652a3af36d487a86373cc80b56b0139344bd43d9e5ce3cd847260abeb598fc99a239c48cd21f85f10d0e5ef46490a03a806e4e20e0a9b1c57d71e8f3252d259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1f9c6bfa4c238d20854f7e480b74da9687381537bd02c34b77a65f481f65f70ce9076e9e8d6f27d880db47c7dd460dc2e2f6490e148a2ad58aea79672529025", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d917315382698843798dd6f665687b335fce2d45b48568055fc697f60d62874bdbcf8ceaf61bad9bba7e94e3817c65d63f4573be9a6bcd3ce382e283fcb3a402", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb23df180926fd438dea900fef32680831f62ef53dd1eab775d8bd3072650e00eb2db1c6708df929128d24103926ba2d934d10c096540acda56c97fb34319050"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 13:11:23.227715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:11:23.228040) ========= 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.jYY6dOFeh8/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.zwBlzZHp6r/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005173 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:11:23.277023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 13:11:23.277411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 13:11:23.277767) ========= ========= Total master_lag: 0.18 =========