builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0354 starttime: 1490952032.19 results: success (0) buildid: 20170331003105 builduid: 331dc9250b1540cd8c1c2d502ff3b259 revision: 7e44e11d00308e72547bfef822d91814c5b47634 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:32.191442) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:32.191873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:32.192202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:32.221236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 02:20:32.325773) ========= 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.QjUkeulwbB/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.VW4GsiGisd/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-31 02:20:32-- 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% 19.3M=0.001s 2017-03-31 02:20:33 (19.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.100506 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 02:20:33.453543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:33.453940) ========= 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.QjUkeulwbB/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.VW4GsiGisd/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.029993 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:33.506599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-31 02:20:33.506955) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e44e11d00308e72547bfef822d91814c5b47634 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e44e11d00308e72547bfef822d91814c5b47634 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QjUkeulwbB/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.VW4GsiGisd/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-31 02:20:33,752 truncating revision to first 12 chars 2017-03-31 02:20:33,753 Setting DEBUG logging. 2017-03-31 02:20:33,753 attempt 1/10 2017-03-31 02:20:33,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e44e11d0030?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 02:20:36,426 unpacking tar archive at: mozilla-aurora-7e44e11d0030/testing/mozharness/ program finished with exit code 0 elapsedTime=2.953967 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-31 02:20:36.486014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:36.486320) ========= script_repo_revision: 7e44e11d00308e72547bfef822d91814c5b47634 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:36.486862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:36.487187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 02:20:36.506833) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2017-03-31 02:20:36.507109) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QjUkeulwbB/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.VW4GsiGisd/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:20:36 INFO - MultiFileLogger online at 20170331 02:20:36 in /builds/slave/test 02:20:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:20:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:36 INFO - {'append_to_log': False, 02:20:36 INFO - 'base_work_dir': '/builds/slave/test', 02:20:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:20:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:36 INFO - 'branch': 'Mozilla-Aurora', 02:20:36 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:36 INFO - 'config_files': ('talos/mac_config.py',), 02:20:36 INFO - 'default_actions': ('clobber', 02:20:36 INFO - 'read-buildbot-config', 02:20:36 INFO - 'download-and-extract', 02:20:36 INFO - 'populate-webroot', 02:20:36 INFO - 'create-virtualenv', 02:20:36 INFO - 'install', 02:20:36 INFO - 'run-tests'), 02:20:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:36 INFO - 'download_minidump_stackwalk': True, 02:20:36 INFO - 'download_symbols': 'ondemand', 02:20:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:36 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:36 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:36 INFO - 'gecko_profile': False, 02:20:36 INFO - 'gecko_profile_interval': 0, 02:20:36 INFO - 'installer_path': 'installer.exe', 02:20:36 INFO - 'log_level': 'info', 02:20:36 INFO - 'log_name': 'talos', 02:20:36 INFO - 'log_to_console': True, 02:20:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:20:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:20:36 INFO - 'opt_config_files': (), 02:20:36 INFO - 'pip_index': False, 02:20:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:36 INFO - 'cmd': ('bash', 02:20:36 INFO - '-c', 02:20:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:36 INFO - 'enabled': True, 02:20:36 INFO - 'halt_on_failure': False, 02:20:36 INFO - 'name': 'check_screen_resolution'},), 02:20:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:36 INFO - 'cmd': ('bash', 02:20:36 INFO - '-c', 02:20:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:36 INFO - 'enabled': True, 02:20:36 INFO - 'halt_on_failure': False, 02:20:36 INFO - 'name': 'check_screen_resolution'},), 02:20:36 INFO - 'run_cmd_checks_enabled': True, 02:20:36 INFO - 'suite': 'dromaeojs', 02:20:36 INFO - 'system_bits': '32', 02:20:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:36 INFO - 'title': 't-yosemite-r7-0354', 02:20:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:36 INFO - 'use_talos_json': True, 02:20:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:36 INFO - 'work_dir': 'build'} 02:20:36 INFO - [mozharness: 2017-03-31 09:20:36.857704Z] Running clobber step. 02:20:36 INFO - Running pre-action listener: _resource_record_pre_action 02:20:36 INFO - Running main action method: clobber 02:20:36 INFO - rmtree: /builds/slave/test/build 02:20:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:39 INFO - Running post-action listener: _resource_record_post_action 02:20:39 INFO - [mozharness: 2017-03-31 09:20:39.223458Z] Finished clobber step (success) 02:20:39 INFO - [mozharness: 2017-03-31 09:20:39.223580Z] Running read-buildbot-config step. 02:20:39 INFO - Running pre-action listener: _resource_record_pre_action 02:20:39 INFO - Running main action method: read_buildbot_config 02:20:39 INFO - Using buildbot properties: 02:20:39 INFO - { 02:20:39 INFO - "project": "", 02:20:39 INFO - "product": "firefox", 02:20:39 INFO - "script_repo_revision": "production", 02:20:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:20:39 INFO - "repository": "", 02:20:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:20:39 INFO - "buildid": "20170331003105", 02:20:39 INFO - "pgo_build": "False", 02:20:39 INFO - "basedir": "/builds/slave/test", 02:20:39 INFO - "buildnumber": 13, 02:20:39 INFO - "slavename": "t-yosemite-r7-0354", 02:20:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:20:39 INFO - "platform": "yosemite_r7", 02:20:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:20:39 INFO - "branch": "mozilla-aurora", 02:20:39 INFO - "repo_path": "releases/mozilla-aurora", 02:20:39 INFO - "revision": "7e44e11d00308e72547bfef822d91814c5b47634", 02:20:39 INFO - "stage_platform": "macosx64", 02:20:39 INFO - "builduid": "331dc9250b1540cd8c1c2d502ff3b259", 02:20:39 INFO - "slavebuilddir": "test" 02:20:39 INFO - } 02:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:20:39 INFO - Running post-action listener: _resource_record_post_action 02:20:39 INFO - [mozharness: 2017-03-31 09:20:39.226822Z] Finished read-buildbot-config step (success) 02:20:39 INFO - [mozharness: 2017-03-31 09:20:39.226949Z] Running download-and-extract step. 02:20:39 INFO - Running pre-action listener: _resource_record_pre_action 02:20:39 INFO - Running main action method: download_and_extract 02:20:39 INFO - mkdir: /builds/slave/test/build/tests 02:20: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')]} 02:20:39 INFO - trying https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:20:40 INFO - Downloaded 1199 bytes. 02:20:40 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:20:40 INFO - Using the following test package requirements: 02:20:40 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:20:40 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:20:40 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:20:40 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'jsshell-mac.zip'], 02:20:40 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:20:40 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:20:40 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:20:40 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:20:40 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:20:40 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:20:40 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:20:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:20:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:20:40 INFO - Fetch https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:20:42 INFO - Expected file size: 51789212 02:20:42 INFO - Obtained file size: 51789212 02:20:58 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:20:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:20:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:20:58 INFO - Fetch https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:21:00 INFO - Expected file size: 51789212 02:21:00 INFO - Obtained file size: 51789212 02:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:21:16 INFO - Expected file size: 14404438 02:21:16 INFO - Obtained file size: 14404438 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - trying https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:21:16 INFO - Downloading https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:21:19 INFO - Downloaded 74691526 bytes. 02:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:21:19 INFO - mkdir: /builds/slave/test/properties 02:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:19 INFO - Contents: 02:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:21:21 INFO - Running post-action listener: _resource_record_post_action 02:21:21 INFO - Running post-action listener: set_extra_try_arguments 02:21:21 INFO - [mozharness: 2017-03-31 09:21:21.005697Z] Finished download-and-extract step (success) 02:21:21 INFO - [mozharness: 2017-03-31 09:21:21.005817Z] Running populate-webroot step. 02:21:21 INFO - Running pre-action listener: _resource_record_pre_action 02:21:21 INFO - Running main action method: populate_webroot 02:21:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:21 INFO - '--tppagecycles', 02:21:21 INFO - '7'], 02:21:21 INFO - 'tests': ['tsvgm']}}, 02:21:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:21:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:21:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:21:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['damp', 'tps']}, 02:21:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'tests': ['damp', 'tps']}, 02:21:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['dromaeo_dom']}, 02:21:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['basic_compositor_video']}, 02:21:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:21:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['a11yr', 02:21:21 INFO - 'ts_paint', 02:21:21 INFO - 'tpaint', 02:21:21 INFO - 'sessionrestore', 02:21:21 INFO - 'sessionrestore_no_auto_restore', 02:21:21 INFO - 'tabpaint']}, 02:21:21 INFO - 'other-e10s': {'tests': ['a11yr', 02:21:21 INFO - 'ts_paint', 02:21:21 INFO - 'tpaint', 02:21:21 INFO - 'sessionrestore', 02:21:21 INFO - 'sessionrestore_no_auto_restore', 02:21:21 INFO - 'tabpaint']}, 02:21:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:21:21 INFO - 'ts_paint', 02:21:21 INFO - 'tpaint', 02:21:21 INFO - 'sessionrestore', 02:21:21 INFO - 'sessionrestore_no_auto_restore', 02:21:21 INFO - 'tabpaint']}, 02:21:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:21:21 INFO - 'ts_paint', 02:21:21 INFO - 'tpaint', 02:21:21 INFO - 'sessionrestore', 02:21:21 INFO - 'sessionrestore_no_auto_restore', 02:21:21 INFO - 'tabpaint']}, 02:21:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['a11yr', 02:21:21 INFO - 'ts_paint', 02:21:21 INFO - 'tpaint', 02:21:21 INFO - 'sessionrestore', 02:21:21 INFO - 'sessionrestore_no_auto_restore', 02:21:21 INFO - 'tabpaint']}, 02:21:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['a11yr', 02:21:21 INFO - 'ts_paint', 02:21:21 INFO - 'tpaint', 02:21:21 INFO - 'sessionrestore', 02:21:21 INFO - 'sessionrestore_no_auto_restore', 02:21:21 INFO - 'tabpaint']}, 02:21:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['tsvgx', 02:21:21 INFO - 'tsvgr_opacity', 02:21:21 INFO - 'tart', 02:21:21 INFO - 'tscrollx', 02:21:21 INFO - 'cart', 02:21:21 INFO - 'tsvg_static']}, 02:21:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:21:21 INFO - 'tsvgr_opacity', 02:21:21 INFO - 'tart', 02:21:21 INFO - 'tscrollx', 02:21:21 INFO - 'cart', 02:21:21 INFO - 'tsvg_static']}, 02:21:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'talos_options': ['--disable-e10s'], 02:21:21 INFO - 'tests': ['tp5o']}, 02:21:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:21:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'talos_options': ['--disable-e10s', 02:21:21 INFO - '--xperf_path', 02:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:21 INFO - 'tests': ['tp5n']}, 02:21:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:21:21 INFO - 'talos_options': ['--xperf_path', 02:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:21 INFO - 'tests': ['tp5n']}}, 02:21:21 INFO - 'talos.zip': {'path': '', 02:21:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:21 INFO - Running post-action listener: _resource_record_post_action 02:21:21 INFO - [mozharness: 2017-03-31 09:21:21.023787Z] Finished populate-webroot step (success) 02:21:21 INFO - [mozharness: 2017-03-31 09:21:21.023926Z] Running create-virtualenv step. 02:21:21 INFO - Running pre-action listener: _resource_record_pre_action 02:21:21 INFO - Running main action method: create_virtualenv 02:21:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:21:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:21 INFO - Using real prefix '/tools/python27' 02:21:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:24 INFO - Installing pip.................done. 02:21:24 INFO - Return code: 0 02:21:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:21:24 INFO - Reading from file tmpfile_stdout 02:21:24 INFO - Output received: 02:21:24 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) 02:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:26 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:26 INFO - 'HOME': '/Users/cltbld', 02:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:26 INFO - 'LOGNAME': 'cltbld', 02:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:26 INFO - 'MOZ_NO_REMOTE': '1', 02:21:26 INFO - 'NO_EM_RESTART': '1', 02:21:26 INFO - 'PAGER': '/bin/cat', 02:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:26 INFO - 'PWD': '/builds/slave/test', 02:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:26 INFO - 'SHELL': '/bin/bash', 02:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:26 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:26 INFO - 'USER': 'cltbld', 02:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:26 INFO - 'XPC_FLAGS': '0x0', 02:21:26 INFO - 'XPC_SERVICE_NAME': '0', 02:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:21:26 INFO - Cleaning up... 02:21:26 INFO - Return code: 0 02:21:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:26 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:26 INFO - 'HOME': '/Users/cltbld', 02:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:26 INFO - 'LOGNAME': 'cltbld', 02:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:26 INFO - 'MOZ_NO_REMOTE': '1', 02:21:26 INFO - 'NO_EM_RESTART': '1', 02:21:26 INFO - 'PAGER': '/bin/cat', 02:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:26 INFO - 'PWD': '/builds/slave/test', 02:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:26 INFO - 'SHELL': '/bin/bash', 02:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:26 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:26 INFO - 'USER': 'cltbld', 02:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:26 INFO - 'XPC_FLAGS': '0x0', 02:21:26 INFO - 'XPC_SERVICE_NAME': '0', 02:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:26 INFO - Downloading/unpacking psutil>=3.1.1 02:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:32 INFO - Installing collected packages: psutil 02:21:32 INFO - Running setup.py install for psutil 02:21:32 INFO - building 'psutil._psutil_osx' extension 02:21:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:21:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:21:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:21:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:21:33 INFO - building 'psutil._psutil_posix' extension 02:21:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:21:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:21:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:21:33 INFO - ^ 02:21:33 INFO - 1 warning generated. 02:21:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:21:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:33 INFO - Successfully installed psutil 02:21:33 INFO - Cleaning up... 02:21:33 INFO - Return code: 0 02:21:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:33 INFO - 'HOME': '/Users/cltbld', 02:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:33 INFO - 'LOGNAME': 'cltbld', 02:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:33 INFO - 'MOZ_NO_REMOTE': '1', 02:21:33 INFO - 'NO_EM_RESTART': '1', 02:21:33 INFO - 'PAGER': '/bin/cat', 02:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:33 INFO - 'PWD': '/builds/slave/test', 02:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:33 INFO - 'SHELL': '/bin/bash', 02:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:33 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:33 INFO - 'USER': 'cltbld', 02:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:33 INFO - 'XPC_FLAGS': '0x0', 02:21:33 INFO - 'XPC_SERVICE_NAME': '0', 02:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:37 INFO - Installing collected packages: mozsystemmonitor 02:21:37 INFO - Running setup.py install for mozsystemmonitor 02:21:37 INFO - Successfully installed mozsystemmonitor 02:21:37 INFO - Cleaning up... 02:21:37 INFO - Return code: 0 02:21:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:37 INFO - 'HOME': '/Users/cltbld', 02:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:37 INFO - 'LOGNAME': 'cltbld', 02:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:37 INFO - 'MOZ_NO_REMOTE': '1', 02:21:37 INFO - 'NO_EM_RESTART': '1', 02:21:37 INFO - 'PAGER': '/bin/cat', 02:21:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:37 INFO - 'PWD': '/builds/slave/test', 02:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:37 INFO - 'SHELL': '/bin/bash', 02:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:37 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:37 INFO - 'USER': 'cltbld', 02:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:37 INFO - 'XPC_FLAGS': '0x0', 02:21:37 INFO - 'XPC_SERVICE_NAME': '0', 02:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:37 INFO - Downloading/unpacking jsonschema==2.5.1 02:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:44 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:44 INFO - warning: no files found matching '*.txt' 02:21:44 INFO - no previously-included directories found matching 'build' 02:21:44 INFO - no previously-included directories found matching 'dist' 02:21:44 INFO - no previously-included directories found matching '.git*' 02:21:44 INFO - Installing collected packages: jsonschema, functools32 02:21:44 INFO - Running setup.py install for functools32 02:21:44 INFO - warning: no files found matching '*.txt' 02:21:44 INFO - no previously-included directories found matching 'build' 02:21:44 INFO - no previously-included directories found matching 'dist' 02:21:44 INFO - no previously-included directories found matching '.git*' 02:21:44 INFO - Successfully installed jsonschema functools32 02:21:44 INFO - Cleaning up... 02:21:44 INFO - Return code: 0 02:21:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:44 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:44 INFO - 'HOME': '/Users/cltbld', 02:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:44 INFO - 'LOGNAME': 'cltbld', 02:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:44 INFO - 'MOZ_NO_REMOTE': '1', 02:21:44 INFO - 'NO_EM_RESTART': '1', 02:21:44 INFO - 'PAGER': '/bin/cat', 02:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:44 INFO - 'PWD': '/builds/slave/test', 02:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:44 INFO - 'SHELL': '/bin/bash', 02:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:44 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:44 INFO - 'USER': 'cltbld', 02:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:44 INFO - 'XPC_FLAGS': '0x0', 02:21:44 INFO - 'XPC_SERVICE_NAME': '0', 02:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:45 INFO - Cleaning up... 02:21:45 INFO - Return code: 0 02:21:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:45 INFO - 'HOME': '/Users/cltbld', 02:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:45 INFO - 'LOGNAME': 'cltbld', 02:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:45 INFO - 'MOZ_NO_REMOTE': '1', 02:21:45 INFO - 'NO_EM_RESTART': '1', 02:21:45 INFO - 'PAGER': '/bin/cat', 02:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:45 INFO - 'PWD': '/builds/slave/test', 02:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:45 INFO - 'SHELL': '/bin/bash', 02:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:45 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:45 INFO - 'USER': 'cltbld', 02:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:45 INFO - 'XPC_FLAGS': '0x0', 02:21:45 INFO - 'XPC_SERVICE_NAME': '0', 02:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:53 INFO - Downloading docopt-0.6.1.tar.gz 02:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:53 INFO - Running setup.py install for blobuploader 02:21:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:54 INFO - Running setup.py install for requests 02:21:54 INFO - Running setup.py install for docopt 02:21:54 INFO - Successfully installed blobuploader requests docopt 02:21:54 INFO - Cleaning up... 02:21:54 INFO - Return code: 0 02:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:54 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:54 INFO - 'HOME': '/Users/cltbld', 02:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:54 INFO - 'LOGNAME': 'cltbld', 02:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:54 INFO - 'MOZ_NO_REMOTE': '1', 02:21:54 INFO - 'NO_EM_RESTART': '1', 02:21:54 INFO - 'PAGER': '/bin/cat', 02:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:54 INFO - 'PWD': '/builds/slave/test', 02:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:54 INFO - 'SHELL': '/bin/bash', 02:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:54 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:54 INFO - 'USER': 'cltbld', 02:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:54 INFO - 'XPC_FLAGS': '0x0', 02:21:54 INFO - 'XPC_SERVICE_NAME': '0', 02:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-IgsMWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-V806ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Zd7b10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-T3TuXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-sFK2zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-BGi42R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-ERKfBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-tfzu2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-gbk7MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-kPRe6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-hEOqwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-cYniak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-b1m6PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-p6W_fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Q64Byk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-B04r1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Rj6SWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:56 INFO - Running setup.py install for manifestparser 02:21:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:56 INFO - Running setup.py install for mozcrash 02:21:57 INFO - Running setup.py install for mozdebug 02:21:57 INFO - Running setup.py install for mozdevice 02:21:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Running setup.py install for mozfile 02:21:57 INFO - Running setup.py install for mozhttpd 02:21:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Running setup.py install for mozinfo 02:21:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Running setup.py install for mozInstall 02:21:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Running setup.py install for mozleak 02:21:58 INFO - Running setup.py install for mozlog 02:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Running setup.py install for moznetwork 02:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Running setup.py install for mozprocess 02:21:58 INFO - Running setup.py install for mozprofile 02:21:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Running setup.py install for mozrunner 02:21:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:58 INFO - Running setup.py install for mozscreenshot 02:21:59 INFO - Running setup.py install for moztest 02:21:59 INFO - Running setup.py install for mozversion 02:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:59 INFO - Cleaning up... 02:21:59 INFO - Return code: 0 02:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:59 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:59 INFO - 'HOME': '/Users/cltbld', 02:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:59 INFO - 'LOGNAME': 'cltbld', 02:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:59 INFO - 'MOZ_NO_REMOTE': '1', 02:21:59 INFO - 'NO_EM_RESTART': '1', 02:21:59 INFO - 'PAGER': '/bin/cat', 02:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:59 INFO - 'PWD': '/builds/slave/test', 02:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:59 INFO - 'SHELL': '/bin/bash', 02:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:21:59 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:59 INFO - 'USER': 'cltbld', 02:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:59 INFO - 'XPC_FLAGS': '0x0', 02:21:59 INFO - 'XPC_SERVICE_NAME': '0', 02:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-NmpxZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-KV6yg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:59 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)) 02:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-QP0p3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5ld6NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:00 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)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-cAy5n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-4W_LCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-yVl8yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-IuDHf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-OkVCfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Bh2pou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-wP3Omn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Wou9wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-nwqmzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:01 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-VVWApX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:01 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)) 02:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:01 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-eEO3N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:01 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-nGJzZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:01 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)) 02:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:01 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Mh3iey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:22:01 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)) 02:22:01 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)) 02:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:01 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)) 02:22:01 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)) 02:22:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:04 INFO - Downloading blessings-1.6.tar.gz 02:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:05 INFO - Installing collected packages: blessings 02:22:05 INFO - Running setup.py install for blessings 02:22:05 INFO - Successfully installed blessings 02:22:05 INFO - Cleaning up... 02:22:05 INFO - Return code: 0 02:22:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:05 INFO - Reading from file tmpfile_stdout 02:22:05 INFO - Current package versions: 02:22:05 INFO - blessings == 1.6 02:22:05 INFO - blobuploader == 1.2.4 02:22:05 INFO - docopt == 0.6.1 02:22:05 INFO - functools32 == 3.2.3-2 02:22:05 INFO - jsonschema == 2.5.1 02:22:05 INFO - manifestparser == 1.1 02:22:05 INFO - mozInstall == 1.12 02:22:05 INFO - mozcrash == 1.0 02:22:05 INFO - mozdebug == 0.1 02:22:05 INFO - mozdevice == 0.49 02:22:05 INFO - mozfile == 1.2 02:22:05 INFO - mozhttpd == 0.7 02:22:05 INFO - mozinfo == 0.9 02:22:05 INFO - mozleak == 0.1 02:22:05 INFO - mozlog == 3.4 02:22:05 INFO - moznetwork == 0.27 02:22:05 INFO - mozprocess == 0.25 02:22:05 INFO - mozprofile == 0.28 02:22:05 INFO - mozrunner == 6.13 02:22:05 INFO - mozscreenshot == 0.1 02:22:05 INFO - mozsystemmonitor == 0.3 02:22:05 INFO - moztest == 0.8 02:22:05 INFO - mozversion == 1.4 02:22:05 INFO - psutil == 3.1.1 02:22:05 INFO - requests == 1.2.3 02:22:05 INFO - wsgiref == 0.1.2 02:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:05 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:05 INFO - 'HOME': '/Users/cltbld', 02:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:05 INFO - 'LOGNAME': 'cltbld', 02:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:05 INFO - 'MOZ_NO_REMOTE': '1', 02:22:05 INFO - 'NO_EM_RESTART': '1', 02:22:05 INFO - 'PAGER': '/bin/cat', 02:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:05 INFO - 'PWD': '/builds/slave/test', 02:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:05 INFO - 'SHELL': '/bin/bash', 02:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:22:05 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:05 INFO - 'USER': 'cltbld', 02:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:05 INFO - 'XPC_FLAGS': '0x0', 02:22:05 INFO - 'XPC_SERVICE_NAME': '0', 02:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:05 INFO - Cleaning up... 02:22:05 INFO - Return code: 0 02:22:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:05 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 0x106ef9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106efc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd03d888e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, '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.QjUkeulwbB/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.VW4GsiGisd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:05 INFO - 'HOME': '/Users/cltbld', 02:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:05 INFO - 'LOGNAME': 'cltbld', 02:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:05 INFO - 'MOZ_NO_REMOTE': '1', 02:22:05 INFO - 'NO_EM_RESTART': '1', 02:22:05 INFO - 'PAGER': '/bin/cat', 02:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:05 INFO - 'PWD': '/builds/slave/test', 02:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:05 INFO - 'SHELL': '/bin/bash', 02:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:22:05 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:05 INFO - 'USER': 'cltbld', 02:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:05 INFO - 'XPC_FLAGS': '0x0', 02:22:05 INFO - 'XPC_SERVICE_NAME': '0', 02:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:22:06 INFO - Cleaning up... 02:22:06 INFO - Return code: 0 02:22:06 INFO - Running post-action listener: _resource_record_post_action 02:22:06 INFO - Running post-action listener: _start_resource_monitoring 02:22:06 INFO - Starting resource monitoring. 02:22:06 INFO - [mozharness: 2017-03-31 09:22:06.172995Z] Finished create-virtualenv step (success) 02:22:06 INFO - [mozharness: 2017-03-31 09:22:06.174019Z] Running install step. 02:22:06 INFO - Running pre-action listener: _resource_record_pre_action 02:22:06 INFO - Running main action method: install 02:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:06 INFO - Reading from file tmpfile_stdout 02:22:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:06 INFO - Reading from file tmpfile_stdout 02:22:06 INFO - Output received: 02:22:06 INFO - Usage: mozinstall [options] installer 02:22:06 INFO - Options: 02:22:06 INFO - -h, --help show this help message and exit 02:22:06 INFO - -d DEST, --destination=DEST 02:22:06 INFO - Directory to install application into. [default: 02:22:06 INFO - "/builds/slave/test"] 02:22:06 INFO - --app=APP Application being installed. [default: firefox] 02:22:06 INFO - mkdir: /builds/slave/test/build/application 02:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:22:26 INFO - Reading from file tmpfile_stdout 02:22:26 INFO - Output received: 02:22:26 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:22:26 INFO - Running post-action listener: _resource_record_post_action 02:22:26 INFO - [mozharness: 2017-03-31 09:22:26.645161Z] Finished install step (success) 02:22:26 INFO - [mozharness: 2017-03-31 09:22:26.645301Z] Running run-tests step. 02:22:26 INFO - Running pre-action listener: _resource_record_pre_action 02:22:26 INFO - Running main action method: run_tests 02:22:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:26 INFO - 2017-03-31 02:22:26.659 screenresolution[1626:7743] starting screenresolution argv=screenresolution get 02:22:26 INFO - 2017-03-31 02:22:26.662 screenresolution[1626:7743] Display 0: 1600x1200x32@60 02:22:26 INFO - 2017-03-31 02:22:26.668 screenresolution[1627:7746] starting screenresolution argv=screenresolution list 02:22:26 INFO - Available Modes on Display 0 02:22:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:26 INFO - Intel Iris: 02:22:26 INFO - Chipset Model: Intel Iris 02:22:26 INFO - Type: GPU 02:22:26 INFO - Bus: Built-In 02:22:26 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:26 INFO - Vendor: Intel (0x8086) 02:22:26 INFO - Device ID: 0x0a2e 02:22:26 INFO - Revision ID: 0x0009 02:22:26 INFO - Displays: 02:22:26 INFO - Display: 02:22:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:26 INFO - Display Serial Number: 1600x1200 60 02:22:26 INFO - Main Display: Yes 02:22:26 INFO - Mirror: Off 02:22:26 INFO - Online: Yes 02:22:26 INFO - Rotation: Supported 02:22:26 INFO - Return code: 0 02:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:22:26 INFO - Python 2.7.3 02:22:26 INFO - Return code: 0 02:22:26 INFO - grabbing minidump binary from tooltool 02:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:26 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 0x106cd7d30>, '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 0x106bfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cccbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:22:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:22:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:22:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:22:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:22:27 INFO - Return code: 0 02:22:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:22:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:22:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:22:27 INFO - ENV: RUST_BACKTRACE is now 1 02:22:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:22:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QjUkeulwbB/Render', 02:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:27 INFO - 'HOME': '/Users/cltbld', 02:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:27 INFO - 'LOGNAME': 'cltbld', 02:22:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:22:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:27 INFO - 'MOZ_NO_REMOTE': '1', 02:22:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:22:27 INFO - 'NO_EM_RESTART': '1', 02:22:27 INFO - 'PAGER': '/bin/cat', 02:22:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:27 INFO - 'PWD': '/builds/slave/test', 02:22:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:27 INFO - 'RUST_BACKTRACE': '1', 02:22:27 INFO - 'SHELL': '/bin/bash', 02:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VW4GsiGisd/Listeners', 02:22:27 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 02:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:27 INFO - 'USER': 'cltbld', 02:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:27 INFO - 'XPC_FLAGS': '0x0', 02:22:27 INFO - 'XPC_SERVICE_NAME': '0', 02:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:22:27 INFO - mozversion application_buildid: 20170331003105 02:22:27 INFO - mozversion application_changeset: 7e44e11d00308e72547bfef822d91814c5b47634 02:22:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:22:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:22:27 INFO - mozversion application_name: Firefox 02:22:27 INFO - mozversion application_remotingname: firefox-dev 02:22:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:22:27 INFO - mozversion application_vendor: Mozilla 02:22:27 INFO - mozversion application_version: 54.0a2 02:22:27 INFO - mozversion platform_buildid: 20170331003105 02:22:27 INFO - mozversion platform_changeset: 7e44e11d00308e72547bfef822d91814c5b47634 02:22:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:22:27 INFO - mozversion platform_version: 54.0a2 02:22:27 INFO - using testdate: 1490952147 02:22:27 INFO - actual date: 1490952147 02:22:27 INFO - starting webserver on 'localhost:49238' 02:22:27 INFO - SUITE-START | Running 2 tests 02:22:27 INFO - TEST-START | dromaeo_css 02:22:27 INFO - operating with platform_type : mac_ 02:22:27 INFO - Initialising browser for dromaeo_css test... 02:22:27 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmprGo0Je/profile http://localhost:49238/getInfo.html) 02:22:29 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 02:22:29 INFO - PROCESS | 1637 | colorDepth:24 02:22:29 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 02:22:29 INFO - PROCESS | 1637 | __metrics 02:22:29 INFO - PROCESS | 1637 | 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" 02:22:29 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:22:30 INFO - TEST-INFO | 1637: exit 0 02:22:30 INFO - Browser initialized. 02:22:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:22:30 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmprGo0Je/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:42 INFO - PROCESS | 1640 | RSS: Main: 214986752 02:22:42 INFO - PROCESS | 1640 | 02:25:47 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 02:25:49 INFO - PROCESS | 1640 | RSS: Main: 346079232 02:25:49 INFO - PROCESS | 1640 | 02:27:32 INFO - PROCESS | 1640 | ************************* 02:27:32 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 02:27:32 INFO - PROCESS | 1640 | 02:27:32 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:27:32 INFO - PROCESS | 1640 | Full stack: 02:27:32 INFO - PROCESS | 1640 | ************************* 02:28:51 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 02:28:52 INFO - PROCESS | 1640 | RSS: Main: 353058816 02:28:52 INFO - PROCESS | 1640 | 02:31:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 02:31:55 INFO - PROCESS | 1640 | RSS: Main: 321634304 02:31:55 INFO - PROCESS | 1640 | 02:34:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 02:34:58 INFO - PROCESS | 1640 | RSS: Main: 316538880 02:34:58 INFO - PROCESS | 1640 | 02:38:02 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 02:38:03 INFO - PROCESS | 1640 | RSS: Main: 327016448 02:38:03 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 02:41:06 INFO - PROCESS | 1640 | RSS: Main: 437764096 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | __start_tp_report 02:41:06 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 02:41:06 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 02:41:06 INFO - PROCESS | 1640 | |i|pagename|runs| 02:41:06 INFO - PROCESS | 1640 | |0;dojo.html;3312.221627917439;3401.812900290485;3405.114670185752;3415.487676848471;3453.740969427292;6006.7897623583185;6012;6014;6029.608075475091;6081.3918608139165;5994.46049855513;6031.939680603193;6063.848403789907;6081.179040829486;6089.969550152254;5385.892282154355;5418.29562156919;5445.264889239961;5456.645318054314;5559.082751346023;5366.382865970405;5367.865803354928;5402.432744561824;5531.225628412026;5549.916751248715;5452.04589196889;5509.614326997112;5543.556515478752;5562.527185189264;5587;5495.120780675113;5507.504324610784;5510.586705997066;5530.806421775259;5559.305086864142;5344.331958505187;5448.754806033738;5450.400455949843;5475.06923822951;5511;5756;5779.33537643168;5791.536677065825;6017.48851347636;6068.57519973602;6332.240131184288;6339.8732025359695;6360.109584658151;6364.522660800412;6372.904406433907;6405.711742971577;6448.45188159007;6458.031295305695;6459.870802583922;6495.9350406495805;6153.661548614825;6219.253689557282;6223.906641400292;6224.657643829542;6228.626282423069;6318.368163183737;6347.936520634735;6618.900716489256;6644.900326495106;6647.567908085959;6251.437370636573;6290.591111577733;6307.842303942438;6310.43206111443;6339.6196228225535;6380.138681278061;6418.454431373292;6424.453921416732;6432.742690292336;6434.903476447857;6257.7809776658505;6365.904511432333;6372;6374.012028135647;6382.968085159638;6286.119943207863;6370.203724534434;6389.6805159741825;6400.039994000844;6404.775832845828;5211;5217.139172036647;5222.791088356499;5227.738613069331;5247.868803279948;4604.861854144381;4625.7687115644085;4650.9767451162525;4654.418197725285;4656.4412270527755;5724.284464441945;5823.039198532195;5896.115582662635;5995.760169593167;6046.606970546901;6417.326180751047;6455.289918109004;6486.545941784124;6498.935010649833;6504.317046710122;5851.707414629252;6028.57799953999;6049.788257411057;6068.937935861207;6068.939310606926;5508.641938274;5631.42993859162;5693.800716974886;5704.34400043992;5730.914036289459;5607;6471;6483.513736469784;6570.770023049362;6636.767713130017;6494.837629059311;6495.642739649365;6495.837604059747;6513.772017979348;6516.902246466212;6586.242582103119;6678.332166783477;6724.495662825406;6726.327367263235;6741.696623652046;6243.469305109116;6252.874942501216;6285.371462853678;6335.1447554579545;6410.102585637921;6365.1088847562305;6447.6131432114225;6452.483801295791;6460.289368169591;6468.223813142453;6154.846128846814;6165.229346331708;6204.472619827366;6222.937770622417;6225.688715564113;6136.417040381157;6341.112244285896;6348.365163483615;6350.936490635035;6351.745930162927;5986.132010858489;5998.370171131968;5999.130126131774;6002.039673652369;6046.3046749624355;6221.09794079865;6268.905966410599;6288.1825362704385;6292.276388215414;6300.905486417616;6236.469900058546;6259.12372267892;6261.906071408841;6265.060240963892;6287.874242515032 02:41:06 INFO - PROCESS | 1640 | |1;ext.html;785.7524879662906;806.0891192951964;834.7454026521908;854.7991222062814;884.4737381258149;28259;39899.2020159597;40205.99485012876;42274;42276.36585451221;41783.79108104463;41854;41901.58098419015;42078;42218.36672449916;9195.586198621062;9356.438613683167;9361.344705870591;9375.015623359517;9376.203022743075;7325.7802265932105;7474.289942455485;7582.924170758277;7586.431017673669;7669.884951725729;11035.3930533821;11293.830592541119;11357.886421135807;11375.601853935113;11376.317420954727;11107.000369966701;11140.164487663458;11153.944230278797;11157.776844463106;11181;7288.56268623879;10800.783984320347;10876;10882.347059176474;10883.149864522971;28763.56854647182;28878.566821497694;28889.56665650017;29123.126306210637;39314.21371572581;3765.6987441004653;3773.3019391412404;3780.3573392523335;3798.1212740420483;3853.7687738735767;27297.590536141975;27316.726832731616;28424.431511369865;29305;29588.112356629335;3035.696430356969;3051.282948507121;3053.832039237841;3261.4129456697783;3267.0852161394846;357868;358571;358925;359160;359256;54151.45848541543;54183;54241.72879135579;54295;54387.728061360234;55359.169612455844;55742;55823.16265256024;55912;55913;14943.10341379499;15048.398064077533;15051.021683590532;15060.171690556905;15092.622684432758;12769.61691149267;12796.232226066466;12813.551525696555;12823.422945967453;12844.614661560168;10511.94744026275;10776;12587.748245035047;12599.93700031494;12664.240145591293;4732.71603703772;5045.445001049881;5447.237386765856;5695.914561281584;5736.483716465538;1136.176272202663;1164.0047759165961;1164.5807509296646;1183.491048912626;1209.5826939705787;21973;26858.32854178661;27527.724722752915;27592.448151036868;27631.723682763317;1043.9634612788668;1191.713988642737;1255.2844878419396;1258.4022589270023;1292.1084451728277;13856.861431385758;13928.58214253574;14018.299085045706;14191.432342706383;14192.645183870485;444855.5514444879;446978.0604387959;447413;447925;448377;57759.844803103704;57799;57883;57921.42078579245;57960.71019644959;1208.4682739594725;1477.2244571599997;1478.482531114123;1481.2149560732828;1482.9925850370894;22817.88591057034;25752.871235643703;25924.870375648003;26807.597886032116;27192.864035679693;48223.51776482331;48299.517004829504;48332.516674832805;48490.51509485001;48524.514754851996;419514.8048519476;420419;420927;421202;421458;29830.403391931606;30281.394372112874;31201.53197701991;31310.530342045342;34806.65193348136;38554.6144538551;39498.40752388774;39569.80215098906;39778;39809.80095099506;27434.314142146606;27967;28641.14076577706;28980.985665501605;29126.961112721907;28095.578566321114;28146;28737.557307629086;28817.42365152727;28984.855075724485;33039;33193.50209746904;33257.66742332546;33347.49978750272;33649.99050028503;28217.57673634856;28642.42715145644;29158;29292.121236362942;29515;21946.012429441034;23151.40406626367;23230;23404.18085367004;23593.29220123399 02:41:06 INFO - PROCESS | 1640 | |2;jquery.html;383.61638361638364;431.6460502388041;432.07810869864767;438.3009100484727;447.592690651507;15983.440579579717;20417.979101044944;21106.577868442622;21255;21639.242626508076;20868.582628347463;21835;21994.670079948814;22057.22799702011;22818.54362912741;5834.533237341024;6892.931070689304;6991.755288564901;7052;7927.920720792805;7792.883106753403;7963.522188668699;8075.959620201891;8092.150324215961;8113.7565873023905;7907.288344049034;7990.161033091529;7996.320312773421;8017.67929282828;8026.879596806052;7664.770056898274;7833.177516360757;7904.604769761547;7905.802354941115;8007.8798818017485;7586.4689471737;7598.962005189938;7678.654460549289;7683.1548529661695;7695.4997925134685;24811.503769924682;26547.601785973227;26959.191224263304;26967.595486067723;27155.45689086227;2897.1453421240576;2939.153583144887;2957.837318947457;2967.1691926260683;3013.7287644112134;16801.24394402255;16980.235889385007;17320.13399330041;17329.48011559655;17916.91041544797;2076.9480762980897;2083.864548804338;2100.726905502275;2115.2808045264683;2220.5114874727533;131800;135055;139171.60828391687;143406.28296858552;143605.28197359052;15904.602384940468;21766.34700958974;21831.34144086037;22078.77921220799;22804.31587052391;27477.587836182473;35643.643563564554;36315.636843631226;36453.45319820205;36459.90620281343;9577.616895324249;9741.659041933499;11104.777904441866;11107.222494425312;11114.888851111386;8872.378933474594;9012.233960113334;9147;9179.908200918038;9191.448513089235;8441.66233350659;10279.845802312972;10376.325538839952;10377.688669339932;10500.684979450629;3760.2291530236234;4001.762716564117;4172.3532852407925;4229.97885010573;4258.659307255412;924.473050361301;939.8966113727485;948.9525523723786;959.6353385713384;975.4342481360794;17759.112044397727;22743.203987860346;23131.884340578526;23135.07459701593;23333.533329333317;948.1419315519466;966.6665000574791;971.2666936462925;979.7991411760572;982.8083523712808;11442.768660111366;11858.288502689866;12082.939585302192;12173.391330433444;12175.688264325241;778288;781774;785043;797869;803401;175949;176788.11605942145;177031.11484442494;177671;184722;1231.1566576894857;1235.9443825027895;1288.027539207892;1288.5039259884825;1294.5922034559085;20177.899110504353;20234;20542.972851357074;20709.275175368788;20741.896290518453;47990.760046199546;59614.70192649009;63227.36772632215;64196;64789.67605161944;94467;94637.5268123655;94749.52625237106;97043;97247.51376243074;11358.829617555579;11762.94118529402;11810.881891180978;11838.230515016496;12107.636770896886;13004.934975325063;13128.934355328161;13134.671633208864;13559.45762169502;13586.388612512263;11096.667099987013;11218.495167717309;11379.658610241706;11437.828432573684;11541.826872597087;9714.902850971683;10317.690469285933;10543.630972915911;10649.787004259717;10709;10985.725356866142;11087.889121108685;11172;11411.486483108114;11676.824847627462;10901.83647245276;11613.070954323803;11713.941430292794;11753.118516111155;11891.167618266638;11107.666769996913;11218.719532011764;11340.675161592018;11563.017143542893;11642.301461912313 02:41:06 INFO - PROCESS | 1640 | |3;mootools.html;1528.1900592685881;1528.7783271425637;1545.6290490282336;1557.7896983907174;1579.9526014219573;10708.946455267722;11298.209125361229;11302.434878256085;11308.208425410225;11315.717107072327;10743.301685390445;10978.560857565708;11043.116550675946;11235.325880447159;11238.213325067249;2345.636426353918;2398.1846172301416;2402.9639555406684;2403.67550380699;2411.4694767151286;2308.3536609749212;2354.740978492373;2400.0399840063938;2400.411899084727;2405.398650337416;2295.5867943770113;2341.5668101401297;2353.5645905507536;2382.261498935327;2394.1500767227644;1930.3050901675385;2294.655801629752;2353.5998880190323;2355.1403737635724;2357.728861180969;2346.671465994762;2348.894299756515;2349.3069544484247;2349.306954448442;2349.800266977309;11043.171762117792;11150.442477876073;11151.107911367071;11155.274907131092;11160;5517.2551705520045;5572.470615291581;5674.631148975303;5681.488666020078;5687.886242275132;3373.2410207703315;3563.94654080189;3601;3649.3248748981523;3657.3965295726175;1134.8184290513477;1174.960701991763;1197.4012993503247;1206.6199147268583;1222.969425764363;13627.182369057888;13980.58058258254;14262.92868535661;15323;15382.384704611803;4543.818247270072;4689.484156742756;4693.95306046942;4710.764461776897;4735.573798358096;10280.485975701335;11303.943480282545;11777.293362398283;11782.234154780082;11783.293002419883;4793.23308270675;4973.35346404965;5667.064934285879;5671.631343962629;5705.600607957486;4189.308764053958;4974.8756281093265;5121.2574176744165;5205.349331333583;5211.661242019332;3668.6881615063016;3821.197548514843;3852.749571277858;3859.363205071188;3891.805409729502;1011.0799172752907;1017.2624846986024;1020.2501161646184;1024.1192574386023;1028.6245520385005;798.7444017914212;945.5886689290044;954.8997355277735;964.4261664309724;1007.3049595778889;5978.013627751459;6352.983522636356;6670.799876003728;6797.728090876409;6842.692078856463;886.499127992682;1019.9439030853226;1022.197574903697;1024.8770147582338;1032.808930347888;4201.831926722958;4207.137536804948;4263.722858014219;4391.187630288407;4465.397171381886;13725.588232353046;14402.063865848895;14443.49447769323;14474.493392731203;14521;13826.30868456573;14082.014259001771;14341.6414589634;14377.856221437862;14386.928065359607;9736.95131524338;10155.746106347253;10334.17326613869;10347.94826025865;10383.325083869524;6854.314568543105;6857.7256909723055;6879.140107486564;7021.087258656342;7126.35862772353;10706;12465.127441079037;12542.1847579907;12588.307643079352;12622.621321360373;11464.82802757976;11838.940805295919;11985.940070299594;12812.078188271833;12816.116373815817;8943.910560894308;9153.542322883963;9229.907700923173;9243.630254790001;9323.440593564137;10364.015418535228;10386.740331491774;10452.425116618659;10468.790624187626;10479.947600262254;7890.9741733574265;8677.696280630147;8779.429337093068;8856.955715221382;8892.33307501927;8240.917590824016;8614.267787237904;8665.696700615701;8690.174433428814;8751.91248087511;7914.1294457608465;8059.597020149086;8075;8075.475094118863;8080;5878.265216847894;5894.233749612523;5896.115582662635;6091.9643660578695;6126.111713801563;5284.313039304866;5869.559783016205;5957.076653118774;6007.8197654070445;6124.5712800103565 02:41:06 INFO - PROCESS | 1640 | |4;prototype.html;321.2835377109047;352.9200646023169;385.6953007124372;390.44946625258393;391.9196564704236;4341.652667786578;4622.352870598111;5140.866540385745;5244.164542410159;5249.081410753117;4341.587549182823;5012.608923622383;5054.140796064668;5064.417591976924;5077.5176358246;3595.5146055282594;3747.3254814133447;4281.464816897896;4289.463817022872;4359.760213188273;3917.7649341039487;4256.531781504032;4328.913421731563;4334.349847522881;4335.030504104682;4296.355546667994;4296.377025331325;4322.805473753673;4329.935050974238;4355.847545335914;3762.024936908118;4176.68674849386;4198.769067701275;4221.26127927613;4274.5939135782055;3509.9649003509894;3909.1986142840933;3920.607939206085;3921.9215615687526;3954.268460334847;4192.392103145027;4875.658703890729;4935.555799978019;5038.571721403649;5059.721715305656;4192.517860446057;4664.696794708333;4810.663253572251;4900.877478063041;4989.800407983676;4713.835015774465;5063.620228482841;5444.891102177974;5485.204645326446;5567.186477263047;3991.5808840071663;4085.162541678949;4099.631033206996;4170.416141740128;4387.254166791653;4897.6326775491625;5155.845324640267;5390.838274851761;5775;5881.588288819784;3864.478295430081;3951.920961580752;4275.422817919603;4500.8649740507835;4513.571210734975;4604.815807367735;4605.286180642006;4613.723176609347;4616.60758835496;4623.329617205486;4180.979095104505;4594.678372513892;4646.279826626878;4656.0920620479355;4715.740634265148;4927.162382395001;5113.954418232663;5115.6443542461275;5246.898151388251;5520.613557050968;1300.674831292177;1378.9310534473236;1532.8237252715858;1544.7528395456673;1552.4333618229266;1120.3445984099394;1149.5631659969326;1155.9190856640123;1162.9069674426196;1170.4323403149465;4293.549177336397;4654.650901182425;4859.732714700725;4881.219004959189;5087.821926232564;4868.367112275381;5146.794128234904;5166.173412254097;5570.470805273492;5770.855728606818;4314.245007123741;4440.2007638625355;4575.862724118282;5066.620003499752;5154.1808409137575;2653.169313173904;2906.13745460721;2907.069737683963;2937.3684657798676;2944.27865173034;4945.826896058621;5087.389513258433;5759.971200143972;5771.7114144293455;6000.7698421823425;5119.769610367543;5493.093639549509;5514.731611729325;5804.680742559115;5991.820245392558;5371.871906899517;5929.673867937305;6027.819165424957;6039.644538629937;6046.309392320463;5593.664380137205;5685.857853553694;5729.369769325454;5775.94224057754;5790.855228619318;4597.448306203277;5193.221016847503;5603.271574695264;5611.410801865745;5675.971620141873;5018.290123333359;5635.33757541518;5656.462636049569;5668.631538949955;5688.54491640676;4077.510698716173;4480.417545719036;4559.794809233659;4568.862934111982;4593.701409408512;5062.569681577107;5710.914926164016;5773.595848290579;5816.592838501264;5866.794662186974;4431.8670439886855;4676.719396836201;5358.84784771276;5386.192071189353;5445.482679145475;4731.787069581946;5402.891942161214;5406.2156490456055;5435.891282174255;5610.3449482401975;5083.364579427572;5148.605898257329;5265.631405801557;5325.50288647849;5476.17857321405;5022.4977502249485;5274.312220089534;5410.918836217538;5480.424555421783;5564.944350556442;4747.477777444409;5329.600279979095;5332.360116786011;5420.961383769118;5445.148649459203 02:41:06 INFO - PROCESS | 1640 | |5;yui.html;720.3085038363171;758.4084414156956;768.5926458976744;840.2983508770177;842.2672275120644;15037.172955487458;15590.688186236282;17538.12309384532;18275.63448731028;18444.631107377845;16563.91718041411;16833;17090.230939607718;17204.311827526915;17872.195751191197;928.0348437624862;952.9094736000103;954.6086104697075;955.5938726041439;957.5834511987273;920.4017388697367;939.1594522901999;954.6038394066454;955.4935883981501;956.5743244256308;1000.2148313573846;1003.3227571389319;1003.9899601004006;1004.4475538453858;1006.8288390973552;998.0169533009979;998.4558415663481;999.7850462150636;1001.2690735762934;1001.4291853643426;737.3216640690578;738.3982054625463;738.65283316841;739.0761548064919;740.1414359343136;15410;15733.606659833482;15800.920995395065;15906.840931590652;16323;14062.616901675408;14240.501582444565;14269.571912842528;14321.283935803169;14417.27913604326;11327.923847234499;11723.706907327385;11752.941235293769;11819.113566482549;11882.643520694393;3489.319582681378;3572.356975744365;3759.8496060157563;3806.0865392305923;3845.711571632111;114525.85474145235;114894.0603342641;115617;116076;116113;10010.149137323264;10413.219008574388;10550.208734344955;10847.566097356017;11091.27906686079;22238.776867272456;22955;22975.19586814487;22989.655155172684;23002.309930702108;7688.192739762245;7816.335611473089;7845.0585929688805;7890.368770498347;8060.637271322805;4331.5884990925815;4411.7573533455325;4459.0413061192;4631.397918270603;4637.6289896808175;3652.415613501827;3864.6715029222833;3879.4568760373572;3890.727649064595;3891.8637847675195;675.4495086504581;695.1033167214338;696.8153439338579;712.8574285142888;714.3927661487797;680.8093733754557;686.4302628818069;693.968771405288;709.8864181730899;739.981500462482;10643.254972151875;10965.890341096647;11175.552977880794;11192.608258711069;11392.601258955896;557.2967630097976;576.7736536967303;594.8839976204686;628.71707731521;695.6347917343435;4654.185517534418;4995.9500404996215;5328.413874473805;5564.610477266633;5629.183768353566;97769.51115244378;98102.03795924185;99875.50062249642;100318;102464.46303305456;74318.62840685762;82864.58567707243;90530;92389;92475.53762231146;78616;80372.5981370101;82269;83510.58244708738;83655.581722091;10162.644307449204;10406.58373665045;10645.467726613484;10658.934106589279;10662.253642244968;36613.26773464462;43248;49998.75000625119;51374.74312628413;52154.73922630362;64100.67949660222;65184.67407663121;65608.01587976089;65689;66403.66798166171;12594.685132871751;12677.80983285233;12731.299778512272;13566;13589.45642174302;13855.930720346738;14362.70735633798;14683.119231418852;14709.338079786648;14820.62948426298;13327.200367977952;13376.063675542619;13422.664433389244;14378.784318235026;14412.919031072503;13384.799228011392;13696.315184240948;13720.108192967426;14308.57074287773;14333.283335832957;12855.1001429899;13322.533711320057;13523.323833808467;13581.524646637321;14091.084079534798;9649.565769540248;9832.410055396698;10075.294729368874;10114.494275286354;10148.746281343025;9779.41323520591;11239.657867011634;11512.59705910289;11524.769504610029;11535.5962541314 02:41:06 INFO - PROCESS | 1640 | __end_tp_report 02:41:06 INFO - PROCESS | 1640 | __start_cc_report 02:41:06 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1935 02:41:06 INFO - PROCESS | 1640 | __end_cc_report 02:41:06 INFO - PROCESS | 1640 | __startTimestamp1490953266762__endTimestamp 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | ------- Summary: start ------- 02:41:06 INFO - PROCESS | 1640 | Number of tests: 6 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5968.61 Median:6221.10 stddev:647.93 (10.4%) stddev-sans-first:615.49 02:41:06 INFO - PROCESS | 1640 | Values: 3312.2 3401.8 3405.1 3415.5 3453.7 6006.8 6012.0 6014.0 6029.6 6081.4 5994.5 6031.9 6063.8 6081.2 6090.0 5385.9 5418.3 5445.3 5456.6 5559.1 5366.4 5367.9 5402.4 5531.2 5549.9 5452.0 5509.6 5543.6 5562.5 5587.0 5495.1 5507.5 5510.6 5530.8 5559.3 5344.3 5448.8 5450.4 5475.1 5511.0 5756.0 5779.3 5791.5 6017.5 6068.6 6332.2 6339.9 6360.1 6364.5 6372.9 6405.7 6448.5 6458.0 6459.9 6495.9 6153.7 6219.3 6223.9 6224.7 6228.6 6318.4 6347.9 6618.9 6644.9 6647.6 6251.4 6290.6 6307.8 6310.4 6339.6 6380.1 6418.5 6424.5 6432.7 6434.9 6257.8 6365.9 6372.0 6374.0 6383.0 6286.1 6370.2 6389.7 6400.0 6404.8 5211.0 5217.1 5222.8 5227.7 5247.9 4604.9 4625.8 4651.0 4654.4 4656.4 5724.3 5823.0 5896.1 5995.8 6046.6 6417.3 6455.3 6486.5 6498.9 6504.3 5851.7 6028.6 6049.8 6068.9 6068.9 5508.6 5631.4 5693.8 5704.3 5730.9 5607.0 6471.0 6483.5 6570.8 6636.8 6494.8 6495.6 6495.8 6513.8 6516.9 6586.2 6678.3 6724.5 6726.3 6741.7 6243.5 6252.9 6285.4 6335.1 6410.1 6365.1 6447.6 6452.5 6460.3 6468.2 6154.8 6165.2 6204.5 6222.9 6225.7 6136.4 6341.1 6348.4 6350.9 6351.7 5986.1 5998.4 5999.1 6002.0 6046.3 6221.1 6268.9 6288.2 6292.3 6300.9 6236.5 6259.1 6261.9 6265.1 6287.9 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:54668.16 Median:16658.55 stddev:108843.77 (653.4%) stddev-sans-first:109073.92 02:41:06 INFO - PROCESS | 1640 | Values: 785.8 806.1 834.7 854.8 884.5 28259.0 39899.2 40206.0 42274.0 42276.4 41783.8 41854.0 41901.6 42078.0 42218.4 9195.6 9356.4 9361.3 9375.0 9376.2 7325.8 7474.3 7582.9 7586.4 7669.9 11035.4 11293.8 11357.9 11375.6 11376.3 11107.0 11140.2 11153.9 11157.8 11181.0 7288.6 10800.8 10876.0 10882.3 10883.1 28763.6 28878.6 28889.6 29123.1 39314.2 3765.7 3773.3 3780.4 3798.1 3853.8 27297.6 27316.7 28424.4 29305.0 29588.1 3035.7 3051.3 3053.8 3261.4 3267.1 357868.0 358571.0 358925.0 359160.0 359256.0 54151.5 54183.0 54241.7 54295.0 54387.7 55359.2 55742.0 55823.2 55912.0 55913.0 14943.1 15048.4 15051.0 15060.2 15092.6 12769.6 12796.2 12813.6 12823.4 12844.6 10511.9 10776.0 12587.7 12599.9 12664.2 4732.7 5045.4 5447.2 5695.9 5736.5 1136.2 1164.0 1164.6 1183.5 1209.6 21973.0 26858.3 27527.7 27592.4 27631.7 1044.0 1191.7 1255.3 1258.4 1292.1 13856.9 13928.6 14018.3 14191.4 14192.6 444855.6 446978.1 447413.0 447925.0 448377.0 57759.8 57799.0 57883.0 57921.4 57960.7 1208.5 1477.2 1478.5 1481.2 1483.0 22817.9 25752.9 25924.9 26807.6 27192.9 48223.5 48299.5 48332.5 48490.5 48524.5 419514.8 420419.0 420927.0 421202.0 421458.0 29830.4 30281.4 31201.5 31310.5 34806.7 38554.6 39498.4 39569.8 39778.0 39809.8 27434.3 27967.0 28641.1 28981.0 29127.0 28095.6 28146.0 28737.6 28817.4 28984.9 33039.0 33193.5 33257.7 33347.5 33650.0 28217.6 28642.4 29158.0 29292.1 29515.0 21946.0 23151.4 23230.0 23404.2 23593.3 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:44979.92 Median:22773.76 stddev:131623.64 (578.0%) stddev-sans-first:131950.28 02:41:06 INFO - PROCESS | 1640 | Values: 383.6 431.6 432.1 438.3 447.6 15983.4 20418.0 21106.6 21255.0 21639.2 20868.6 21835.0 21994.7 22057.2 22818.5 5834.5 6892.9 6991.8 7052.0 7927.9 7792.9 7963.5 8076.0 8092.2 8113.8 7907.3 7990.2 7996.3 8017.7 8026.9 7664.8 7833.2 7904.6 7905.8 8007.9 7586.5 7599.0 7678.7 7683.2 7695.5 24811.5 26547.6 26959.2 26967.6 27155.5 2897.1 2939.2 2957.8 2967.2 3013.7 16801.2 16980.2 17320.1 17329.5 17916.9 2076.9 2083.9 2100.7 2115.3 2220.5 131800.0 135055.0 139171.6 143406.3 143605.3 15904.6 21766.3 21831.3 22078.8 22804.3 27477.6 35643.6 36315.6 36453.5 36459.9 9577.6 9741.7 11104.8 11107.2 11114.9 8872.4 9012.2 9147.0 9179.9 9191.4 8441.7 10279.8 10376.3 10377.7 10500.7 3760.2 4001.8 4172.4 4230.0 4258.7 924.5 939.9 949.0 959.6 975.4 17759.1 22743.2 23131.9 23135.1 23333.5 948.1 966.7 971.3 979.8 982.8 11442.8 11858.3 12082.9 12173.4 12175.7 778288.0 781774.0 785043.0 797869.0 803401.0 175949.0 176788.1 177031.1 177671.0 184722.0 1231.2 1235.9 1288.0 1288.5 1294.6 20177.9 20234.0 20543.0 20709.3 20741.9 47990.8 59614.7 63227.4 64196.0 64789.7 94467.0 94637.5 94749.5 97043.0 97247.5 11358.8 11762.9 11810.9 11838.2 12107.6 13004.9 13128.9 13134.7 13559.5 13586.4 11096.7 11218.5 11379.7 11437.8 11541.8 9714.9 10317.7 10543.6 10649.8 10709.0 10985.7 11087.9 11172.0 11411.5 11676.8 10901.8 11613.1 11713.9 11753.1 11891.2 11107.7 11218.7 11340.7 11563.0 11642.3 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6728.31 Median:2388.21 stddev:4245.50 (177.8%) stddev-sans-first:4239.43 02:41:06 INFO - PROCESS | 1640 | Values: 1528.2 1528.8 1545.6 1557.8 1580.0 10708.9 11298.2 11302.4 11308.2 11315.7 10743.3 10978.6 11043.1 11235.3 11238.2 2345.6 2398.2 2403.0 2403.7 2411.5 2308.4 2354.7 2400.0 2400.4 2405.4 2295.6 2341.6 2353.6 2382.3 2394.2 1930.3 2294.7 2353.6 2355.1 2357.7 2346.7 2348.9 2349.3 2349.3 2349.8 11043.2 11150.4 11151.1 11155.3 11160.0 5517.3 5572.5 5674.6 5681.5 5687.9 3373.2 3563.9 3601.0 3649.3 3657.4 1134.8 1175.0 1197.4 1206.6 1223.0 13627.2 13980.6 14262.9 15323.0 15382.4 4543.8 4689.5 4694.0 4710.8 4735.6 10280.5 11303.9 11777.3 11782.2 11783.3 4793.2 4973.4 5667.1 5671.6 5705.6 4189.3 4974.9 5121.3 5205.3 5211.7 3668.7 3821.2 3852.7 3859.4 3891.8 1011.1 1017.3 1020.3 1024.1 1028.6 798.7 945.6 954.9 964.4 1007.3 5978.0 6353.0 6670.8 6797.7 6842.7 886.5 1019.9 1022.2 1024.9 1032.8 4201.8 4207.1 4263.7 4391.2 4465.4 13725.6 14402.1 14443.5 14474.5 14521.0 13826.3 14082.0 14341.6 14377.9 14386.9 9737.0 10155.7 10334.2 10347.9 10383.3 6854.3 6857.7 6879.1 7021.1 7126.4 10706.0 12465.1 12542.2 12588.3 12622.6 11464.8 11838.9 11985.9 12812.1 12816.1 8943.9 9153.5 9229.9 9243.6 9323.4 10364.0 10386.7 10452.4 10468.8 10479.9 7891.0 8677.7 8779.4 8857.0 8892.3 8240.9 8614.3 8665.7 8690.2 8751.9 7914.1 8059.6 8075.0 8075.5 8080.0 5878.3 5894.2 5896.1 6092.0 6126.1 5284.3 5869.6 5957.1 6007.8 6124.6 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4552.04 Median:4878.44 stddev:1275.21 (26.1%) stddev-sans-first:1238.62 02:41:06 INFO - PROCESS | 1640 | Values: 321.3 352.9 385.7 390.4 391.9 4341.7 4622.4 5140.9 5244.2 5249.1 4341.6 5012.6 5054.1 5064.4 5077.5 3595.5 3747.3 4281.5 4289.5 4359.8 3917.8 4256.5 4328.9 4334.3 4335.0 4296.4 4296.4 4322.8 4329.9 4355.8 3762.0 4176.7 4198.8 4221.3 4274.6 3510.0 3909.2 3920.6 3921.9 3954.3 4192.4 4875.7 4935.6 5038.6 5059.7 4192.5 4664.7 4810.7 4900.9 4989.8 4713.8 5063.6 5444.9 5485.2 5567.2 3991.6 4085.2 4099.6 4170.4 4387.3 4897.6 5155.8 5390.8 5775.0 5881.6 3864.5 3951.9 4275.4 4500.9 4513.6 4604.8 4605.3 4613.7 4616.6 4623.3 4181.0 4594.7 4646.3 4656.1 4715.7 4927.2 5114.0 5115.6 5246.9 5520.6 1300.7 1378.9 1532.8 1544.8 1552.4 1120.3 1149.6 1155.9 1162.9 1170.4 4293.5 4654.7 4859.7 4881.2 5087.8 4868.4 5146.8 5166.2 5570.5 5770.9 4314.2 4440.2 4575.9 5066.6 5154.2 2653.2 2906.1 2907.1 2937.4 2944.3 4945.8 5087.4 5760.0 5771.7 6000.8 5119.8 5493.1 5514.7 5804.7 5991.8 5371.9 5929.7 6027.8 6039.6 6046.3 5593.7 5685.9 5729.4 5775.9 5790.9 4597.4 5193.2 5603.3 5611.4 5676.0 5018.3 5635.3 5656.5 5668.6 5688.5 4077.5 4480.4 4559.8 4568.9 4593.7 5062.6 5710.9 5773.6 5816.6 5866.8 4431.9 4676.7 5358.8 5386.2 5445.5 4731.8 5402.9 5406.2 5435.9 5610.3 5083.4 5148.6 5265.6 5325.5 5476.2 5022.5 5274.3 5410.9 5480.4 5564.9 4747.5 5329.6 5332.4 5421.0 5445.1 02:41:06 INFO - PROCESS | 1640 | 02:41:06 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20794.80 Median:13245.81 stddev:29785.45 (224.9%) stddev-sans-first:29830.87 02:41:06 INFO - PROCESS | 1640 | Values: 720.3 758.4 768.6 840.3 842.3 15037.2 15590.7 17538.1 18275.6 18444.6 16563.9 16833.0 17090.2 17204.3 17872.2 928.0 952.9 954.6 955.6 957.6 920.4 939.2 954.6 955.5 956.6 1000.2 1003.3 1004.0 1004.4 1006.8 998.0 998.5 999.8 1001.3 1001.4 737.3 738.4 738.7 739.1 740.1 15410.0 15733.6 15800.9 15906.8 16323.0 14062.6 14240.5 14269.6 14321.3 14417.3 11327.9 11723.7 11752.9 11819.1 11882.6 3489.3 3572.4 3759.8 3806.1 3845.7 114525.9 114894.1 115617.0 116076.0 116113.0 10010.1 10413.2 10550.2 10847.6 11091.3 22238.8 22955.0 22975.2 22989.7 23002.3 7688.2 7816.3 7845.1 7890.4 8060.6 4331.6 4411.8 4459.0 4631.4 4637.6 3652.4 3864.7 3879.5 3890.7 3891.9 675.4 695.1 696.8 712.9 714.4 680.8 686.4 694.0 709.9 740.0 10643.3 10965.9 11175.6 11192.6 11392.6 557.3 576.8 594.9 628.7 695.6 4654.2 4996.0 5328.4 5564.6 5629.2 97769.5 98102.0 99875.5 100318.0 102464.5 74318.6 82864.6 90530.0 92389.0 92475.5 78616.0 80372.6 82269.0 83510.6 83655.6 10162.6 10406.6 10645.5 10658.9 10662.3 36613.3 43248.0 49998.8 51374.7 52154.7 64100.7 65184.7 65608.0 65689.0 66403.7 12594.7 12677.8 12731.3 13566.0 13589.5 13855.9 14362.7 14683.1 14709.3 14820.6 13327.2 13376.1 13422.7 14378.8 14412.9 13384.8 13696.3 13720.1 14308.6 14333.3 12855.1 13322.5 13523.3 13581.5 14091.1 9649.6 9832.4 10075.3 10114.5 10148.7 9779.4 11239.7 11512.6 11524.8 11535.6 02:41:06 INFO - PROCESS | 1640 | -------- Summary: end -------- 02:41:06 INFO - PROCESS | 1640 | 02:41:07 INFO - TEST-INFO | 1640: exit 0 02:41:07 INFO - TEST-OK | dromaeo_css | took 1120352ms 02:41:07 INFO - TEST-START | kraken 02:41:07 INFO - operating with platform_type : mac_ 02:41:07 INFO - Initialising browser for kraken test... 02:41:07 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpEK9E59/profile http://localhost:49238/getInfo.html) 02:41:09 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 02:41:09 INFO - PROCESS | 1646 | colorDepth:24 02:41:09 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 02:41:09 INFO - PROCESS | 1646 | __metrics 02:41:09 INFO - PROCESS | 1646 | 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" 02:41:09 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:41:10 INFO - TEST-INFO | 1646: exit 0 02:41:10 INFO - Browser initialized. 02:41:10 INFO - Running cycle 1/1 for kraken test... 02:41:10 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpEK9E59/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:22 INFO - PROCESS | 1647 | RSS: Main: 214859776 02:41:22 INFO - PROCESS | 1647 | 02:41:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 02:41:26 INFO - PROCESS | 1647 | RSS: Main: 267661312 02:41:26 INFO - PROCESS | 1647 | 02:41:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 02:41:29 INFO - PROCESS | 1647 | RSS: Main: 278876160 02:41:29 INFO - PROCESS | 1647 | 02:41:33 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 02:41:33 INFO - PROCESS | 1647 | RSS: Main: 375341056 02:41:33 INFO - PROCESS | 1647 | 02:41:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 02:41:36 INFO - PROCESS | 1647 | RSS: Main: 279011328 02:41:36 INFO - PROCESS | 1647 | 02:41:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:39 INFO - PROCESS | 1647 | RSS: Main: 280743936 02:41:39 INFO - PROCESS | 1647 | 02:41:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:42 INFO - PROCESS | 1647 | RSS: Main: 320909312 02:41:42 INFO - PROCESS | 1647 | 02:41:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:46 INFO - PROCESS | 1647 | RSS: Main: 322252800 02:41:46 INFO - PROCESS | 1647 | 02:41:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 02:41:49 INFO - PROCESS | 1647 | RSS: Main: 317468672 02:41:49 INFO - PROCESS | 1647 | 02:41:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:41:51 INFO - PROCESS | 1647 | RSS: Main: 295096320 02:41:51 INFO - PROCESS | 1647 | 02:41:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:54 INFO - PROCESS | 1647 | RSS: Main: 296435712 02:41:54 INFO - PROCESS | 1647 | 02:41:56 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:57 INFO - PROCESS | 1647 | RSS: Main: 308125696 02:41:57 INFO - PROCESS | 1647 | 02:41:59 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:00 INFO - PROCESS | 1647 | RSS: Main: 321581056 02:42:00 INFO - PROCESS | 1647 | 02:42:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:04 INFO - PROCESS | 1647 | RSS: Main: 314421248 02:42:04 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 02:42:06 INFO - PROCESS | 1647 | RSS: Main: 358961152 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | __start_tp_report 02:42:06 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 02:42:06 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 02:42:06 INFO - PROCESS | 1647 | |i|pagename|runs| 02:42:06 INFO - PROCESS | 1647 | |0;ai-astar;116;114;116;115;116;116;115;118;165;172 02:42:06 INFO - PROCESS | 1647 | |1;audio-beat-detection;138;107;109;143;112;108;107;107;128;107 02:42:06 INFO - PROCESS | 1647 | |2;audio-dft;184;185;183;184;183;182;184;181;189;183 02:42:06 INFO - PROCESS | 1647 | |3;audio-fft;82;60;61;90;63;60;59;60;76;61 02:42:06 INFO - PROCESS | 1647 | |4;audio-oscillator;89;68;87;69;69;79;111;103;92;84 02:42:06 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;85;86;86;86;87;86;86;87;86;86 02:42:06 INFO - PROCESS | 1647 | |6;imaging-darkroom;93;94;93;97;94;95;95;97;93;93 02:42:06 INFO - PROCESS | 1647 | |7;imaging-desaturate;85;83;84;84;86;83;85;84;83;84 02:42:06 INFO - PROCESS | 1647 | |8;json-parse-financial;62;61;60;61;62;64;65;63;63;63 02:42:06 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;53;63;56;68;62;61;57;57;57;57 02:42:06 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;86;82;84;83;82;84;84;88;89;90 02:42:06 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;136;139;137;133;133;135;144;144;181;159 02:42:06 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;208;165;164;163;166;171;163;164;162;162 02:42:06 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;64;65;66;63;66;65;63;64;62;60 02:42:06 INFO - PROCESS | 1647 | __end_tp_report 02:42:06 INFO - PROCESS | 1647 | __start_cc_report 02:42:06 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2253 02:42:06 INFO - PROCESS | 1647 | __end_cc_report 02:42:06 INFO - PROCESS | 1647 | __startTimestamp1490953326308__endTimestamp 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | ------- Summary: start ------- 02:42:06 INFO - PROCESS | 1647 | Number of tests: 14 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:126.30 Median:116.00 stddev:22.33 (19.2%) stddev-sans-first:23.37 02:42:06 INFO - PROCESS | 1647 | Values: 116.0 114.0 116.0 115.0 116.0 116.0 115.0 118.0 165.0 172.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:116.60 Median:110.50 stddev:14.17 (12.8%) stddev-sans-first:12.74 02:42:06 INFO - PROCESS | 1647 | Values: 138.0 107.0 109.0 143.0 112.0 108.0 107.0 107.0 128.0 107.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:2.15 (1.2%) stddev-sans-first:2.28 02:42:06 INFO - PROCESS | 1647 | Values: 184.0 185.0 183.0 184.0 183.0 182.0 184.0 181.0 189.0 183.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:67.20 Median:62.00 stddev:11.22 (18.1%) stddev-sans-first:10.55 02:42:06 INFO - PROCESS | 1647 | Values: 82.0 60.0 61.0 90.0 63.0 60.0 59.0 60.0 76.0 61.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:81.50 stddev:14.56 (17.9%) stddev-sans-first:15.37 02:42:06 INFO - PROCESS | 1647 | Values: 89.0 68.0 87.0 69.0 69.0 79.0 111.0 103.0 92.0 84.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:0.57 (0.7%) stddev-sans-first:0.44 02:42:06 INFO - PROCESS | 1647 | Values: 85.0 86.0 86.0 86.0 87.0 86.0 86.0 87.0 86.0 86.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.50 stddev:1.58 (1.7%) stddev-sans-first:1.59 02:42:06 INFO - PROCESS | 1647 | Values: 93.0 94.0 93.0 97.0 94.0 95.0 95.0 97.0 93.0 93.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 02:42:06 INFO - PROCESS | 1647 | Values: 85.0 83.0 84.0 84.0 86.0 83.0 85.0 84.0 83.0 84.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 02:42:06 INFO - PROCESS | 1647 | Values: 62.0 61.0 60.0 61.0 62.0 64.0 65.0 63.0 63.0 63.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:4.36 (7.4%) stddev-sans-first:4.02 02:42:06 INFO - PROCESS | 1647 | Values: 53.0 63.0 56.0 68.0 62.0 61.0 57.0 57.0 57.0 57.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.90 (3.4%) stddev-sans-first:3.06 02:42:06 INFO - PROCESS | 1647 | Values: 86.0 82.0 84.0 83.0 82.0 84.0 84.0 88.0 89.0 90.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:141.50 stddev:15.11 (10.7%) stddev-sans-first:15.74 02:42:06 INFO - PROCESS | 1647 | Values: 136.0 139.0 137.0 133.0 133.0 135.0 144.0 144.0 181.0 159.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:164.50 stddev:14.02 (8.5%) stddev-sans-first:2.79 02:42:06 INFO - PROCESS | 1647 | Values: 208.0 165.0 164.0 163.0 166.0 171.0 163.0 164.0 162.0 162.0 02:42:06 INFO - PROCESS | 1647 | 02:42:06 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.50 stddev:1.87 (2.9%) stddev-sans-first:1.99 02:42:06 INFO - PROCESS | 1647 | Values: 64.0 65.0 66.0 63.0 66.0 65.0 63.0 64.0 62.0 60.0 02:42:06 INFO - PROCESS | 1647 | -------- Summary: end -------- 02:42:06 INFO - PROCESS | 1647 | 02:42:07 INFO - TEST-INFO | 1647: exit 0 02:42:07 INFO - TEST-OK | kraken | took 59596ms 02:42:07 INFO - SUITE-END | took 1179s 02:42:07 INFO - Completed test suite (00:19:40) 02:42:07 INFO - javascript benchmark 02:42:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7762.142490277851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.221627917439, 3401.812900290485, 3405.114670185752, 3415.487676848471, 3453.740969427292, 6006.7897623583185, 6012.0, 6014.0, 6029.608075475091, 6081.3918608139165, 5994.46049855513, 6031.939680603193, 6063.848403789907, 6081.179040829486, 6089.969550152254, 5385.892282154355, 5418.29562156919, 5445.264889239961, 5456.645318054314, 5559.082751346023, 5366.382865970405, 5367.865803354928, 5402.432744561824, 5531.225628412026, 5549.916751248715, 5452.04589196889, 5509.614326997112, 5543.556515478752, 5562.527185189264, 5587.0, 5495.120780675113, 5507.504324610784, 5510.586705997066, 5530.806421775259, 5559.305086864142, 5344.331958505187, 5448.754806033738, 5450.400455949843, 5475.06923822951, 5511.0, 5756.0, 5779.33537643168, 5791.536677065825, 6017.48851347636, 6068.57519973602, 6332.240131184288, 6339.8732025359695, 6360.109584658151, 6364.522660800412, 6372.904406433907, 6405.711742971577, 6448.45188159007, 6458.031295305695, 6459.870802583922, 6495.9350406495805, 6153.661548614825, 6219.253689557282, 6223.906641400292, 6224.657643829542, 6228.626282423069, 6318.368163183737, 6347.936520634735, 6618.900716489256, 6644.900326495106, 6647.567908085959, 6251.437370636573, 6290.591111577733, 6307.842303942438, 6310.43206111443, 6339.6196228225535, 6380.138681278061, 6418.454431373292, 6424.453921416732, 6432.742690292336, 6434.903476447857, 6257.7809776658505, 6365.904511432333, 6372.0, 6374.012028135647, 6382.968085159638, 6286.119943207863, 6370.203724534434, 6389.6805159741825, 6400.039994000844, 6404.775832845828, 5211.0, 5217.139172036647, 5222.791088356499, 5227.738613069331, 5247.868803279948, 4604.861854144381, 4625.7687115644085, 4650.9767451162525, 4654.418197725285, 4656.4412270527755, 5724.284464441945, 5823.039198532195, 5896.115582662635, 5995.760169593167, 6046.606970546901, 6417.326180751047, 6455.289918109004, 6486.545941784124, 6498.935010649833, 6504.317046710122, 5851.707414629252, 6028.57799953999, 6049.788257411057, 6068.937935861207, 6068.939310606926, 5508.641938274, 5631.42993859162, 5693.800716974886, 5704.34400043992, 5730.914036289459, 5607.0, 6471.0, 6483.513736469784, 6570.770023049362, 6636.767713130017, 6494.837629059311, 6495.642739649365, 6495.837604059747, 6513.772017979348, 6516.902246466212, 6586.242582103119, 6678.332166783477, 6724.495662825406, 6726.327367263235, 6741.696623652046, 6243.469305109116, 6252.874942501216, 6285.371462853678, 6335.1447554579545, 6410.102585637921, 6365.1088847562305, 6447.6131432114225, 6452.483801295791, 6460.289368169591, 6468.223813142453, 6154.846128846814, 6165.229346331708, 6204.472619827366, 6222.937770622417, 6225.688715564113, 6136.417040381157, 6341.112244285896, 6348.365163483615, 6350.936490635035, 6351.745930162927, 5986.132010858489, 5998.370171131968, 5999.130126131774, 6002.039673652369, 6046.3046749624355, 6221.09794079865, 6268.905966410599, 6288.1825362704385, 6292.276388215414, 6300.905486417616, 6236.469900058546, 6259.12372267892, 6261.906071408841, 6265.060240963892, 6287.874242515032], "value": 5926.5360714953395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.7524879662906, 806.0891192951964, 834.7454026521908, 854.7991222062814, 884.4737381258149, 28259.0, 39899.2020159597, 40205.99485012876, 42274.0, 42276.36585451221, 41783.79108104463, 41854.0, 41901.58098419015, 42078.0, 42218.36672449916, 9195.586198621062, 9356.438613683167, 9361.344705870591, 9375.015623359517, 9376.203022743075, 7325.7802265932105, 7474.289942455485, 7582.924170758277, 7586.431017673669, 7669.884951725729, 11035.3930533821, 11293.830592541119, 11357.886421135807, 11375.601853935113, 11376.317420954727, 11107.000369966701, 11140.164487663458, 11153.944230278797, 11157.776844463106, 11181.0, 7288.56268623879, 10800.783984320347, 10876.0, 10882.347059176474, 10883.149864522971, 28763.56854647182, 28878.566821497694, 28889.56665650017, 29123.126306210637, 39314.21371572581, 3765.6987441004653, 3773.3019391412404, 3780.3573392523335, 3798.1212740420483, 3853.7687738735767, 27297.590536141975, 27316.726832731616, 28424.431511369865, 29305.0, 29588.112356629335, 3035.696430356969, 3051.282948507121, 3053.832039237841, 3261.4129456697783, 3267.0852161394846, 357868.0, 358571.0, 358925.0, 359160.0, 359256.0, 54151.45848541543, 54183.0, 54241.72879135579, 54295.0, 54387.728061360234, 55359.169612455844, 55742.0, 55823.16265256024, 55912.0, 55913.0, 14943.10341379499, 15048.398064077533, 15051.021683590532, 15060.171690556905, 15092.622684432758, 12769.61691149267, 12796.232226066466, 12813.551525696555, 12823.422945967453, 12844.614661560168, 10511.94744026275, 10776.0, 12587.748245035047, 12599.93700031494, 12664.240145591293, 4732.71603703772, 5045.445001049881, 5447.237386765856, 5695.914561281584, 5736.483716465538, 1136.176272202663, 1164.0047759165961, 1164.5807509296646, 1183.491048912626, 1209.5826939705787, 21973.0, 26858.32854178661, 27527.724722752915, 27592.448151036868, 27631.723682763317, 1043.9634612788668, 1191.713988642737, 1255.2844878419396, 1258.4022589270023, 1292.1084451728277, 13856.861431385758, 13928.58214253574, 14018.299085045706, 14191.432342706383, 14192.645183870485, 444855.5514444879, 446978.0604387959, 447413.0, 447925.0, 448377.0, 57759.844803103704, 57799.0, 57883.0, 57921.42078579245, 57960.71019644959, 1208.4682739594725, 1477.2244571599997, 1478.482531114123, 1481.2149560732828, 1482.9925850370894, 22817.88591057034, 25752.871235643703, 25924.870375648003, 26807.597886032116, 27192.864035679693, 48223.51776482331, 48299.517004829504, 48332.516674832805, 48490.51509485001, 48524.514754851996, 419514.8048519476, 420419.0, 420927.0, 421202.0, 421458.0, 29830.403391931606, 30281.394372112874, 31201.53197701991, 31310.530342045342, 34806.65193348136, 38554.6144538551, 39498.40752388774, 39569.80215098906, 39778.0, 39809.80095099506, 27434.314142146606, 27967.0, 28641.14076577706, 28980.985665501605, 29126.961112721907, 28095.578566321114, 28146.0, 28737.557307629086, 28817.42365152727, 28984.855075724485, 33039.0, 33193.50209746904, 33257.66742332546, 33347.49978750272, 33649.99050028503, 28217.57673634856, 28642.42715145644, 29158.0, 29292.121236362942, 29515.0, 21946.012429441034, 23151.40406626367, 23230.0, 23404.18085367004, 23593.29220123399], "value": 18453.26933829977, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.61638361638364, 431.6460502388041, 432.07810869864767, 438.3009100484727, 447.592690651507, 15983.440579579717, 20417.979101044944, 21106.577868442622, 21255.0, 21639.242626508076, 20868.582628347463, 21835.0, 21994.670079948814, 22057.22799702011, 22818.54362912741, 5834.533237341024, 6892.931070689304, 6991.755288564901, 7052.0, 7927.920720792805, 7792.883106753403, 7963.522188668699, 8075.959620201891, 8092.150324215961, 8113.7565873023905, 7907.288344049034, 7990.161033091529, 7996.320312773421, 8017.67929282828, 8026.879596806052, 7664.770056898274, 7833.177516360757, 7904.604769761547, 7905.802354941115, 8007.8798818017485, 7586.4689471737, 7598.962005189938, 7678.654460549289, 7683.1548529661695, 7695.4997925134685, 24811.503769924682, 26547.601785973227, 26959.191224263304, 26967.595486067723, 27155.45689086227, 2897.1453421240576, 2939.153583144887, 2957.837318947457, 2967.1691926260683, 3013.7287644112134, 16801.24394402255, 16980.235889385007, 17320.13399330041, 17329.48011559655, 17916.91041544797, 2076.9480762980897, 2083.864548804338, 2100.726905502275, 2115.2808045264683, 2220.5114874727533, 131800.0, 135055.0, 139171.60828391687, 143406.28296858552, 143605.28197359052, 15904.602384940468, 21766.34700958974, 21831.34144086037, 22078.77921220799, 22804.31587052391, 27477.587836182473, 35643.643563564554, 36315.636843631226, 36453.45319820205, 36459.90620281343, 9577.616895324249, 9741.659041933499, 11104.777904441866, 11107.222494425312, 11114.888851111386, 8872.378933474594, 9012.233960113334, 9147.0, 9179.908200918038, 9191.448513089235, 8441.66233350659, 10279.845802312972, 10376.325538839952, 10377.688669339932, 10500.684979450629, 3760.2291530236234, 4001.762716564117, 4172.3532852407925, 4229.97885010573, 4258.659307255412, 924.473050361301, 939.8966113727485, 948.9525523723786, 959.6353385713384, 975.4342481360794, 17759.112044397727, 22743.203987860346, 23131.884340578526, 23135.07459701593, 23333.533329333317, 948.1419315519466, 966.6665000574791, 971.2666936462925, 979.7991411760572, 982.8083523712808, 11442.768660111366, 11858.288502689866, 12082.939585302192, 12173.391330433444, 12175.688264325241, 778288.0, 781774.0, 785043.0, 797869.0, 803401.0, 175949.0, 176788.11605942145, 177031.11484442494, 177671.0, 184722.0, 1231.1566576894857, 1235.9443825027895, 1288.027539207892, 1288.5039259884825, 1294.5922034559085, 20177.899110504353, 20234.0, 20542.972851357074, 20709.275175368788, 20741.896290518453, 47990.760046199546, 59614.70192649009, 63227.36772632215, 64196.0, 64789.67605161944, 94467.0, 94637.5268123655, 94749.52625237106, 97043.0, 97247.51376243074, 11358.829617555579, 11762.94118529402, 11810.881891180978, 11838.230515016496, 12107.636770896886, 13004.934975325063, 13128.934355328161, 13134.671633208864, 13559.45762169502, 13586.388612512263, 11096.667099987013, 11218.495167717309, 11379.658610241706, 11437.828432573684, 11541.826872597087, 9714.902850971683, 10317.690469285933, 10543.630972915911, 10649.787004259717, 10709.0, 10985.725356866142, 11087.889121108685, 11172.0, 11411.486483108114, 11676.824847627462, 10901.83647245276, 11613.070954323803, 11713.941430292794, 11753.118516111155, 11891.167618266638, 11107.666769996913, 11218.719532011764, 11340.675161592018, 11563.017143542893, 11642.301461912313], "value": 12031.939154928716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.1900592685881, 1528.7783271425637, 1545.6290490282336, 1557.7896983907174, 1579.9526014219573, 10708.946455267722, 11298.209125361229, 11302.434878256085, 11308.208425410225, 11315.717107072327, 10743.301685390445, 10978.560857565708, 11043.116550675946, 11235.325880447159, 11238.213325067249, 2345.636426353918, 2398.1846172301416, 2402.9639555406684, 2403.67550380699, 2411.4694767151286, 2308.3536609749212, 2354.740978492373, 2400.0399840063938, 2400.411899084727, 2405.398650337416, 2295.5867943770113, 2341.5668101401297, 2353.5645905507536, 2382.261498935327, 2394.1500767227644, 1930.3050901675385, 2294.655801629752, 2353.5998880190323, 2355.1403737635724, 2357.728861180969, 2346.671465994762, 2348.894299756515, 2349.3069544484247, 2349.306954448442, 2349.800266977309, 11043.171762117792, 11150.442477876073, 11151.107911367071, 11155.274907131092, 11160.0, 5517.2551705520045, 5572.470615291581, 5674.631148975303, 5681.488666020078, 5687.886242275132, 3373.2410207703315, 3563.94654080189, 3601.0, 3649.3248748981523, 3657.3965295726175, 1134.8184290513477, 1174.960701991763, 1197.4012993503247, 1206.6199147268583, 1222.969425764363, 13627.182369057888, 13980.58058258254, 14262.92868535661, 15323.0, 15382.384704611803, 4543.818247270072, 4689.484156742756, 4693.95306046942, 4710.764461776897, 4735.573798358096, 10280.485975701335, 11303.943480282545, 11777.293362398283, 11782.234154780082, 11783.293002419883, 4793.23308270675, 4973.35346404965, 5667.064934285879, 5671.631343962629, 5705.600607957486, 4189.308764053958, 4974.8756281093265, 5121.2574176744165, 5205.349331333583, 5211.661242019332, 3668.6881615063016, 3821.197548514843, 3852.749571277858, 3859.363205071188, 3891.805409729502, 1011.0799172752907, 1017.2624846986024, 1020.2501161646184, 1024.1192574386023, 1028.6245520385005, 798.7444017914212, 945.5886689290044, 954.8997355277735, 964.4261664309724, 1007.3049595778889, 5978.013627751459, 6352.983522636356, 6670.799876003728, 6797.728090876409, 6842.692078856463, 886.499127992682, 1019.9439030853226, 1022.197574903697, 1024.8770147582338, 1032.808930347888, 4201.831926722958, 4207.137536804948, 4263.722858014219, 4391.187630288407, 4465.397171381886, 13725.588232353046, 14402.063865848895, 14443.49447769323, 14474.493392731203, 14521.0, 13826.30868456573, 14082.014259001771, 14341.6414589634, 14377.856221437862, 14386.928065359607, 9736.95131524338, 10155.746106347253, 10334.17326613869, 10347.94826025865, 10383.325083869524, 6854.314568543105, 6857.7256909723055, 6879.140107486564, 7021.087258656342, 7126.35862772353, 10706.0, 12465.127441079037, 12542.1847579907, 12588.307643079352, 12622.621321360373, 11464.82802757976, 11838.940805295919, 11985.940070299594, 12812.078188271833, 12816.116373815817, 8943.910560894308, 9153.542322883963, 9229.907700923173, 9243.630254790001, 9323.440593564137, 10364.015418535228, 10386.740331491774, 10452.425116618659, 10468.790624187626, 10479.947600262254, 7890.9741733574265, 8677.696280630147, 8779.429337093068, 8856.955715221382, 8892.33307501927, 8240.917590824016, 8614.267787237904, 8665.696700615701, 8690.174433428814, 8751.91248087511, 7914.1294457608465, 8059.597020149086, 8075.0, 8075.475094118863, 8080.0, 5878.265216847894, 5894.233749612523, 5896.115582662635, 6091.9643660578695, 6126.111713801563, 5284.313039304866, 5869.559783016205, 5957.076653118774, 6007.8197654070445, 6124.5712800103565], "value": 5111.214064384132, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.2835377109047, 352.9200646023169, 385.6953007124372, 390.44946625258393, 391.9196564704236, 4341.652667786578, 4622.352870598111, 5140.866540385745, 5244.164542410159, 5249.081410753117, 4341.587549182823, 5012.608923622383, 5054.140796064668, 5064.417591976924, 5077.5176358246, 3595.5146055282594, 3747.3254814133447, 4281.464816897896, 4289.463817022872, 4359.760213188273, 3917.7649341039487, 4256.531781504032, 4328.913421731563, 4334.349847522881, 4335.030504104682, 4296.355546667994, 4296.377025331325, 4322.805473753673, 4329.935050974238, 4355.847545335914, 3762.024936908118, 4176.68674849386, 4198.769067701275, 4221.26127927613, 4274.5939135782055, 3509.9649003509894, 3909.1986142840933, 3920.607939206085, 3921.9215615687526, 3954.268460334847, 4192.392103145027, 4875.658703890729, 4935.555799978019, 5038.571721403649, 5059.721715305656, 4192.517860446057, 4664.696794708333, 4810.663253572251, 4900.877478063041, 4989.800407983676, 4713.835015774465, 5063.620228482841, 5444.891102177974, 5485.204645326446, 5567.186477263047, 3991.5808840071663, 4085.162541678949, 4099.631033206996, 4170.416141740128, 4387.254166791653, 4897.6326775491625, 5155.845324640267, 5390.838274851761, 5775.0, 5881.588288819784, 3864.478295430081, 3951.920961580752, 4275.422817919603, 4500.8649740507835, 4513.571210734975, 4604.815807367735, 4605.286180642006, 4613.723176609347, 4616.60758835496, 4623.329617205486, 4180.979095104505, 4594.678372513892, 4646.279826626878, 4656.0920620479355, 4715.740634265148, 4927.162382395001, 5113.954418232663, 5115.6443542461275, 5246.898151388251, 5520.613557050968, 1300.674831292177, 1378.9310534473236, 1532.8237252715858, 1544.7528395456673, 1552.4333618229266, 1120.3445984099394, 1149.5631659969326, 1155.9190856640123, 1162.9069674426196, 1170.4323403149465, 4293.549177336397, 4654.650901182425, 4859.732714700725, 4881.219004959189, 5087.821926232564, 4868.367112275381, 5146.794128234904, 5166.173412254097, 5570.470805273492, 5770.855728606818, 4314.245007123741, 4440.2007638625355, 4575.862724118282, 5066.620003499752, 5154.1808409137575, 2653.169313173904, 2906.13745460721, 2907.069737683963, 2937.3684657798676, 2944.27865173034, 4945.826896058621, 5087.389513258433, 5759.971200143972, 5771.7114144293455, 6000.7698421823425, 5119.769610367543, 5493.093639549509, 5514.731611729325, 5804.680742559115, 5991.820245392558, 5371.871906899517, 5929.673867937305, 6027.819165424957, 6039.644538629937, 6046.309392320463, 5593.664380137205, 5685.857853553694, 5729.369769325454, 5775.94224057754, 5790.855228619318, 4597.448306203277, 5193.221016847503, 5603.271574695264, 5611.410801865745, 5675.971620141873, 5018.290123333359, 5635.33757541518, 5656.462636049569, 5668.631538949955, 5688.54491640676, 4077.510698716173, 4480.417545719036, 4559.794809233659, 4568.862934111982, 4593.701409408512, 5062.569681577107, 5710.914926164016, 5773.595848290579, 5816.592838501264, 5866.794662186974, 4431.8670439886855, 4676.719396836201, 5358.84784771276, 5386.192071189353, 5445.482679145475, 4731.787069581946, 5402.891942161214, 5406.2156490456055, 5435.891282174255, 5610.3449482401975, 5083.364579427572, 5148.605898257329, 5265.631405801557, 5325.50288647849, 5476.17857321405, 5022.4977502249485, 5274.312220089534, 5410.918836217538, 5480.424555421783, 5564.944350556442, 4747.477777444409, 5329.600279979095, 5332.360116786011, 5420.961383769118, 5445.148649459203], "value": 4178.676851701592, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.3085038363171, 758.4084414156956, 768.5926458976744, 840.2983508770177, 842.2672275120644, 15037.172955487458, 15590.688186236282, 17538.12309384532, 18275.63448731028, 18444.631107377845, 16563.91718041411, 16833.0, 17090.230939607718, 17204.311827526915, 17872.195751191197, 928.0348437624862, 952.9094736000103, 954.6086104697075, 955.5938726041439, 957.5834511987273, 920.4017388697367, 939.1594522901999, 954.6038394066454, 955.4935883981501, 956.5743244256308, 1000.2148313573846, 1003.3227571389319, 1003.9899601004006, 1004.4475538453858, 1006.8288390973552, 998.0169533009979, 998.4558415663481, 999.7850462150636, 1001.2690735762934, 1001.4291853643426, 737.3216640690578, 738.3982054625463, 738.65283316841, 739.0761548064919, 740.1414359343136, 15410.0, 15733.606659833482, 15800.920995395065, 15906.840931590652, 16323.0, 14062.616901675408, 14240.501582444565, 14269.571912842528, 14321.283935803169, 14417.27913604326, 11327.923847234499, 11723.706907327385, 11752.941235293769, 11819.113566482549, 11882.643520694393, 3489.319582681378, 3572.356975744365, 3759.8496060157563, 3806.0865392305923, 3845.711571632111, 114525.85474145235, 114894.0603342641, 115617.0, 116076.0, 116113.0, 10010.149137323264, 10413.219008574388, 10550.208734344955, 10847.566097356017, 11091.27906686079, 22238.776867272456, 22955.0, 22975.19586814487, 22989.655155172684, 23002.309930702108, 7688.192739762245, 7816.335611473089, 7845.0585929688805, 7890.368770498347, 8060.637271322805, 4331.5884990925815, 4411.7573533455325, 4459.0413061192, 4631.397918270603, 4637.6289896808175, 3652.415613501827, 3864.6715029222833, 3879.4568760373572, 3890.727649064595, 3891.8637847675195, 675.4495086504581, 695.1033167214338, 696.8153439338579, 712.8574285142888, 714.3927661487797, 680.8093733754557, 686.4302628818069, 693.968771405288, 709.8864181730899, 739.981500462482, 10643.254972151875, 10965.890341096647, 11175.552977880794, 11192.608258711069, 11392.601258955896, 557.2967630097976, 576.7736536967303, 594.8839976204686, 628.71707731521, 695.6347917343435, 4654.185517534418, 4995.9500404996215, 5328.413874473805, 5564.610477266633, 5629.183768353566, 97769.51115244378, 98102.03795924185, 99875.50062249642, 100318.0, 102464.46303305456, 74318.62840685762, 82864.58567707243, 90530.0, 92389.0, 92475.53762231146, 78616.0, 80372.5981370101, 82269.0, 83510.58244708738, 83655.581722091, 10162.644307449204, 10406.58373665045, 10645.467726613484, 10658.934106589279, 10662.253642244968, 36613.26773464462, 43248.0, 49998.75000625119, 51374.74312628413, 52154.73922630362, 64100.67949660222, 65184.67407663121, 65608.01587976089, 65689.0, 66403.66798166171, 12594.685132871751, 12677.80983285233, 12731.299778512272, 13566.0, 13589.45642174302, 13855.930720346738, 14362.70735633798, 14683.119231418852, 14709.338079786648, 14820.62948426298, 13327.200367977952, 13376.063675542619, 13422.664433389244, 14378.784318235026, 14412.919031072503, 13384.799228011392, 13696.315184240948, 13720.108192967426, 14308.57074287773, 14333.283335832957, 12855.1001429899, 13322.533711320057, 13523.323833808467, 13581.524646637321, 14091.084079534798, 9649.565769540248, 9832.410055396698, 10075.294729368874, 10114.494275286354, 10148.746281343025, 9779.41323520591, 11239.657867011634, 11512.59705910289, 11524.769504610029, 11535.5962541314], "value": 7781.709637024387, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 116.0, 115.0, 116.0, 116.0, 115.0, 118.0, 165.0, 172.0], "value": 126.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 107.0, 109.0, 143.0, 112.0, 108.0, 107.0, 107.0, 128.0, 107.0], "value": 116.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 183.0, 184.0, 183.0, 182.0, 184.0, 181.0, 189.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 90.0, 63.0, 60.0, 59.0, 60.0, 76.0, 61.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 87.0, 69.0, 69.0, 79.0, 111.0, 103.0, 92.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 87.0, 86.0, 86.0, 87.0, 86.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 97.0, 94.0, 95.0, 95.0, 97.0, 93.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 84.0, 86.0, 83.0, 85.0, 84.0, 83.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 62.0, 64.0, 65.0, 63.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 63.0, 56.0, 68.0, 62.0, 61.0, 57.0, 57.0, 57.0, 57.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 84.0, 83.0, 82.0, 84.0, 84.0, 88.0, 89.0, 90.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 137.0, 133.0, 133.0, 135.0, 144.0, 144.0, 181.0, 159.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 165.0, 164.0, 163.0, 166.0, 171.0, 163.0, 164.0, 162.0, 162.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 63.0, 66.0, 65.0, 63.0, 64.0, 62.0, 60.0], "value": 63.8, "unit": "score"}]}]} 02:42:07 INFO - Return code: 0 02:42:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:42:07 ERROR - # TBPL SUCCESS # 02:42:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:42:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:42:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:42:07 INFO - 2017-03-31 02:42:07.647 screenresolution[1651:9888] starting screenresolution argv=screenresolution get 02:42:07 INFO - 2017-03-31 02:42:07.650 screenresolution[1651:9888] Display 0: 1600x1200x32@60 02:42:07 INFO - 2017-03-31 02:42:07.655 screenresolution[1652:9891] starting screenresolution argv=screenresolution list 02:42:07 INFO - Available Modes on Display 0 02:42:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:42:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:42:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:42:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:42:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:42:07 INFO - Intel Iris: 02:42:07 INFO - Chipset Model: Intel Iris 02:42:07 INFO - Type: GPU 02:42:07 INFO - Bus: Built-In 02:42:07 INFO - VRAM (Dynamic, Max): 1536 MB 02:42:07 INFO - Vendor: Intel (0x8086) 02:42:07 INFO - Device ID: 0x0a2e 02:42:07 INFO - Revision ID: 0x0009 02:42:07 INFO - Displays: 02:42:07 INFO - Display: 02:42:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:42:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:42:07 INFO - Display Serial Number: 1600x1200 60 02:42:07 INFO - Main Display: Yes 02:42:07 INFO - Mirror: Off 02:42:07 INFO - Online: Yes 02:42:07 INFO - Rotation: Supported 02:42:07 INFO - Return code: 0 02:42:07 INFO - Running post-action listener: _resource_record_post_action 02:42:07 INFO - [mozharness: 2017-03-31 09:42:07.877914Z] Finished run-tests step (success) 02:42:07 INFO - Running post-run listener: _resource_record_post_run 02:42:07 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32672768; Write bytes: 510246400; Read time: 321; Write time: 1580 02:42:07 INFO - TinderboxPrint: CPU usage
53.9% 02:42:07 INFO - TinderboxPrint: I/O read bytes / time
32,672,768 / 321 02:42:07 INFO - TinderboxPrint: I/O write bytes / time
510,246,400 / 1,580 02:42:07 INFO - TinderboxPrint: CPU idle
2,216.9 (46.1%) 02:42:07 INFO - TinderboxPrint: CPU system
959.5 (20.0%) 02:42:07 INFO - TinderboxPrint: CPU user
1,629.5 (33.9%) 02:42:07 INFO - TinderboxPrint: Swap in / out
236,376,064 / 0 02:42:07 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203737600; Write bytes: 200689664; Read time: 15707; Write time: 447 02:42:07 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30690304; Write bytes: 298747392; Read time: 303; Write time: 1102 02:42:08 INFO - Running post-run listener: _upload_blobber_files 02:42:08 INFO - Blob upload gear active. 02:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:09 INFO - (blobuploader) - INFO - Done attempting. 02:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:10 INFO - (blobuploader) - INFO - Done attempting. 02:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:11 INFO - (blobuploader) - INFO - Done attempting. 02:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:14 INFO - (blobuploader) - INFO - Done attempting. 02:42:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:42:14 INFO - Return code: 0 02:42:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:42:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:42:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfee554f8be6cdb203f2f2040711e0a17192f9146968df1e14307b35d2a8c502a4ba7d0565eb18d64439409ea49e3c958052157913d6c0e04d2068de7b53f89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18f05f96b6d9abdf9952fdeb378a9a400f2590f996b4bfa288140f0d9fba6ad917df2e3da5cf7bfc4b511b8a022ac4a762d9d0e298822f7794b4f4caa7286528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac78527212b81ea908102df38b770ce5d111c180a0652bdd11c4ad48df4d930bb1f1241cca817d86f74acae33145eae51f61ab1eec822a8a723d468bd5e81127", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9421a08e8900b32cf83d5ca44d1f82f958e85a198e27002986bc5e59030b4d53d21ae11df16a17bbcf9cd3f6e85c1eec9b0393e463060182869096bf5fe5552c"} 02:42:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:42:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:42:14 INFO - Contents: 02:42:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfee554f8be6cdb203f2f2040711e0a17192f9146968df1e14307b35d2a8c502a4ba7d0565eb18d64439409ea49e3c958052157913d6c0e04d2068de7b53f89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18f05f96b6d9abdf9952fdeb378a9a400f2590f996b4bfa288140f0d9fba6ad917df2e3da5cf7bfc4b511b8a022ac4a762d9d0e298822f7794b4f4caa7286528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac78527212b81ea908102df38b770ce5d111c180a0652bdd11c4ad48df4d930bb1f1241cca817d86f74acae33145eae51f61ab1eec822a8a723d468bd5e81127", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9421a08e8900b32cf83d5ca44d1f82f958e85a198e27002986bc5e59030b4d53d21ae11df16a17bbcf9cd3f6e85c1eec9b0393e463060182869096bf5fe5552c"} 02:42:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:42:14 INFO - Copying logs to upload dir... 02:42:14 INFO - mkdir: /builds/slave/test/build/upload/logs 02:42:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.716448 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2017-03-31 02:42:14.361722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 02:42:14.365080) ========= 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.QjUkeulwbB/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.VW4GsiGisd/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfee554f8be6cdb203f2f2040711e0a17192f9146968df1e14307b35d2a8c502a4ba7d0565eb18d64439409ea49e3c958052157913d6c0e04d2068de7b53f89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18f05f96b6d9abdf9952fdeb378a9a400f2590f996b4bfa288140f0d9fba6ad917df2e3da5cf7bfc4b511b8a022ac4a762d9d0e298822f7794b4f4caa7286528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac78527212b81ea908102df38b770ce5d111c180a0652bdd11c4ad48df4d930bb1f1241cca817d86f74acae33145eae51f61ab1eec822a8a723d468bd5e81127", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9421a08e8900b32cf83d5ca44d1f82f958e85a198e27002986bc5e59030b4d53d21ae11df16a17bbcf9cd3f6e85c1eec9b0393e463060182869096bf5fe5552c"} build_url:https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/B0eorW2NQXiDOW7KHDJVSw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfee554f8be6cdb203f2f2040711e0a17192f9146968df1e14307b35d2a8c502a4ba7d0565eb18d64439409ea49e3c958052157913d6c0e04d2068de7b53f89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18f05f96b6d9abdf9952fdeb378a9a400f2590f996b4bfa288140f0d9fba6ad917df2e3da5cf7bfc4b511b8a022ac4a762d9d0e298822f7794b4f4caa7286528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac78527212b81ea908102df38b770ce5d111c180a0652bdd11c4ad48df4d930bb1f1241cca817d86f74acae33145eae51f61ab1eec822a8a723d468bd5e81127", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9421a08e8900b32cf83d5ca44d1f82f958e85a198e27002986bc5e59030b4d53d21ae11df16a17bbcf9cd3f6e85c1eec9b0393e463060182869096bf5fe5552c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 02:42:14.400415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 02:42:14.400750) ========= 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.QjUkeulwbB/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.VW4GsiGisd/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005156 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 02:42:14.449365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 02:42:14.449683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 02:42:14.449982) ========= ========= Total master_lag: 0.28 =========