builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1490974294.04 results: success (0) buildid: 20170331073706 builduid: ef7d28ac69294082b3ac09f85c7a41ce revision: 939c485875a5a118ff7b6c79c79986d818b70a38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:34.038325) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:34.038818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:34.039100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:34.844890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:34.845306) ========= 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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-31 08:31:34-- 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% 18.8M=0.001s 2017-03-31 08:31:35 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:35.020249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:35.020590) ========= 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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.026913 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:35.068948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 08:31:35.072348) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 939c485875a5a118ff7b6c79c79986d818b70a38 --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-beta --rev 939c485875a5a118ff7b6c79c79986d818b70a38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5GtwBAIt04/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.I2XMwBJyMQ/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-31 08:31:35,181 truncating revision to first 12 chars 2017-03-31 08:31:35,181 Setting DEBUG logging. 2017-03-31 08:31:35,181 attempt 1/10 2017-03-31 08:31:35,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/939c485875a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 08:31:36,345 unpacking tar archive at: mozilla-beta-939c485875a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.434824 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 08:31:36.534513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:36.535012) ========= script_repo_revision: 939c485875a5a118ff7b6c79c79986d818b70a38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:36.535625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:36.536019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 08:31:36.557636) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-31 08:31:36.558292) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5GtwBAIt04/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.I2XMwBJyMQ/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:31:36 INFO - MultiFileLogger online at 20170331 08:31:36 in /builds/slave/test 08:31:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:31:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:31:36 INFO - {'append_to_log': False, 08:31:36 INFO - 'base_work_dir': '/builds/slave/test', 08:31:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:31:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:31:36 INFO - 'branch': 'Mozilla-Beta', 08:31:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:31:36 INFO - 'config_files': ('talos/mac_config.py',), 08:31:36 INFO - 'default_actions': ('clobber', 08:31:36 INFO - 'read-buildbot-config', 08:31:36 INFO - 'download-and-extract', 08:31:36 INFO - 'populate-webroot', 08:31:36 INFO - 'create-virtualenv', 08:31:36 INFO - 'install', 08:31:36 INFO - 'run-tests'), 08:31:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:31:36 INFO - 'download_minidump_stackwalk': True, 08:31:36 INFO - 'download_symbols': 'ondemand', 08:31:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:31:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:31:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:31:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:31:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:31:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:31:36 INFO - 'installer_path': 'installer.exe', 08:31:36 INFO - 'log_level': 'info', 08:31:36 INFO - 'log_name': 'talos', 08:31:36 INFO - 'log_to_console': True, 08:31:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:31:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:31:36 INFO - 'opt_config_files': (), 08:31:36 INFO - 'pip_index': False, 08:31:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:31:36 INFO - 'cmd': ('bash', 08:31:36 INFO - '-c', 08:31:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:31:36 INFO - 'enabled': True, 08:31:36 INFO - 'halt_on_failure': False, 08:31:36 INFO - 'name': 'check_screen_resolution'},), 08:31:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:31:36 INFO - 'cmd': ('bash', 08:31:36 INFO - '-c', 08:31:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:31:36 INFO - 'enabled': True, 08:31:36 INFO - 'halt_on_failure': False, 08:31:36 INFO - 'name': 'check_screen_resolution'},), 08:31:36 INFO - 'run_cmd_checks_enabled': True, 08:31:36 INFO - 'sps_profile': False, 08:31:36 INFO - 'sps_profile_interval': 0, 08:31:36 INFO - 'suite': 'dromaeojs', 08:31:36 INFO - 'system_bits': '32', 08:31:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:31:36 INFO - 'title': 't-yosemite-r7-0312', 08:31:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:31:36 INFO - 'use_talos_json': True, 08:31:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:31:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:31:36 INFO - 'work_dir': 'build'} 08:31:36 INFO - [mozharness: 2017-03-31 15:31:36.772877Z] Running clobber step. 08:31:36 INFO - Running pre-action listener: _resource_record_pre_action 08:31:36 INFO - Running main action method: clobber 08:31:36 INFO - rmtree: /builds/slave/test/build 08:31:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:31:39 INFO - Running post-action listener: _resource_record_post_action 08:31:39 INFO - [mozharness: 2017-03-31 15:31:39.111152Z] Finished clobber step (success) 08:31:39 INFO - [mozharness: 2017-03-31 15:31:39.111288Z] Running read-buildbot-config step. 08:31:39 INFO - Running pre-action listener: _resource_record_pre_action 08:31:39 INFO - Running main action method: read_buildbot_config 08:31:39 INFO - Using buildbot properties: 08:31:39 INFO - { 08:31:39 INFO - "project": "", 08:31:39 INFO - "product": "firefox", 08:31:39 INFO - "script_repo_revision": "production", 08:31:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:31:39 INFO - "repository": "", 08:31:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:31:39 INFO - "buildid": "20170331073706", 08:31:39 INFO - "pgo_build": "False", 08:31:39 INFO - "basedir": "/builds/slave/test", 08:31:39 INFO - "buildnumber": 5, 08:31:39 INFO - "slavename": "t-yosemite-r7-0312", 08:31:39 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:31:39 INFO - "platform": "yosemite_r7", 08:31:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:31:39 INFO - "branch": "mozilla-beta", 08:31:39 INFO - "repo_path": "releases/mozilla-beta", 08:31:39 INFO - "revision": "939c485875a5a118ff7b6c79c79986d818b70a38", 08:31:39 INFO - "stage_platform": "macosx64", 08:31:39 INFO - "builduid": "ef7d28ac69294082b3ac09f85c7a41ce", 08:31:39 INFO - "slavebuilddir": "test" 08:31:39 INFO - } 08:31:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 08:31:39 INFO - Running post-action listener: _resource_record_post_action 08:31:39 INFO - [mozharness: 2017-03-31 15:31:39.114628Z] Finished read-buildbot-config step (success) 08:31:39 INFO - [mozharness: 2017-03-31 15:31:39.114770Z] Running download-and-extract step. 08:31:39 INFO - Running pre-action listener: _resource_record_pre_action 08:31:39 INFO - Running main action method: download_and_extract 08:31:39 INFO - mkdir: /builds/slave/test/build/tests 08:31:39 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')]} 08:31:39 INFO - trying https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 08:31:39 INFO - Downloading https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 08:31:40 INFO - Downloaded 1165 bytes. 08:31:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:31:40 INFO - Using the following test package requirements: 08:31:40 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:31:40 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 08:31:40 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 08:31:40 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:31:40 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 08:31:40 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:31:40 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 08:31:40 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 08:31:40 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 08:31:40 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:31:40 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 08:31:40 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 08:31:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:31:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:31:40 INFO - Fetch https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:31:40 INFO - Expected file size: 16108787 08:31:40 INFO - Obtained file size: 16108787 08:31:47 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:31:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:31:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:31:47 INFO - Fetch https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:31:48 INFO - Expected file size: 16108787 08:31:48 INFO - Obtained file size: 16108787 08:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 08:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 08:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 08:31:55 INFO - Expected file size: 14403663 08:31:55 INFO - Obtained file size: 14403663 08:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:55 INFO - trying https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:31:55 INFO - Downloading https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 08:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 08:31:57 INFO - Downloaded 58693982 bytes. 08:31:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:31:57 INFO - mkdir: /builds/slave/test/properties 08:31:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:31:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:31:57 INFO - Contents: 08:31:57 INFO - build_url:https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:31:58 INFO - Running post-action listener: _resource_record_post_action 08:31:58 INFO - Running post-action listener: set_extra_try_arguments 08:31:58 INFO - [mozharness: 2017-03-31 15:31:58.294175Z] Finished download-and-extract step (success) 08:31:58 INFO - [mozharness: 2017-03-31 15:31:58.294317Z] Running populate-webroot step. 08:31:58 INFO - Running pre-action listener: _resource_record_pre_action 08:31:58 INFO - Running main action method: populate_webroot 08:31:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:58 INFO - '--tppagecycles', 08:31:58 INFO - '7'], 08:31:58 INFO - 'tests': ['tsvgm']}}, 08:31:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:31:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:31:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:31:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['damp', 'tps']}, 08:31:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'tests': ['damp', 'tps']}, 08:31:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['dromaeo_dom']}, 08:31:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['basic_compositor_video']}, 08:31:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:31:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['a11yr', 08:31:58 INFO - 'ts_paint', 08:31:58 INFO - 'tpaint', 08:31:58 INFO - 'sessionrestore', 08:31:58 INFO - 'sessionrestore_no_auto_restore', 08:31:58 INFO - 'tabpaint']}, 08:31:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:31:58 INFO - 'ts_paint', 08:31:58 INFO - 'tpaint', 08:31:58 INFO - 'sessionrestore', 08:31:58 INFO - 'sessionrestore_no_auto_restore', 08:31:58 INFO - 'tabpaint']}, 08:31:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:31:58 INFO - 'ts_paint', 08:31:58 INFO - 'tpaint', 08:31:58 INFO - 'sessionrestore', 08:31:58 INFO - 'sessionrestore_no_auto_restore', 08:31:58 INFO - 'tabpaint']}, 08:31:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:31:58 INFO - 'ts_paint', 08:31:58 INFO - 'tpaint', 08:31:58 INFO - 'sessionrestore', 08:31:58 INFO - 'sessionrestore_no_auto_restore', 08:31:58 INFO - 'tabpaint']}, 08:31:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['a11yr', 08:31:58 INFO - 'ts_paint', 08:31:58 INFO - 'tpaint', 08:31:58 INFO - 'sessionrestore', 08:31:58 INFO - 'sessionrestore_no_auto_restore', 08:31:58 INFO - 'tabpaint']}, 08:31:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['a11yr', 08:31:58 INFO - 'ts_paint', 08:31:58 INFO - 'tpaint', 08:31:58 INFO - 'sessionrestore', 08:31:58 INFO - 'sessionrestore_no_auto_restore', 08:31:58 INFO - 'tabpaint']}, 08:31:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['tsvgx', 08:31:58 INFO - 'tsvgr_opacity', 08:31:58 INFO - 'tart', 08:31:58 INFO - 'tscrollx', 08:31:58 INFO - 'cart', 08:31:58 INFO - 'tsvg_static']}, 08:31:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:31:58 INFO - 'tsvgr_opacity', 08:31:58 INFO - 'tart', 08:31:58 INFO - 'tscrollx', 08:31:58 INFO - 'cart', 08:31:58 INFO - 'tsvg_static']}, 08:31:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'talos_options': ['--disable-e10s'], 08:31:58 INFO - 'tests': ['tp5o']}, 08:31:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:31:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'talos_options': ['--disable-e10s', 08:31:58 INFO - '--xperf_path', 08:31:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:58 INFO - 'tests': ['tp5n']}, 08:31:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:31:58 INFO - 'talos_options': ['--xperf_path', 08:31:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:58 INFO - 'tests': ['tp5n']}}, 08:31:58 INFO - 'talos.zip': {'path': '', 08:31:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:58 INFO - Running post-action listener: _resource_record_post_action 08:31:58 INFO - [mozharness: 2017-03-31 15:31:58.312710Z] Finished populate-webroot step (success) 08:31:58 INFO - [mozharness: 2017-03-31 15:31:58.312815Z] Running create-virtualenv step. 08:31:58 INFO - Running pre-action listener: _resource_record_pre_action 08:31:58 INFO - Running main action method: create_virtualenv 08:31:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:31:58 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 08:31:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:31:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:58 INFO - Using real prefix '/tools/python27' 08:31:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:31:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:01 INFO - Installing pip.................done. 08:32:01 INFO - Return code: 0 08:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:02 INFO - Reading from file tmpfile_stdout 08:32:02 INFO - Output received: 08:32:02 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) 08:32:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:02 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')]} 08:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:02 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')]} 08:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:02 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:02 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 08:32:02 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 08:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:02 INFO - 'HOME': '/Users/cltbld', 08:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:02 INFO - 'LOGNAME': 'cltbld', 08:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:02 INFO - 'MOZ_NO_REMOTE': '1', 08:32:02 INFO - 'NO_EM_RESTART': '1', 08:32:02 INFO - 'PAGER': '/bin/cat', 08:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:02 INFO - 'PWD': '/builds/slave/test', 08:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:02 INFO - 'SHELL': '/bin/bash', 08:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:02 INFO - 'USER': 'cltbld', 08:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:02 INFO - 'XPC_FLAGS': '0x0', 08:32:02 INFO - 'XPC_SERVICE_NAME': '0', 08:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:02 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 08:32:02 INFO - Cleaning up... 08:32:02 INFO - Return code: 0 08:32:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:02 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')]} 08:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:02 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')]} 08:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:02 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:02 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 08:32:02 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 08:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:02 INFO - 'HOME': '/Users/cltbld', 08:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:02 INFO - 'LOGNAME': 'cltbld', 08:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:02 INFO - 'MOZ_NO_REMOTE': '1', 08:32:02 INFO - 'NO_EM_RESTART': '1', 08:32:02 INFO - 'PAGER': '/bin/cat', 08:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:02 INFO - 'PWD': '/builds/slave/test', 08:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:02 INFO - 'SHELL': '/bin/bash', 08:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:02 INFO - 'USER': 'cltbld', 08:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:02 INFO - 'XPC_FLAGS': '0x0', 08:32:02 INFO - 'XPC_SERVICE_NAME': '0', 08:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:02 INFO - Downloading/unpacking psutil>=3.1.1 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:06 INFO - Installing collected packages: psutil 08:32:06 INFO - Running setup.py install for psutil 08:32:06 INFO - building 'psutil._psutil_osx' extension 08:32:06 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 08:32:06 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 08:32:06 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 08:32:07 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 08:32:07 INFO - building 'psutil._psutil_posix' extension 08:32:07 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 08:32:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:32:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:32:07 INFO - ^ 08:32:07 INFO - 1 warning generated. 08:32:07 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 08:32:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:07 INFO - Successfully installed psutil 08:32:07 INFO - Cleaning up... 08:32:07 INFO - Return code: 0 08:32:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:32:07 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')]} 08:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:07 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')]} 08:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:07 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:07 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 08:32:07 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 08:32:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:07 INFO - 'HOME': '/Users/cltbld', 08:32:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:07 INFO - 'LOGNAME': 'cltbld', 08:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:07 INFO - 'MOZ_NO_REMOTE': '1', 08:32:07 INFO - 'NO_EM_RESTART': '1', 08:32:07 INFO - 'PAGER': '/bin/cat', 08:32:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:07 INFO - 'PWD': '/builds/slave/test', 08:32:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:07 INFO - 'SHELL': '/bin/bash', 08:32:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:07 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:07 INFO - 'USER': 'cltbld', 08:32:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:07 INFO - 'XPC_FLAGS': '0x0', 08:32:07 INFO - 'XPC_SERVICE_NAME': '0', 08:32:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:32:07 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 08:32:07 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 08:32:07 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 08:32:07 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 08:32:07 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 08:32:07 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 08:32:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:32:10 INFO - Installing collected packages: mozsystemmonitor 08:32:10 INFO - Running setup.py install for mozsystemmonitor 08:32:10 INFO - Successfully installed mozsystemmonitor 08:32:10 INFO - Cleaning up... 08:32:10 INFO - Return code: 0 08:32:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:32:10 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')]} 08:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:10 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')]} 08:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:10 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:10 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 08:32:10 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 08:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:10 INFO - 'HOME': '/Users/cltbld', 08:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:10 INFO - 'LOGNAME': 'cltbld', 08:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:10 INFO - 'MOZ_NO_REMOTE': '1', 08:32:10 INFO - 'NO_EM_RESTART': '1', 08:32:10 INFO - 'PAGER': '/bin/cat', 08:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:10 INFO - 'PWD': '/builds/slave/test', 08:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:10 INFO - 'SHELL': '/bin/bash', 08:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:10 INFO - 'USER': 'cltbld', 08:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:10 INFO - 'XPC_FLAGS': '0x0', 08:32:10 INFO - 'XPC_SERVICE_NAME': '0', 08:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:10 INFO - Downloading/unpacking jsonschema==2.5.1 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:32:13 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 08:32:13 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 08:32:13 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 08:32:13 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 08:32:13 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 08:32:13 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 08:32:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:13 INFO - warning: no files found matching '*.txt' 08:32:13 INFO - no previously-included directories found matching 'build' 08:32:13 INFO - no previously-included directories found matching 'dist' 08:32:13 INFO - no previously-included directories found matching '.git*' 08:32:13 INFO - Installing collected packages: jsonschema, functools32 08:32:14 INFO - Running setup.py install for functools32 08:32:14 INFO - warning: no files found matching '*.txt' 08:32:14 INFO - no previously-included directories found matching 'build' 08:32:14 INFO - no previously-included directories found matching 'dist' 08:32:14 INFO - no previously-included directories found matching '.git*' 08:32:14 INFO - Successfully installed jsonschema functools32 08:32:14 INFO - Cleaning up... 08:32:14 INFO - Return code: 0 08:32:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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', '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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:32: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 functools32==3.2.3-2 08:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:14 INFO - 'HOME': '/Users/cltbld', 08:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:14 INFO - 'LOGNAME': 'cltbld', 08:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:14 INFO - 'MOZ_NO_REMOTE': '1', 08:32:14 INFO - 'NO_EM_RESTART': '1', 08:32:14 INFO - 'PAGER': '/bin/cat', 08:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:14 INFO - 'PWD': '/builds/slave/test', 08:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:14 INFO - 'SHELL': '/bin/bash', 08:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:14 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:14 INFO - 'USER': 'cltbld', 08:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:14 INFO - 'XPC_FLAGS': '0x0', 08:32:14 INFO - 'XPC_SERVICE_NAME': '0', 08:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:32:14 INFO - Cleaning up... 08:32:14 INFO - Return code: 0 08:32:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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', '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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:32: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 blobuploader==1.2.4 08:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:14 INFO - 'HOME': '/Users/cltbld', 08:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:14 INFO - 'LOGNAME': 'cltbld', 08:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:14 INFO - 'MOZ_NO_REMOTE': '1', 08:32:14 INFO - 'NO_EM_RESTART': '1', 08:32:14 INFO - 'PAGER': '/bin/cat', 08:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:14 INFO - 'PWD': '/builds/slave/test', 08:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:14 INFO - 'SHELL': '/bin/bash', 08:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:14 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:14 INFO - 'USER': 'cltbld', 08:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:14 INFO - 'XPC_FLAGS': '0x0', 08:32:14 INFO - 'XPC_SERVICE_NAME': '0', 08:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:17 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 08:32:17 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 08:32:17 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 08:32:17 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 08:32:17 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 08:32:17 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 08:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:18 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 08:32:18 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 08:32:18 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 08:32:18 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 08:32:18 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 08:32:18 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 08:32:18 INFO - Downloading docopt-0.6.1.tar.gz 08:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:18 INFO - Running setup.py install for blobuploader 08:32:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:18 INFO - Running setup.py install for requests 08:32:19 INFO - Running setup.py install for docopt 08:32:19 INFO - Successfully installed blobuploader requests docopt 08:32:19 INFO - Cleaning up... 08:32:19 INFO - Return code: 0 08:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:20 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')]} 08:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:20 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:20 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 08:32:20 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 08:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:20 INFO - 'HOME': '/Users/cltbld', 08:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:20 INFO - 'LOGNAME': 'cltbld', 08:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:20 INFO - 'MOZ_NO_REMOTE': '1', 08:32:20 INFO - 'NO_EM_RESTART': '1', 08:32:20 INFO - 'PAGER': '/bin/cat', 08:32:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:20 INFO - 'PWD': '/builds/slave/test', 08:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:20 INFO - 'SHELL': '/bin/bash', 08:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:20 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:20 INFO - 'USER': 'cltbld', 08:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:20 INFO - 'XPC_FLAGS': '0x0', 08:32:20 INFO - 'XPC_SERVICE_NAME': '0', 08:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-REYYkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0MC6si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CxzOy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wXfoYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TFE0XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4t2pEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xeOL9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jWPGbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-T2_jX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-8PoeJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SqFDfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Mz2xmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MRnFBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-mJaZBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-vgeNmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CuV7K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0vE8TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:22 INFO - Running setup.py install for manifestparser 08:32:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:22 INFO - Running setup.py install for mozcrash 08:32:22 INFO - Running setup.py install for mozdebug 08:32:22 INFO - Running setup.py install for mozdevice 08:32:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Running setup.py install for mozfile 08:32:23 INFO - Running setup.py install for mozhttpd 08:32:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Running setup.py install for mozinfo 08:32:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Running setup.py install for mozInstall 08:32:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:23 INFO - Running setup.py install for mozleak 08:32:23 INFO - Running setup.py install for mozlog 08:32:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:24 INFO - Running setup.py install for moznetwork 08:32:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:24 INFO - Running setup.py install for mozprocess 08:32:24 INFO - Running setup.py install for mozprofile 08:32:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:24 INFO - Running setup.py install for mozrunner 08:32:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:24 INFO - Running setup.py install for mozscreenshot 08:32:24 INFO - Running setup.py install for moztest 08:32:24 INFO - Running setup.py install for mozversion 08:32:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:25 INFO - Cleaning up... 08:32:25 INFO - Return code: 0 08:32:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:25 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')]} 08:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 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')]} 08:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:25 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 08:32:25 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 08:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:25 INFO - 'HOME': '/Users/cltbld', 08:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:25 INFO - 'LOGNAME': 'cltbld', 08:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:25 INFO - 'MOZ_NO_REMOTE': '1', 08:32:25 INFO - 'NO_EM_RESTART': '1', 08:32:25 INFO - 'PAGER': '/bin/cat', 08:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:25 INFO - 'PWD': '/builds/slave/test', 08:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:25 INFO - 'SHELL': '/bin/bash', 08:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:25 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:25 INFO - 'USER': 'cltbld', 08:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:25 INFO - 'XPC_FLAGS': '0x0', 08:32:25 INFO - 'XPC_SERVICE_NAME': '0', 08:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UR9Fx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xpe48O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-GvkPAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Pj4orn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cc9KuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wWSzzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0b1aXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:26 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)) 08:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-JmUJQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-o2jPaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SZ1gBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-bjkWT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Vy1Yav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-w33gBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-eJZnHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ee8Ni7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ybLjVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:27 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)) 08:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-RNB5B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:27 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)) 08:32:27 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)) 08:32:27 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)) 08:32:27 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)) 08:32:27 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)) 08:32:27 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)) 08:32:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:31 INFO - Downloading blessings-1.6.tar.gz 08:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:31 INFO - Installing collected packages: blessings 08:32:31 INFO - Running setup.py install for blessings 08:32:31 INFO - Successfully installed blessings 08:32:31 INFO - Cleaning up... 08:32:31 INFO - Return code: 0 08:32:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:31 INFO - Reading from file tmpfile_stdout 08:32:31 INFO - Current package versions: 08:32:31 INFO - blessings == 1.6 08:32:31 INFO - blobuploader == 1.2.4 08:32:31 INFO - docopt == 0.6.1 08:32:31 INFO - functools32 == 3.2.3-2 08:32:31 INFO - jsonschema == 2.5.1 08:32:31 INFO - manifestparser == 1.1 08:32:31 INFO - mozInstall == 1.12 08:32:31 INFO - mozcrash == 1.0 08:32:31 INFO - mozdebug == 0.1 08:32:31 INFO - mozdevice == 0.49 08:32:31 INFO - mozfile == 1.2 08:32:31 INFO - mozhttpd == 0.7 08:32:31 INFO - mozinfo == 0.9 08:32:31 INFO - mozleak == 0.1 08:32:31 INFO - mozlog == 3.4 08:32:31 INFO - moznetwork == 0.27 08:32:31 INFO - mozprocess == 0.24 08:32:31 INFO - mozprofile == 0.28 08:32:31 INFO - mozrunner == 6.13 08:32:31 INFO - mozscreenshot == 0.1 08:32:31 INFO - mozsystemmonitor == 0.3 08:32:31 INFO - moztest == 0.8 08:32:31 INFO - mozversion == 1.4 08:32:31 INFO - psutil == 3.1.1 08:32:31 INFO - requests == 1.2.3 08:32:31 INFO - wsgiref == 0.1.2 08:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:31 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 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:31 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 08:32:31 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 08:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:31 INFO - 'HOME': '/Users/cltbld', 08:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:31 INFO - 'LOGNAME': 'cltbld', 08:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:31 INFO - 'MOZ_NO_REMOTE': '1', 08:32:31 INFO - 'NO_EM_RESTART': '1', 08:32:31 INFO - 'PAGER': '/bin/cat', 08:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:31 INFO - 'PWD': '/builds/slave/test', 08:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:31 INFO - 'SHELL': '/bin/bash', 08:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:31 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:31 INFO - 'USER': 'cltbld', 08:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:31 INFO - 'XPC_FLAGS': '0x0', 08:32:31 INFO - 'XPC_SERVICE_NAME': '0', 08:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 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)) 08:32:31 INFO - Cleaning up... 08:32:31 INFO - Return code: 0 08:32:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10261fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102622768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0324a3580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, '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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 08:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:31 INFO - 'HOME': '/Users/cltbld', 08:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:31 INFO - 'LOGNAME': 'cltbld', 08:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:31 INFO - 'MOZ_NO_REMOTE': '1', 08:32:31 INFO - 'NO_EM_RESTART': '1', 08:32:31 INFO - 'PAGER': '/bin/cat', 08:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:31 INFO - 'PWD': '/builds/slave/test', 08:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:31 INFO - 'SHELL': '/bin/bash', 08:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:31 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:31 INFO - 'USER': 'cltbld', 08:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:31 INFO - 'XPC_FLAGS': '0x0', 08:32:31 INFO - 'XPC_SERVICE_NAME': '0', 08:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:32:32 INFO - Cleaning up... 08:32:32 INFO - Return code: 0 08:32:32 INFO - Running post-action listener: _resource_record_post_action 08:32:32 INFO - Running post-action listener: _start_resource_monitoring 08:32:32 INFO - Starting resource monitoring. 08:32:32 INFO - [mozharness: 2017-03-31 15:32:32.288458Z] Finished create-virtualenv step (success) 08:32:32 INFO - [mozharness: 2017-03-31 15:32:32.289444Z] Running install step. 08:32:32 INFO - Running pre-action listener: _resource_record_pre_action 08:32:32 INFO - Running main action method: install 08:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:32 INFO - Reading from file tmpfile_stdout 08:32:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:32 INFO - Reading from file tmpfile_stdout 08:32:32 INFO - Output received: 08:32:32 INFO - Usage: mozinstall [options] installer 08:32:32 INFO - Options: 08:32:32 INFO - -h, --help show this help message and exit 08:32:32 INFO - -d DEST, --destination=DEST 08:32:32 INFO - Directory to install application into. [default: 08:32:32 INFO - "/builds/slave/test"] 08:32:32 INFO - --app=APP Application being installed. [default: firefox] 08:32:32 INFO - mkdir: /builds/slave/test/build/application 08:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:32:47 INFO - Reading from file tmpfile_stdout 08:32:47 INFO - Output received: 08:32:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:32:47 INFO - Running post-action listener: _resource_record_post_action 08:32:47 INFO - [mozharness: 2017-03-31 15:32:47.149278Z] Finished install step (success) 08:32:47 INFO - [mozharness: 2017-03-31 15:32:47.149419Z] Running run-tests step. 08:32:47 INFO - Running pre-action listener: _resource_record_pre_action 08:32:47 INFO - Running main action method: run_tests 08:32:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:32:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:32:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:32:47 INFO - 2017-03-31 08:32:47.163 screenresolution[1625:7299] starting screenresolution argv=screenresolution get 08:32:47 INFO - 2017-03-31 08:32:47.166 screenresolution[1625:7299] Display 0: 1600x1200x32@60 08:32:47 INFO - 2017-03-31 08:32:47.172 screenresolution[1626:7301] starting screenresolution argv=screenresolution list 08:32:47 INFO - Available Modes on Display 0 08:32:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:32:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:32:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:32:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:32:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:32:47 INFO - Intel Iris: 08:32:47 INFO - Chipset Model: Intel Iris 08:32:47 INFO - Type: GPU 08:32:47 INFO - Bus: Built-In 08:32:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:32:47 INFO - Vendor: Intel (0x8086) 08:32:47 INFO - Device ID: 0x0a2e 08:32:47 INFO - Revision ID: 0x0009 08:32:47 INFO - Displays: 08:32:47 INFO - Display: 08:32:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:32:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:32:47 INFO - Display Serial Number: 1600x1200 60 08:32:47 INFO - Main Display: Yes 08:32:47 INFO - Mirror: Off 08:32:47 INFO - Online: Yes 08:32:47 INFO - Rotation: Supported 08:32:47 INFO - Return code: 0 08:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:32:47 INFO - Python 2.7.3 08:32:47 INFO - Return code: 0 08:32:47 INFO - grabbing minidump binary from tooltool 08:32:47 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')]} 08:32:47 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 0x1023fdd30>, '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 0x102324db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:47 INFO - Return code: 0 08:32:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:32:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:32:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:32:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:32:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 08:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 08:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GtwBAIt04/Render', 08:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:47 INFO - 'HOME': '/Users/cltbld', 08:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:47 INFO - 'LOGNAME': 'cltbld', 08:32:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:32:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:47 INFO - 'MOZ_NO_REMOTE': '1', 08:32:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:32:47 INFO - 'NO_EM_RESTART': '1', 08:32:47 INFO - 'PAGER': '/bin/cat', 08:32:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:47 INFO - 'PWD': '/builds/slave/test', 08:32:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:47 INFO - 'SHELL': '/bin/bash', 08:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I2XMwBJyMQ/Listeners', 08:32:47 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 08:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:47 INFO - 'USER': 'cltbld', 08:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:47 INFO - 'XPC_FLAGS': '0x0', 08:32:47 INFO - 'XPC_SERVICE_NAME': '0', 08:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 08:32:47 INFO - mozversion application_buildid: 20170331073706 08:32:47 INFO - mozversion application_changeset: 939c485875a5a118ff7b6c79c79986d818b70a38 08:32:47 INFO - mozversion application_display_name: Firefox 08:32:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:47 INFO - mozversion application_name: Firefox 08:32:47 INFO - mozversion application_remotingname: firefox 08:32:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:32:47 INFO - mozversion application_vendor: Mozilla 08:32:47 INFO - mozversion application_version: 53.0 08:32:47 INFO - mozversion platform_buildid: 20170331073706 08:32:47 INFO - mozversion platform_changeset: 939c485875a5a118ff7b6c79c79986d818b70a38 08:32:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:32:47 INFO - mozversion platform_version: 53.0 08:32:47 INFO - using testdate: 1490974367 08:32:47 INFO - actual date: 1490974367 08:32:47 INFO - starting webserver on 'localhost:49246' 08:32:47 INFO - SUITE-START | Running 2 tests 08:32:47 INFO - TEST-START | dromaeo_css 08:32:47 INFO - operating with platform_type : mac_ 08:32:47 INFO - Initialising browser for dromaeo_css test... 08:32:47 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpTVXNab/profile http://localhost:49246/getInfo.html) 08:32:50 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 08:32:50 INFO - PROCESS | 1636 | colorDepth:24 08:32:50 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 08:32:50 INFO - PROCESS | 1636 | __metrics 08:32:50 INFO - PROCESS | 1636 | 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" 08:32:50 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:51 INFO - TEST-INFO | 1636: exit 0 08:32:51 INFO - Browser initialized. 08:32:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:32:51 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpTVXNab/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:02 INFO - PROCESS | 1639 | RSS: Main: 167350272 08:33:02 INFO - PROCESS | 1639 | 08:36:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 08:36:07 INFO - PROCESS | 1639 | RSS: Main: 318640128 08:36:07 INFO - PROCESS | 1639 | 08:39:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 08:39:10 INFO - PROCESS | 1639 | RSS: Main: 307912704 08:39:10 INFO - PROCESS | 1639 | 08:42:12 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 08:42:13 INFO - PROCESS | 1639 | RSS: Main: 275218432 08:42:13 INFO - PROCESS | 1639 | 08:45:15 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 08:45:16 INFO - PROCESS | 1639 | RSS: Main: 289439744 08:45:16 INFO - PROCESS | 1639 | 08:48:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 08:48:20 INFO - PROCESS | 1639 | RSS: Main: 274595840 08:48:20 INFO - PROCESS | 1639 | 08:51:23 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 08:51:24 INFO - PROCESS | 1639 | RSS: Main: 431890432 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | __start_tp_report 08:51:24 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:51:24 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:51:24 INFO - PROCESS | 1639 | |i|pagename|runs| 08:51:24 INFO - PROCESS | 1639 | |0;dojo.html;3317.3696997570473;3341.131305860477;3349.8492567834446;3367.595888493381;3409.5397121388614;5680.289963754531;5736.368999410061;5755.568332375078;5762.308522977238;5769.740361683724;5027.723475208862;5656.925184214996;5722.885542289162;5815.941840581593;5817.127430885369;5205.843824685266;5220.190870415092;5238.1357076082495;5250.396204436482;5285;5182.844514664547;5193.428722840504;5193.766280517386;5321.733913304339;5322.0952438085615;5199.662021968579;5240.842774716745;5252.36971563411;5291.1798671206025;5319.042572336978;5290.4974027467715;5293.153095504701;5299.788008479656;5302.734863256822;5312.468753124676;5101.0308041472;5138.614603904722;5204.661696989721;5210.01009808139;5267.157254839208;5628.296462942132;5639.097744360924;5714.399988001242;5718.34239062509;5726.942730572724;6260.968695156541;6320.494360451153;6324.177856878622;6329.272133704637;6353.587016843937;6275.937240627627;6359.586626869285;6366.6180029198395;6375.362463753588;6377.744890204386;5795.449432303924;5846.093855452412;5857.912131318034;5910.734016969247;5938.228030356069;6236.438720515175;6285.371462853769;6300.180976473121;6341.55609107358;6342.460890824239;6191.25704915413;6199.3490683478485;6217.751289948442;6233.189685340877;6244.1570387997035;6206;6272.968635156795;6275.309715931244;6341.873162536724;6351.523635727246;6175.104609831549;6237;6250.843728906722;6288.842778930563;6324.71538780756;6337.334579869047;6338.841528961812;6346.238451385863;6351.650659213788;6359.523035772336;5019.598432125421;5026.522480364432;5029.220470827027;5034.874128146826;5042.445331013586;4364.8254069837485;4445.977770111129;4447.911041779146;4460.30865215892;4495.955040449554;5625.38120806711;5645.266115404971;5748.338941021752;5894.734736936848;5905.232319798399;5567.498925096761;6284.937150628527;6296.181496405438;6307.905381419282;6335.809925702236;5604;5744.798932037359;5835.44563266489;5860.677662728591;5881.411858814085;5441.863953401117;5461.617686761968;5476.945230547643;5489.917651235235;5520.392756796749;5225.3207083079715;6294.748210071637;6295.055741638791;6326.304106548276;6328.493720502441;6288.654124023223;6291.559590828598;6306;6337.271213810471;6341.936580634135;6251.874962500634;6262.561620686508;6271.874562508816;6299.30707622152;6302.180716506825;5249.396319423316;6297.4017468340435;6317.305096439296;6333.303336633059;6337.90493142594;6182.258129024546;6320.841978950563;6342.809715708536;6359.8092057238355;6367.331430199948;6048;6119.051547010221;6175.2589689237575;6229.719662615284;6246.968765156145;6127.892078906909;6147.016477363601;6203.0075187969705;6223.315435302204;6245.156903817927;6090.512758979183;6092.025275955826;6103.664298463627;6110.2868817655635;6112.116811553812;6059.6364218147055;6165.445109940127;6166.691665416801;6228.5951413158;6274.623522588659;5733.913991290051;5950.2264705587995;6041.69791510414;6092.360302168386;6138 08:51:24 INFO - PROCESS | 1639 | |1;ext.html;446.8034065011395;504.684572142411;539.3446961941241;539.8380485854243;540.1465684218934;29834.850825745867;33529.32941341172;33556.4966525502;40506;42965.78517107418;44076.77961610196;44360.55639443605;44637.7768111159;44676;44764.552354476444;9423.575939082757;9655.46894920779;9659;9660.90339096607;9684.983076776942;8866.468011919273;9100.99889012208;9568.995255498177;11693.473793679304;12017.819732703972;11737.941310293436;11827.526898924032;11830.408479575986;11830.763384732343;11853.348065856375;11864.050875929948;11936.58221962227;11947.58183463579;11947.701307467383;11960.58137965167;11736.119791015708;11830.822537661941;11839.644810655695;11844.940775296069;11848.17062805604;41179.588204118176;41390.965225869295;41425.1714965702;41504;41544.37683434751;4044.3529035354204;4066.4916885389325;4104.281750693646;4126.814293356806;4142.5028996520305;29383.55924661132;30407.23981900448;31223.531647025313;31362;31499.842500787578;3274.6889045540634;3330.6835850594157;3472.340255351475;3522.172289511963;3529.6117427083;484500.5774971138;491012;492014.53992730164;492124;494047;59179;59573;59616.70191649101;59627.701861490415;59648;62815.74368512604;62916.05625915615;63002.68498657569;63049;63074.369256307764;17113;17284.567885802702;17289.48131556055;17300.394486192923;17320.30718771235;13188.208707477583;13267.336633168303;13277.867221327857;13296.335183240994;13312.600621981355;16357.591060223589;16722.916385418237;16747.162641867857;17014.72851176091;18181;8073.717419890276;8227.876581851277;8236.546989915492;8239.588020599065;8246.793830154294;826.7602395305414;901.6258252825004;915.624593916491;950.6245033211843;957.2389949989636;28879.42241155165;29259.829606815914;29269.56095658567;31224.843875780476;31419.371612567622;1103.7902798468265;1105.5909313554037;1144.2848219862585;1149.1438878035917;1183.3728124094243;15253.542393728207;15790.842091579167;16257.943233689772;16378;16695.332186712396;640354;643324;645919;646029.7698511571;646965;55043;55667.44332556704;62154.68922655358;62289.377106228356;63297.36702632915;1492.5074725340612;1496.8503149684943;1497.2738221962557;1511.60698218464;1517.2944580769995;27826.16521504358;30818;32539;32557.674423256412;32586.39766350043;46924.29613555731;47220.29169562528;47284.7635761819;47406.762966186325;47505.76247118742;482049;771463;774311;776091;776129;22556.32331030072;27675.584866227426;27740.58389124205;27930;28062.579061314504;48533.27200091931;48567.514324857715;49155.754221228664;49630;49695.751521242164;32912.1771955703;33432.665673342955;33481.66518334883;33728.49407258942;34069.148271293416;33169.66830331762;33308.666913330555;33929.83035084809;34229.31541369109;34560.65439345675;38332.425013625376;39504.60495395009;39564.81305560838;39624.40563391609;39648.40527392149;32743.345133097682;32809;33155.668443315255;34329;34443.655563444045;24450.266492005267;25657.871710642074;25687.486250275262;25864.99830098576;25915.352116197246 08:51:24 INFO - PROCESS | 1639 | |2;jquery.html;391.6905644540813;396.6033966033966;397.5686380277399;405.624797062717;425.36408069935453;21151.57696846062;21529.784702152974;21705.240316588923;22416.66375004372;22670.54658906821;22440.214592489265;22755.658665120038;23434.765652343514;23449;23690.5261894762;5764.423557644233;5998.910016349758;6127.662978536178;6138.47822935051;6147.170132032164;5856.795012174574;6029.909551356734;6043.939560604382;6098.359672234418;6111.816645500619;6035.668038257894;6049.606775559597;6055.818325450244;6056.000759874615;6060.939390606081;5766.942330576703;5936.5547583931375;6017.72920218589;6040.788572399989;6041.305249896231;5160.690358578459;5237.847673511821;5295.0998330283555;5296.09966305729;5304.6286759926825;27386;27691;27697.307567310778;27741;28032.579511307347;2436.6832311799353;2539.8349107307968;2773.653293338333;2792.4524565164506;2798.174538511144;13805.378757955916;15946.441874534452;16315.184429072522;16333.673326533402;16629;1774.299151835031;1820.9271629134819;1821.089455272364;1831.3681779785952;1857.2756624916294;119851;125785.11322330173;126721;126820.36589817084;128856.99999999907;10319.535620896928;11256;11716.121290903217;11762.529498820122;11917.642470725892;15254.161021143722;15267.465638702814;15278.388864445298;15286.617834554225;15310.464133755266;8822.691205807765;9093.40892841963;9127.680531181377;9251.814963700823;9277.814443711088;9103.135202155785;9113.77215569616;9115.863262051074;9138.17756401927;9333.766655833659;7353.154387245429;7469.178390377054;7471.215522370073;7503.474756766974;7503.662335194929;1972.9506762331057;1998.381311137983;2010.4069299556666;2010.6179825833044;2010.8592398532255;995.9253056020683;1077.8706555213425;1087.0922779479065;1099.4887377369562;1152.2222499812592;19141.80858191428;23720.7627923722;23768.524629507312;23771.168009119945;23887.044518219423;1107.839363292318;1111.8832522585012;1123.984947514356;1155.5435602936793;1156.6414411532453;11992.280463172237;12273.509059637692;12404.007679385628;12418.944389726974;12509.624711258677;398798;680350;704531;774615;802348;116180.41909790566;121835.42563456457;129340.41319173564;133776;134785;1028.3058935218846;1055.4617145255975;1056.2447849787438;1135.0862555642623;1138.2942575603013;19528.90235548813;19833.30583429573;20265.189392424138;20296.289629862884;20329.695054574488;46880.53119468762;52199.73900130627;53066.73466632642;55840;56381.87236255334;75654;75969.62015189888;76506.2349376499;77380;77661.4467710654;7523.360514356341;7616.276453736886;7767.106782719833;7907.604619768874;8010.519368837655;12333.876661233631;13012.349382531025;13137.737245255232;13469.865301347254;13518.25649589282;11248.718782030515;11533.078658624778;11685.474153662935;11794.823077653671;11876.228045177382;10762;10814.188935829687;10886.49610589553;10903.672889813319;11315.943420282845;11634.243774154653;11680.883191167979;11742.236754610924;11825.586104486645;12069.215500992408;7342.229065947999;7684.538927664358;7730.11103723079;7848;8039.959800200962;8656.91343086561;8816.471011739317;9129.45223286605;9147;9175.403598766059 08:51:24 INFO - PROCESS | 1639 | |3;mootools.html;1245.7757603631342;1496.3864815425677;1516.5450364890532;1518.2181176694005;1530.3266562712402;6930.480213983946;7762.563925673748;8050.436469447133;8593.269572086365;8599.91400085999;8527.360447966395;8609.56952152393;8611.569421528915;8619.353548483874;8627.396082274243;2383;2431.9756802431925;2444.27893771337;2449.448874003344;2450.0934654177977;2182.1053368119074;2268.104098880941;2404.362843846382;2473.2332976777166;2488.688913885764;2424.0560023416942;2444.340028192387;2445.8899349529315;2447.1434997750735;2452.1172377943926;2440.170342083691;2457.7910877575428;2458.21337172105;2461.3354394313615;2467.3954881054256;2424.933029467029;2430.635404689293;2460.7785299323145;2465.778079972811;2472.5920223163157;8663.306935445213;8719.869201961976;8744.606492707844;8755.3871229014;8783.12168783123;5258.92111618326;5416.83749487516;5427.701476418795;5431.565474762049;5437.510624043855;3409.3522230776075;3426.9485957710654;3516.384632689269;3632.5822530409077;3636.981815090934;1184.1178322150054;1211.2550781269545;1233.0813543909755;1245.8973808179735;1286.9420876060506;11145.442727863574;11230.270032447865;11243.718907027389;11245.493952772145;11260.662180134608;4179.435776170239;4529.252673308933;4730.394348564849;4822.276658501182;4889.168841296988;9783.168430683472;9793.21654267657;9803.313768036312;9812.165965892978;9813.264005199639;5307.4692530746615;5409.891802163935;5437.755301011385;5461.972690136524;5467.5625949923915;4539.0921815637;4798.23228283473;4941.876453088702;4971.90056198874;4973.825916092919;3815.027168072124;3825.3688141456905;3830.042489377656;3834.328992426314;3835.175437280998;1269.320913311374;1277.757226127033;1314.5004898138836;1315.605318404475;1318.9340532973313;779.5128044971892;922.9400088994194;934.3272843552631;940.2478017585904;940.7507010642186;5625.634333768292;5704.572157088152;5841.386654401226;5857;6097.481714054266;987.807377561383;1003.2174903575223;1023.7287118913493;1048.3552615141784;1069.5240617924949;3790.298794722985;3885.86399476017;3905.082305658168;3938.4879965604287;3999.6600288975183;10059.044390782863;10239.539220735085;10301.124404425558;10318.793624127626;10368.585256589651;10244.59021639141;10253.84619230712;10273.897261027443;10289.816671082772;10289.845652315222;7369.77890663281;7924.722634707758;8043.839123217503;8104.756857294291;8123.025236971601;5332.586864480993;5934.525237980864;5949.868599187718;5950.2264705587995;6096.177016102947;8613.397062205586;9493.66772162971;9562.665306714232;9613.134817866425;9777.21782257432;9540;9617.903820961701;9689.41863488193;9728.319017668695;9792.167665748491;7319.231480694663;7392.112946446461;7449.6275186241555;7528.962355188189;7532.7740167795055;7391.260873912565;8091.150429205084;8177.386695997943;8187.959060204899;8196.918030819616;6472.385123413268;6824.829379265558;6996.580205187705;7044.718211271492;7080.858382832417;6825.453963682794;6902.827429314308;6933.2720064392515;6963.303669632996;6967.09427774386;5233.842984710464;6446.7098980546925;6518.543701940818;6524.67376631176;6567.179102612174;4458.398116254264;4948.2082866742585;4977.122420028465;5131.179011358165;5153.5361817436615;4972.403311602486;5008.6243531734535;5123.795048198031;5195.090859099567;5270.973645131903 08:51:24 INFO - PROCESS | 1639 | |4;prototype.html;367.21965822626913;368.756620630384;375.91541903071806;384.18169299392326;389.3925476257039;4328.6537077033845;4390.034192477658;4776.928346074812;5449.1553809159595;5481.808136715215;4153.335466325389;4465.508794032654;5302.045631786277;5324.710374538947;5331.733413329337;3648.8358023888854;4122.835086596532;4191.664666826662;4215.894602634943;4227.894302642428;3165.0821261834158;4092.9386059208987;4097.959020409788;4146.857896208695;4211.536730959608;3641.8725344612944;4144.564820693829;4194.769287689176;4199.45407097077;4200.537940826506;3738.7848949091517;3999.2601368746873;4044.4944381952255;4102.466679331697;4114.732542384751;3685.7235707322056;3686.447032945053;3690.8892733218045;3705;3706.369917114097;5249;5280.07598670235;5320.76056577455;5351.866203344908;5353.652012619167;4352.455943007124;4496.055828276066;4625.8149674013;4661.650376221763;4896.3389942358035;4993.90012199754;5277.47225277473;5606.2060140754975;5612.943870561283;5678.630888992202;3346.8828590999196;3867.961320386816;3888.650021498079;3921.8431262749455;3977.1846771411792;4850.410696084907;5957.6127551709;6022.6937739516015;6074.51403887688;6107.72515236811;4273.401723758676;4283;4293.69944103916;4308.289132293136;4323.848665296699;3983.4423180754716;4415.366314463669;4419.11617676466;4439.778011099432;4453.265211240109;4643.512431194744;4754.595859351994;4962.528559786814;4971.726555039435;5026.271190677405;4764.880877978009;4930.802767889244;5303.708296043677;5649.322081350264;5773.90053062322;1208.5347141350644;1314.737052589486;1347.6927380440957;1371.6433727230992;1401.9649508762363;854.6111519258723;904.1139683110589;950.3917492804611;963.3882484622176;964.4840010594298;3940.192260586573;4068.3287257602165;5003.724050367206;5008.724520151354;5022.874428139253;5062.544665837066;5079.263506791568;5144.819931302462;5276.894462110737;5619.67937534679;4308.116836048603;4348.934511044814;4523.914260577503;4627.444706635225;5007.674501157413;2449.4488740033707;2658.57462805954;2712.734866386589;2752.559590465516;2923.2460523686045;5190.429052804188;5347.81282655113;5396.568274538027;5494.80768173112;5803.8549036274435;4759.809607615656;4972.950270497248;5215.24378965048;5326.5206131447585;5499.972500137474;4753.502646666289;5702.515286200636;5748.798792042258;5750.281214848061;5819.5635327351465;4619.214733495247;4859.95140048595;5091.821786237464;5676.545876329967;5676.921384936849;4443.511213766547;4958.231474121517;5484.862878428071;5515.862103447446;5545.334559852843;4728.834490792943;4894.314795928644;5522;5736.246601631157;5780.364159942487;3754.9061273468383;3757.4363845423404;3803.7337386382687;3804.619538046173;3806.6954643628997;4775.5463230993;5201.791928322825;5283.494204151798;5436.809711660073;5450.892990995253;4843.588294994824;4936.925946110883;5638.661680299195;5677.933915685649;5682.829515114553;5622.297212848394;5623.875224954943;5627.971860140673;5645.774169033192;5690.487856092972;4620.283856002325;4721;5233.613092530559;5342.98483288174;5542.473465020817;4537.705049171794;4757.5718185363485;4932.30947667334;5658.264425624642;5692.861427714391;5240.816571419982;5525.320219693365;5557.5831812613405;5582.358028826737;5582.720863956704 08:51:24 INFO - PROCESS | 1639 | |5;yui.html;739.7595781371056;748.7042618165829;778.3461892010711;803.3773825285404;886.6896586194831;14855.925720371397;15225.086494810304;15824.446144384949;15848.68302633948;15849.92075039626;14109.365078571464;14195.006349555535;14363;14527.78208326876;14576.125432474033;783.7883771381723;898.9820203595924;911.731039343392;913.6436789652041;915.8488849339851;721.4444877444365;746.8244962433823;762.3596179209463;890.9465432074064;919.4575200631626;942.3780304998702;956.4548207521715;957.6839642917855;958.5782255807422;958.7075941837737;950.2587981374504;950.3917492804611;952.4999375327939;952.5380190607584;956.8564715292692;715.1061173533084;717.3722992381666;718.0163176448247;719.4783781758235;719.597025665629;15432;15541.300641471162;15657.686846263012;15737.842621573753;16030.278637461342;14761;14825.925870370687;14969;15217.847821521864;15325.003874748105;11747.659161994994;11790.528378864836;11932;11943.462544185446;12365.258084514868;3767.020574650583;3799.67702745267;3814;3951.7431366961055;4050.8784736457956;79673;85714.71427928586;85972.57013714954;97447;98690;10749.08632766208;10904.945475272572;11310.60412885545;11393.772124557463;12218.144729869002;22196.334109976728;22697.65953510699;22920.541589168122;22987.42531436694;23027.424314392276;7759.844803104019;7903.209679032166;7973.043234811859;8013.998250218722;8120.553369564731;4367.432233809584;4386.232409328419;4413.984783499749;4499.482559505634;4630.699004564693;3468.4103702370658;3542.822858857047;3570.8750193743094;3906.7069969752383;4108.322126849036;719.9856002879914;721.8375865430236;733.4535770850644;736.1865139021411;745.9216782237895;693.6982412650514;711.2816055783695;712.0529695504966;729.212450553401;772.97681069568;8907.821843563092;9968.302218844756;10544.367337959748;10657.745385029011;10933.453327333602;691.882379995402;693.445243804954;704.9647517624098;721.1706537481938;730.1749023603294;5296.576273898079;5442.102053161263;5563.777448902079;5571.498565129158;5799.3620701722775;99060;105693;105726.47136764268;106094.46952765186;106916;65059;88183;89389;90766;92203.15593688223;54889.72555137199;71713.64143179251;72178.2782172182;77237.99999999888;77299;10896.509657065293;11064.612738554433;11075.72310692239;11357.318560886373;11482.483288252215;35585;46677;46769.766151169024;46790;49717;59879.401205987386;60319.095213572706;60376.698116509135;61646.38353616407;62906.68546657421;12967.805482917574;13037.47850085986;13415.597532074053;13421.597352079454;13590.252536110609;14673.413063477768;14849.703005940037;14888.181150036851;15093.47172848945;15184;13651.726965460834;13907;14204.644883877572;14311.785323220369;14867.405303787727;13170.670733231746;13554.322283885964;14164.858351416766;14205.857941420867;14258.928705356408;12983.870161298266;13724.45102195901;13895.58313250604;14168.149911005372;14386.46826249728;9470.585895549246;10010.299279050689;10173.491325433552;10197.643082492077;10221.233407494616;10303.330283531546;10694.41180735067;11339.943300283447;11790.792482847972;11798.351090690094 08:51:24 INFO - PROCESS | 1639 | __end_tp_report 08:51:24 INFO - PROCESS | 1639 | __start_cc_report 08:51:24 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1596 08:51:24 INFO - PROCESS | 1639 | __end_cc_report 08:51:24 INFO - PROCESS | 1639 | __startTimestamp1490975484046__endTimestamp 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:51:24 INFO - PROCESS | 1639 | Number of tests: 6 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5786.60 Median:6059.64 stddev:655.81 (10.8%) stddev-sans-first:628.56 08:51:24 INFO - PROCESS | 1639 | Values: 3317.4 3341.1 3349.8 3367.6 3409.5 5680.3 5736.4 5755.6 5762.3 5769.7 5027.7 5656.9 5722.9 5815.9 5817.1 5205.8 5220.2 5238.1 5250.4 5285.0 5182.8 5193.4 5193.8 5321.7 5322.1 5199.7 5240.8 5252.4 5291.2 5319.0 5290.5 5293.2 5299.8 5302.7 5312.5 5101.0 5138.6 5204.7 5210.0 5267.2 5628.3 5639.1 5714.4 5718.3 5726.9 6261.0 6320.5 6324.2 6329.3 6353.6 6275.9 6359.6 6366.6 6375.4 6377.7 5795.4 5846.1 5857.9 5910.7 5938.2 6236.4 6285.4 6300.2 6341.6 6342.5 6191.3 6199.3 6217.8 6233.2 6244.2 6206.0 6273.0 6275.3 6341.9 6351.5 6175.1 6237.0 6250.8 6288.8 6324.7 6337.3 6338.8 6346.2 6351.7 6359.5 5019.6 5026.5 5029.2 5034.9 5042.4 4364.8 4446.0 4447.9 4460.3 4496.0 5625.4 5645.3 5748.3 5894.7 5905.2 5567.5 6284.9 6296.2 6307.9 6335.8 5604.0 5744.8 5835.4 5860.7 5881.4 5441.9 5461.6 5476.9 5489.9 5520.4 5225.3 6294.7 6295.1 6326.3 6328.5 6288.7 6291.6 6306.0 6337.3 6341.9 6251.9 6262.6 6271.9 6299.3 6302.2 5249.4 6297.4 6317.3 6333.3 6337.9 6182.3 6320.8 6342.8 6359.8 6367.3 6048.0 6119.1 6175.3 6229.7 6247.0 6127.9 6147.0 6203.0 6223.3 6245.2 6090.5 6092.0 6103.7 6110.3 6112.1 6059.6 6165.4 6166.7 6228.6 6274.6 5733.9 5950.2 6041.7 6092.4 6138.0 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:74311.77 Median:34502.15 stddev:168416.93 (488.1%) stddev-sans-first:168798.08 08:51:24 INFO - PROCESS | 1639 | Values: 446.8 504.7 539.3 539.8 540.1 29834.9 33529.3 33556.5 40506.0 42965.8 44076.8 44360.6 44637.8 44676.0 44764.6 9423.6 9655.5 9659.0 9660.9 9685.0 8866.5 9101.0 9569.0 11693.5 12017.8 11737.9 11827.5 11830.4 11830.8 11853.3 11864.1 11936.6 11947.6 11947.7 11960.6 11736.1 11830.8 11839.6 11844.9 11848.2 41179.6 41391.0 41425.2 41504.0 41544.4 4044.4 4066.5 4104.3 4126.8 4142.5 29383.6 30407.2 31223.5 31362.0 31499.8 3274.7 3330.7 3472.3 3522.2 3529.6 484500.6 491012.0 492014.5 492124.0 494047.0 59179.0 59573.0 59616.7 59627.7 59648.0 62815.7 62916.1 63002.7 63049.0 63074.4 17113.0 17284.6 17289.5 17300.4 17320.3 13188.2 13267.3 13277.9 13296.3 13312.6 16357.6 16722.9 16747.2 17014.7 18181.0 8073.7 8227.9 8236.5 8239.6 8246.8 826.8 901.6 915.6 950.6 957.2 28879.4 29259.8 29269.6 31224.8 31419.4 1103.8 1105.6 1144.3 1149.1 1183.4 15253.5 15790.8 16257.9 16378.0 16695.3 640354.0 643324.0 645919.0 646029.8 646965.0 55043.0 55667.4 62154.7 62289.4 63297.4 1492.5 1496.9 1497.3 1511.6 1517.3 27826.2 30818.0 32539.0 32557.7 32586.4 46924.3 47220.3 47284.8 47406.8 47505.8 482049.0 771463.0 774311.0 776091.0 776129.0 22556.3 27675.6 27740.6 27930.0 28062.6 48533.3 48567.5 49155.8 49630.0 49695.8 32912.2 33432.7 33481.7 33728.5 34069.1 33169.7 33308.7 33929.8 34229.3 34560.7 38332.4 39504.6 39564.8 39624.4 39648.4 32743.3 32809.0 33155.7 34329.0 34443.7 24450.3 25657.9 25687.5 25865.0 25915.4 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:37835.58 Median:23744.64 stddev:114119.29 (480.6%) stddev-sans-first:114404.79 08:51:24 INFO - PROCESS | 1639 | Values: 391.7 396.6 397.6 405.6 425.4 21151.6 21529.8 21705.2 22416.7 22670.5 22440.2 22755.7 23434.8 23449.0 23690.5 5764.4 5998.9 6127.7 6138.5 6147.2 5856.8 6029.9 6043.9 6098.4 6111.8 6035.7 6049.6 6055.8 6056.0 6060.9 5766.9 5936.6 6017.7 6040.8 6041.3 5160.7 5237.8 5295.1 5296.1 5304.6 27386.0 27691.0 27697.3 27741.0 28032.6 2436.7 2539.8 2773.7 2792.5 2798.2 13805.4 15946.4 16315.2 16333.7 16629.0 1774.3 1820.9 1821.1 1831.4 1857.3 119851.0 125785.1 126721.0 126820.4 128857.0 10319.5 11256.0 11716.1 11762.5 11917.6 15254.2 15267.5 15278.4 15286.6 15310.5 8822.7 9093.4 9127.7 9251.8 9277.8 9103.1 9113.8 9115.9 9138.2 9333.8 7353.2 7469.2 7471.2 7503.5 7503.7 1973.0 1998.4 2010.4 2010.6 2010.9 995.9 1077.9 1087.1 1099.5 1152.2 19141.8 23720.8 23768.5 23771.2 23887.0 1107.8 1111.9 1124.0 1155.5 1156.6 11992.3 12273.5 12404.0 12418.9 12509.6 398798.0 680350.0 704531.0 774615.0 802348.0 116180.4 121835.4 129340.4 133776.0 134785.0 1028.3 1055.5 1056.2 1135.1 1138.3 19528.9 19833.3 20265.2 20296.3 20329.7 46880.5 52199.7 53066.7 55840.0 56381.9 75654.0 75969.6 76506.2 77380.0 77661.4 7523.4 7616.3 7767.1 7907.6 8010.5 12333.9 13012.3 13137.7 13469.9 13518.3 11248.7 11533.1 11685.5 11794.8 11876.2 10762.0 10814.2 10886.5 10903.7 11315.9 11634.2 11680.9 11742.2 11825.6 12069.2 7342.2 7684.5 7730.1 7848.0 8040.0 8656.9 8816.5 9129.5 9147.0 9175.4 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5575.66 Median:5142.36 stddev:3030.75 (58.9%) stddev-sans-first:3021.78 08:51:24 INFO - PROCESS | 1639 | Values: 1245.8 1496.4 1516.5 1518.2 1530.3 6930.5 7762.6 8050.4 8593.3 8599.9 8527.4 8609.6 8611.6 8619.4 8627.4 2383.0 2432.0 2444.3 2449.4 2450.1 2182.1 2268.1 2404.4 2473.2 2488.7 2424.1 2444.3 2445.9 2447.1 2452.1 2440.2 2457.8 2458.2 2461.3 2467.4 2424.9 2430.6 2460.8 2465.8 2472.6 8663.3 8719.9 8744.6 8755.4 8783.1 5258.9 5416.8 5427.7 5431.6 5437.5 3409.4 3426.9 3516.4 3632.6 3637.0 1184.1 1211.3 1233.1 1245.9 1286.9 11145.4 11230.3 11243.7 11245.5 11260.7 4179.4 4529.3 4730.4 4822.3 4889.2 9783.2 9793.2 9803.3 9812.2 9813.3 5307.5 5409.9 5437.8 5462.0 5467.6 4539.1 4798.2 4941.9 4971.9 4973.8 3815.0 3825.4 3830.0 3834.3 3835.2 1269.3 1277.8 1314.5 1315.6 1318.9 779.5 922.9 934.3 940.2 940.8 5625.6 5704.6 5841.4 5857.0 6097.5 987.8 1003.2 1023.7 1048.4 1069.5 3790.3 3885.9 3905.1 3938.5 3999.7 10059.0 10239.5 10301.1 10318.8 10368.6 10244.6 10253.8 10273.9 10289.8 10289.8 7369.8 7924.7 8043.8 8104.8 8123.0 5332.6 5934.5 5949.9 5950.2 6096.2 8613.4 9493.7 9562.7 9613.1 9777.2 9540.0 9617.9 9689.4 9728.3 9792.2 7319.2 7392.1 7449.6 7529.0 7532.8 7391.3 8091.2 8177.4 8188.0 8196.9 6472.4 6824.8 6996.6 7044.7 7080.9 6825.5 6902.8 6933.3 6963.3 6967.1 5233.8 6446.7 6518.5 6524.7 6567.2 4458.4 4948.2 4977.1 5131.2 5153.5 4972.4 5008.6 5123.8 5195.1 5271.0 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4463.03 Median:4877.13 stddev:1316.37 (27.0%) stddev-sans-first:1283.67 08:51:24 INFO - PROCESS | 1639 | Values: 367.2 368.8 375.9 384.2 389.4 4328.7 4390.0 4776.9 5449.2 5481.8 4153.3 4465.5 5302.0 5324.7 5331.7 3648.8 4122.8 4191.7 4215.9 4227.9 3165.1 4092.9 4098.0 4146.9 4211.5 3641.9 4144.6 4194.8 4199.5 4200.5 3738.8 3999.3 4044.5 4102.5 4114.7 3685.7 3686.4 3690.9 3705.0 3706.4 5249.0 5280.1 5320.8 5351.9 5353.7 4352.5 4496.1 4625.8 4661.7 4896.3 4993.9 5277.5 5606.2 5612.9 5678.6 3346.9 3868.0 3888.7 3921.8 3977.2 4850.4 5957.6 6022.7 6074.5 6107.7 4273.4 4283.0 4293.7 4308.3 4323.8 3983.4 4415.4 4419.1 4439.8 4453.3 4643.5 4754.6 4962.5 4971.7 5026.3 4764.9 4930.8 5303.7 5649.3 5773.9 1208.5 1314.7 1347.7 1371.6 1402.0 854.6 904.1 950.4 963.4 964.5 3940.2 4068.3 5003.7 5008.7 5022.9 5062.5 5079.3 5144.8 5276.9 5619.7 4308.1 4348.9 4523.9 4627.4 5007.7 2449.4 2658.6 2712.7 2752.6 2923.2 5190.4 5347.8 5396.6 5494.8 5803.9 4759.8 4973.0 5215.2 5326.5 5500.0 4753.5 5702.5 5748.8 5750.3 5819.6 4619.2 4860.0 5091.8 5676.5 5676.9 4443.5 4958.2 5484.9 5515.9 5545.3 4728.8 4894.3 5522.0 5736.2 5780.4 3754.9 3757.4 3803.7 3804.6 3806.7 4775.5 5201.8 5283.5 5436.8 5450.9 4843.6 4936.9 5638.7 5677.9 5682.8 5622.3 5623.9 5628.0 5645.8 5690.5 4620.3 4721.0 5233.6 5343.0 5542.5 4537.7 4757.6 4932.3 5658.3 5692.9 5240.8 5525.3 5557.6 5582.4 5582.7 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19673.25 Median:4079.60 stddev:27254.15 (668.1%) stddev-sans-first:27293.53 08:51:24 INFO - PROCESS | 1639 | Values: 739.8 748.7 778.3 803.4 886.7 14855.9 15225.1 15824.4 15848.7 15849.9 14109.4 14195.0 14363.0 14527.8 14576.1 783.8 899.0 911.7 913.6 915.8 721.4 746.8 762.4 890.9 919.5 942.4 956.5 957.7 958.6 958.7 950.3 950.4 952.5 952.5 956.9 715.1 717.4 718.0 719.5 719.6 15432.0 15541.3 15657.7 15737.8 16030.3 14761.0 14825.9 14969.0 15217.8 15325.0 11747.7 11790.5 11932.0 11943.5 12365.3 3767.0 3799.7 3814.0 3951.7 4050.9 79673.0 85714.7 85972.6 97447.0 98690.0 10749.1 10904.9 11310.6 11393.8 12218.1 22196.3 22697.7 22920.5 22987.4 23027.4 7759.8 7903.2 7973.0 8014.0 8120.6 4367.4 4386.2 4414.0 4499.5 4630.7 3468.4 3542.8 3570.9 3906.7 4108.3 720.0 721.8 733.5 736.2 745.9 693.7 711.3 712.1 729.2 773.0 8907.8 9968.3 10544.4 10657.7 10933.5 691.9 693.4 705.0 721.2 730.2 5296.6 5442.1 5563.8 5571.5 5799.4 99060.0 105693.0 105726.5 106094.5 106916.0 65059.0 88183.0 89389.0 90766.0 92203.2 54889.7 71713.6 72178.3 77238.0 77299.0 10896.5 11064.6 11075.7 11357.3 11482.5 35585.0 46677.0 46769.8 46790.0 49717.0 59879.4 60319.1 60376.7 61646.4 62906.7 12967.8 13037.5 13415.6 13421.6 13590.3 14673.4 14849.7 14888.2 15093.5 15184.0 13651.7 13907.0 14204.6 14311.8 14867.4 13170.7 13554.3 14164.9 14205.9 14258.9 12983.9 13724.5 13895.6 14168.1 14386.5 9470.6 10010.3 10173.5 10197.6 10221.2 10303.3 10694.4 11339.9 11790.8 11798.4 08:51:24 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:51:24 INFO - PROCESS | 1639 | 08:51:24 INFO - TEST-INFO | 1639: exit 0 08:51:24 INFO - TEST-OK | dromaeo_css | took 1116875ms 08:51:24 INFO - TEST-START | kraken 08:51:24 INFO - operating with platform_type : mac_ 08:51:24 INFO - Initialising browser for kraken test... 08:51:24 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpUXBRRH/profile http://localhost:49246/getInfo.html) 08:51:26 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:51:26 INFO - PROCESS | 1649 | colorDepth:24 08:51:26 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:51:26 INFO - PROCESS | 1649 | __metrics 08:51:26 INFO - PROCESS | 1649 | 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" 08:51:26 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:27 INFO - TEST-INFO | 1649: exit 0 08:51:27 INFO - Browser initialized. 08:51:27 INFO - Running cycle 1/1 for kraken test... 08:51:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpUXBRRH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:39 INFO - PROCESS | 1651 | RSS: Main: 163766272 08:51:39 INFO - PROCESS | 1651 | 08:51:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:43 INFO - PROCESS | 1651 | RSS: Main: 213987328 08:51:43 INFO - PROCESS | 1651 | 08:51:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 08:51:46 INFO - PROCESS | 1651 | RSS: Main: 228253696 08:51:46 INFO - PROCESS | 1651 | 08:51:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 08:51:50 INFO - PROCESS | 1651 | RSS: Main: 325615616 08:51:50 INFO - PROCESS | 1651 | 08:51:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 08:51:52 INFO - PROCESS | 1651 | RSS: Main: 229122048 08:51:52 INFO - PROCESS | 1651 | 08:51:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:55 INFO - PROCESS | 1651 | RSS: Main: 230924288 08:51:55 INFO - PROCESS | 1651 | 08:51:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:58 INFO - PROCESS | 1651 | RSS: Main: 270168064 08:51:58 INFO - PROCESS | 1651 | 08:52:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:02 INFO - PROCESS | 1651 | RSS: Main: 269492224 08:52:02 INFO - PROCESS | 1651 | 08:52:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 08:52:05 INFO - PROCESS | 1651 | RSS: Main: 267239424 08:52:05 INFO - PROCESS | 1651 | 08:52:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:07 INFO - PROCESS | 1651 | RSS: Main: 245313536 08:52:07 INFO - PROCESS | 1651 | 08:52:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:10 INFO - PROCESS | 1651 | RSS: Main: 245858304 08:52:10 INFO - PROCESS | 1651 | 08:52:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:12 INFO - PROCESS | 1651 | RSS: Main: 254001152 08:52:12 INFO - PROCESS | 1651 | 08:52:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:16 INFO - PROCESS | 1651 | RSS: Main: 268161024 08:52:16 INFO - PROCESS | 1651 | 08:52:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:20 INFO - PROCESS | 1651 | RSS: Main: 262098944 08:52:20 INFO - PROCESS | 1651 | 08:52:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 08:52:22 INFO - PROCESS | 1651 | RSS: Main: 306470912 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | __start_tp_report 08:52:22 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:52:22 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:52:22 INFO - PROCESS | 1651 | |i|pagename|runs| 08:52:22 INFO - PROCESS | 1651 | |0;ai-astar;103;115;113;113;113;112;113;113;113;114 08:52:22 INFO - PROCESS | 1651 | |1;audio-beat-detection;144;106;108;142;108;106;105;108;126;106 08:52:22 INFO - PROCESS | 1651 | |2;audio-dft;188;181;182;190;258;205;182;181;184;179 08:52:22 INFO - PROCESS | 1651 | |3;audio-fft;81;58;58;88;61;59;60;76;62;61 08:52:22 INFO - PROCESS | 1651 | |4;audio-oscillator;82;69;87;67;67;70;80;67;68;81 08:52:22 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;87;84;86;85;88;85;88;84;86;83 08:52:22 INFO - PROCESS | 1651 | |6;imaging-darkroom;92;116;148;93;93;94;93;94;93;93 08:52:22 INFO - PROCESS | 1651 | |7;imaging-desaturate;84;85;87;85;86;84;84;85;87;87 08:52:22 INFO - PROCESS | 1651 | |8;json-parse-financial;52;52;52;53;55;56;55;55;55;55 08:52:22 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;76;78;73;69;68;67;67;69;69 08:52:22 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;84;82;80;80;80;79;81;86;82 08:52:22 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;132;134;128;130;129;133;130;137;171;154 08:52:22 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;163;163;158;156;161;170;163;162;221;212 08:52:22 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;65;64;63;64;63;80;80;81;79 08:52:22 INFO - PROCESS | 1651 | __end_tp_report 08:52:22 INFO - PROCESS | 1651 | __start_cc_report 08:52:22 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1948 08:52:22 INFO - PROCESS | 1651 | __end_cc_report 08:52:22 INFO - PROCESS | 1651 | __startTimestamp1490975542065__endTimestamp 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:52:22 INFO - PROCESS | 1651 | Number of tests: 14 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.33 (2.9%) stddev-sans-first:0.83 08:52:22 INFO - PROCESS | 1651 | Values: 103.0 115.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 114.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:115.90 Median:108.00 stddev:15.54 (14.4%) stddev-sans-first:12.73 08:52:22 INFO - PROCESS | 1651 | Values: 144.0 106.0 108.0 142.0 108.0 106.0 105.0 108.0 126.0 106.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:193.00 Median:186.00 stddev:24.06 (12.9%) stddev-sans-first:25.45 08:52:22 INFO - PROCESS | 1651 | Values: 188.0 181.0 182.0 190.0 258.0 205.0 182.0 181.0 184.0 179.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.50 stddev:10.99 (17.9%) stddev-sans-first:10.31 08:52:22 INFO - PROCESS | 1651 | Values: 81.0 58.0 58.0 88.0 61.0 59.0 60.0 76.0 62.0 61.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:73.80 Median:75.00 stddev:7.76 (10.3%) stddev-sans-first:7.64 08:52:22 INFO - PROCESS | 1651 | Values: 82.0 69.0 87.0 67.0 67.0 70.0 80.0 67.0 68.0 81.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:1.71 (2.0%) stddev-sans-first:1.74 08:52:22 INFO - PROCESS | 1651 | Values: 87.0 84.0 86.0 85.0 88.0 85.0 88.0 84.0 86.0 83.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:93.00 stddev:18.05 (19.4%) stddev-sans-first:18.86 08:52:22 INFO - PROCESS | 1651 | Values: 92.0 116.0 148.0 93.0 93.0 94.0 93.0 94.0 93.0 93.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.26 (1.5%) stddev-sans-first:1.24 08:52:22 INFO - PROCESS | 1651 | Values: 84.0 85.0 87.0 85.0 86.0 84.0 84.0 85.0 87.0 87.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:1.56 (2.8%) stddev-sans-first:1.48 08:52:22 INFO - PROCESS | 1651 | Values: 52.0 52.0 52.0 53.0 55.0 56.0 55.0 55.0 55.0 55.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.00 stddev:4.35 (6.3%) stddev-sans-first:4.03 08:52:22 INFO - PROCESS | 1651 | Values: 64.0 76.0 78.0 73.0 69.0 68.0 67.0 67.0 69.0 69.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:2.16 (2.6%) stddev-sans-first:2.24 08:52:22 INFO - PROCESS | 1651 | Values: 83.0 84.0 82.0 80.0 80.0 80.0 79.0 81.0 86.0 82.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:133.50 stddev:13.87 (10.4%) stddev-sans-first:14.55 08:52:22 INFO - PROCESS | 1651 | Values: 132.0 134.0 128.0 130.0 129.0 133.0 130.0 137.0 171.0 154.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:163.00 stddev:23.36 (14.3%) stddev-sans-first:24.51 08:52:22 INFO - PROCESS | 1651 | Values: 163.0 163.0 158.0 156.0 161.0 170.0 163.0 162.0 221.0 212.0 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:72.00 stddev:8.38 (11.6%) stddev-sans-first:8.57 08:52:22 INFO - PROCESS | 1651 | Values: 64.0 65.0 64.0 63.0 64.0 63.0 80.0 80.0 81.0 79.0 08:52:22 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:52:22 INFO - PROCESS | 1651 | 08:52:22 INFO - TEST-INFO | 1651: exit 0 08:52:22 INFO - TEST-OK | kraken | took 58270ms 08:52:22 INFO - SUITE-END | took 1175s 08:52:23 INFO - Completed test suite (00:19:35) 08:52:23 INFO - javascript benchmark 08:52:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.3696997570473, 3341.131305860477, 3349.8492567834446, 3367.595888493381, 3409.5397121388614, 5680.289963754531, 5736.368999410061, 5755.568332375078, 5762.308522977238, 5769.740361683724, 5027.723475208862, 5656.925184214996, 5722.885542289162, 5815.941840581593, 5817.127430885369, 5205.843824685266, 5220.190870415092, 5238.1357076082495, 5250.396204436482, 5285.0, 5182.844514664547, 5193.428722840504, 5193.766280517386, 5321.733913304339, 5322.0952438085615, 5199.662021968579, 5240.842774716745, 5252.36971563411, 5291.1798671206025, 5319.042572336978, 5290.4974027467715, 5293.153095504701, 5299.788008479656, 5302.734863256822, 5312.468753124676, 5101.0308041472, 5138.614603904722, 5204.661696989721, 5210.01009808139, 5267.157254839208, 5628.296462942132, 5639.097744360924, 5714.399988001242, 5718.34239062509, 5726.942730572724, 6260.968695156541, 6320.494360451153, 6324.177856878622, 6329.272133704637, 6353.587016843937, 6275.937240627627, 6359.586626869285, 6366.6180029198395, 6375.362463753588, 6377.744890204386, 5795.449432303924, 5846.093855452412, 5857.912131318034, 5910.734016969247, 5938.228030356069, 6236.438720515175, 6285.371462853769, 6300.180976473121, 6341.55609107358, 6342.460890824239, 6191.25704915413, 6199.3490683478485, 6217.751289948442, 6233.189685340877, 6244.1570387997035, 6206.0, 6272.968635156795, 6275.309715931244, 6341.873162536724, 6351.523635727246, 6175.104609831549, 6237.0, 6250.843728906722, 6288.842778930563, 6324.71538780756, 6337.334579869047, 6338.841528961812, 6346.238451385863, 6351.650659213788, 6359.523035772336, 5019.598432125421, 5026.522480364432, 5029.220470827027, 5034.874128146826, 5042.445331013586, 4364.8254069837485, 4445.977770111129, 4447.911041779146, 4460.30865215892, 4495.955040449554, 5625.38120806711, 5645.266115404971, 5748.338941021752, 5894.734736936848, 5905.232319798399, 5567.498925096761, 6284.937150628527, 6296.181496405438, 6307.905381419282, 6335.809925702236, 5604.0, 5744.798932037359, 5835.44563266489, 5860.677662728591, 5881.411858814085, 5441.863953401117, 5461.617686761968, 5476.945230547643, 5489.917651235235, 5520.392756796749, 5225.3207083079715, 6294.748210071637, 6295.055741638791, 6326.304106548276, 6328.493720502441, 6288.654124023223, 6291.559590828598, 6306.0, 6337.271213810471, 6341.936580634135, 6251.874962500634, 6262.561620686508, 6271.874562508816, 6299.30707622152, 6302.180716506825, 5249.396319423316, 6297.4017468340435, 6317.305096439296, 6333.303336633059, 6337.90493142594, 6182.258129024546, 6320.841978950563, 6342.809715708536, 6359.8092057238355, 6367.331430199948, 6048.0, 6119.051547010221, 6175.2589689237575, 6229.719662615284, 6246.968765156145, 6127.892078906909, 6147.016477363601, 6203.0075187969705, 6223.315435302204, 6245.156903817927, 6090.512758979183, 6092.025275955826, 6103.664298463627, 6110.2868817655635, 6112.116811553812, 6059.6364218147055, 6165.445109940127, 6166.691665416801, 6228.5951413158, 6274.623522588659, 5733.913991290051, 5950.2264705587995, 6041.69791510414, 6092.360302168386, 6138.0], "value": 5744.279441190222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.8034065011395, 504.684572142411, 539.3446961941241, 539.8380485854243, 540.1465684218934, 29834.850825745867, 33529.32941341172, 33556.4966525502, 40506.0, 42965.78517107418, 44076.77961610196, 44360.55639443605, 44637.7768111159, 44676.0, 44764.552354476444, 9423.575939082757, 9655.46894920779, 9659.0, 9660.90339096607, 9684.983076776942, 8866.468011919273, 9100.99889012208, 9568.995255498177, 11693.473793679304, 12017.819732703972, 11737.941310293436, 11827.526898924032, 11830.408479575986, 11830.763384732343, 11853.348065856375, 11864.050875929948, 11936.58221962227, 11947.58183463579, 11947.701307467383, 11960.58137965167, 11736.119791015708, 11830.822537661941, 11839.644810655695, 11844.940775296069, 11848.17062805604, 41179.588204118176, 41390.965225869295, 41425.1714965702, 41504.0, 41544.37683434751, 4044.3529035354204, 4066.4916885389325, 4104.281750693646, 4126.814293356806, 4142.5028996520305, 29383.55924661132, 30407.23981900448, 31223.531647025313, 31362.0, 31499.842500787578, 3274.6889045540634, 3330.6835850594157, 3472.340255351475, 3522.172289511963, 3529.6117427083, 484500.5774971138, 491012.0, 492014.53992730164, 492124.0, 494047.0, 59179.0, 59573.0, 59616.70191649101, 59627.701861490415, 59648.0, 62815.74368512604, 62916.05625915615, 63002.68498657569, 63049.0, 63074.369256307764, 17113.0, 17284.567885802702, 17289.48131556055, 17300.394486192923, 17320.30718771235, 13188.208707477583, 13267.336633168303, 13277.867221327857, 13296.335183240994, 13312.600621981355, 16357.591060223589, 16722.916385418237, 16747.162641867857, 17014.72851176091, 18181.0, 8073.717419890276, 8227.876581851277, 8236.546989915492, 8239.588020599065, 8246.793830154294, 826.7602395305414, 901.6258252825004, 915.624593916491, 950.6245033211843, 957.2389949989636, 28879.42241155165, 29259.829606815914, 29269.56095658567, 31224.843875780476, 31419.371612567622, 1103.7902798468265, 1105.5909313554037, 1144.2848219862585, 1149.1438878035917, 1183.3728124094243, 15253.542393728207, 15790.842091579167, 16257.943233689772, 16378.0, 16695.332186712396, 640354.0, 643324.0, 645919.0, 646029.7698511571, 646965.0, 55043.0, 55667.44332556704, 62154.68922655358, 62289.377106228356, 63297.36702632915, 1492.5074725340612, 1496.8503149684943, 1497.2738221962557, 1511.60698218464, 1517.2944580769995, 27826.16521504358, 30818.0, 32539.0, 32557.674423256412, 32586.39766350043, 46924.29613555731, 47220.29169562528, 47284.7635761819, 47406.762966186325, 47505.76247118742, 482049.0, 771463.0, 774311.0, 776091.0, 776129.0, 22556.32331030072, 27675.584866227426, 27740.58389124205, 27930.0, 28062.579061314504, 48533.27200091931, 48567.514324857715, 49155.754221228664, 49630.0, 49695.751521242164, 32912.1771955703, 33432.665673342955, 33481.66518334883, 33728.49407258942, 34069.148271293416, 33169.66830331762, 33308.666913330555, 33929.83035084809, 34229.31541369109, 34560.65439345675, 38332.425013625376, 39504.60495395009, 39564.81305560838, 39624.40563391609, 39648.40527392149, 32743.345133097682, 32809.0, 33155.668443315255, 34329.0, 34443.655563444045, 24450.266492005267, 25657.871710642074, 25687.486250275262, 25864.99830098576, 25915.352116197246], "value": 20656.25975888139, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.6905644540813, 396.6033966033966, 397.5686380277399, 405.624797062717, 425.36408069935453, 21151.57696846062, 21529.784702152974, 21705.240316588923, 22416.66375004372, 22670.54658906821, 22440.214592489265, 22755.658665120038, 23434.765652343514, 23449.0, 23690.5261894762, 5764.423557644233, 5998.910016349758, 6127.662978536178, 6138.47822935051, 6147.170132032164, 5856.795012174574, 6029.909551356734, 6043.939560604382, 6098.359672234418, 6111.816645500619, 6035.668038257894, 6049.606775559597, 6055.818325450244, 6056.000759874615, 6060.939390606081, 5766.942330576703, 5936.5547583931375, 6017.72920218589, 6040.788572399989, 6041.305249896231, 5160.690358578459, 5237.847673511821, 5295.0998330283555, 5296.09966305729, 5304.6286759926825, 27386.0, 27691.0, 27697.307567310778, 27741.0, 28032.579511307347, 2436.6832311799353, 2539.8349107307968, 2773.653293338333, 2792.4524565164506, 2798.174538511144, 13805.378757955916, 15946.441874534452, 16315.184429072522, 16333.673326533402, 16629.0, 1774.299151835031, 1820.9271629134819, 1821.089455272364, 1831.3681779785952, 1857.2756624916294, 119851.0, 125785.11322330173, 126721.0, 126820.36589817084, 128856.99999999907, 10319.535620896928, 11256.0, 11716.121290903217, 11762.529498820122, 11917.642470725892, 15254.161021143722, 15267.465638702814, 15278.388864445298, 15286.617834554225, 15310.464133755266, 8822.691205807765, 9093.40892841963, 9127.680531181377, 9251.814963700823, 9277.814443711088, 9103.135202155785, 9113.77215569616, 9115.863262051074, 9138.17756401927, 9333.766655833659, 7353.154387245429, 7469.178390377054, 7471.215522370073, 7503.474756766974, 7503.662335194929, 1972.9506762331057, 1998.381311137983, 2010.4069299556666, 2010.6179825833044, 2010.8592398532255, 995.9253056020683, 1077.8706555213425, 1087.0922779479065, 1099.4887377369562, 1152.2222499812592, 19141.80858191428, 23720.7627923722, 23768.524629507312, 23771.168009119945, 23887.044518219423, 1107.839363292318, 1111.8832522585012, 1123.984947514356, 1155.5435602936793, 1156.6414411532453, 11992.280463172237, 12273.509059637692, 12404.007679385628, 12418.944389726974, 12509.624711258677, 398798.0, 680350.0, 704531.0, 774615.0, 802348.0, 116180.41909790566, 121835.42563456457, 129340.41319173564, 133776.0, 134785.0, 1028.3058935218846, 1055.4617145255975, 1056.2447849787438, 1135.0862555642623, 1138.2942575603013, 19528.90235548813, 19833.30583429573, 20265.189392424138, 20296.289629862884, 20329.695054574488, 46880.53119468762, 52199.73900130627, 53066.73466632642, 55840.0, 56381.87236255334, 75654.0, 75969.62015189888, 76506.2349376499, 77380.0, 77661.4467710654, 7523.360514356341, 7616.276453736886, 7767.106782719833, 7907.604619768874, 8010.519368837655, 12333.876661233631, 13012.349382531025, 13137.737245255232, 13469.865301347254, 13518.25649589282, 11248.718782030515, 11533.078658624778, 11685.474153662935, 11794.823077653671, 11876.228045177382, 10762.0, 10814.188935829687, 10886.49610589553, 10903.672889813319, 11315.943420282845, 11634.243774154653, 11680.883191167979, 11742.236754610924, 11825.586104486645, 12069.215500992408, 7342.229065947999, 7684.538927664358, 7730.11103723079, 7848.0, 8039.959800200962, 8656.91343086561, 8816.471011739317, 9129.45223286605, 9147.0, 9175.403598766059], "value": 10228.981025058814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.7757603631342, 1496.3864815425677, 1516.5450364890532, 1518.2181176694005, 1530.3266562712402, 6930.480213983946, 7762.563925673748, 8050.436469447133, 8593.269572086365, 8599.91400085999, 8527.360447966395, 8609.56952152393, 8611.569421528915, 8619.353548483874, 8627.396082274243, 2383.0, 2431.9756802431925, 2444.27893771337, 2449.448874003344, 2450.0934654177977, 2182.1053368119074, 2268.104098880941, 2404.362843846382, 2473.2332976777166, 2488.688913885764, 2424.0560023416942, 2444.340028192387, 2445.8899349529315, 2447.1434997750735, 2452.1172377943926, 2440.170342083691, 2457.7910877575428, 2458.21337172105, 2461.3354394313615, 2467.3954881054256, 2424.933029467029, 2430.635404689293, 2460.7785299323145, 2465.778079972811, 2472.5920223163157, 8663.306935445213, 8719.869201961976, 8744.606492707844, 8755.3871229014, 8783.12168783123, 5258.92111618326, 5416.83749487516, 5427.701476418795, 5431.565474762049, 5437.510624043855, 3409.3522230776075, 3426.9485957710654, 3516.384632689269, 3632.5822530409077, 3636.981815090934, 1184.1178322150054, 1211.2550781269545, 1233.0813543909755, 1245.8973808179735, 1286.9420876060506, 11145.442727863574, 11230.270032447865, 11243.718907027389, 11245.493952772145, 11260.662180134608, 4179.435776170239, 4529.252673308933, 4730.394348564849, 4822.276658501182, 4889.168841296988, 9783.168430683472, 9793.21654267657, 9803.313768036312, 9812.165965892978, 9813.264005199639, 5307.4692530746615, 5409.891802163935, 5437.755301011385, 5461.972690136524, 5467.5625949923915, 4539.0921815637, 4798.23228283473, 4941.876453088702, 4971.90056198874, 4973.825916092919, 3815.027168072124, 3825.3688141456905, 3830.042489377656, 3834.328992426314, 3835.175437280998, 1269.320913311374, 1277.757226127033, 1314.5004898138836, 1315.605318404475, 1318.9340532973313, 779.5128044971892, 922.9400088994194, 934.3272843552631, 940.2478017585904, 940.7507010642186, 5625.634333768292, 5704.572157088152, 5841.386654401226, 5857.0, 6097.481714054266, 987.807377561383, 1003.2174903575223, 1023.7287118913493, 1048.3552615141784, 1069.5240617924949, 3790.298794722985, 3885.86399476017, 3905.082305658168, 3938.4879965604287, 3999.6600288975183, 10059.044390782863, 10239.539220735085, 10301.124404425558, 10318.793624127626, 10368.585256589651, 10244.59021639141, 10253.84619230712, 10273.897261027443, 10289.816671082772, 10289.845652315222, 7369.77890663281, 7924.722634707758, 8043.839123217503, 8104.756857294291, 8123.025236971601, 5332.586864480993, 5934.525237980864, 5949.868599187718, 5950.2264705587995, 6096.177016102947, 8613.397062205586, 9493.66772162971, 9562.665306714232, 9613.134817866425, 9777.21782257432, 9540.0, 9617.903820961701, 9689.41863488193, 9728.319017668695, 9792.167665748491, 7319.231480694663, 7392.112946446461, 7449.6275186241555, 7528.962355188189, 7532.7740167795055, 7391.260873912565, 8091.150429205084, 8177.386695997943, 8187.959060204899, 8196.918030819616, 6472.385123413268, 6824.829379265558, 6996.580205187705, 7044.718211271492, 7080.858382832417, 6825.453963682794, 6902.827429314308, 6933.2720064392515, 6963.303669632996, 6967.09427774386, 5233.842984710464, 6446.7098980546925, 6518.543701940818, 6524.67376631176, 6567.179102612174, 4458.398116254264, 4948.2082866742585, 4977.122420028465, 5131.179011358165, 5153.5361817436615, 4972.403311602486, 5008.6243531734535, 5123.795048198031, 5195.090859099567, 5270.973645131903], "value": 4549.553048572453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.21965822626913, 368.756620630384, 375.91541903071806, 384.18169299392326, 389.3925476257039, 4328.6537077033845, 4390.034192477658, 4776.928346074812, 5449.1553809159595, 5481.808136715215, 4153.335466325389, 4465.508794032654, 5302.045631786277, 5324.710374538947, 5331.733413329337, 3648.8358023888854, 4122.835086596532, 4191.664666826662, 4215.894602634943, 4227.894302642428, 3165.0821261834158, 4092.9386059208987, 4097.959020409788, 4146.857896208695, 4211.536730959608, 3641.8725344612944, 4144.564820693829, 4194.769287689176, 4199.45407097077, 4200.537940826506, 3738.7848949091517, 3999.2601368746873, 4044.4944381952255, 4102.466679331697, 4114.732542384751, 3685.7235707322056, 3686.447032945053, 3690.8892733218045, 3705.0, 3706.369917114097, 5249.0, 5280.07598670235, 5320.76056577455, 5351.866203344908, 5353.652012619167, 4352.455943007124, 4496.055828276066, 4625.8149674013, 4661.650376221763, 4896.3389942358035, 4993.90012199754, 5277.47225277473, 5606.2060140754975, 5612.943870561283, 5678.630888992202, 3346.8828590999196, 3867.961320386816, 3888.650021498079, 3921.8431262749455, 3977.1846771411792, 4850.410696084907, 5957.6127551709, 6022.6937739516015, 6074.51403887688, 6107.72515236811, 4273.401723758676, 4283.0, 4293.69944103916, 4308.289132293136, 4323.848665296699, 3983.4423180754716, 4415.366314463669, 4419.11617676466, 4439.778011099432, 4453.265211240109, 4643.512431194744, 4754.595859351994, 4962.528559786814, 4971.726555039435, 5026.271190677405, 4764.880877978009, 4930.802767889244, 5303.708296043677, 5649.322081350264, 5773.90053062322, 1208.5347141350644, 1314.737052589486, 1347.6927380440957, 1371.6433727230992, 1401.9649508762363, 854.6111519258723, 904.1139683110589, 950.3917492804611, 963.3882484622176, 964.4840010594298, 3940.192260586573, 4068.3287257602165, 5003.724050367206, 5008.724520151354, 5022.874428139253, 5062.544665837066, 5079.263506791568, 5144.819931302462, 5276.894462110737, 5619.67937534679, 4308.116836048603, 4348.934511044814, 4523.914260577503, 4627.444706635225, 5007.674501157413, 2449.4488740033707, 2658.57462805954, 2712.734866386589, 2752.559590465516, 2923.2460523686045, 5190.429052804188, 5347.81282655113, 5396.568274538027, 5494.80768173112, 5803.8549036274435, 4759.809607615656, 4972.950270497248, 5215.24378965048, 5326.5206131447585, 5499.972500137474, 4753.502646666289, 5702.515286200636, 5748.798792042258, 5750.281214848061, 5819.5635327351465, 4619.214733495247, 4859.95140048595, 5091.821786237464, 5676.545876329967, 5676.921384936849, 4443.511213766547, 4958.231474121517, 5484.862878428071, 5515.862103447446, 5545.334559852843, 4728.834490792943, 4894.314795928644, 5522.0, 5736.246601631157, 5780.364159942487, 3754.9061273468383, 3757.4363845423404, 3803.7337386382687, 3804.619538046173, 3806.6954643628997, 4775.5463230993, 5201.791928322825, 5283.494204151798, 5436.809711660073, 5450.892990995253, 4843.588294994824, 4936.925946110883, 5638.661680299195, 5677.933915685649, 5682.829515114553, 5622.297212848394, 5623.875224954943, 5627.971860140673, 5645.774169033192, 5690.487856092972, 4620.283856002325, 4721.0, 5233.613092530559, 5342.98483288174, 5542.473465020817, 4537.705049171794, 4757.5718185363485, 4932.30947667334, 5658.264425624642, 5692.861427714391, 5240.816571419982, 5525.320219693365, 5557.5831812613405, 5582.358028826737, 5582.720863956704], "value": 4068.5584205192354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7595781371056, 748.7042618165829, 778.3461892010711, 803.3773825285404, 886.6896586194831, 14855.925720371397, 15225.086494810304, 15824.446144384949, 15848.68302633948, 15849.92075039626, 14109.365078571464, 14195.006349555535, 14363.0, 14527.78208326876, 14576.125432474033, 783.7883771381723, 898.9820203595924, 911.731039343392, 913.6436789652041, 915.8488849339851, 721.4444877444365, 746.8244962433823, 762.3596179209463, 890.9465432074064, 919.4575200631626, 942.3780304998702, 956.4548207521715, 957.6839642917855, 958.5782255807422, 958.7075941837737, 950.2587981374504, 950.3917492804611, 952.4999375327939, 952.5380190607584, 956.8564715292692, 715.1061173533084, 717.3722992381666, 718.0163176448247, 719.4783781758235, 719.597025665629, 15432.0, 15541.300641471162, 15657.686846263012, 15737.842621573753, 16030.278637461342, 14761.0, 14825.925870370687, 14969.0, 15217.847821521864, 15325.003874748105, 11747.659161994994, 11790.528378864836, 11932.0, 11943.462544185446, 12365.258084514868, 3767.020574650583, 3799.67702745267, 3814.0, 3951.7431366961055, 4050.8784736457956, 79673.0, 85714.71427928586, 85972.57013714954, 97447.0, 98690.0, 10749.08632766208, 10904.945475272572, 11310.60412885545, 11393.772124557463, 12218.144729869002, 22196.334109976728, 22697.65953510699, 22920.541589168122, 22987.42531436694, 23027.424314392276, 7759.844803104019, 7903.209679032166, 7973.043234811859, 8013.998250218722, 8120.553369564731, 4367.432233809584, 4386.232409328419, 4413.984783499749, 4499.482559505634, 4630.699004564693, 3468.4103702370658, 3542.822858857047, 3570.8750193743094, 3906.7069969752383, 4108.322126849036, 719.9856002879914, 721.8375865430236, 733.4535770850644, 736.1865139021411, 745.9216782237895, 693.6982412650514, 711.2816055783695, 712.0529695504966, 729.212450553401, 772.97681069568, 8907.821843563092, 9968.302218844756, 10544.367337959748, 10657.745385029011, 10933.453327333602, 691.882379995402, 693.445243804954, 704.9647517624098, 721.1706537481938, 730.1749023603294, 5296.576273898079, 5442.102053161263, 5563.777448902079, 5571.498565129158, 5799.3620701722775, 99060.0, 105693.0, 105726.47136764268, 106094.46952765186, 106916.0, 65059.0, 88183.0, 89389.0, 90766.0, 92203.15593688223, 54889.72555137199, 71713.64143179251, 72178.2782172182, 77237.99999999888, 77299.0, 10896.509657065293, 11064.612738554433, 11075.72310692239, 11357.318560886373, 11482.483288252215, 35585.0, 46677.0, 46769.766151169024, 46790.0, 49717.0, 59879.401205987386, 60319.095213572706, 60376.698116509135, 61646.38353616407, 62906.68546657421, 12967.805482917574, 13037.47850085986, 13415.597532074053, 13421.597352079454, 13590.252536110609, 14673.413063477768, 14849.703005940037, 14888.181150036851, 15093.47172848945, 15184.0, 13651.726965460834, 13907.0, 14204.644883877572, 14311.785323220369, 14867.405303787727, 13170.670733231746, 13554.322283885964, 14164.858351416766, 14205.857941420867, 14258.928705356408, 12983.870161298266, 13724.45102195901, 13895.58313250604, 14168.149911005372, 14386.46826249728, 9470.585895549246, 10010.299279050689, 10173.491325433552, 10197.643082492077, 10221.233407494616, 10303.330283531546, 10694.41180735067, 11339.943300283447, 11790.792482847972, 11798.351090690094], "value": 7661.597420636402, "unit": "score"}], "name": "dromaeo_css", "value": 7458.465258688741, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 114.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 108.0, 142.0, 108.0, 106.0, 105.0, 108.0, 126.0, 106.0], "value": 115.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 181.0, 182.0, 190.0, 258.0, 205.0, 182.0, 181.0, 184.0, 179.0], "value": 193.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 88.0, 61.0, 59.0, 60.0, 76.0, 62.0, 61.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 87.0, 67.0, 67.0, 70.0, 80.0, 67.0, 68.0, 81.0], "value": 73.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 85.0, 88.0, 85.0, 88.0, 84.0, 86.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 116.0, 148.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 87.0, 85.0, 86.0, 84.0, 84.0, 85.0, 87.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 78.0, 73.0, 69.0, 68.0, 67.0, 67.0, 69.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 80.0, 80.0, 80.0, 79.0, 81.0, 86.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 128.0, 130.0, 129.0, 133.0, 130.0, 137.0, 171.0, 154.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 158.0, 156.0, 161.0, 170.0, 163.0, 162.0, 221.0, 212.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 63.0, 80.0, 80.0, 81.0, 79.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1419.8999999999999, "alertThreshold": 2.0}]} 08:52:23 INFO - Return code: 0 08:52:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:52:23 INFO - # TBPL SUCCESS # 08:52:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:23 INFO - 2017-03-31 08:52:23.376 screenresolution[1655:10014] starting screenresolution argv=screenresolution get 08:52:23 INFO - 2017-03-31 08:52:23.379 screenresolution[1655:10014] Display 0: 1600x1200x32@60 08:52:23 INFO - 2017-03-31 08:52:23.385 screenresolution[1656:10017] starting screenresolution argv=screenresolution list 08:52:23 INFO - Available Modes on Display 0 08:52:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:23 INFO - Intel Iris: 08:52:23 INFO - Chipset Model: Intel Iris 08:52:23 INFO - Type: GPU 08:52:23 INFO - Bus: Built-In 08:52:23 INFO - VRAM (Dynamic, Max): 1536 MB 08:52:23 INFO - Vendor: Intel (0x8086) 08:52:23 INFO - Device ID: 0x0a2e 08:52:23 INFO - Revision ID: 0x0009 08:52:23 INFO - Displays: 08:52:23 INFO - Display: 08:52:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:23 INFO - Display Serial Number: 1600x1200 60 08:52:23 INFO - Main Display: Yes 08:52:23 INFO - Mirror: Off 08:52:23 INFO - Online: Yes 08:52:23 INFO - Rotation: Supported 08:52:23 INFO - Return code: 0 08:52:23 INFO - Running post-action listener: _resource_record_post_action 08:52:23 INFO - [mozharness: 2017-03-31 15:52:23.621366Z] Finished run-tests step (success) 08:52:23 INFO - Running post-run listener: _resource_record_post_run 08:52:23 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38031360; Write bytes: 420935168; Read time: 241; Write time: 1367 08:52:23 INFO - TinderboxPrint: CPU usage
53.6% 08:52:23 INFO - TinderboxPrint: I/O read bytes / time
38,031,360 / 241 08:52:23 INFO - TinderboxPrint: I/O write bytes / time
420,935,168 / 1,367 08:52:23 INFO - TinderboxPrint: CPU idle
2,209.4 (46.4%) 08:52:23 INFO - TinderboxPrint: CPU system
949.0 (19.9%) 08:52:23 INFO - TinderboxPrint: CPU user
1,603.3 (33.7%) 08:52:23 INFO - TinderboxPrint: Swap in / out
160,022,528 / 0 08:52:23 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 111874560; Write bytes: 104177664; Read time: 9937; Write time: 218 08:52:23 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37089280; Write bytes: 298366464; Read time: 230; Write time: 1091 08:52:24 INFO - Running post-run listener: _upload_blobber_files 08:52:24 INFO - Blob upload gear active. 08:52:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:52:24 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 08:52:24 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:52:24 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:52:24 INFO - (blobuploader) - INFO - Open directory for files ... 08:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:25 INFO - (blobuploader) - INFO - Done attempting. 08:52:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:52:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:52:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:26 INFO - (blobuploader) - INFO - Done attempting. 08:52:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:52:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:27 INFO - (blobuploader) - INFO - Done attempting. 08:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:29 INFO - (blobuploader) - INFO - Done attempting. 08:52:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:52:29 INFO - Return code: 0 08:52:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:52:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:52:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0003e89e4cb4cf5764bdbc422f7b2f45fdbc45fb7f516979d5dca7d750ddd1594400aabec76495168451c52fd7601d300bc4f7600e356c36a0d05e71de186a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a99ca0b322d4d6b4d35f2f6efac0b4b6938eca86efb37b37bc1e99012f42e411329efe6b2fbcc4ecb807de808d4b21df46af51eba51242c5f466dfc62d944b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a325023a6a06a621e149f2f1375093628296c73b9a91a3bf4a6498536385d173fbb437bbf41128792699fcfdb047416e29446d7ec2bff3896620feefd265d39", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/057a8abba27ff2ec1b1ab2ab5c7ab0962f2b18c25295fe289559b86e94357aff0657b24445629771c619ab6b08113f787c60918c8c2b25290580c1fee11ad059"} 08:52:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:52:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:52:29 INFO - Contents: 08:52:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0003e89e4cb4cf5764bdbc422f7b2f45fdbc45fb7f516979d5dca7d750ddd1594400aabec76495168451c52fd7601d300bc4f7600e356c36a0d05e71de186a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a99ca0b322d4d6b4d35f2f6efac0b4b6938eca86efb37b37bc1e99012f42e411329efe6b2fbcc4ecb807de808d4b21df46af51eba51242c5f466dfc62d944b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a325023a6a06a621e149f2f1375093628296c73b9a91a3bf4a6498536385d173fbb437bbf41128792699fcfdb047416e29446d7ec2bff3896620feefd265d39", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/057a8abba27ff2ec1b1ab2ab5c7ab0962f2b18c25295fe289559b86e94357aff0657b24445629771c619ab6b08113f787c60918c8c2b25290580c1fee11ad059"} 08:52:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:52:29 INFO - Copying logs to upload dir... 08:52:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:52:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.992094 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-31 08:52:29.591688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 08:52:29.595703) ========= 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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-Beta/sha512/0003e89e4cb4cf5764bdbc422f7b2f45fdbc45fb7f516979d5dca7d750ddd1594400aabec76495168451c52fd7601d300bc4f7600e356c36a0d05e71de186a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a99ca0b322d4d6b4d35f2f6efac0b4b6938eca86efb37b37bc1e99012f42e411329efe6b2fbcc4ecb807de808d4b21df46af51eba51242c5f466dfc62d944b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a325023a6a06a621e149f2f1375093628296c73b9a91a3bf4a6498536385d173fbb437bbf41128792699fcfdb047416e29446d7ec2bff3896620feefd265d39", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/057a8abba27ff2ec1b1ab2ab5c7ab0962f2b18c25295fe289559b86e94357aff0657b24445629771c619ab6b08113f787c60918c8c2b25290580c1fee11ad059"} build_url:https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/QPUEwEpKShC8o26-Fmap9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0003e89e4cb4cf5764bdbc422f7b2f45fdbc45fb7f516979d5dca7d750ddd1594400aabec76495168451c52fd7601d300bc4f7600e356c36a0d05e71de186a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a99ca0b322d4d6b4d35f2f6efac0b4b6938eca86efb37b37bc1e99012f42e411329efe6b2fbcc4ecb807de808d4b21df46af51eba51242c5f466dfc62d944b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a325023a6a06a621e149f2f1375093628296c73b9a91a3bf4a6498536385d173fbb437bbf41128792699fcfdb047416e29446d7ec2bff3896620feefd265d39", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/057a8abba27ff2ec1b1ab2ab5c7ab0962f2b18c25295fe289559b86e94357aff0657b24445629771c619ab6b08113f787c60918c8c2b25290580c1fee11ad059"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 08:52:29.635354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 08:52:29.635891) ========= 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.5GtwBAIt04/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.I2XMwBJyMQ/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.004955 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 08:52:29.685158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 08:52:29.685475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 08:52:29.685808) ========= ========= Total master_lag: 0.19 =========