builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0283 starttime: 1485971308.4 results: success (0) buildid: 20170201082708 builduid: 7500aa1ef7b54f48a609f26d83c96a86 revision: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.402374) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.402828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.403102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.427612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.427988) ========= 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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-02-01 09:48:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.0M=0s 2017-02-01 09:48:28 (66.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.527499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.527815) ========= 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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.020441 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:28.576135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 09:48:28.576561) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a4f2c6889112c9f7e4d3edd2cec93e6ced66270d --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 a4f2c6889112c9f7e4d3edd2cec93e6ced66270d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yLWEtvJxCw/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.FEg1NhHhRk/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-02-01 09:48:28,668 truncating revision to first 12 chars 2017-02-01 09:48:28,668 Setting DEBUG logging. 2017-02-01 09:48:28,668 attempt 1/10 2017-02-01 09:48:28,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a4f2c6889112?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 09:48:30,455 unpacking tar archive at: mozilla-aurora-a4f2c6889112/testing/mozharness/ program finished with exit code 0 elapsedTime=2.045497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 09:48:30.645979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:30.646351) ========= script_repo_revision: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:30.646835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:30.647148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:48:30.666914) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-01 09:48:30.667289) ========= /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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:48:30 INFO - MultiFileLogger online at 20170201 09:48:30 in /builds/slave/test 09:48:30 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 09:48:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:30 INFO - {'append_to_log': False, 09:48:30 INFO - 'base_work_dir': '/builds/slave/test', 09:48:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:48:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:30 INFO - 'branch': 'Mozilla-Aurora', 09:48:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:30 INFO - 'config_files': ('talos/mac_config.py',), 09:48:30 INFO - 'default_actions': ('clobber', 09:48:30 INFO - 'read-buildbot-config', 09:48:30 INFO - 'download-and-extract', 09:48:30 INFO - 'populate-webroot', 09:48:30 INFO - 'create-virtualenv', 09:48:30 INFO - 'install', 09:48:30 INFO - 'run-tests'), 09:48:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:30 INFO - 'download_minidump_stackwalk': True, 09:48:30 INFO - 'download_symbols': 'ondemand', 09:48:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:30 INFO - 'installer_path': 'installer.exe', 09:48:30 INFO - 'log_level': 'info', 09:48:30 INFO - 'log_name': 'talos', 09:48:30 INFO - 'log_to_console': True, 09:48:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:48:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:48:30 INFO - 'opt_config_files': (), 09:48:30 INFO - 'pip_index': False, 09:48:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:30 INFO - 'cmd': ('bash', 09:48:30 INFO - '-c', 09:48:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:30 INFO - 'enabled': True, 09:48:30 INFO - 'halt_on_failure': False, 09:48:30 INFO - 'name': 'check_screen_resolution'},), 09:48:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:30 INFO - 'cmd': ('bash', 09:48:30 INFO - '-c', 09:48:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:30 INFO - 'enabled': True, 09:48:30 INFO - 'halt_on_failure': False, 09:48:30 INFO - 'name': 'check_screen_resolution'},), 09:48:30 INFO - 'run_cmd_checks_enabled': True, 09:48:30 INFO - 'sps_profile': False, 09:48:30 INFO - 'sps_profile_interval': 0, 09:48:30 INFO - 'suite': 'dromaeojs', 09:48:30 INFO - 'system_bits': '32', 09:48:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:30 INFO - 'title': 't-yosemite-r7-0283', 09:48:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:30 INFO - 'use_talos_json': True, 09:48:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:30 INFO - 'work_dir': 'build'} 09:48:30 INFO - [mozharness: 2017-02-01 17:48:30.879428Z] Running clobber step. 09:48:30 INFO - Running pre-action listener: _resource_record_pre_action 09:48:30 INFO - Running main action method: clobber 09:48:30 INFO - rmtree: /builds/slave/test/build 09:48:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:32 INFO - Running post-action listener: _resource_record_post_action 09:48:32 INFO - [mozharness: 2017-02-01 17:48:32.539714Z] Finished clobber step (success) 09:48:32 INFO - [mozharness: 2017-02-01 17:48:32.539885Z] Running read-buildbot-config step. 09:48:32 INFO - Running pre-action listener: _resource_record_pre_action 09:48:32 INFO - Running main action method: read_buildbot_config 09:48:32 INFO - Using buildbot properties: 09:48:32 INFO - { 09:48:32 INFO - "project": "", 09:48:32 INFO - "product": "firefox", 09:48:32 INFO - "script_repo_revision": "production", 09:48:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:48:32 INFO - "repository": "", 09:48:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:48:32 INFO - "buildid": "20170201082708", 09:48:32 INFO - "pgo_build": "False", 09:48:32 INFO - "basedir": "/builds/slave/test", 09:48:32 INFO - "buildnumber": 35, 09:48:32 INFO - "slavename": "t-yosemite-r7-0283", 09:48:32 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:48:32 INFO - "platform": "yosemite_r7", 09:48:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:48:32 INFO - "branch": "mozilla-aurora", 09:48:32 INFO - "repo_path": "releases/mozilla-aurora", 09:48:32 INFO - "revision": "a4f2c6889112c9f7e4d3edd2cec93e6ced66270d", 09:48:32 INFO - "stage_platform": "macosx64", 09:48:32 INFO - "builduid": "7500aa1ef7b54f48a609f26d83c96a86", 09:48:32 INFO - "slavebuilddir": "test" 09:48:32 INFO - } 09:48:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:48:32 INFO - Running post-action listener: _resource_record_post_action 09:48:32 INFO - [mozharness: 2017-02-01 17:48:32.543768Z] Finished read-buildbot-config step (success) 09:48:32 INFO - [mozharness: 2017-02-01 17:48:32.543899Z] Running download-and-extract step. 09:48:32 INFO - Running pre-action listener: _resource_record_pre_action 09:48:32 INFO - Running main action method: download_and_extract 09:48:32 INFO - mkdir: /builds/slave/test/build/tests 09:48:32 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')]} 09:48:32 INFO - trying https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:48:32 INFO - Downloading https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:48:33 INFO - Downloaded 1199 bytes. 09:48:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:48:33 INFO - Using the following test package requirements: 09:48:33 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:48:33 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:48:33 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:48:33 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'jsshell-mac.zip'], 09:48:33 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:48:33 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:48:33 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:48:33 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:48:33 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:48:33 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:48:33 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:48:33 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:48:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:48:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:48:33 INFO - Fetch https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:48:34 INFO - Expected file size: 16354738 09:48:34 INFO - Obtained file size: 16354738 09:48:41 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:48:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:48:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:48:41 INFO - Fetch https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:48:42 INFO - Expected file size: 16354738 09:48:42 INFO - Obtained file size: 16354738 09:48:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:48:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:48:48 INFO - Fetch https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:48:50 INFO - Expected file size: 14403485 09:48:50 INFO - Obtained file size: 14403485 09:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:50 INFO - trying https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:48:50 INFO - Downloading https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:48:53 INFO - Downloaded 73846347 bytes. 09:48:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:48:53 INFO - mkdir: /builds/slave/test/properties 09:48:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:53 INFO - Contents: 09:48:53 INFO - build_url:https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:48:54 INFO - Running post-action listener: _resource_record_post_action 09:48:54 INFO - Running post-action listener: set_extra_try_arguments 09:48:54 INFO - [mozharness: 2017-02-01 17:48:54.273663Z] Finished download-and-extract step (success) 09:48:54 INFO - [mozharness: 2017-02-01 17:48:54.273823Z] Running populate-webroot step. 09:48:54 INFO - Running pre-action listener: _resource_record_pre_action 09:48:54 INFO - Running main action method: populate_webroot 09:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:54 INFO - '--tppagecycles', 09:48:54 INFO - '7'], 09:48:54 INFO - 'tests': ['tsvgm']}}, 09:48:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['damp', 'tps']}, 09:48:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'tests': ['damp', 'tps']}, 09:48:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['dromaeo_dom']}, 09:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['basic_compositor_video']}, 09:48:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:48:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['a11yr', 09:48:54 INFO - 'ts_paint', 09:48:54 INFO - 'tpaint', 09:48:54 INFO - 'sessionrestore', 09:48:54 INFO - 'sessionrestore_no_auto_restore', 09:48:54 INFO - 'tabpaint']}, 09:48:54 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:54 INFO - 'ts_paint', 09:48:54 INFO - 'tpaint', 09:48:54 INFO - 'sessionrestore', 09:48:54 INFO - 'sessionrestore_no_auto_restore', 09:48:54 INFO - 'tabpaint']}, 09:48:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:54 INFO - 'ts_paint', 09:48:54 INFO - 'tpaint', 09:48:54 INFO - 'sessionrestore', 09:48:54 INFO - 'sessionrestore_no_auto_restore', 09:48:54 INFO - 'tabpaint']}, 09:48:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:54 INFO - 'ts_paint', 09:48:54 INFO - 'tpaint', 09:48:54 INFO - 'sessionrestore', 09:48:54 INFO - 'sessionrestore_no_auto_restore', 09:48:54 INFO - 'tabpaint']}, 09:48:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['a11yr', 09:48:54 INFO - 'ts_paint', 09:48:54 INFO - 'tpaint', 09:48:54 INFO - 'sessionrestore', 09:48:54 INFO - 'sessionrestore_no_auto_restore', 09:48:54 INFO - 'tabpaint']}, 09:48:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['a11yr', 09:48:54 INFO - 'ts_paint', 09:48:54 INFO - 'tpaint', 09:48:54 INFO - 'sessionrestore', 09:48:54 INFO - 'sessionrestore_no_auto_restore', 09:48:54 INFO - 'tabpaint']}, 09:48:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['tsvgx', 09:48:54 INFO - 'tsvgr_opacity', 09:48:54 INFO - 'tart', 09:48:54 INFO - 'tscrollx', 09:48:54 INFO - 'cart', 09:48:54 INFO - 'tsvg_static']}, 09:48:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:54 INFO - 'tsvgr_opacity', 09:48:54 INFO - 'tart', 09:48:54 INFO - 'tscrollx', 09:48:54 INFO - 'cart', 09:48:54 INFO - 'tsvg_static']}, 09:48:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'talos_options': ['--disable-e10s'], 09:48:54 INFO - 'tests': ['tp5o']}, 09:48:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:48:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'talos_options': ['--disable-e10s', 09:48:54 INFO - '--xperf_path', 09:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:54 INFO - 'tests': ['tp5n']}, 09:48:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:48:54 INFO - 'talos_options': ['--xperf_path', 09:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:54 INFO - 'tests': ['tp5n']}}, 09:48:54 INFO - 'talos.zip': {'path': '', 09:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:54 INFO - Running post-action listener: _resource_record_post_action 09:48:54 INFO - [mozharness: 2017-02-01 17:48:54.292354Z] Finished populate-webroot step (success) 09:48:54 INFO - [mozharness: 2017-02-01 17:48:54.292458Z] Running create-virtualenv step. 09:48:54 INFO - Running pre-action listener: _resource_record_pre_action 09:48:54 INFO - Running main action method: create_virtualenv 09:48:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:54 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 09:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:54 INFO - Using real prefix '/tools/python27' 09:48:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:57 INFO - Installing pip.................done. 09:48:57 INFO - Return code: 0 09:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:48:58 INFO - Reading from file tmpfile_stdout 09:48:58 INFO - Output received: 09:48:58 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) 09:48:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:58 INFO - 'HOME': '/Users/cltbld', 09:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:58 INFO - 'LOGNAME': 'cltbld', 09:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:58 INFO - 'MOZ_NO_REMOTE': '1', 09:48:58 INFO - 'NO_EM_RESTART': '1', 09:48:58 INFO - 'PAGER': '/bin/cat', 09:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:58 INFO - 'PWD': '/builds/slave/test', 09:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:58 INFO - 'SHELL': '/bin/bash', 09:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:48:58 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:58 INFO - 'USER': 'cltbld', 09:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:58 INFO - 'XPC_FLAGS': '0x0', 09:48:58 INFO - 'XPC_SERVICE_NAME': '0', 09:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:58 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 09:48:58 INFO - Cleaning up... 09:48:58 INFO - Return code: 0 09:48:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:58 INFO - 'HOME': '/Users/cltbld', 09:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:58 INFO - 'LOGNAME': 'cltbld', 09:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:58 INFO - 'MOZ_NO_REMOTE': '1', 09:48:58 INFO - 'NO_EM_RESTART': '1', 09:48:58 INFO - 'PAGER': '/bin/cat', 09:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:58 INFO - 'PWD': '/builds/slave/test', 09:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:58 INFO - 'SHELL': '/bin/bash', 09:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:48:58 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:58 INFO - 'USER': 'cltbld', 09:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:58 INFO - 'XPC_FLAGS': '0x0', 09:48:58 INFO - 'XPC_SERVICE_NAME': '0', 09:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:58 INFO - Downloading/unpacking psutil>=3.1.1 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:02 INFO - Installing collected packages: psutil 09:49:02 INFO - Running setup.py install for psutil 09:49:02 INFO - building 'psutil._psutil_osx' extension 09:49:02 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 09:49:02 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 09:49:02 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 09:49:02 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 09:49:02 INFO - building 'psutil._psutil_posix' extension 09:49:02 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 09:49:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:49:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:49:02 INFO - ^ 09:49:02 INFO - 1 warning generated. 09:49:02 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 09:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:03 INFO - Successfully installed psutil 09:49:03 INFO - Cleaning up... 09:49:03 INFO - Return code: 0 09:49:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:03 INFO - 'HOME': '/Users/cltbld', 09:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:03 INFO - 'LOGNAME': 'cltbld', 09:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:03 INFO - 'MOZ_NO_REMOTE': '1', 09:49:03 INFO - 'NO_EM_RESTART': '1', 09:49:03 INFO - 'PAGER': '/bin/cat', 09:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:03 INFO - 'PWD': '/builds/slave/test', 09:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:03 INFO - 'SHELL': '/bin/bash', 09:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:03 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:03 INFO - 'USER': 'cltbld', 09:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:03 INFO - 'XPC_FLAGS': '0x0', 09:49:03 INFO - 'XPC_SERVICE_NAME': '0', 09:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:06 INFO - Installing collected packages: mozsystemmonitor 09:49:06 INFO - Running setup.py install for mozsystemmonitor 09:49:06 INFO - Successfully installed mozsystemmonitor 09:49:06 INFO - Cleaning up... 09:49:06 INFO - Return code: 0 09:49:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:06 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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:06 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 09:49:06 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 09:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:06 INFO - 'HOME': '/Users/cltbld', 09:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:06 INFO - 'LOGNAME': 'cltbld', 09:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:06 INFO - 'MOZ_NO_REMOTE': '1', 09:49:06 INFO - 'NO_EM_RESTART': '1', 09:49:06 INFO - 'PAGER': '/bin/cat', 09:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:06 INFO - 'PWD': '/builds/slave/test', 09:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:06 INFO - 'SHELL': '/bin/bash', 09:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:06 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:06 INFO - 'USER': 'cltbld', 09:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:06 INFO - 'XPC_FLAGS': '0x0', 09:49:06 INFO - 'XPC_SERVICE_NAME': '0', 09:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:09 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 09:49:09 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 09:49:09 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 09:49:09 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 09:49:09 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 09:49:09 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 09:49:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:09 INFO - warning: no files found matching '*.txt' 09:49:09 INFO - no previously-included directories found matching 'build' 09:49:09 INFO - no previously-included directories found matching 'dist' 09:49:09 INFO - no previously-included directories found matching '.git*' 09:49:09 INFO - Installing collected packages: jsonschema, functools32 09:49:09 INFO - Running setup.py install for functools32 09:49:09 INFO - warning: no files found matching '*.txt' 09:49:09 INFO - no previously-included directories found matching 'build' 09:49:09 INFO - no previously-included directories found matching 'dist' 09:49:09 INFO - no previously-included directories found matching '.git*' 09:49:09 INFO - Successfully installed jsonschema functools32 09:49:09 INFO - Cleaning up... 09:49:09 INFO - Return code: 0 09:49:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:49:09 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')]} 09:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:09 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')]} 09:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:09 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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:09 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 09:49:09 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 09:49:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:09 INFO - 'HOME': '/Users/cltbld', 09:49:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:09 INFO - 'LOGNAME': 'cltbld', 09:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:09 INFO - 'MOZ_NO_REMOTE': '1', 09:49:09 INFO - 'NO_EM_RESTART': '1', 09:49:09 INFO - 'PAGER': '/bin/cat', 09:49:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:09 INFO - 'PWD': '/builds/slave/test', 09:49:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:09 INFO - 'SHELL': '/bin/bash', 09:49:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:09 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:09 INFO - 'USER': 'cltbld', 09:49:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:09 INFO - 'XPC_FLAGS': '0x0', 09:49:09 INFO - 'XPC_SERVICE_NAME': '0', 09:49:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:49:10 INFO - Cleaning up... 09:49:10 INFO - Return code: 0 09:49:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:10 INFO - 'HOME': '/Users/cltbld', 09:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:10 INFO - 'LOGNAME': 'cltbld', 09:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:10 INFO - 'MOZ_NO_REMOTE': '1', 09:49:10 INFO - 'NO_EM_RESTART': '1', 09:49:10 INFO - 'PAGER': '/bin/cat', 09:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:10 INFO - 'PWD': '/builds/slave/test', 09:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:10 INFO - 'SHELL': '/bin/bash', 09:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:10 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:10 INFO - 'USER': 'cltbld', 09:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:10 INFO - 'XPC_FLAGS': '0x0', 09:49:10 INFO - 'XPC_SERVICE_NAME': '0', 09:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:14 INFO - Downloading docopt-0.6.1.tar.gz 09:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:14 INFO - Running setup.py install for blobuploader 09:49:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:14 INFO - Running setup.py install for requests 09:49:14 INFO - Running setup.py install for docopt 09:49:15 INFO - Successfully installed blobuploader requests docopt 09:49:15 INFO - Cleaning up... 09:49:15 INFO - Return code: 0 09:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:15 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')]} 09:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:15 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')]} 09:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:15 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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:15 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 09:49:15 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 09:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:15 INFO - 'HOME': '/Users/cltbld', 09:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:15 INFO - 'LOGNAME': 'cltbld', 09:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:15 INFO - 'MOZ_NO_REMOTE': '1', 09:49:15 INFO - 'NO_EM_RESTART': '1', 09:49:15 INFO - 'PAGER': '/bin/cat', 09:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:15 INFO - 'PWD': '/builds/slave/test', 09:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:15 INFO - 'SHELL': '/bin/bash', 09:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:15 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:15 INFO - 'USER': 'cltbld', 09:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:15 INFO - 'XPC_FLAGS': '0x0', 09:49:15 INFO - 'XPC_SERVICE_NAME': '0', 09:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-uFDUzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-W3Xdu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-G4C_9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-jvU2nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-bq2LAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-zwT5cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Z_sUkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-4ensU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-L52lhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-XaBEdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-a993OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-jQYB3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-_wRI9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-FvaHZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ZYrWgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-91D1b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-GPdo6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:17 INFO - Running setup.py install for manifestparser 09:49:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:17 INFO - Running setup.py install for mozcrash 09:49:17 INFO - Running setup.py install for mozdebug 09:49:17 INFO - Running setup.py install for mozdevice 09:49:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:17 INFO - Running setup.py install for mozfile 09:49:17 INFO - Running setup.py install for mozhttpd 09:49:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Running setup.py install for mozinfo 09:49:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Running setup.py install for mozInstall 09:49:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Running setup.py install for mozleak 09:49:18 INFO - Running setup.py install for mozlog 09:49:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Running setup.py install for moznetwork 09:49:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:18 INFO - Running setup.py install for mozprocess 09:49:19 INFO - Running setup.py install for mozprofile 09:49:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Running setup.py install for mozrunner 09:49:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Running setup.py install for mozscreenshot 09:49:19 INFO - Running setup.py install for moztest 09:49:19 INFO - Running setup.py install for mozversion 09:49:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:19 INFO - Cleaning up... 09:49:19 INFO - Return code: 0 09:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:19 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 09:49:19 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 09:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:19 INFO - 'HOME': '/Users/cltbld', 09:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:19 INFO - 'LOGNAME': 'cltbld', 09:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:19 INFO - 'MOZ_NO_REMOTE': '1', 09:49:19 INFO - 'NO_EM_RESTART': '1', 09:49:19 INFO - 'PAGER': '/bin/cat', 09:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:19 INFO - 'PWD': '/builds/slave/test', 09:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:19 INFO - 'SHELL': '/bin/bash', 09:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:19 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:19 INFO - 'USER': 'cltbld', 09:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:19 INFO - 'XPC_FLAGS': '0x0', 09:49:19 INFO - 'XPC_SERVICE_NAME': '0', 09:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-JHhKXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-8F1sgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Yw0AWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Vbt_v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-BQvoWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-sbQ8v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-KLmr1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-V1kqEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:20 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)) 09:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-b7rKqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-bcgR5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-YT70vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-EPHMTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-cbK2mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Zvz7dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-cCdwyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-AMeKrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-7dVdX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:21 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)) 09:49:21 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)) 09:49:21 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)) 09:49:21 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)) 09:49:21 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)) 09:49:21 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)) 09:49:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:21 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 09:49:24 INFO - Downloading blessings-1.6.tar.gz 09:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:24 INFO - Installing collected packages: blessings 09:49:24 INFO - Running setup.py install for blessings 09:49:24 INFO - Successfully installed blessings 09:49:24 INFO - Cleaning up... 09:49:24 INFO - Return code: 0 09:49:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:25 INFO - Reading from file tmpfile_stdout 09:49:25 INFO - Current package versions: 09:49:25 INFO - blessings == 1.6 09:49:25 INFO - blobuploader == 1.2.4 09:49:25 INFO - docopt == 0.6.1 09:49:25 INFO - functools32 == 3.2.3-2 09:49:25 INFO - jsonschema == 2.5.1 09:49:25 INFO - manifestparser == 1.1 09:49:25 INFO - mozInstall == 1.12 09:49:25 INFO - mozcrash == 1.0 09:49:25 INFO - mozdebug == 0.1 09:49:25 INFO - mozdevice == 0.49 09:49:25 INFO - mozfile == 1.2 09:49:25 INFO - mozhttpd == 0.7 09:49:25 INFO - mozinfo == 0.9 09:49:25 INFO - mozleak == 0.1 09:49:25 INFO - mozlog == 3.4 09:49:25 INFO - moznetwork == 0.27 09:49:25 INFO - mozprocess == 0.24 09:49:25 INFO - mozprofile == 0.28 09:49:25 INFO - mozrunner == 6.13 09:49:25 INFO - mozscreenshot == 0.1 09:49:25 INFO - mozsystemmonitor == 0.3 09:49:25 INFO - moztest == 0.8 09:49:25 INFO - mozversion == 1.4 09:49:25 INFO - psutil == 3.1.1 09:49:25 INFO - requests == 1.2.3 09:49:25 INFO - wsgiref == 0.1.2 09:49:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:26 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 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49:26 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 09:49:26 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 09:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:26 INFO - 'HOME': '/Users/cltbld', 09:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:26 INFO - 'LOGNAME': 'cltbld', 09:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:26 INFO - 'MOZ_NO_REMOTE': '1', 09:49:26 INFO - 'NO_EM_RESTART': '1', 09:49:26 INFO - 'PAGER': '/bin/cat', 09:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:26 INFO - 'PWD': '/builds/slave/test', 09:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:26 INFO - 'SHELL': '/bin/bash', 09:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:26 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:26 INFO - 'USER': 'cltbld', 09:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:26 INFO - 'XPC_FLAGS': '0x0', 09:49:26 INFO - 'XPC_SERVICE_NAME': '0', 09:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 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)) 09:49:26 INFO - Cleaning up... 09:49:26 INFO - Return code: 0 09:49:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb81474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, '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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 09:49: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', 'jsonschema'] in /builds/slave/test/build 09:49: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 jsonschema 09:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:26 INFO - 'HOME': '/Users/cltbld', 09:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:26 INFO - 'LOGNAME': 'cltbld', 09:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:26 INFO - 'MOZ_NO_REMOTE': '1', 09:49:26 INFO - 'NO_EM_RESTART': '1', 09:49:26 INFO - 'PAGER': '/bin/cat', 09:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:26 INFO - 'PWD': '/builds/slave/test', 09:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:26 INFO - 'SHELL': '/bin/bash', 09:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:26 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:26 INFO - 'USER': 'cltbld', 09:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:26 INFO - 'XPC_FLAGS': '0x0', 09:49:26 INFO - 'XPC_SERVICE_NAME': '0', 09:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:27 INFO - Cleaning up... 09:49:27 INFO - Return code: 0 09:49:27 INFO - Running post-action listener: _resource_record_post_action 09:49:27 INFO - Running post-action listener: _start_resource_monitoring 09:49:27 INFO - Starting resource monitoring. 09:49:27 INFO - [mozharness: 2017-02-01 17:49:27.079096Z] Finished create-virtualenv step (success) 09:49:27 INFO - [mozharness: 2017-02-01 17:49:27.079910Z] Running install step. 09:49:27 INFO - Running pre-action listener: _resource_record_pre_action 09:49:27 INFO - Running main action method: install 09:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:27 INFO - Reading from file tmpfile_stdout 09:49:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:27 INFO - Reading from file tmpfile_stdout 09:49:27 INFO - Output received: 09:49:27 INFO - Usage: mozinstall [options] installer 09:49:27 INFO - Options: 09:49:27 INFO - -h, --help show this help message and exit 09:49:27 INFO - -d DEST, --destination=DEST 09:49:27 INFO - Directory to install application into. [default: 09:49:27 INFO - "/builds/slave/test"] 09:49:27 INFO - --app=APP Application being installed. [default: firefox] 09:49:27 INFO - mkdir: /builds/slave/test/build/application 09:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:49:47 INFO - Reading from file tmpfile_stdout 09:49:47 INFO - Output received: 09:49:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:49:47 INFO - Running post-action listener: _resource_record_post_action 09:49:47 INFO - [mozharness: 2017-02-01 17:49:47.235804Z] Finished install step (success) 09:49:47 INFO - [mozharness: 2017-02-01 17:49:47.235946Z] Running run-tests step. 09:49:47 INFO - Running pre-action listener: _resource_record_pre_action 09:49:47 INFO - Running main action method: run_tests 09:49:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:47 INFO - 2017-02-01 09:49:47.251 screenresolution[2183:33101] starting screenresolution argv=screenresolution get 09:49:47 INFO - 2017-02-01 09:49:47.253 screenresolution[2183:33101] Display 0: 1600x1200x32@60 09:49:47 INFO - 2017-02-01 09:49:47.259 screenresolution[2184:33104] starting screenresolution argv=screenresolution list 09:49:47 INFO - Available Modes on Display 0 09:49:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:47 INFO - Intel Iris: 09:49:47 INFO - Chipset Model: Intel Iris 09:49:47 INFO - Type: GPU 09:49:47 INFO - Bus: Built-In 09:49:47 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:47 INFO - Vendor: Intel (0x8086) 09:49:47 INFO - Device ID: 0x0a2e 09:49:47 INFO - Revision ID: 0x0009 09:49:47 INFO - Displays: 09:49:47 INFO - Display: 09:49:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:47 INFO - Display Serial Number: 1600x1200 60 09:49:47 INFO - Main Display: Yes 09:49:47 INFO - Mirror: Off 09:49:47 INFO - Online: Yes 09:49:47 INFO - Rotation: Supported 09:49:47 INFO - Return code: 0 09:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:47 INFO - Python 2.7.3 09:49:47 INFO - Return code: 0 09:49:47 INFO - grabbing minidump binary from tooltool 09:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f07fd30>, '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 0x10efa6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f074be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:49:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:49:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:49:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:47 INFO - Return code: 0 09:49:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:49:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:49:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:47 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/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 09:49:47 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/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --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 09:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yLWEtvJxCw/Render', 09:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:47 INFO - 'HOME': '/Users/cltbld', 09:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:47 INFO - 'LOGNAME': 'cltbld', 09:49:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:47 INFO - 'MOZ_NO_REMOTE': '1', 09:49:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:47 INFO - 'NO_EM_RESTART': '1', 09:49:47 INFO - 'PAGER': '/bin/cat', 09:49:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:47 INFO - 'PWD': '/builds/slave/test', 09:49:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:47 INFO - 'SHELL': '/bin/bash', 09:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEg1NhHhRk/Listeners', 09:49:47 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 09:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:47 INFO - 'USER': 'cltbld', 09:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:47 INFO - 'XPC_FLAGS': '0x0', 09:49:47 INFO - 'XPC_SERVICE_NAME': '0', 09:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:47 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/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 09:49:47 INFO - mozversion application_buildid: 20170201082708 09:49:47 INFO - mozversion application_changeset: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d 09:49:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:49:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:47 INFO - mozversion application_name: Firefox 09:49:47 INFO - mozversion application_remotingname: firefox-dev 09:49:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:47 INFO - mozversion application_vendor: Mozilla 09:49:47 INFO - mozversion application_version: 53.0a2 09:49:47 INFO - mozversion platform_buildid: 20170201082708 09:49:47 INFO - mozversion platform_changeset: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d 09:49:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:47 INFO - mozversion platform_version: 53.0a2 09:49:47 INFO - using testdate: 1485971387 09:49:47 INFO - actual date: 1485971387 09:49:47 INFO - starting webserver on 'localhost:62842' 09:49:47 INFO - SUITE-START | Running 2 tests 09:49:47 INFO - TEST-START | dromaeo_css 09:49:47 INFO - operating with platform_type : mac_ 09:49:47 INFO - Initialising browser for dromaeo_css test... 09:49:47 INFO - TEST-INFO | started process 2194 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpFouLFt/profile http://localhost:62842/getInfo.html) 09:49:50 INFO - PROCESS | 2194 | __metrics Screen width/height:1600/1200 09:49:50 INFO - PROCESS | 2194 | colorDepth:24 09:49:50 INFO - PROCESS | 2194 | Browser inner width/height: 1024/689 09:49:50 INFO - PROCESS | 2194 | __metrics 09:49:50 INFO - PROCESS | 2194 | 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" 09:49:50 INFO - PROCESS | 2194 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:51 INFO - TEST-INFO | 2194: exit 0 09:49:51 INFO - Browser initialized. 09:49:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:51 INFO - TEST-INFO | started process 2196 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpFouLFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:03 INFO - PROCESS | 2196 | RSS: Main: 212578304 09:50:03 INFO - PROCESS | 2196 | 09:53:06 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:62842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62842/tests/dromaeo/cssquery-ext.html) 09:53:08 INFO - PROCESS | 2196 | RSS: Main: 355622912 09:53:08 INFO - PROCESS | 2196 | 09:54:53 INFO - PROCESS | 2196 | ************************* 09:54:53 INFO - PROCESS | 2196 | A coding exception was thrown and uncaught in a Task. 09:54:53 INFO - PROCESS | 2196 | 09:54:53 ERROR - PROCESS | 2196 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:53 INFO - PROCESS | 2196 | Full stack: 09:54:53 INFO - PROCESS | 2196 | ************************* 09:56:10 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:62842/tests/dromaeo/cssquery-ext.html (next: http://localhost:62842/tests/dromaeo/cssquery-jquery.html) 09:56:11 INFO - PROCESS | 2196 | RSS: Main: 349741056 09:56:11 INFO - PROCESS | 2196 | 09:59:13 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:62842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62842/tests/dromaeo/cssquery-mootools.html) 09:59:14 INFO - PROCESS | 2196 | RSS: Main: 351055872 09:59:14 INFO - PROCESS | 2196 | 10:02:16 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:62842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62842/tests/dromaeo/cssquery-prototype.html) 10:02:17 INFO - PROCESS | 2196 | RSS: Main: 323129344 10:02:17 INFO - PROCESS | 2196 | 10:05:20 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:62842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62842/tests/dromaeo/cssquery-yui.html) 10:05:21 INFO - PROCESS | 2196 | RSS: Main: 318853120 10:05:21 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:62842/tests/dromaeo/cssquery-yui.html (next: http://localhost:62842/tests/dromaeo/cssquery-dojo.html) 10:08:24 INFO - PROCESS | 2196 | RSS: Main: 363569152 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | __start_tp_report 10:08:24 INFO - PROCESS | 2196 | _x_x_mozilla_page_load 10:08:24 INFO - PROCESS | 2196 | _x_x_mozilla_page_load_details 10:08:24 INFO - PROCESS | 2196 | |i|pagename|runs| 10:08:24 INFO - PROCESS | 2196 | |0;dojo.html;3087.3825234953006;3252.951205731913;3271.4111459937208;3303.223742420529;3346.69879710826;5513.283273174492;5535.031369510335;5543.861403464905;5543.944560554393;5552.361478429982;5556.888862222763;5610.270664813579;5613.550915926727;5621.662700237988;5646.604737668365;5117.130087885059;5136.306598609196;5165.845024649267;5215.113430716769;5231.986167284428;5065.797368105272;5078.035173317076;5106.004329155816;5159.71621560814;5211.062008838408;5188.247704082905;5223.320968274119;5234.162533994561;5250.238715386266;5255.395629502618;5233.293505376763;5238.92141617876;5245.449227831061;5250.159974404096;5263.157894736823;5094.337736094284;5159.045576568309;5168.147255702805;5169.586433085344;5206.114960456732;5492.890142197173;5511.807086751985;5540.141278101901;5548.805791797308;5571.164325351229;6112.533877023307;6114.361011839412;6136.9173623037705;6154.84612884677;6155.753769849201;6159.168512250879;6210.627362358273;6215.56491045627;6221.564490485668;6236.719347629368;5623.437656234426;5658.603897727202;5672.14917762339;5678;5761.366249712528;6239.594426362272;6247.344028876993;6262.3111457739615;6271.96864015677;6319.842003949938;6048.879022419527;6075.058365953284;6085.391460853879;6089.48239399656;6097.054956481752;6131.478824299896;6159.722812473449;6178.814635560941;6210.627362358273;6216.160818289473;5917.467427931507;5953.077273022688;5977.910331345033;6063.605865618721;6063.969125248718;6125;6125.479334256549;6129.23653806838;6139.658497107545;6172.598781079216;4872.269159626085;4928.137575924199;4929.334539837076;4935.506449355035;4953.23224900141;4410.029793445437;4422.71252368595;4425.778711064434;4430.778461076933;4467.30756732707;5552.91670624941;5588.804391846266;5610.915836262459;5680.943190568124;5710.143478478261;6210.130581718563;6257.311695713468;6271;6274.937250627435;6276.058591211264;5680.261565996394;5718.399568045378;5736.825371592106;5743.569232307594;5763.423657634203;4531.071130418256;5298.523132918056;5334.119870221448;5395.541378982752;5425.701586412785;6158.168647232566;6193.163922870355;6204.038374052029;6266.624002559861;6305.243370795534;6102.267727872683;6105.839890420806;6114.510839132769;6115.158028819334;6136.6806136680825;6200.224971878515;6245.3754624539;6251.281102673251;6255.874882502233;6256.155419018374;5181.948180518147;5968.492678122235;6039.909401358896;6086.573939824169;6125;6222.09779581949;6229.657368844757;6241.032639940817;6242.344553821783;6246.031865060922;5940.108983652487;5979.880402391841;6041.940756687754;6067.908981365194;6117.96941015292;5819.621724587888;5868.149118377897;5912.852178695567;5929.881402372014;5961.986462301333;4879.512048795092;5809.912851307149;5855.473007429352;5858.619189752652;5902.763889444374;5802.332731735904;5859.472647461749;6021.9397806023135;6027.638341699512;6051.425114614105;5787.39232380594;5853.64878107315;5869;5874.295084589877;5925.496332811586 10:08:24 INFO - PROCESS | 2196 | |1;ext.html;449.40005093200574;476.4615983938148;488.43097791073393;492.44107937490935;512.0271484180057;30620.387592248142;39312.21375572487;40978.59021409789;41038.17923641526;41267.793661031654;42845.357319640156;43280.13439731204;43321.78339108308;43344.3498347525;43365.56634433655;9263.583138758771;9488.715338539854;9498.477583732893;9508.239340852715;9515.952420237889;8412;8647.740567782977;11120.277181983185;11365.147613928946;11398.544058237661;11354.034907032912;11402.486888090014;11439.370834604093;11444.942775286112;11458.083353331713;8464.830703385898;11369;11440;11457.770844583103;11468.13988950832;8451.323894088458;10990.560377584887;11259.662210133627;11302.321860688386;11502;39752;40126.79936600327;40153.59846401557;40202.59797402018;40250.39624405607;3396.490526421032;3903.726739128262;3957.3668213086057;4014.036631208489;4065.410515475269;29035.41929161426;29267.414651706848;29733;29763;30792;2761.16516409296;2921.8896819208776;3192.090254277543;3277.066036179677;3370.5449764281752;463531;463577;467156;467755;468648;60924.390756092755;61607.691961540804;61811.763764724456;62010.68994654998;62133.68933155396;64520;64666.0300095499;64793;64806.0279095814;64972;16140.435084771976;16800.74798878018;16824.57938551546;16878.409255675993;16910.83089169117;11729.941350293195;11986.820197697041;12616.873831261753;12685.556005539762;13045.673858153432;14707.632309192355;16263;16423.91788041052;16444;16541.917290413472;7104.502684812117;7125.679344429514;7141.9285807142305;7180.922861570702;7184.928150718426;876.609908590671;876.8991565969867;878.1613559051091;882.6734108379941;922.4926290540176;28890.855545722137;30021.549676754865;30357.848210758806;30411.847940760155;30698.69301307003;1037.5849660135855;1084.6854412220368;1094.7700982793704;1095.244281445816;1218.774526712561;15176.317065732068;15664.37342506287;15796.447124350592;15933.283002264925;16101.355945762272;602825;606022;608246.9587652034;610399;610672;60192;60411;60518;60534.69732651309;60691;1293.2951541409955;1396.9231692257024;1413.2227274998709;1459.5402448228774;1460.3720400228003;28802;29611;29623;29715.55426668645;30311.393772123993;50588.49411505985;50904.74547627238;51002;51128.74435627798;51215.743921280155;534809;537674;537979;538857;539167;39440;40138.598614013485;40464.98837529085;40512.3923141159;40565.79717101395;45720;46047.309290360005;46550.836229094544;46933.76533117313;47295.29057064216;37262.62737372592;38392.808035960756;38394.42408363933;39484;39516.40725389064;35908.28183436369;36722.44916326204;37854.43218351672;37955.62044379521;37978.050548735395;33893.813716519806;34443.82778086194;34767.65232347745;34790;35344.646553534134;29686.406271874872;31880.84059579687;32017.199570010936;32102.876399325913;32141;23381.298561043197;23718.881405592863;23876.64185037191;23921.401964951016;24295.149669761475 10:08:24 INFO - PROCESS | 2196 | |2;jquery.html;348.31034551587857;355.160046490051;370.7738279649415;384.47903091311275;420.58362221400824;15259.694806103871;15539.844601553981;17044.91477542612;20575.485612859688;21072.15711371547;21302.72183668981;21329.36011919641;21554.89222553885;21583.46041348967;21675.566488670218;5683.374828768853;5736.483716465527;5864.5894787364905;5979.282486101674;5989.760409583611;4152.875413737577;5803.361630220672;5925.140854576084;5926.199963004982;5930.555208359368;4348.30427131659;6207.4723648489935;6480.351964803529;6492.05865149553;6584.6501467199105;6325.240971083499;6505.804825855184;6538.248101468344;6563.245226798931;6589.439897608709;5733.942660573382;5734.111212762028;5737.340205876336;5754.539636829044;5757.88484230313;25190.874045629836;26094;26133.73866261332;26140.86929565359;26430.73569264302;2701.3651791828906;2750.752432281084;2756.8483733394655;2764.6129541864157;2765.1289843699374;14782.113073215534;15202.771958420633;15275.236238188047;15672.902896797228;15793;1489.3149151390373;1691.957701057471;1775.4762345108225;1794.55136215946;1842.9262829486804;109950;130232.34883825615;130873.69126308805;135538;136182.999999999;11374;11712.765744685059;11885.481349006192;11887.70280742971;11915.165938384403;15288.006279591791;15298;15538.922305388402;15615.219239038002;15656.765148522782;8636.568171591522;8856.734297970943;8862.468251904776;8863.601137948808;8923.687670931486;8683.782905427288;8701.26039286655;8853.73438796837;8853.778655533662;8867.512286824287;4617.630589552828;4636.466806317249;4652.209124448852;4712.31671407644;4767.736549814302;1760.1111438723362;1982.4449154236836;1985.4440756588178;1997.880127192373;2024.1397406102349;968.719071469266;1018.256672628985;1026.2508368890751;1034.9482525873675;1047.3244757131608;20066.598668026556;21259.38590439629;21267.574648507252;21686.674699879513;21742.565148696936;868.3183700794846;936.2369668719972;1016.1464369929295;1033.8655974723238;1058.2327812336148;10271.332363396505;11028.834567481494;11263.887361126448;11286.887131128748;11336.149788765711;704414;705435;716470;731445;733018;129184.35407822901;155538;155794;156460.21769891077;161225;976.6191185437685;990.6235630460523;1002.5638847101534;1007.8337074382645;1009.0716540782498;17596.03221822812;18282.268709251483;18415.26338946427;18535.07324633736;18558.536036599195;60135.489838261434;60931.69534152301;61354.69322653358;62256.377436225055;62638.80764173232;84888.57555712182;85777;86231.13768862232;86322;87794;7102.75701752181;7882.684692612232;7919.564423956737;8133.75598732039;8206.384521161057;11061.557537698402;12291.32397718134;12468.625941221779;12482.063845211464;12562.246265224116;10388.48057597102;10538.262321637412;10723.356598604109;10774.676759697222;10913.890861091606;10059.245556583139;10514.526846292089;10779.299345542515;10973.451327433437;11051.944740276247;10511.632092876713;10757.731056723644;11033.944830275797;11059.557617695202;11093;8036.156203598772;8047.919520804717;8202.097769245498;8225.753227403187;8313.6674533018;9252.167304942588;10959.06847917936;10991.753688876746;10991.945040275068;11002.944985275022 10:08:24 INFO - PROCESS | 2196 | |3;mootools.html;1430.3205977160849;1436.0809082187402;1443.0836418874012;1450.7968884356192;1452.2738630684655;8054.959725201373;8447.366447516439;8454.57727113645;8460.365472589565;8463.365247606438;7466.290702383279;7701.9614901925415;7720.45956783024;8046.5976701164855;8231.67073317068;2270.750217476076;2276.64711969645;2321.431249343913;2321.5937210988095;2324.7210334759766;2249.257744944173;2338.684277622525;2340.9297721068397;2347.295811256625;2349.119080344871;2039.276056999766;2123.097683484513;2227.0646328542052;2295.024614538823;2325.2094287942095;2290.4617414907484;2295.7933785959344;2303.700518932528;2303.8617682939075;2304.4008557774932;1889.9622007559772;2037;2243.371855880356;2280.1677387753352;2294.1167650454527;8354;8410.78973025673;8445.239928406472;8449.957750211272;8457.112003239694;5011.473795251519;5160.92258616121;5171.456997015334;5172.689638621657;5181.326427564392;3204.7115759581516;3359.731221502274;3369;3432.2105915639545;3435.4331535296647;1111.7665290289049;1117.4692021289904;1166.0787977497766;1167.4454634048843;1267.6323866078826;9243.306751993627;10880.183986200987;10884.782304353868;10887.183461240438;10888.29226100301;4549.27211646135;4582.5417458253905;4695.835645752382;4721.055788842245;4733.715977041388;8615.22462978335;8636.0500344962;8776.517291549026;8779.429337093195;8796.988346340126;4549.795259213343;5072.822451214263;5093.9490605094215;5134.024535338273;5148.279240906276;4526.932096018562;4659.464161621389;4733.266343716729;4796.712197268175;4801.759912004386;3328.683775041367;3632.3461776880417;3655.634436556323;3726.6273372662517;3731.9440208396895;1081.6971248050559;1143.3254379915888;1143.988560114405;1155.4742592120565;1155.6821873984554;736.5359823311279;749.4454103963028;751.4439314907039;887.7469921072593;895.1004240738016;4776.47458779534;4939.185034469344;5399.919001214985;5671.092625179951;5730.169125476783;957.9425234485954;964.6189755046718;965.8744363232735;984.0700537991672;1028.922830787694;3807.543094828583;3824.2542704172974;3934.9213015740097;3981.7457500887126;4040.878773636796;9688.515574221261;9924.759405074366;9972.601095956226;9981.201503879673;10056.396616203052;9349.205317547949;9775.51122443875;9793.755156121011;9937.602495900082;9956.352837065568;7636.3890888728765;7856.332211762065;7880.133185349607;7885.250901164495;7886.093099293655;5234.13636749932;5330.413654498079;5400.729963501888;5536.114221724505;5700.572457065654;7418.1839997599145;9299.349045566745;9335.113164249386;9351.438913665203;9373.859392108987;8967.820643587222;9348.439093654402;9365.578548965177;9381.812363752822;9395.201407880406;7679.846403072019;7849.646765895663;7858.960705196438;7870.763877083697;7888.605569721606;7729.149793522595;7738.303552680286;7805.297523222937;7841.725539606086;7880.605969701377;7051.365377116084;7070.151581810215;7187.9640601796655;7212.567245965259;7250.9637451812405;5826.94173058264;6894.448444124358;7034.613096279549;7073.434125270069;7145.714171433085;6294.213223347082;6338.0809782580345;6405.647689377129;6422.357764223727;6467.708953097216;3884.0095775577047;4333.9349909750745;4763.7618119094595;4862.176683743596;5091.007253585515;4891.608671306216;4911.312416261655;4964.0071985603745;5062.746862656926;5098.1842905135 10:08:24 INFO - PROCESS | 2196 | |4;prototype.html;343.9896803095907;355.2805568723335;360.12848905648326;365.0745360511105;375.73322940712126;4454.396417289773;4492.079123779626;4728.243481043034;5052.964142350814;5279.023380674578;5134.947335796162;5167.4574169712205;5192.792288308473;5227.424983251849;5283.735813209334;3049.90850274491;3884.6503814656744;3955.2682753690515;3997.3004724173297;4091.4476545666403;3560.501529785832;4076.9592304077023;4087.4481944937497;4090.406891000803;4094.9181016379653;4077.7757223352705;4087.713860029799;4098.569650186732;4105.651019663333;4121.443605113302;3306.768526203167;3678.834452449646;3880.5149356330458;3893.851313862403;4004.599540046001;3594.3530164570366;3600.1899572596217;3604.6215147409407;3630.3828349180703;3655.981720091409;4610.3315019322345;4841.273808928654;5164;5182.481751824825;5219.973900130513;3846.74996125251;4570.9314360284625;4701.811927522895;4781.3784208053075;4794.5684888359865;4665.463471700764;5472.467709041474;5589.608727389084;5605.859853503654;5627.54979601635;3383.712384447325;3992.680585553149;3999.580044095357;4006.559278479394;4013.4381186633605;5188.792448302102;5217.660852044605;5304.787808487695;5606.8225672608805;5633.549406008358;3999.3800960851113;4012.2376748417705;4022.2558826616582;4023.657989070962;4046.4537287466405;3744.7940363279736;3772.1701225730294;4033.757974521538;4090.3455447128317;4111.958880411157;4175.519815221228;4558.3789321140475;4567.912835755952;4689.02247073111;4695.366125573004;5483.396826349099;5532.474414930575;5534.446555344433;5542.91685624716;5571.582131340166;1107.429673718036;1285.6785803549112;1306.6667999660026;1321.6894029902965;1333.1467860569244;813.5525460996429;846.4921047371528;877.8631671984795;947.1428357336621;949.3876449689911;4333.826646934087;4932.202204302667;4981.555348948837;5004.699718016858;5021.338690494044;5037.546620804072;5229;5483.670979741229;5537.916931246034;5544.889102217933;4355.1725172217175;4709;4794.496577859344;4954.40547134339;5035.7985680572365;2821.50623640862;2828.618136551539;2851.8003739738433;2863.5275179595133;2864.7654829233234;5026;5069.391672999263;5468.535174510132;5636.956043736418;5651.519620832275;5280.9207861882105;5515.448455154453;5562.221289019541;5583.162525621189;5659.3208814941645;4961.652684312064;5860.589758716934;5896.204012458349;5934.8813023739285;5972.104184372379;4773.260144677581;5631.521320687787;5653.802116925888;5667.574931880043;5687.317521897398;5180.507851754077;5372.167314066326;5585.245991791056;5599.152279747755;5602.467765562265;5332.973335133454;5560;5724.225490098083;5725.456081672234;5848.327442344185;3570.946435803413;3916.8433262669173;4088.6898902120206;4118.19695159441;4151.252774500498;4600.976995115003;5600.915986260291;5680.289963754531;5702.657840529581;5741.6842073684675;5013.222950442687;5019.347484826949;5071.467495912876;5321.866953326043;5543.223948647112;5272.7063727278755;5373.892522149613;5433.755481003285;5467.735166570082;5478.369987451494;5129.487051294841;5420.53925416344;5420.7560659769615;5429.615448060719;5434.510894019557;5411.945880541144;5427.701476418835;5448.83653490396;5462.657187535839;5478.972605136949;4777.8327758528285;5059.822906198266;5336.546393556436;5366.758495867617;5385.973070134624 10:08:24 INFO - PROCESS | 2196 | |5;yui.html;705.9823504412392;717.307797974954;724.9021382113415;779.8089468080321;819.9918000819991;14935.17856517891;15810.4466343678;15839.920800395996;15846.445374411898;15846.68306633868;14497.565073047825;14515.709685806278;14525.927370363133;14704.705905881876;14707.044042137253;860.2945584620597;882.563131250029;888.3825741109931;894.4901406198469;897.407710910799;888.0852721696631;889.3330002498126;890.2121622364222;890.3189060368791;890.8485557455248;939.8261321655482;941.1764705882352;943.3066695978484;945.3524335829944;947.322664295029;935.6771913689801;936.8454205056191;937.7889974755693;938.0010289042149;939.6100618243421;699.9650017499105;700.1423256510784;700.166801506206;701.0850839654249;701.235653138082;15131.243437828174;15698.529044128694;15702.057876527444;15774;16030.519084427486;14013.439462421491;14309.427622895071;14324.212168330738;14387.496437624737;14599.051061680957;10944.781104377947;11493.770124597544;11569.479373428216;11758.882411175864;11898.22661526998;3669.4495825626104;3713.275911197318;3748;3800.9619903800885;3812.1041555234497;83589.58205208996;84912.57543712304;95753;97387.51306243494;103705;11072.723181920355;11141.498632561554;11146.721331966604;11461.598844040585;11483.540658373739;21770.673439898415;22008.779912200993;22285.66571501429;22457.887710561343;22531.436714081952;7887.605619718991;7904.565248911365;7947.3642108631175;7956.323712484388;8083.434159608889;4300.827966881289;4351.8476853309985;4405.31717583775;4486.461624605003;4541.386912766734;3507.649235076523;3525.4888041233876;3558.804265765356;3613.3134704406602;3615.240799432096;642.5823214910253;643.2923783837834;646.5668002438377;649.1917562634455;651.9152510173742;667.9933200668029;678.2132726037772;696.738722978883;709.975150869717;714.3285311806885;9490;9616;9751.658691945748;9900.40597564134;10265;666.1706175811049;709.670003448399;723.3634401726447;742.254034695128;744.6760659113303;4635.632488415926;4849.199882019498;4859.95140048602;4905.411350637946;4926.05420858766;101021;103106;103364.44953325707;106076.646409525;108076;87368.68946965801;87441;89071.55464222637;90302;91529.54235228781;74710.99999999891;79571.20428795753;81543;81642;83685.16314836773;8393.538355390268;9326.860097098684;9410.529473526432;9438.150566449052;9442.291828113057;47016.824579385786;47975.76012119917;50647;50741;51683.741581291855;55142.172867407826;67922;68792.3120768806;68897.83266255152;71880.64059679669;11516.769664606829;13050.282234477196;13367;13412.731745365234;14034.929825350808;13337.53318633843;13952.232627205602;14486.420543178156;14605.342759576057;15017.774733379227;13540.187588744708;13596.66008349799;13712.3829427678;14153.646158846112;14172.716545669235;13225.80161297562;13386;13439.731205376032;13969.161850289016;13981.790273146114;13518;13578.836525470684;13584.93207533956;13701.588952331445;13953.3720982554;8980.550972451221;10055.798884022424;10447.477626118816;11274.37990910475;11693.649190524298;8309;9253;9619.903800961902;10098.192144628265;10113.898861011296 10:08:24 INFO - PROCESS | 2196 | __end_tp_report 10:08:24 INFO - PROCESS | 2196 | __start_cc_report 10:08:24 INFO - PROCESS | 2196 | _x_x_mozilla_cycle_collect,1397 10:08:24 INFO - PROCESS | 2196 | __end_cc_report 10:08:24 INFO - PROCESS | 2196 | __startTimestamp1485972504875__endTimestamp 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | ------- Summary: start ------- 10:08:24 INFO - PROCESS | 2196 | Number of tests: 6 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | [#0] dojo.html Cycles:165 Average:5661.17 Median:5855.47 stddev:636.40 (10.9%) stddev-sans-first:605.48 10:08:24 INFO - PROCESS | 2196 | Values: 3087.4 3253.0 3271.4 3303.2 3346.7 5513.3 5535.0 5543.9 5543.9 5552.4 5556.9 5610.3 5613.6 5621.7 5646.6 5117.1 5136.3 5165.8 5215.1 5232.0 5065.8 5078.0 5106.0 5159.7 5211.1 5188.2 5223.3 5234.2 5250.2 5255.4 5233.3 5238.9 5245.4 5250.2 5263.2 5094.3 5159.0 5168.1 5169.6 5206.1 5492.9 5511.8 5540.1 5548.8 5571.2 6112.5 6114.4 6136.9 6154.8 6155.8 6159.2 6210.6 6215.6 6221.6 6236.7 5623.4 5658.6 5672.1 5678.0 5761.4 6239.6 6247.3 6262.3 6272.0 6319.8 6048.9 6075.1 6085.4 6089.5 6097.1 6131.5 6159.7 6178.8 6210.6 6216.2 5917.5 5953.1 5977.9 6063.6 6064.0 6125.0 6125.5 6129.2 6139.7 6172.6 4872.3 4928.1 4929.3 4935.5 4953.2 4410.0 4422.7 4425.8 4430.8 4467.3 5552.9 5588.8 5610.9 5680.9 5710.1 6210.1 6257.3 6271.0 6274.9 6276.1 5680.3 5718.4 5736.8 5743.6 5763.4 4531.1 5298.5 5334.1 5395.5 5425.7 6158.2 6193.2 6204.0 6266.6 6305.2 6102.3 6105.8 6114.5 6115.2 6136.7 6200.2 6245.4 6251.3 6255.9 6256.2 5181.9 5968.5 6039.9 6086.6 6125.0 6222.1 6229.7 6241.0 6242.3 6246.0 5940.1 5979.9 6041.9 6067.9 6118.0 5819.6 5868.1 5912.9 5929.9 5962.0 4879.5 5809.9 5855.5 5858.6 5902.8 5802.3 5859.5 6021.9 6027.6 6051.4 5787.4 5853.6 5869.0 5874.3 5925.5 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | [#1] ext.html Cycles:180 Average:67915.26 Median:21149.08 stddev:144014.63 (681.0%) stddev-sans-first:144329.55 10:08:24 INFO - PROCESS | 2196 | Values: 449.4 476.5 488.4 492.4 512.0 30620.4 39312.2 40978.6 41038.2 41267.8 42845.4 43280.1 43321.8 43344.3 43365.6 9263.6 9488.7 9498.5 9508.2 9516.0 8412.0 8647.7 11120.3 11365.1 11398.5 11354.0 11402.5 11439.4 11444.9 11458.1 8464.8 11369.0 11440.0 11457.8 11468.1 8451.3 10990.6 11259.7 11302.3 11502.0 39752.0 40126.8 40153.6 40202.6 40250.4 3396.5 3903.7 3957.4 4014.0 4065.4 29035.4 29267.4 29733.0 29763.0 30792.0 2761.2 2921.9 3192.1 3277.1 3370.5 463531.0 463577.0 467156.0 467755.0 468648.0 60924.4 61607.7 61811.8 62010.7 62133.7 64520.0 64666.0 64793.0 64806.0 64972.0 16140.4 16800.7 16824.6 16878.4 16910.8 11729.9 11986.8 12616.9 12685.6 13045.7 14707.6 16263.0 16423.9 16444.0 16541.9 7104.5 7125.7 7141.9 7180.9 7184.9 876.6 876.9 878.2 882.7 922.5 28890.9 30021.5 30357.8 30411.8 30698.7 1037.6 1084.7 1094.8 1095.2 1218.8 15176.3 15664.4 15796.4 15933.3 16101.4 602825.0 606022.0 608247.0 610399.0 610672.0 60192.0 60411.0 60518.0 60534.7 60691.0 1293.3 1396.9 1413.2 1459.5 1460.4 28802.0 29611.0 29623.0 29715.6 30311.4 50588.5 50904.7 51002.0 51128.7 51215.7 534809.0 537674.0 537979.0 538857.0 539167.0 39440.0 40138.6 40465.0 40512.4 40565.8 45720.0 46047.3 46550.8 46933.8 47295.3 37262.6 38392.8 38394.4 39484.0 39516.4 35908.3 36722.4 37854.4 37955.6 37978.1 33893.8 34443.8 34767.7 34790.0 35344.6 29686.4 31880.8 32017.2 32102.9 32141.0 23381.3 23718.9 23876.6 23921.4 24295.1 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | [#2] jquery.html Cycles:180 Average:39925.62 Median:21629.51 stddev:119771.74 (553.7%) stddev-sans-first:120070.86 10:08:24 INFO - PROCESS | 2196 | Values: 348.3 355.2 370.8 384.5 420.6 15259.7 15539.8 17044.9 20575.5 21072.2 21302.7 21329.4 21554.9 21583.5 21675.6 5683.4 5736.5 5864.6 5979.3 5989.8 4152.9 5803.4 5925.1 5926.2 5930.6 4348.3 6207.5 6480.4 6492.1 6584.7 6325.2 6505.8 6538.2 6563.2 6589.4 5733.9 5734.1 5737.3 5754.5 5757.9 25190.9 26094.0 26133.7 26140.9 26430.7 2701.4 2750.8 2756.8 2764.6 2765.1 14782.1 15202.8 15275.2 15672.9 15793.0 1489.3 1692.0 1775.5 1794.6 1842.9 109950.0 130232.3 130873.7 135538.0 136183.0 11374.0 11712.8 11885.5 11887.7 11915.2 15288.0 15298.0 15538.9 15615.2 15656.8 8636.6 8856.7 8862.5 8863.6 8923.7 8683.8 8701.3 8853.7 8853.8 8867.5 4617.6 4636.5 4652.2 4712.3 4767.7 1760.1 1982.4 1985.4 1997.9 2024.1 968.7 1018.3 1026.3 1034.9 1047.3 20066.6 21259.4 21267.6 21686.7 21742.6 868.3 936.2 1016.1 1033.9 1058.2 10271.3 11028.8 11263.9 11286.9 11336.1 704414.0 705435.0 716470.0 731445.0 733018.0 129184.4 155538.0 155794.0 156460.2 161225.0 976.6 990.6 1002.6 1007.8 1009.1 17596.0 18282.3 18415.3 18535.1 18558.5 60135.5 60931.7 61354.7 62256.4 62638.8 84888.6 85777.0 86231.1 86322.0 87794.0 7102.8 7882.7 7919.6 8133.8 8206.4 11061.6 12291.3 12468.6 12482.1 12562.2 10388.5 10538.3 10723.4 10774.7 10913.9 10059.2 10514.5 10779.3 10973.5 11051.9 10511.6 10757.7 11033.9 11059.6 11093.0 8036.2 8047.9 8202.1 8225.8 8313.7 9252.2 10959.1 10991.8 10991.9 11002.9 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | [#3] mootools.html Cycles:180 Average:5365.39 Median:5172.07 stddev:2932.62 (56.7%) stddev-sans-first:2925.93 10:08:24 INFO - PROCESS | 2196 | Values: 1430.3 1436.1 1443.1 1450.8 1452.3 8055.0 8447.4 8454.6 8460.4 8463.4 7466.3 7702.0 7720.5 8046.6 8231.7 2270.8 2276.6 2321.4 2321.6 2324.7 2249.3 2338.7 2340.9 2347.3 2349.1 2039.3 2123.1 2227.1 2295.0 2325.2 2290.5 2295.8 2303.7 2303.9 2304.4 1890.0 2037.0 2243.4 2280.2 2294.1 8354.0 8410.8 8445.2 8450.0 8457.1 5011.5 5160.9 5171.5 5172.7 5181.3 3204.7 3359.7 3369.0 3432.2 3435.4 1111.8 1117.5 1166.1 1167.4 1267.6 9243.3 10880.2 10884.8 10887.2 10888.3 4549.3 4582.5 4695.8 4721.1 4733.7 8615.2 8636.1 8776.5 8779.4 8797.0 4549.8 5072.8 5093.9 5134.0 5148.3 4526.9 4659.5 4733.3 4796.7 4801.8 3328.7 3632.3 3655.6 3726.6 3731.9 1081.7 1143.3 1144.0 1155.5 1155.7 736.5 749.4 751.4 887.7 895.1 4776.5 4939.2 5399.9 5671.1 5730.2 957.9 964.6 965.9 984.1 1028.9 3807.5 3824.3 3934.9 3981.7 4040.9 9688.5 9924.8 9972.6 9981.2 10056.4 9349.2 9775.5 9793.8 9937.6 9956.4 7636.4 7856.3 7880.1 7885.3 7886.1 5234.1 5330.4 5400.7 5536.1 5700.6 7418.2 9299.3 9335.1 9351.4 9373.9 8967.8 9348.4 9365.6 9381.8 9395.2 7679.8 7849.6 7859.0 7870.8 7888.6 7729.1 7738.3 7805.3 7841.7 7880.6 7051.4 7070.2 7188.0 7212.6 7251.0 5826.9 6894.4 7034.6 7073.4 7145.7 6294.2 6338.1 6405.6 6422.4 6467.7 3884.0 4333.9 4763.8 4862.2 5091.0 4891.6 4911.3 4964.0 5062.7 5098.2 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | [#4] prototype.html Cycles:180 Average:4474.62 Median:5023.67 stddev:1335.73 (26.6%) stddev-sans-first:1303.00 10:08:24 INFO - PROCESS | 2196 | Values: 344.0 355.3 360.1 365.1 375.7 4454.4 4492.1 4728.2 5053.0 5279.0 5134.9 5167.5 5192.8 5227.4 5283.7 3049.9 3884.7 3955.3 3997.3 4091.4 3560.5 4077.0 4087.4 4090.4 4094.9 4077.8 4087.7 4098.6 4105.7 4121.4 3306.8 3678.8 3880.5 3893.9 4004.6 3594.4 3600.2 3604.6 3630.4 3656.0 4610.3 4841.3 5164.0 5182.5 5220.0 3846.7 4570.9 4701.8 4781.4 4794.6 4665.5 5472.5 5589.6 5605.9 5627.5 3383.7 3992.7 3999.6 4006.6 4013.4 5188.8 5217.7 5304.8 5606.8 5633.5 3999.4 4012.2 4022.3 4023.7 4046.5 3744.8 3772.2 4033.8 4090.3 4112.0 4175.5 4558.4 4567.9 4689.0 4695.4 5483.4 5532.5 5534.4 5542.9 5571.6 1107.4 1285.7 1306.7 1321.7 1333.1 813.6 846.5 877.9 947.1 949.4 4333.8 4932.2 4981.6 5004.7 5021.3 5037.5 5229.0 5483.7 5537.9 5544.9 4355.2 4709.0 4794.5 4954.4 5035.8 2821.5 2828.6 2851.8 2863.5 2864.8 5026.0 5069.4 5468.5 5637.0 5651.5 5280.9 5515.4 5562.2 5583.2 5659.3 4961.7 5860.6 5896.2 5934.9 5972.1 4773.3 5631.5 5653.8 5667.6 5687.3 5180.5 5372.2 5585.2 5599.2 5602.5 5333.0 5560.0 5724.2 5725.5 5848.3 3570.9 3916.8 4088.7 4118.2 4151.3 4601.0 5600.9 5680.3 5702.7 5741.7 5013.2 5019.3 5071.5 5321.9 5543.2 5272.7 5373.9 5433.8 5467.7 5478.4 5129.5 5420.5 5420.8 5429.6 5434.5 5411.9 5427.7 5448.8 5462.7 5479.0 4777.8 5059.8 5336.5 5366.8 5386.0 10:08:24 INFO - PROCESS | 2196 | 10:08:24 INFO - PROCESS | 2196 | [#5] yui.html Cycles:180 Average:20202.10 Median:26412.48 stddev:28638.46 (108.4%) stddev-sans-first:28681.38 10:08:24 INFO - PROCESS | 2196 | Values: 706.0 717.3 724.9 779.8 820.0 14935.2 15810.4 15839.9 15846.4 15846.7 14497.6 14515.7 14525.9 14704.7 14707.0 860.3 882.6 888.4 894.5 897.4 888.1 889.3 890.2 890.3 890.8 939.8 941.2 943.3 945.4 947.3 935.7 936.8 937.8 938.0 939.6 700.0 700.1 700.2 701.1 701.2 15131.2 15698.5 15702.1 15774.0 16030.5 14013.4 14309.4 14324.2 14387.5 14599.1 10944.8 11493.8 11569.5 11758.9 11898.2 3669.4 3713.3 3748.0 3801.0 3812.1 83589.6 84912.6 95753.0 97387.5 103705.0 11072.7 11141.5 11146.7 11461.6 11483.5 21770.7 22008.8 22285.7 22457.9 22531.4 7887.6 7904.6 7947.4 7956.3 8083.4 4300.8 4351.8 4405.3 4486.5 4541.4 3507.6 3525.5 3558.8 3613.3 3615.2 642.6 643.3 646.6 649.2 651.9 668.0 678.2 696.7 710.0 714.3 9490.0 9616.0 9751.7 9900.4 10265.0 666.2 709.7 723.4 742.3 744.7 4635.6 4849.2 4860.0 4905.4 4926.1 101021.0 103106.0 103364.4 106076.6 108076.0 87368.7 87441.0 89071.6 90302.0 91529.5 74711.0 79571.2 81543.0 81642.0 83685.2 8393.5 9326.9 9410.5 9438.2 9442.3 47016.8 47975.8 50647.0 50741.0 51683.7 55142.2 67922.0 68792.3 68897.8 71880.6 11516.8 13050.3 13367.0 13412.7 14034.9 13337.5 13952.2 14486.4 14605.3 15017.8 13540.2 13596.7 13712.4 14153.6 14172.7 13225.8 13386.0 13439.7 13969.2 13981.8 13518.0 13578.8 13584.9 13701.6 13953.4 8980.6 10055.8 10447.5 11274.4 11693.6 8309.0 9253.0 9619.9 10098.2 10113.9 10:08:24 INFO - PROCESS | 2196 | -------- Summary: end -------- 10:08:24 INFO - PROCESS | 2196 | 10:08:25 INFO - TEST-INFO | 2196: exit 0 10:08:25 INFO - TEST-OK | dromaeo_css | took 1117715ms 10:08:25 INFO - TEST-START | kraken 10:08:25 INFO - operating with platform_type : mac_ 10:08:25 INFO - Initialising browser for kraken test... 10:08:25 INFO - TEST-INFO | started process 2199 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpTqEcjQ/profile http://localhost:62842/getInfo.html) 10:08:27 INFO - PROCESS | 2199 | __metrics Screen width/height:1600/1200 10:08:27 INFO - PROCESS | 2199 | colorDepth:24 10:08:27 INFO - PROCESS | 2199 | Browser inner width/height: 1024/689 10:08:27 INFO - PROCESS | 2199 | __metrics 10:08:28 INFO - PROCESS | 2199 | 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" 10:08:28 INFO - PROCESS | 2199 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:28 INFO - TEST-INFO | 2199: exit 0 10:08:28 INFO - Browser initialized. 10:08:28 INFO - Running cycle 1/1 for kraken test... 10:08:28 INFO - TEST-INFO | started process 2200 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpTqEcjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:40 INFO - PROCESS | 2200 | RSS: Main: 212467712 10:08:40 INFO - PROCESS | 2200 | 10:08:43 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62842/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:44 INFO - PROCESS | 2200 | RSS: Main: 264445952 10:08:44 INFO - PROCESS | 2200 | 10:08:47 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62842/tests/kraken/driver.html?testName=audio-dft) 10:08:47 INFO - PROCESS | 2200 | RSS: Main: 278425600 10:08:47 INFO - PROCESS | 2200 | 10:08:51 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62842/tests/kraken/driver.html?testName=audio-fft) 10:08:51 INFO - PROCESS | 2200 | RSS: Main: 374407168 10:08:51 INFO - PROCESS | 2200 | 10:08:53 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62842/tests/kraken/driver.html?testName=audio-oscillator) 10:08:54 INFO - PROCESS | 2200 | RSS: Main: 277786624 10:08:54 INFO - PROCESS | 2200 | 10:08:56 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:56 INFO - PROCESS | 2200 | RSS: Main: 278896640 10:08:56 INFO - PROCESS | 2200 | 10:08:59 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62842/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:00 INFO - PROCESS | 2200 | RSS: Main: 319348736 10:09:00 INFO - PROCESS | 2200 | 10:09:03 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62842/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:03 INFO - PROCESS | 2200 | RSS: Main: 318926848 10:09:03 INFO - PROCESS | 2200 | 10:09:06 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62842/tests/kraken/driver.html?testName=json-parse-financial) 10:09:07 INFO - PROCESS | 2200 | RSS: Main: 315514880 10:09:07 INFO - PROCESS | 2200 | 10:09:08 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:09 INFO - PROCESS | 2200 | RSS: Main: 294666240 10:09:09 INFO - PROCESS | 2200 | 10:09:11 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:12 INFO - PROCESS | 2200 | RSS: Main: 296890368 10:09:12 INFO - PROCESS | 2200 | 10:09:14 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:14 INFO - PROCESS | 2200 | RSS: Main: 299515904 10:09:14 INFO - PROCESS | 2200 | 10:09:17 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:18 INFO - PROCESS | 2200 | RSS: Main: 315412480 10:09:18 INFO - PROCESS | 2200 | 10:09:21 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:22 INFO - PROCESS | 2200 | RSS: Main: 309080064 10:09:22 INFO - PROCESS | 2200 | 10:09:23 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:62842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62842/tests/kraken/driver.html?testName=ai-astar) 10:09:24 INFO - PROCESS | 2200 | RSS: Main: 353574912 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | __start_tp_report 10:09:24 INFO - PROCESS | 2200 | _x_x_mozilla_page_load 10:09:24 INFO - PROCESS | 2200 | _x_x_mozilla_page_load_details 10:09:24 INFO - PROCESS | 2200 | |i|pagename|runs| 10:09:24 INFO - PROCESS | 2200 | |0;ai-astar;112;114;113;113;112;112;112;112;111;112 10:09:24 INFO - PROCESS | 2200 | |1;audio-beat-detection;140;139;97;157;150;139;112;107;125;111 10:09:24 INFO - PROCESS | 2200 | |2;audio-dft;255;262;210;187;182;183;185;184;183;185 10:09:24 INFO - PROCESS | 2200 | |3;audio-fft;82;57;60;90;59;59;59;58;73;58 10:09:24 INFO - PROCESS | 2200 | |4;audio-oscillator;88;70;85;70;67;69;82;67;69;83 10:09:24 INFO - PROCESS | 2200 | |5;imaging-gaussian-blur;86;87;89;84;86;84;86;83;85;83 10:09:24 INFO - PROCESS | 2200 | |6;imaging-darkroom;95;96;100;101;158;95;101;95;96;95 10:09:24 INFO - PROCESS | 2200 | |7;imaging-desaturate;85;88;87;88;85;86;85;84;85;84 10:09:24 INFO - PROCESS | 2200 | |8;json-parse-financial;55;55;54;53;58;57;57;56;57;56 10:09:24 INFO - PROCESS | 2200 | |9;json-stringify-tinderbox;74;78;72;66;69;71;72;70;73;73 10:09:24 INFO - PROCESS | 2200 | |10;stanford-crypto-aes;89;83;83;84;85;99;102;94;86;84 10:09:24 INFO - PROCESS | 2200 | |11;stanford-crypto-ccm;143;155;151;136;137;142;141;144;183;157 10:09:24 INFO - PROCESS | 2200 | |12;stanford-crypto-pbkdf2;208;231;180;167;168;170;167;171;170;170 10:09:24 INFO - PROCESS | 2200 | |13;stanford-crypto-sha256-iterative;65;66;65;66;63;58;59;76;85;83 10:09:24 INFO - PROCESS | 2200 | __end_tp_report 10:09:24 INFO - PROCESS | 2200 | __start_cc_report 10:09:24 INFO - PROCESS | 2200 | _x_x_mozilla_cycle_collect,2048 10:09:24 INFO - PROCESS | 2200 | __end_cc_report 10:09:24 INFO - PROCESS | 2200 | __startTimestamp1485972564238__endTimestamp 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | ------- Summary: start ------- 10:09:24 INFO - PROCESS | 2200 | Number of tests: 14 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:09:24 INFO - PROCESS | 2200 | Values: 112.0 114.0 113.0 113.0 112.0 112.0 112.0 112.0 111.0 112.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:139.50 stddev:20.18 (14.5%) stddev-sans-first:20.91 10:09:24 INFO - PROCESS | 2200 | Values: 140.0 139.0 97.0 157.0 150.0 139.0 112.0 107.0 125.0 111.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#2] audio-dft Cycles:10 Average:201.60 Median:186.00 stddev:31.13 (16.7%) stddev-sans-first:26.34 10:09:24 INFO - PROCESS | 2200 | Values: 255.0 262.0 210.0 187.0 182.0 183.0 185.0 184.0 183.0 185.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#3] audio-fft Cycles:10 Average:65.50 Median:59.50 stddev:11.88 (20.0%) stddev-sans-first:11.00 10:09:24 INFO - PROCESS | 2200 | Values: 82.0 57.0 60.0 90.0 59.0 59.0 59.0 58.0 73.0 58.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:8.38 (11.0%) stddev-sans-first:7.45 10:09:24 INFO - PROCESS | 2200 | Values: 88.0 70.0 85.0 70.0 67.0 69.0 82.0 67.0 69.0 83.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.00 stddev:1.89 (2.2%) stddev-sans-first:1.99 10:09:24 INFO - PROCESS | 2200 | Values: 86.0 87.0 89.0 84.0 86.0 84.0 86.0 83.0 85.0 83.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:95.00 stddev:19.42 (20.4%) stddev-sans-first:20.37 10:09:24 INFO - PROCESS | 2200 | Values: 95.0 96.0 100.0 101.0 158.0 95.0 101.0 95.0 96.0 95.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.56 10:09:24 INFO - PROCESS | 2200 | Values: 85.0 88.0 87.0 88.0 85.0 86.0 85.0 84.0 85.0 84.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:1.55 (2.7%) stddev-sans-first:1.62 10:09:24 INFO - PROCESS | 2200 | Values: 55.0 55.0 54.0 53.0 58.0 57.0 57.0 56.0 57.0 56.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.50 stddev:3.19 (4.4%) stddev-sans-first:3.28 10:09:24 INFO - PROCESS | 2200 | Values: 74.0 78.0 72.0 66.0 69.0 71.0 72.0 70.0 73.0 73.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.50 stddev:7.00 (8.2%) stddev-sans-first:7.42 10:09:24 INFO - PROCESS | 2200 | Values: 89.0 83.0 83.0 84.0 85.0 99.0 102.0 94.0 86.0 84.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:147.50 stddev:13.93 (9.4%) stddev-sans-first:14.61 10:09:24 INFO - PROCESS | 2200 | Values: 143.0 155.0 151.0 136.0 137.0 142.0 141.0 144.0 183.0 157.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:170.50 stddev:21.72 (12.7%) stddev-sans-first:20.58 10:09:24 INFO - PROCESS | 2200 | Values: 208.0 231.0 180.0 167.0 168.0 170.0 167.0 171.0 170.0 170.0 10:09:24 INFO - PROCESS | 2200 | 10:09:24 INFO - PROCESS | 2200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:66.00 stddev:9.47 (14.3%) stddev-sans-first:9.95 10:09:24 INFO - PROCESS | 2200 | Values: 65.0 66.0 65.0 66.0 63.0 58.0 59.0 76.0 85.0 83.0 10:09:24 INFO - PROCESS | 2200 | -------- Summary: end -------- 10:09:24 INFO - PROCESS | 2200 | 10:09:25 INFO - TEST-INFO | 2200: exit 0 10:09:25 INFO - TEST-OK | kraken | took 59563ms 10:09:25 INFO - SUITE-END | took 1177s 10:09:25 INFO - Completed test suite (00:19:37) 10:09:25 INFO - javascript benchmark 10:09:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.3825234953006, 3252.951205731913, 3271.4111459937208, 3303.223742420529, 3346.69879710826, 5513.283273174492, 5535.031369510335, 5543.861403464905, 5543.944560554393, 5552.361478429982, 5556.888862222763, 5610.270664813579, 5613.550915926727, 5621.662700237988, 5646.604737668365, 5117.130087885059, 5136.306598609196, 5165.845024649267, 5215.113430716769, 5231.986167284428, 5065.797368105272, 5078.035173317076, 5106.004329155816, 5159.71621560814, 5211.062008838408, 5188.247704082905, 5223.320968274119, 5234.162533994561, 5250.238715386266, 5255.395629502618, 5233.293505376763, 5238.92141617876, 5245.449227831061, 5250.159974404096, 5263.157894736823, 5094.337736094284, 5159.045576568309, 5168.147255702805, 5169.586433085344, 5206.114960456732, 5492.890142197173, 5511.807086751985, 5540.141278101901, 5548.805791797308, 5571.164325351229, 6112.533877023307, 6114.361011839412, 6136.9173623037705, 6154.84612884677, 6155.753769849201, 6159.168512250879, 6210.627362358273, 6215.56491045627, 6221.564490485668, 6236.719347629368, 5623.437656234426, 5658.603897727202, 5672.14917762339, 5678.0, 5761.366249712528, 6239.594426362272, 6247.344028876993, 6262.3111457739615, 6271.96864015677, 6319.842003949938, 6048.879022419527, 6075.058365953284, 6085.391460853879, 6089.48239399656, 6097.054956481752, 6131.478824299896, 6159.722812473449, 6178.814635560941, 6210.627362358273, 6216.160818289473, 5917.467427931507, 5953.077273022688, 5977.910331345033, 6063.605865618721, 6063.969125248718, 6125.0, 6125.479334256549, 6129.23653806838, 6139.658497107545, 6172.598781079216, 4872.269159626085, 4928.137575924199, 4929.334539837076, 4935.506449355035, 4953.23224900141, 4410.029793445437, 4422.71252368595, 4425.778711064434, 4430.778461076933, 4467.30756732707, 5552.91670624941, 5588.804391846266, 5610.915836262459, 5680.943190568124, 5710.143478478261, 6210.130581718563, 6257.311695713468, 6271.0, 6274.937250627435, 6276.058591211264, 5680.261565996394, 5718.399568045378, 5736.825371592106, 5743.569232307594, 5763.423657634203, 4531.071130418256, 5298.523132918056, 5334.119870221448, 5395.541378982752, 5425.701586412785, 6158.168647232566, 6193.163922870355, 6204.038374052029, 6266.624002559861, 6305.243370795534, 6102.267727872683, 6105.839890420806, 6114.510839132769, 6115.158028819334, 6136.6806136680825, 6200.224971878515, 6245.3754624539, 6251.281102673251, 6255.874882502233, 6256.155419018374, 5181.948180518147, 5968.492678122235, 6039.909401358896, 6086.573939824169, 6125.0, 6222.09779581949, 6229.657368844757, 6241.032639940817, 6242.344553821783, 6246.031865060922, 5940.108983652487, 5979.880402391841, 6041.940756687754, 6067.908981365194, 6117.96941015292, 5819.621724587888, 5868.149118377897, 5912.852178695567, 5929.881402372014, 5961.986462301333, 4879.512048795092, 5809.912851307149, 5855.473007429352, 5858.619189752652, 5902.763889444374, 5802.332731735904, 5859.472647461749, 6021.9397806023135, 6027.638341699512, 6051.425114614105, 5787.39232380594, 5853.64878107315, 5869.0, 5874.295084589877, 5925.496332811586], "value": 5619.882372716013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.40005093200574, 476.4615983938148, 488.43097791073393, 492.44107937490935, 512.0271484180057, 30620.387592248142, 39312.21375572487, 40978.59021409789, 41038.17923641526, 41267.793661031654, 42845.357319640156, 43280.13439731204, 43321.78339108308, 43344.3498347525, 43365.56634433655, 9263.583138758771, 9488.715338539854, 9498.477583732893, 9508.239340852715, 9515.952420237889, 8412.0, 8647.740567782977, 11120.277181983185, 11365.147613928946, 11398.544058237661, 11354.034907032912, 11402.486888090014, 11439.370834604093, 11444.942775286112, 11458.083353331713, 8464.830703385898, 11369.0, 11440.0, 11457.770844583103, 11468.13988950832, 8451.323894088458, 10990.560377584887, 11259.662210133627, 11302.321860688386, 11502.0, 39752.0, 40126.79936600327, 40153.59846401557, 40202.59797402018, 40250.39624405607, 3396.490526421032, 3903.726739128262, 3957.3668213086057, 4014.036631208489, 4065.410515475269, 29035.41929161426, 29267.414651706848, 29733.0, 29763.0, 30792.0, 2761.16516409296, 2921.8896819208776, 3192.090254277543, 3277.066036179677, 3370.5449764281752, 463531.0, 463577.0, 467156.0, 467755.0, 468648.0, 60924.390756092755, 61607.691961540804, 61811.763764724456, 62010.68994654998, 62133.68933155396, 64520.0, 64666.0300095499, 64793.0, 64806.0279095814, 64972.0, 16140.435084771976, 16800.74798878018, 16824.57938551546, 16878.409255675993, 16910.83089169117, 11729.941350293195, 11986.820197697041, 12616.873831261753, 12685.556005539762, 13045.673858153432, 14707.632309192355, 16263.0, 16423.91788041052, 16444.0, 16541.917290413472, 7104.502684812117, 7125.679344429514, 7141.9285807142305, 7180.922861570702, 7184.928150718426, 876.609908590671, 876.8991565969867, 878.1613559051091, 882.6734108379941, 922.4926290540176, 28890.855545722137, 30021.549676754865, 30357.848210758806, 30411.847940760155, 30698.69301307003, 1037.5849660135855, 1084.6854412220368, 1094.7700982793704, 1095.244281445816, 1218.774526712561, 15176.317065732068, 15664.37342506287, 15796.447124350592, 15933.283002264925, 16101.355945762272, 602825.0, 606022.0, 608246.9587652034, 610399.0, 610672.0, 60192.0, 60411.0, 60518.0, 60534.69732651309, 60691.0, 1293.2951541409955, 1396.9231692257024, 1413.2227274998709, 1459.5402448228774, 1460.3720400228003, 28802.0, 29611.0, 29623.0, 29715.55426668645, 30311.393772123993, 50588.49411505985, 50904.74547627238, 51002.0, 51128.74435627798, 51215.743921280155, 534809.0, 537674.0, 537979.0, 538857.0, 539167.0, 39440.0, 40138.598614013485, 40464.98837529085, 40512.3923141159, 40565.79717101395, 45720.0, 46047.309290360005, 46550.836229094544, 46933.76533117313, 47295.29057064216, 37262.62737372592, 38392.808035960756, 38394.42408363933, 39484.0, 39516.40725389064, 35908.28183436369, 36722.44916326204, 37854.43218351672, 37955.62044379521, 37978.050548735395, 33893.813716519806, 34443.82778086194, 34767.65232347745, 34790.0, 35344.646553534134, 29686.406271874872, 31880.84059579687, 32017.199570010936, 32102.876399325913, 32141.0, 23381.298561043197, 23718.881405592863, 23876.64185037191, 23921.401964951016, 24295.149669761475], "value": 20149.920391164887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.31034551587857, 355.160046490051, 370.7738279649415, 384.47903091311275, 420.58362221400824, 15259.694806103871, 15539.844601553981, 17044.91477542612, 20575.485612859688, 21072.15711371547, 21302.72183668981, 21329.36011919641, 21554.89222553885, 21583.46041348967, 21675.566488670218, 5683.374828768853, 5736.483716465527, 5864.5894787364905, 5979.282486101674, 5989.760409583611, 4152.875413737577, 5803.361630220672, 5925.140854576084, 5926.199963004982, 5930.555208359368, 4348.30427131659, 6207.4723648489935, 6480.351964803529, 6492.05865149553, 6584.6501467199105, 6325.240971083499, 6505.804825855184, 6538.248101468344, 6563.245226798931, 6589.439897608709, 5733.942660573382, 5734.111212762028, 5737.340205876336, 5754.539636829044, 5757.88484230313, 25190.874045629836, 26094.0, 26133.73866261332, 26140.86929565359, 26430.73569264302, 2701.3651791828906, 2750.752432281084, 2756.8483733394655, 2764.6129541864157, 2765.1289843699374, 14782.113073215534, 15202.771958420633, 15275.236238188047, 15672.902896797228, 15793.0, 1489.3149151390373, 1691.957701057471, 1775.4762345108225, 1794.55136215946, 1842.9262829486804, 109950.0, 130232.34883825615, 130873.69126308805, 135538.0, 136182.999999999, 11374.0, 11712.765744685059, 11885.481349006192, 11887.70280742971, 11915.165938384403, 15288.006279591791, 15298.0, 15538.922305388402, 15615.219239038002, 15656.765148522782, 8636.568171591522, 8856.734297970943, 8862.468251904776, 8863.601137948808, 8923.687670931486, 8683.782905427288, 8701.26039286655, 8853.73438796837, 8853.778655533662, 8867.512286824287, 4617.630589552828, 4636.466806317249, 4652.209124448852, 4712.31671407644, 4767.736549814302, 1760.1111438723362, 1982.4449154236836, 1985.4440756588178, 1997.880127192373, 2024.1397406102349, 968.719071469266, 1018.256672628985, 1026.2508368890751, 1034.9482525873675, 1047.3244757131608, 20066.598668026556, 21259.38590439629, 21267.574648507252, 21686.674699879513, 21742.565148696936, 868.3183700794846, 936.2369668719972, 1016.1464369929295, 1033.8655974723238, 1058.2327812336148, 10271.332363396505, 11028.834567481494, 11263.887361126448, 11286.887131128748, 11336.149788765711, 704414.0, 705435.0, 716470.0, 731445.0, 733018.0, 129184.35407822901, 155538.0, 155794.0, 156460.21769891077, 161225.0, 976.6191185437685, 990.6235630460523, 1002.5638847101534, 1007.8337074382645, 1009.0716540782498, 17596.03221822812, 18282.268709251483, 18415.26338946427, 18535.07324633736, 18558.536036599195, 60135.489838261434, 60931.69534152301, 61354.69322653358, 62256.377436225055, 62638.80764173232, 84888.57555712182, 85777.0, 86231.13768862232, 86322.0, 87794.0, 7102.75701752181, 7882.684692612232, 7919.564423956737, 8133.75598732039, 8206.384521161057, 11061.557537698402, 12291.32397718134, 12468.625941221779, 12482.063845211464, 12562.246265224116, 10388.48057597102, 10538.262321637412, 10723.356598604109, 10774.676759697222, 10913.890861091606, 10059.245556583139, 10514.526846292089, 10779.299345542515, 10973.451327433437, 11051.944740276247, 10511.632092876713, 10757.731056723644, 11033.944830275797, 11059.557617695202, 11093.0, 8036.156203598772, 8047.919520804717, 8202.097769245498, 8225.753227403187, 8313.6674533018, 9252.167304942588, 10959.06847917936, 10991.753688876746, 10991.945040275068, 11002.944985275022], "value": 9952.044224386684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.3205977160849, 1436.0809082187402, 1443.0836418874012, 1450.7968884356192, 1452.2738630684655, 8054.959725201373, 8447.366447516439, 8454.57727113645, 8460.365472589565, 8463.365247606438, 7466.290702383279, 7701.9614901925415, 7720.45956783024, 8046.5976701164855, 8231.67073317068, 2270.750217476076, 2276.64711969645, 2321.431249343913, 2321.5937210988095, 2324.7210334759766, 2249.257744944173, 2338.684277622525, 2340.9297721068397, 2347.295811256625, 2349.119080344871, 2039.276056999766, 2123.097683484513, 2227.0646328542052, 2295.024614538823, 2325.2094287942095, 2290.4617414907484, 2295.7933785959344, 2303.700518932528, 2303.8617682939075, 2304.4008557774932, 1889.9622007559772, 2037.0, 2243.371855880356, 2280.1677387753352, 2294.1167650454527, 8354.0, 8410.78973025673, 8445.239928406472, 8449.957750211272, 8457.112003239694, 5011.473795251519, 5160.92258616121, 5171.456997015334, 5172.689638621657, 5181.326427564392, 3204.7115759581516, 3359.731221502274, 3369.0, 3432.2105915639545, 3435.4331535296647, 1111.7665290289049, 1117.4692021289904, 1166.0787977497766, 1167.4454634048843, 1267.6323866078826, 9243.306751993627, 10880.183986200987, 10884.782304353868, 10887.183461240438, 10888.29226100301, 4549.27211646135, 4582.5417458253905, 4695.835645752382, 4721.055788842245, 4733.715977041388, 8615.22462978335, 8636.0500344962, 8776.517291549026, 8779.429337093195, 8796.988346340126, 4549.795259213343, 5072.822451214263, 5093.9490605094215, 5134.024535338273, 5148.279240906276, 4526.932096018562, 4659.464161621389, 4733.266343716729, 4796.712197268175, 4801.759912004386, 3328.683775041367, 3632.3461776880417, 3655.634436556323, 3726.6273372662517, 3731.9440208396895, 1081.6971248050559, 1143.3254379915888, 1143.988560114405, 1155.4742592120565, 1155.6821873984554, 736.5359823311279, 749.4454103963028, 751.4439314907039, 887.7469921072593, 895.1004240738016, 4776.47458779534, 4939.185034469344, 5399.919001214985, 5671.092625179951, 5730.169125476783, 957.9425234485954, 964.6189755046718, 965.8744363232735, 984.0700537991672, 1028.922830787694, 3807.543094828583, 3824.2542704172974, 3934.9213015740097, 3981.7457500887126, 4040.878773636796, 9688.515574221261, 9924.759405074366, 9972.601095956226, 9981.201503879673, 10056.396616203052, 9349.205317547949, 9775.51122443875, 9793.755156121011, 9937.602495900082, 9956.352837065568, 7636.3890888728765, 7856.332211762065, 7880.133185349607, 7885.250901164495, 7886.093099293655, 5234.13636749932, 5330.413654498079, 5400.729963501888, 5536.114221724505, 5700.572457065654, 7418.1839997599145, 9299.349045566745, 9335.113164249386, 9351.438913665203, 9373.859392108987, 8967.820643587222, 9348.439093654402, 9365.578548965177, 9381.812363752822, 9395.201407880406, 7679.846403072019, 7849.646765895663, 7858.960705196438, 7870.763877083697, 7888.605569721606, 7729.149793522595, 7738.303552680286, 7805.297523222937, 7841.725539606086, 7880.605969701377, 7051.365377116084, 7070.151581810215, 7187.9640601796655, 7212.567245965259, 7250.9637451812405, 5826.94173058264, 6894.448444124358, 7034.613096279549, 7073.434125270069, 7145.714171433085, 6294.213223347082, 6338.0809782580345, 6405.647689377129, 6422.357764223727, 6467.708953097216, 3884.0095775577047, 4333.9349909750745, 4763.7618119094595, 4862.176683743596, 5091.007253585515, 4891.608671306216, 4911.312416261655, 4964.0071985603745, 5062.746862656926, 5098.1842905135], "value": 4347.429394143926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9896803095907, 355.2805568723335, 360.12848905648326, 365.0745360511105, 375.73322940712126, 4454.396417289773, 4492.079123779626, 4728.243481043034, 5052.964142350814, 5279.023380674578, 5134.947335796162, 5167.4574169712205, 5192.792288308473, 5227.424983251849, 5283.735813209334, 3049.90850274491, 3884.6503814656744, 3955.2682753690515, 3997.3004724173297, 4091.4476545666403, 3560.501529785832, 4076.9592304077023, 4087.4481944937497, 4090.406891000803, 4094.9181016379653, 4077.7757223352705, 4087.713860029799, 4098.569650186732, 4105.651019663333, 4121.443605113302, 3306.768526203167, 3678.834452449646, 3880.5149356330458, 3893.851313862403, 4004.599540046001, 3594.3530164570366, 3600.1899572596217, 3604.6215147409407, 3630.3828349180703, 3655.981720091409, 4610.3315019322345, 4841.273808928654, 5164.0, 5182.481751824825, 5219.973900130513, 3846.74996125251, 4570.9314360284625, 4701.811927522895, 4781.3784208053075, 4794.5684888359865, 4665.463471700764, 5472.467709041474, 5589.608727389084, 5605.859853503654, 5627.54979601635, 3383.712384447325, 3992.680585553149, 3999.580044095357, 4006.559278479394, 4013.4381186633605, 5188.792448302102, 5217.660852044605, 5304.787808487695, 5606.8225672608805, 5633.549406008358, 3999.3800960851113, 4012.2376748417705, 4022.2558826616582, 4023.657989070962, 4046.4537287466405, 3744.7940363279736, 3772.1701225730294, 4033.757974521538, 4090.3455447128317, 4111.958880411157, 4175.519815221228, 4558.3789321140475, 4567.912835755952, 4689.02247073111, 4695.366125573004, 5483.396826349099, 5532.474414930575, 5534.446555344433, 5542.91685624716, 5571.582131340166, 1107.429673718036, 1285.6785803549112, 1306.6667999660026, 1321.6894029902965, 1333.1467860569244, 813.5525460996429, 846.4921047371528, 877.8631671984795, 947.1428357336621, 949.3876449689911, 4333.826646934087, 4932.202204302667, 4981.555348948837, 5004.699718016858, 5021.338690494044, 5037.546620804072, 5229.0, 5483.670979741229, 5537.916931246034, 5544.889102217933, 4355.1725172217175, 4709.0, 4794.496577859344, 4954.40547134339, 5035.7985680572365, 2821.50623640862, 2828.618136551539, 2851.8003739738433, 2863.5275179595133, 2864.7654829233234, 5026.0, 5069.391672999263, 5468.535174510132, 5636.956043736418, 5651.519620832275, 5280.9207861882105, 5515.448455154453, 5562.221289019541, 5583.162525621189, 5659.3208814941645, 4961.652684312064, 5860.589758716934, 5896.204012458349, 5934.8813023739285, 5972.104184372379, 4773.260144677581, 5631.521320687787, 5653.802116925888, 5667.574931880043, 5687.317521897398, 5180.507851754077, 5372.167314066326, 5585.245991791056, 5599.152279747755, 5602.467765562265, 5332.973335133454, 5560.0, 5724.225490098083, 5725.456081672234, 5848.327442344185, 3570.946435803413, 3916.8433262669173, 4088.6898902120206, 4118.19695159441, 4151.252774500498, 4600.976995115003, 5600.915986260291, 5680.289963754531, 5702.657840529581, 5741.6842073684675, 5013.222950442687, 5019.347484826949, 5071.467495912876, 5321.866953326043, 5543.223948647112, 5272.7063727278755, 5373.892522149613, 5433.755481003285, 5467.735166570082, 5478.369987451494, 5129.487051294841, 5420.53925416344, 5420.7560659769615, 5429.615448060719, 5434.510894019557, 5411.945880541144, 5427.701476418835, 5448.83653490396, 5462.657187535839, 5478.972605136949, 4777.8327758528285, 5059.822906198266, 5336.546393556436, 5366.758495867617, 5385.973070134624], "value": 4061.4229858795384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.9823504412392, 717.307797974954, 724.9021382113415, 779.8089468080321, 819.9918000819991, 14935.17856517891, 15810.4466343678, 15839.920800395996, 15846.445374411898, 15846.68306633868, 14497.565073047825, 14515.709685806278, 14525.927370363133, 14704.705905881876, 14707.044042137253, 860.2945584620597, 882.563131250029, 888.3825741109931, 894.4901406198469, 897.407710910799, 888.0852721696631, 889.3330002498126, 890.2121622364222, 890.3189060368791, 890.8485557455248, 939.8261321655482, 941.1764705882352, 943.3066695978484, 945.3524335829944, 947.322664295029, 935.6771913689801, 936.8454205056191, 937.7889974755693, 938.0010289042149, 939.6100618243421, 699.9650017499105, 700.1423256510784, 700.166801506206, 701.0850839654249, 701.235653138082, 15131.243437828174, 15698.529044128694, 15702.057876527444, 15774.0, 16030.519084427486, 14013.439462421491, 14309.427622895071, 14324.212168330738, 14387.496437624737, 14599.051061680957, 10944.781104377947, 11493.770124597544, 11569.479373428216, 11758.882411175864, 11898.22661526998, 3669.4495825626104, 3713.275911197318, 3748.0, 3800.9619903800885, 3812.1041555234497, 83589.58205208996, 84912.57543712304, 95753.0, 97387.51306243494, 103705.0, 11072.723181920355, 11141.498632561554, 11146.721331966604, 11461.598844040585, 11483.540658373739, 21770.673439898415, 22008.779912200993, 22285.66571501429, 22457.887710561343, 22531.436714081952, 7887.605619718991, 7904.565248911365, 7947.3642108631175, 7956.323712484388, 8083.434159608889, 4300.827966881289, 4351.8476853309985, 4405.31717583775, 4486.461624605003, 4541.386912766734, 3507.649235076523, 3525.4888041233876, 3558.804265765356, 3613.3134704406602, 3615.240799432096, 642.5823214910253, 643.2923783837834, 646.5668002438377, 649.1917562634455, 651.9152510173742, 667.9933200668029, 678.2132726037772, 696.738722978883, 709.975150869717, 714.3285311806885, 9490.0, 9616.0, 9751.658691945748, 9900.40597564134, 10265.0, 666.1706175811049, 709.670003448399, 723.3634401726447, 742.254034695128, 744.6760659113303, 4635.632488415926, 4849.199882019498, 4859.95140048602, 4905.411350637946, 4926.05420858766, 101021.0, 103106.0, 103364.44953325707, 106076.646409525, 108076.0, 87368.68946965801, 87441.0, 89071.55464222637, 90302.0, 91529.54235228781, 74710.99999999891, 79571.20428795753, 81543.0, 81642.0, 83685.16314836773, 8393.538355390268, 9326.860097098684, 9410.529473526432, 9438.150566449052, 9442.291828113057, 47016.824579385786, 47975.76012119917, 50647.0, 50741.0, 51683.741581291855, 55142.172867407826, 67922.0, 68792.3120768806, 68897.83266255152, 71880.64059679669, 11516.769664606829, 13050.282234477196, 13367.0, 13412.731745365234, 14034.929825350808, 13337.53318633843, 13952.232627205602, 14486.420543178156, 14605.342759576057, 15017.774733379227, 13540.187588744708, 13596.66008349799, 13712.3829427678, 14153.646158846112, 14172.716545669235, 13225.80161297562, 13386.0, 13439.731205376032, 13969.161850289016, 13981.790273146114, 13518.0, 13578.836525470684, 13584.93207533956, 13701.588952331445, 13953.3720982554, 8980.550972451221, 10055.798884022424, 10447.477626118816, 11274.37990910475, 11693.649190524298, 8309.0, 9253.0, 9619.903800961902, 10098.192144628265, 10113.898861011296], "value": 7544.62119020887, "unit": "score"}], "name": "dromaeo_css", "value": 7290.406539032168, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 113.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 97.0, 157.0, 150.0, 139.0, 112.0, 107.0, 125.0, 111.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [255.0, 262.0, 210.0, 187.0, 182.0, 183.0, 185.0, 184.0, 183.0, 185.0], "value": 201.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 60.0, 90.0, 59.0, 59.0, 59.0, 58.0, 73.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 70.0, 67.0, 69.0, 82.0, 67.0, 69.0, 83.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 89.0, 84.0, 86.0, 84.0, 86.0, 83.0, 85.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 100.0, 101.0, 158.0, 95.0, 101.0, 95.0, 96.0, 95.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 87.0, 88.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 58.0, 57.0, 57.0, 56.0, 57.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 72.0, 66.0, 69.0, 71.0, 72.0, 70.0, 73.0, 73.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 83.0, 84.0, 85.0, 99.0, 102.0, 94.0, 86.0, 84.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 155.0, 151.0, 136.0, 137.0, 142.0, 141.0, 144.0, 183.0, 157.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 231.0, 180.0, 167.0, 168.0, 170.0, 167.0, 171.0, 170.0, 170.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 63.0, 58.0, 59.0, 76.0, 85.0, 83.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1470.5, "alertThreshold": 2.0}]} 10:09:25 INFO - Return code: 0 10:09:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:25 ERROR - # TBPL SUCCESS # 10:09:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:25 INFO - 2017-02-01 10:09:25.548 screenresolution[2204:35280] starting screenresolution argv=screenresolution get 10:09:25 INFO - 2017-02-01 10:09:25.550 screenresolution[2204:35280] Display 0: 1600x1200x32@60 10:09:25 INFO - 2017-02-01 10:09:25.556 screenresolution[2205:35283] starting screenresolution argv=screenresolution list 10:09:25 INFO - Available Modes on Display 0 10:09:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:25 INFO - Intel Iris: 10:09:25 INFO - Chipset Model: Intel Iris 10:09:25 INFO - Type: GPU 10:09:25 INFO - Bus: Built-In 10:09:25 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:25 INFO - Vendor: Intel (0x8086) 10:09:25 INFO - Device ID: 0x0a2e 10:09:25 INFO - Revision ID: 0x0009 10:09:25 INFO - Displays: 10:09:25 INFO - Display: 10:09:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:25 INFO - Display Serial Number: 1600x1200 60 10:09:25 INFO - Main Display: Yes 10:09:25 INFO - Mirror: Off 10:09:25 INFO - Online: Yes 10:09:25 INFO - Rotation: Supported 10:09:25 INFO - Return code: 0 10:09:25 INFO - Running post-action listener: _resource_record_post_action 10:09:25 INFO - [mozharness: 2017-02-01 18:09:25.798810Z] Finished run-tests step (success) 10:09:25 INFO - Running post-run listener: _resource_record_post_run 10:09:25 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 520192; Write bytes: 507869696; Read time: 5; Write time: 1588 10:09:25 INFO - TinderboxPrint: CPU usage
53.4% 10:09:25 INFO - TinderboxPrint: I/O read bytes / time
520,192 / 5 10:09:25 INFO - TinderboxPrint: I/O write bytes / time
507,869,696 / 1,588 10:09:25 INFO - TinderboxPrint: CPU idle
2,232.1 (46.6%) 10:09:25 INFO - TinderboxPrint: CPU system
957.1 (20.0%) 10:09:25 INFO - TinderboxPrint: CPU user
1,604.5 (33.5%) 10:09:25 INFO - TinderboxPrint: Swap in / out
207,609,856 / 0 10:09:25 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208423424; Write bytes: 202163712; Read time: 15997; Write time: 449 10:09:25 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 483328; Write bytes: 295695360; Read time: 4; Write time: 1104 10:09:26 INFO - Running post-run listener: _upload_blobber_files 10:09:26 INFO - Blob upload gear active. 10:09:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:26 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 10:09:26 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'] 10:09:26 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 10:09:26 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:09:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:27 INFO - (blobuploader) - INFO - Done attempting. 10:09:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:28 INFO - (blobuploader) - INFO - Done attempting. 10:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:29 INFO - (blobuploader) - INFO - Done attempting. 10:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:31 INFO - (blobuploader) - INFO - Done attempting. 10:09:31 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:31 INFO - Return code: 0 10:09:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa96340b56c828f8061174c76df9fbe7463255dbdb5241003027d57a8b6d6fa2486c1916a1cd6ab9a4d7420ca415d17c421bd8e7c38b91148bbcd1925bf2e49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0121dfa676cd745eded0f763ebe65972d29ce155ac4d9a325024e53ab41fd03ca11ffe184a5599bf8ae276a941e1cc182d95c0fc9328258310fbda4d8be2a9f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcd8260bcd3d7a571d84fcfd591c52d837e42c1fea645f8932af1d669fc19818c91a45369abfbb4456d451b789745c8c6ee855791e02e791d24cf7e7b87c89e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a3d0bf17300567528c9aebc93824926ad2e61c9a77853aeadd0c36d688ac1ebd7bc1aa419aee316c0cf4ab2c1d9f865230e671ba8446b3a13f7b89e368337fe"} 10:09:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:31 INFO - Contents: 10:09:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa96340b56c828f8061174c76df9fbe7463255dbdb5241003027d57a8b6d6fa2486c1916a1cd6ab9a4d7420ca415d17c421bd8e7c38b91148bbcd1925bf2e49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0121dfa676cd745eded0f763ebe65972d29ce155ac4d9a325024e53ab41fd03ca11ffe184a5599bf8ae276a941e1cc182d95c0fc9328258310fbda4d8be2a9f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcd8260bcd3d7a571d84fcfd591c52d837e42c1fea645f8932af1d669fc19818c91a45369abfbb4456d451b789745c8c6ee855791e02e791d24cf7e7b87c89e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a3d0bf17300567528c9aebc93824926ad2e61c9a77853aeadd0c36d688ac1ebd7bc1aa419aee316c0cf4ab2c1d9f865230e671ba8446b3a13f7b89e368337fe"} 10:09:31 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:31 INFO - Copying logs to upload dir... 10:09:31 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.243338 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-01 10:09:31.948934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:09:31.952676) ========= 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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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/aa96340b56c828f8061174c76df9fbe7463255dbdb5241003027d57a8b6d6fa2486c1916a1cd6ab9a4d7420ca415d17c421bd8e7c38b91148bbcd1925bf2e49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0121dfa676cd745eded0f763ebe65972d29ce155ac4d9a325024e53ab41fd03ca11ffe184a5599bf8ae276a941e1cc182d95c0fc9328258310fbda4d8be2a9f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcd8260bcd3d7a571d84fcfd591c52d837e42c1fea645f8932af1d669fc19818c91a45369abfbb4456d451b789745c8c6ee855791e02e791d24cf7e7b87c89e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a3d0bf17300567528c9aebc93824926ad2e61c9a77853aeadd0c36d688ac1ebd7bc1aa419aee316c0cf4ab2c1d9f865230e671ba8446b3a13f7b89e368337fe"} build_url:https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa96340b56c828f8061174c76df9fbe7463255dbdb5241003027d57a8b6d6fa2486c1916a1cd6ab9a4d7420ca415d17c421bd8e7c38b91148bbcd1925bf2e49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0121dfa676cd745eded0f763ebe65972d29ce155ac4d9a325024e53ab41fd03ca11ffe184a5599bf8ae276a941e1cc182d95c0fc9328258310fbda4d8be2a9f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcd8260bcd3d7a571d84fcfd591c52d837e42c1fea645f8932af1d669fc19818c91a45369abfbb4456d451b789745c8c6ee855791e02e791d24cf7e7b87c89e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a3d0bf17300567528c9aebc93824926ad2e61c9a77853aeadd0c36d688ac1ebd7bc1aa419aee316c0cf4ab2c1d9f865230e671ba8446b3a13f7b89e368337fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:09:31.987305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:09:31.987697) ========= 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.yLWEtvJxCw/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.FEg1NhHhRk/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.005123 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:09:32.037880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:09:32.038279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:09:32.041651) ========= ========= Total master_lag: 0.18 =========