builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0379 starttime: 1480782290.82 results: success (0) buildid: 20161203062943 builduid: 05fb224fd87f4147b7d331f5f89834fd revision: f664a80393daca803f15055ade0c85145883f3ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:50.824115) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:50.825146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:50.825496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:50.853269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:50.853967) ========= 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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-03 08:24:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-12-03 08:24:51 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.487599 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:51.420202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:51.420597) ========= 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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.025993 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:51.529055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-03 08:24:51.529431) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f664a80393daca803f15055ade0c85145883f3ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f664a80393daca803f15055ade0c85145883f3ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9iIq1tXLmC/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.g4UMkOzAjo/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-03 08:24:51,623 truncating revision to first 12 chars 2016-12-03 08:24:51,624 Setting DEBUG logging. 2016-12-03 08:24:51,624 attempt 1/10 2016-12-03 08:24:51,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f664a80393da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 08:24:53,319 unpacking tar archive at: mozilla-central-f664a80393da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.971821 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-03 08:24:53.573793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:53.574576) ========= script_repo_revision: f664a80393daca803f15055ade0c85145883f3ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:53.575528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:53.576180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 08:24:53.619821) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-03 08:24:53.620542) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9iIq1tXLmC/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.g4UMkOzAjo/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:24:53 INFO - MultiFileLogger online at 20161203 08:24:53 in /builds/slave/test 08:24:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:24:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:53 INFO - {'append_to_log': False, 08:24:53 INFO - 'base_work_dir': '/builds/slave/test', 08:24:53 INFO - 'blob_upload_branch': 'Firefox', 08:24:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:53 INFO - 'branch': 'Firefox', 08:24:53 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:53 INFO - 'config_files': ('talos/mac_config.py',), 08:24:53 INFO - 'default_actions': ('clobber', 08:24:53 INFO - 'read-buildbot-config', 08:24:53 INFO - 'download-and-extract', 08:24:53 INFO - 'populate-webroot', 08:24:53 INFO - 'create-virtualenv', 08:24:53 INFO - 'install', 08:24:53 INFO - 'run-tests'), 08:24:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:53 INFO - 'download_minidump_stackwalk': True, 08:24:53 INFO - 'download_symbols': 'ondemand', 08:24:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:53 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:53 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:53 INFO - 'installer_path': 'installer.exe', 08:24:53 INFO - 'log_level': 'info', 08:24:53 INFO - 'log_name': 'talos', 08:24:53 INFO - 'log_to_console': True, 08:24:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:24:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:24:53 INFO - 'opt_config_files': (), 08:24:53 INFO - 'pip_index': False, 08:24:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:24:53 INFO - 'cmd': ('bash', 08:24:53 INFO - '-c', 08:24:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:24:53 INFO - 'enabled': True, 08:24:53 INFO - 'halt_on_failure': False, 08:24:53 INFO - 'name': 'check_screen_resolution'},), 08:24:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:24:53 INFO - 'cmd': ('bash', 08:24:53 INFO - '-c', 08:24:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:24:53 INFO - 'enabled': True, 08:24:53 INFO - 'halt_on_failure': False, 08:24:53 INFO - 'name': 'check_screen_resolution'},), 08:24:53 INFO - 'run_cmd_checks_enabled': True, 08:24:53 INFO - 'sps_profile': False, 08:24:53 INFO - 'sps_profile_interval': 0, 08:24:53 INFO - 'suite': 'dromaeojs', 08:24:53 INFO - 'system_bits': '32', 08:24:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:53 INFO - 'title': 't-yosemite-r7-0379', 08:24:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:53 INFO - 'use_talos_json': True, 08:24:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:53 INFO - 'work_dir': 'build'} 08:24:53 INFO - [mozharness: 2016-12-03 16:24:53.825583Z] Running clobber step. 08:24:53 INFO - Running pre-action listener: _resource_record_pre_action 08:24:53 INFO - Running main action method: clobber 08:24:53 INFO - rmtree: /builds/slave/test/build 08:24:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:56 INFO - Running post-action listener: _resource_record_post_action 08:24:56 INFO - [mozharness: 2016-12-03 16:24:56.549145Z] Finished clobber step (success) 08:24:56 INFO - [mozharness: 2016-12-03 16:24:56.549424Z] Running read-buildbot-config step. 08:24:56 INFO - Running pre-action listener: _resource_record_pre_action 08:24:56 INFO - Running main action method: read_buildbot_config 08:24:56 INFO - Using buildbot properties: 08:24:56 INFO - { 08:24:56 INFO - "project": "", 08:24:56 INFO - "product": "firefox", 08:24:56 INFO - "script_repo_revision": "production", 08:24:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:24:56 INFO - "repository": "", 08:24:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:24:56 INFO - "buildid": "20161203062943", 08:24:56 INFO - "pgo_build": "False", 08:24:56 INFO - "basedir": "/builds/slave/test", 08:24:56 INFO - "buildnumber": 13, 08:24:56 INFO - "slavename": "t-yosemite-r7-0379", 08:24:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:24:56 INFO - "platform": "yosemite_r7", 08:24:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:24:56 INFO - "branch": "mozilla-central", 08:24:56 INFO - "repo_path": "mozilla-central", 08:24:56 INFO - "revision": "f664a80393daca803f15055ade0c85145883f3ff", 08:24:56 INFO - "stage_platform": "macosx64", 08:24:56 INFO - "builduid": "05fb224fd87f4147b7d331f5f89834fd", 08:24:56 INFO - "slavebuilddir": "test" 08:24:56 INFO - } 08:24:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:24:56 INFO - Running post-action listener: _resource_record_post_action 08:24:56 INFO - [mozharness: 2016-12-03 16:24:56.555071Z] Finished read-buildbot-config step (success) 08:24:56 INFO - [mozharness: 2016-12-03 16:24:56.555234Z] Running download-and-extract step. 08:24:56 INFO - Running pre-action listener: _resource_record_pre_action 08:24:56 INFO - Running main action method: download_and_extract 08:24:56 INFO - mkdir: /builds/slave/test/build/tests 08:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:56 INFO - trying https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:24:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:24:58 INFO - Downloaded 1199 bytes. 08:24:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:24:58 INFO - Using the following test package requirements: 08:24:58 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:24:58 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:24:58 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:24:58 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'jsshell-mac.zip'], 08:24:58 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:24:58 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:24:58 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:24:58 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:24:58 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:24:58 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:24:58 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:24:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:24:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:24:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:24:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:24:58 INFO - Expected file size: 16283765 08:24:58 INFO - Obtained file size: 16283765 08:25:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:25:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:25:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:25:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:25:06 INFO - Expected file size: 16283765 08:25:06 INFO - Obtained file size: 16283765 08:25:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:25:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:25:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:25:14 INFO - Expected file size: 14409734 08:25:14 INFO - Obtained file size: 14409734 08:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:14 INFO - trying https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:25:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:25:17 INFO - Downloaded 107592696 bytes. 08:25:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:25:17 INFO - mkdir: /builds/slave/test/properties 08:25:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:17 INFO - Contents: 08:25:17 INFO - build_url:https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:25:17 INFO - Running post-action listener: _resource_record_post_action 08:25:17 INFO - Running post-action listener: set_extra_try_arguments 08:25:17 INFO - [mozharness: 2016-12-03 16:25:17.772139Z] Finished download-and-extract step (success) 08:25:17 INFO - [mozharness: 2016-12-03 16:25:17.772273Z] Running populate-webroot step. 08:25:17 INFO - Running pre-action listener: _resource_record_pre_action 08:25:17 INFO - Running main action method: populate_webroot 08:25:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:17 INFO - '--tppagecycles', 08:25:17 INFO - '7'], 08:25:17 INFO - 'tests': ['tsvgm']}}, 08:25:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['damp', 'tps']}, 08:25:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'tests': ['damp', 'tps']}, 08:25:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['dromaeo_dom']}, 08:25:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['basic_compositor_video']}, 08:25:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:25:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['a11yr', 08:25:17 INFO - 'ts_paint', 08:25:17 INFO - 'tpaint', 08:25:17 INFO - 'sessionrestore', 08:25:17 INFO - 'sessionrestore_no_auto_restore', 08:25:17 INFO - 'tabpaint']}, 08:25:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:17 INFO - 'ts_paint', 08:25:17 INFO - 'tpaint', 08:25:17 INFO - 'sessionrestore', 08:25:17 INFO - 'sessionrestore_no_auto_restore', 08:25:17 INFO - 'tabpaint']}, 08:25:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:17 INFO - 'ts_paint', 08:25:17 INFO - 'tpaint', 08:25:17 INFO - 'sessionrestore', 08:25:17 INFO - 'sessionrestore_no_auto_restore', 08:25:17 INFO - 'tabpaint']}, 08:25:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:17 INFO - 'ts_paint', 08:25:17 INFO - 'tpaint', 08:25:17 INFO - 'sessionrestore', 08:25:17 INFO - 'sessionrestore_no_auto_restore', 08:25:17 INFO - 'tabpaint']}, 08:25:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['a11yr', 08:25:17 INFO - 'ts_paint', 08:25:17 INFO - 'tpaint', 08:25:17 INFO - 'sessionrestore', 08:25:17 INFO - 'sessionrestore_no_auto_restore', 08:25:17 INFO - 'tabpaint']}, 08:25:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['a11yr', 08:25:17 INFO - 'ts_paint', 08:25:17 INFO - 'tpaint', 08:25:17 INFO - 'sessionrestore', 08:25:17 INFO - 'sessionrestore_no_auto_restore', 08:25:17 INFO - 'tabpaint']}, 08:25:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['tsvgx', 08:25:17 INFO - 'tsvgr_opacity', 08:25:17 INFO - 'tart', 08:25:17 INFO - 'tscrollx', 08:25:17 INFO - 'cart', 08:25:17 INFO - 'tsvg_static']}, 08:25:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:17 INFO - 'tsvgr_opacity', 08:25:17 INFO - 'tart', 08:25:17 INFO - 'tscrollx', 08:25:17 INFO - 'cart', 08:25:17 INFO - 'tsvg_static']}, 08:25:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'talos_options': ['--disable-e10s'], 08:25:17 INFO - 'tests': ['tp5o']}, 08:25:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:25:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'talos_options': ['--disable-e10s', 08:25:17 INFO - '--xperf_path', 08:25:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:17 INFO - 'tests': ['tp5n']}, 08:25:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:25:17 INFO - 'talos_options': ['--xperf_path', 08:25:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:17 INFO - 'tests': ['tp5n']}}, 08:25:17 INFO - 'talos.zip': {'path': '', 08:25:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:17 INFO - Running post-action listener: _resource_record_post_action 08:25:17 INFO - [mozharness: 2016-12-03 16:25:17.790158Z] Finished populate-webroot step (success) 08:25:17 INFO - [mozharness: 2016-12-03 16:25:17.790296Z] Running create-virtualenv step. 08:25:17 INFO - Running pre-action listener: _resource_record_pre_action 08:25:17 INFO - Running main action method: create_virtualenv 08:25:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:25:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:17 INFO - Using real prefix '/tools/python27' 08:25:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:21 INFO - Installing pip.................done. 08:25:21 INFO - Return code: 0 08:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:25:21 INFO - Reading from file tmpfile_stdout 08:25:21 INFO - Output received: 08:25:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:25:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:21 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:21 INFO - 'HOME': '/Users/cltbld', 08:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:21 INFO - 'LOGNAME': 'cltbld', 08:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:21 INFO - 'MOZ_NO_REMOTE': '1', 08:25:21 INFO - 'NO_EM_RESTART': '1', 08:25:21 INFO - 'PAGER': '/bin/cat', 08:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:21 INFO - 'PWD': '/builds/slave/test', 08:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:21 INFO - 'SHELL': '/bin/bash', 08:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:21 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:21 INFO - 'USER': 'cltbld', 08:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:21 INFO - 'XPC_FLAGS': '0x0', 08:25:21 INFO - 'XPC_SERVICE_NAME': '0', 08:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:25:22 INFO - Cleaning up... 08:25:22 INFO - Return code: 0 08:25:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:22 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:25:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:22 INFO - 'HOME': '/Users/cltbld', 08:25:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:22 INFO - 'LOGNAME': 'cltbld', 08:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:22 INFO - 'MOZ_NO_REMOTE': '1', 08:25:22 INFO - 'NO_EM_RESTART': '1', 08:25:22 INFO - 'PAGER': '/bin/cat', 08:25:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:22 INFO - 'PWD': '/builds/slave/test', 08:25:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:22 INFO - 'SHELL': '/bin/bash', 08:25:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:22 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:22 INFO - 'USER': 'cltbld', 08:25:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:22 INFO - 'XPC_FLAGS': '0x0', 08:25:22 INFO - 'XPC_SERVICE_NAME': '0', 08:25:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:22 INFO - Downloading/unpacking psutil>=3.1.1 08:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:26 INFO - Installing collected packages: psutil 08:25:26 INFO - Running setup.py install for psutil 08:25:26 INFO - building 'psutil._psutil_osx' extension 08:25:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:25:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:25:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:25:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:25:26 INFO - building 'psutil._psutil_posix' extension 08:25:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:25:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:25:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:25:27 INFO - ^ 08:25:27 INFO - 1 warning generated. 08:25:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:25:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:27 INFO - Successfully installed psutil 08:25:27 INFO - Cleaning up... 08:25:27 INFO - Return code: 0 08:25:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:27 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:27 INFO - 'HOME': '/Users/cltbld', 08:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:27 INFO - 'LOGNAME': 'cltbld', 08:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:27 INFO - 'MOZ_NO_REMOTE': '1', 08:25:27 INFO - 'NO_EM_RESTART': '1', 08:25:27 INFO - 'PAGER': '/bin/cat', 08:25:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:27 INFO - 'PWD': '/builds/slave/test', 08:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:27 INFO - 'SHELL': '/bin/bash', 08:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:27 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:27 INFO - 'USER': 'cltbld', 08:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:27 INFO - 'XPC_FLAGS': '0x0', 08:25:27 INFO - 'XPC_SERVICE_NAME': '0', 08:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:31 INFO - Installing collected packages: mozsystemmonitor 08:25:31 INFO - Running setup.py install for mozsystemmonitor 08:25:31 INFO - Successfully installed mozsystemmonitor 08:25:31 INFO - Cleaning up... 08:25:31 INFO - Return code: 0 08:25:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:25:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:31 INFO - 'HOME': '/Users/cltbld', 08:25:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:31 INFO - 'LOGNAME': 'cltbld', 08:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:31 INFO - 'MOZ_NO_REMOTE': '1', 08:25:31 INFO - 'NO_EM_RESTART': '1', 08:25:31 INFO - 'PAGER': '/bin/cat', 08:25:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:31 INFO - 'PWD': '/builds/slave/test', 08:25:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:31 INFO - 'SHELL': '/bin/bash', 08:25:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:31 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:31 INFO - 'USER': 'cltbld', 08:25:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:31 INFO - 'XPC_FLAGS': '0x0', 08:25:31 INFO - 'XPC_SERVICE_NAME': '0', 08:25:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:34 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:34 INFO - warning: no files found matching '*.txt' 08:25:34 INFO - no previously-included directories found matching 'build' 08:25:34 INFO - no previously-included directories found matching 'dist' 08:25:34 INFO - no previously-included directories found matching '.git*' 08:25:34 INFO - Installing collected packages: jsonschema, functools32 08:25:34 INFO - Running setup.py install for functools32 08:25:35 INFO - warning: no files found matching '*.txt' 08:25:35 INFO - no previously-included directories found matching 'build' 08:25:35 INFO - no previously-included directories found matching 'dist' 08:25:35 INFO - no previously-included directories found matching '.git*' 08:25:35 INFO - Successfully installed jsonschema functools32 08:25:35 INFO - Cleaning up... 08:25:35 INFO - Return code: 0 08:25:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:35 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:25:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:35 INFO - 'HOME': '/Users/cltbld', 08:25:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:35 INFO - 'LOGNAME': 'cltbld', 08:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:35 INFO - 'MOZ_NO_REMOTE': '1', 08:25:35 INFO - 'NO_EM_RESTART': '1', 08:25:35 INFO - 'PAGER': '/bin/cat', 08:25:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:35 INFO - 'PWD': '/builds/slave/test', 08:25:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:35 INFO - 'SHELL': '/bin/bash', 08:25:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:35 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:35 INFO - 'USER': 'cltbld', 08:25:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:35 INFO - 'XPC_FLAGS': '0x0', 08:25:35 INFO - 'XPC_SERVICE_NAME': '0', 08:25:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:25:35 INFO - Cleaning up... 08:25:35 INFO - Return code: 0 08:25:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:35 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:25:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:35 INFO - 'HOME': '/Users/cltbld', 08:25:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:35 INFO - 'LOGNAME': 'cltbld', 08:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:35 INFO - 'MOZ_NO_REMOTE': '1', 08:25:35 INFO - 'NO_EM_RESTART': '1', 08:25:35 INFO - 'PAGER': '/bin/cat', 08:25:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:35 INFO - 'PWD': '/builds/slave/test', 08:25:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:35 INFO - 'SHELL': '/bin/bash', 08:25:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:35 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:35 INFO - 'USER': 'cltbld', 08:25:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:35 INFO - 'XPC_FLAGS': '0x0', 08:25:35 INFO - 'XPC_SERVICE_NAME': '0', 08:25:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:39 INFO - Downloading docopt-0.6.1.tar.gz 08:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:39 INFO - Running setup.py install for blobuploader 08:25:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:39 INFO - Running setup.py install for requests 08:25:40 INFO - Running setup.py install for docopt 08:25:40 INFO - Successfully installed blobuploader requests docopt 08:25:40 INFO - Cleaning up... 08:25:40 INFO - Return code: 0 08:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:40 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:40 INFO - 'HOME': '/Users/cltbld', 08:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:40 INFO - 'LOGNAME': 'cltbld', 08:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:40 INFO - 'MOZ_NO_REMOTE': '1', 08:25:40 INFO - 'NO_EM_RESTART': '1', 08:25:40 INFO - 'PAGER': '/bin/cat', 08:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:40 INFO - 'PWD': '/builds/slave/test', 08:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:40 INFO - 'SHELL': '/bin/bash', 08:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:40 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:40 INFO - 'USER': 'cltbld', 08:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:40 INFO - 'XPC_FLAGS': '0x0', 08:25:40 INFO - 'XPC_SERVICE_NAME': '0', 08:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-cefebh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-M92xTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-o3Aro1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-r_an0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-iFuikw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-2TQIFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-GtZVJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-smY3P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-IYqqVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-neHwQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-XZ7xzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-jxsrDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:41 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-dEQnMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:42 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-n7In30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:42 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-aPTlva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:42 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-SNYySW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:42 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-EIswDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:42 INFO - Running setup.py install for manifestparser 08:25:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:42 INFO - Running setup.py install for mozcrash 08:25:42 INFO - Running setup.py install for mozdebug 08:25:42 INFO - Running setup.py install for mozdevice 08:25:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Running setup.py install for mozfile 08:25:43 INFO - Running setup.py install for mozhttpd 08:25:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Running setup.py install for mozinfo 08:25:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Running setup.py install for mozInstall 08:25:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Running setup.py install for mozleak 08:25:43 INFO - Running setup.py install for mozlog 08:25:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:43 INFO - Running setup.py install for moznetwork 08:25:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:44 INFO - Running setup.py install for mozprocess 08:25:44 INFO - Running setup.py install for mozprofile 08:25:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:44 INFO - Running setup.py install for mozrunner 08:25:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:44 INFO - Running setup.py install for mozscreenshot 08:25:44 INFO - Running setup.py install for moztest 08:25:44 INFO - Running setup.py install for mozversion 08:25:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:45 INFO - Cleaning up... 08:25:45 INFO - Return code: 0 08:25:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:45 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:45 INFO - 'HOME': '/Users/cltbld', 08:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:45 INFO - 'LOGNAME': 'cltbld', 08:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:45 INFO - 'MOZ_NO_REMOTE': '1', 08:25:45 INFO - 'NO_EM_RESTART': '1', 08:25:45 INFO - 'PAGER': '/bin/cat', 08:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:45 INFO - 'PWD': '/builds/slave/test', 08:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:45 INFO - 'SHELL': '/bin/bash', 08:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:45 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:45 INFO - 'USER': 'cltbld', 08:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:45 INFO - 'XPC_FLAGS': '0x0', 08:25:45 INFO - 'XPC_SERVICE_NAME': '0', 08:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-V93DA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-0T8XkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-vlmEIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-0kkRXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Xk_n9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Iv1WYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:45 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-MAVTK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-4rxLml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-YJ615X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-CiSm8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-KFNL2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-6A9s9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-9r3KwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-mgZRIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-JjfFAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:46 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-XxX4nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:47 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-yyEJRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:49 INFO - Downloading blessings-1.6.tar.gz 08:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:49 INFO - Installing collected packages: blessings 08:25:49 INFO - Running setup.py install for blessings 08:25:50 INFO - Successfully installed blessings 08:25:50 INFO - Cleaning up... 08:25:50 INFO - Return code: 0 08:25:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:50 INFO - Reading from file tmpfile_stdout 08:25:50 INFO - Current package versions: 08:25:50 INFO - blessings == 1.6 08:25:50 INFO - blobuploader == 1.2.4 08:25:50 INFO - docopt == 0.6.1 08:25:50 INFO - functools32 == 3.2.3-2 08:25:50 INFO - jsonschema == 2.5.1 08:25:50 INFO - manifestparser == 1.1 08:25:50 INFO - mozInstall == 1.12 08:25:50 INFO - mozcrash == 1.0 08:25:50 INFO - mozdebug == 0.1 08:25:50 INFO - mozdevice == 0.49 08:25:50 INFO - mozfile == 1.2 08:25:50 INFO - mozhttpd == 0.7 08:25:50 INFO - mozinfo == 0.9 08:25:50 INFO - mozleak == 0.1 08:25:50 INFO - mozlog == 3.4 08:25:50 INFO - moznetwork == 0.27 08:25:50 INFO - mozprocess == 0.23 08:25:50 INFO - mozprofile == 0.28 08:25:50 INFO - mozrunner == 6.13 08:25:50 INFO - mozscreenshot == 0.1 08:25:50 INFO - mozsystemmonitor == 0.3 08:25:50 INFO - moztest == 0.7 08:25:50 INFO - mozversion == 1.4 08:25:50 INFO - psutil == 3.1.1 08:25:50 INFO - requests == 1.2.3 08:25:50 INFO - wsgiref == 0.1.2 08:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:50 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:50 INFO - 'HOME': '/Users/cltbld', 08:25:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:50 INFO - 'LOGNAME': 'cltbld', 08:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:50 INFO - 'MOZ_NO_REMOTE': '1', 08:25:50 INFO - 'NO_EM_RESTART': '1', 08:25:50 INFO - 'PAGER': '/bin/cat', 08:25:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:50 INFO - 'PWD': '/builds/slave/test', 08:25:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:50 INFO - 'SHELL': '/bin/bash', 08:25:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:50 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:50 INFO - 'USER': 'cltbld', 08:25:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:50 INFO - 'XPC_FLAGS': '0x0', 08:25:50 INFO - 'XPC_SERVICE_NAME': '0', 08:25:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:50 INFO - Cleaning up... 08:25:50 INFO - Return code: 0 08:25:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:50 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 0x10454f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9539d7a150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, '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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:25:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:25:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:25:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:25:50 INFO - 'HOME': '/Users/cltbld', 08:25:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:25:50 INFO - 'LOGNAME': 'cltbld', 08:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:50 INFO - 'MOZ_NO_REMOTE': '1', 08:25:50 INFO - 'NO_EM_RESTART': '1', 08:25:50 INFO - 'PAGER': '/bin/cat', 08:25:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:50 INFO - 'PWD': '/builds/slave/test', 08:25:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:25:50 INFO - 'SHELL': '/bin/bash', 08:25:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:25:50 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:25:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:25:50 INFO - 'USER': 'cltbld', 08:25:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:25:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:50 INFO - 'XPC_FLAGS': '0x0', 08:25:50 INFO - 'XPC_SERVICE_NAME': '0', 08:25:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:50 INFO - Cleaning up... 08:25:50 INFO - Return code: 0 08:25:50 INFO - Running post-action listener: _resource_record_post_action 08:25:50 INFO - Running post-action listener: _start_resource_monitoring 08:25:50 INFO - Starting resource monitoring. 08:25:50 INFO - [mozharness: 2016-12-03 16:25:50.965320Z] Finished create-virtualenv step (success) 08:25:50 INFO - [mozharness: 2016-12-03 16:25:50.966304Z] Running install step. 08:25:50 INFO - Running pre-action listener: _resource_record_pre_action 08:25:50 INFO - Running main action method: install 08:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:51 INFO - Reading from file tmpfile_stdout 08:25:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:51 INFO - Reading from file tmpfile_stdout 08:25:51 INFO - Output received: 08:25:51 INFO - Usage: mozinstall [options] installer 08:25:51 INFO - Options: 08:25:51 INFO - -h, --help show this help message and exit 08:25:51 INFO - -d DEST, --destination=DEST 08:25:51 INFO - Directory to install application into. [default: 08:25:51 INFO - "/builds/slave/test"] 08:25:51 INFO - --app=APP Application being installed. [default: firefox] 08:25:51 INFO - mkdir: /builds/slave/test/build/application 08:25:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:26:24 INFO - Reading from file tmpfile_stdout 08:26:24 INFO - Output received: 08:26:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:26:24 INFO - Running post-action listener: _resource_record_post_action 08:26:24 INFO - [mozharness: 2016-12-03 16:26:24.131890Z] Finished install step (success) 08:26:24 INFO - [mozharness: 2016-12-03 16:26:24.132051Z] Running run-tests step. 08:26:24 INFO - Running pre-action listener: _resource_record_pre_action 08:26:24 INFO - Running main action method: run_tests 08:26:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:26:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:26:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:26:24 INFO - 2016-12-03 08:26:24.145 screenresolution[1631:8269] starting screenresolution argv=screenresolution get 08:26:24 INFO - 2016-12-03 08:26:24.148 screenresolution[1631:8269] Display 0: 1600x1200x32@60 08:26:24 INFO - 2016-12-03 08:26:24.153 screenresolution[1632:8271] starting screenresolution argv=screenresolution list 08:26:24 INFO - Available Modes on Display 0 08:26:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:26:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:26:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:26:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:26:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:26:24 INFO - Intel Iris: 08:26:24 INFO - Chipset Model: Intel Iris 08:26:24 INFO - Type: GPU 08:26:24 INFO - Bus: Built-In 08:26:24 INFO - VRAM (Dynamic, Max): 1536 MB 08:26:24 INFO - Vendor: Intel (0x8086) 08:26:24 INFO - Device ID: 0x0a2e 08:26:24 INFO - Revision ID: 0x0009 08:26:24 INFO - Displays: 08:26:24 INFO - Display: 08:26:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:26:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:26:24 INFO - Display Serial Number: 1600x1200 60 08:26:24 INFO - Main Display: Yes 08:26:24 INFO - Mirror: Off 08:26:24 INFO - Online: Yes 08:26:24 INFO - Rotation: Supported 08:26:24 INFO - Return code: 0 08:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:26:24 INFO - Python 2.7.3 08:26:24 INFO - Return code: 0 08:26:24 INFO - grabbing minidump binary from tooltool 08:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:24 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 0x104364d30>, '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 0x1041cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10435cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:26:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:26:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:26:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:26:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:26:24 INFO - Return code: 0 08:26:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:26:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:26:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:26:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:26:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0379 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iIq1tXLmC/Render', 08:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:24 INFO - 'HOME': '/Users/cltbld', 08:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:24 INFO - 'LOGNAME': 'cltbld', 08:26:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:26:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:24 INFO - 'MOZ_NO_REMOTE': '1', 08:26:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:26:24 INFO - 'NO_EM_RESTART': '1', 08:26:24 INFO - 'PAGER': '/bin/cat', 08:26:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:24 INFO - 'PWD': '/builds/slave/test', 08:26:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:24 INFO - 'SHELL': '/bin/bash', 08:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4UMkOzAjo/Listeners', 08:26:24 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 08:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:24 INFO - 'USER': 'cltbld', 08:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:24 INFO - 'XPC_FLAGS': '0x0', 08:26:24 INFO - 'XPC_SERVICE_NAME': '0', 08:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:26:24 INFO - mozversion application_buildid: 20161203062943 08:26:24 INFO - mozversion application_changeset: f664a80393daca803f15055ade0c85145883f3ff 08:26:24 INFO - mozversion application_display_name: Nightly 08:26:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:26:24 INFO - mozversion application_name: Firefox 08:26:24 INFO - mozversion application_remotingname: firefox 08:26:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:26:24 INFO - mozversion application_vendor: Mozilla 08:26:24 INFO - mozversion application_version: 53.0a1 08:26:24 INFO - mozversion platform_buildid: 20161203062943 08:26:24 INFO - mozversion platform_changeset: f664a80393daca803f15055ade0c85145883f3ff 08:26:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:26:24 INFO - mozversion platform_version: 53.0a1 08:26:24 INFO - using testdate: 1480782384 08:26:24 INFO - actual date: 1480782384 08:26:24 INFO - starting webserver on 'localhost:49242' 08:26:24 INFO - SUITE-START | Running 2 tests 08:26:24 INFO - TEST-START | dromaeo_css 08:26:24 INFO - operating with platform_type : mac_ 08:26:24 INFO - Initialising browser for dromaeo_css test... 08:26:24 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpoe3Pmu/profile http://localhost:49242/getInfo.html) 08:26:27 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 08:26:27 INFO - PROCESS | 1642 | colorDepth:24 08:26:27 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 08:26:27 INFO - PROCESS | 1642 | __metrics 08:26:27 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:26:27 INFO - PROCESS | 1642 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:28 INFO - TEST-INFO | 1642: exit 0 08:26:28 INFO - Browser initialized. 08:26:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:26:28 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpoe3Pmu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:40 INFO - PROCESS | 1645 | RSS: Main: 236302336 08:26:40 INFO - PROCESS | 1645 | 08:27:32 INFO - PROCESS | 1645 | 1480782452270 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:29:44 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 08:29:46 INFO - PROCESS | 1645 | RSS: Main: 411168768 08:29:46 INFO - PROCESS | 1645 | 08:32:49 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 08:32:50 INFO - PROCESS | 1645 | RSS: Main: 383799296 08:32:50 INFO - PROCESS | 1645 | 08:35:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 08:35:53 INFO - PROCESS | 1645 | RSS: Main: 344932352 08:35:53 INFO - PROCESS | 1645 | 08:38:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 08:38:56 INFO - PROCESS | 1645 | RSS: Main: 340803584 08:38:56 INFO - PROCESS | 1645 | 08:41:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 08:42:00 INFO - PROCESS | 1645 | RSS: Main: 332599296 08:42:00 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 08:45:03 INFO - PROCESS | 1645 | RSS: Main: 476880896 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | __start_tp_report 08:45:03 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 08:45:03 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 08:45:03 INFO - PROCESS | 1645 | |i|pagename|runs| 08:45:03 INFO - PROCESS | 1645 | |0;dojo.html;3304.9834750826244;3309.9338013239735;3317.1375442384974;3329.217633856045;3394.0496660934946;5535.723213839312;5618.18536312235;5620.718964051802;5691.231683722696;5697.6866272355;5599.944000559994;5604.131359639263;5694.088945768678;5697.743601537931;5718.79984200552;5047;5068.46781087986;5103.26002729604;5155.639105262633;5176.948230517703;5237.973810130963;5259.552938000255;5264.201840685499;5271.367435907697;5321.866953326159;5058.114829904789;5218.76515556797;5243.580513558906;5250.816221432251;5324;5093.439721630618;5128.615353848476;5176.197689358156;5177.870553236162;5182.274481572583;5098.770555325019;5129.179331306973;5144.5369916707305;5175.249588809602;5194.584433245332;5426.321709786277;5613.326400831886;5635.6618602883955;5649.4633009864;5671.574631902583;6024.1566180734735;6078.544109191828;6098.634081955097;6134.754609815602;6139.478144357735;6130.632162070246;6141.039029825737;6179.134921111048;6190.350013248589;6230.626162430269;5657.066584013633;5717.028105222123;5732.914006289909;5740.167675687086;5764.135379693038;6127.861529871541;6177.104319873683;6242.719077641517;6247.031710084944;6256.217972753406;5557;5940.227770389822;5983.551233657493;5990.341062483123;6048.243969503812;5117.334746483008;6142.867137759775;6152.569320147636;6156.507479401637;6157.230346206724;6032.125341825411;6063.423974722395;6071.666058366833;6087.391260873877;6092.847678808065;5991.820245392645;6045.939540604626;6048.183495228088;6097.664628445389;6121.8288776978925;4800.255960326085;4836.298736683161;4843.564079232886;4849.054434385332;4852.514748525119;4269.5090064642345;4319.460067491564;4358.629516491071;4373.1472362888935;4374.58441448062;5533.3083364579425;5591.552675785927;5601.495865372136;5607.074832652566;5627.380988091307;6105.8843398869;6106.642687876681;6115.392460734087;6117.492485019875;6122.947104152868;5620.072688006515;5630.774769009276;5644.943550564524;5649.152627105967;5652.0674088774895;5280.867978300574;5285.2600635911;5330.546903513167;5346.759395827197;5352.892942141136;6238.1266622672865;6248.156498872594;6262.279837818709;6263.342349053284;6276.529260305495;5848.64908105515;6120.60216085953;6161.014237721943;6163.506919446523;6189.938100618936;6142.590862071594;6184.783532576338;6204.472619827185;6220.782272620437;6239.875202495834;6135.875804921915;6137.274298789996;6140.749659041455;6149.907751383822;6153.046277826944;6048.788292409745;6153.095953665273;6192.3807619239515;6195.132681424514;6197.504199663926;5868.23712917318;5956.047032474783;5956.791512297049;5967.373425790403;6046.762697801842;5921.733521991435;6018.548608854266;6030.48740857032;6047.0627052806885;6087.908681369871;5791.420857914175;5820.243368362086;5824.650520968756;5828.825135245949;5853.853653658693;5377.758000890048;5813;5839.211706419749;6052.546059045677;6097.2683278006925;5433.347998240079;5788.768449261982;5848.181254624271;5858.297004359504;5899.941000590111 08:45:03 INFO - PROCESS | 1645 | |1;ext.html;473.4271531446949;503.66779867251114;507.73343994402956;517.8891278208245;531.2323692264677;29414.85292573537;38002.23995520088;39020.80489597552;39021.024474388156;40769;39631;39927;40150.7992460038;40208.99477513064;40287.798561007156;9209.401388909733;9345.626174952993;9373.06269373064;9381.577828997712;9383.24934005278;8361.498310101413;8586.957065214665;10979.121670266399;11266.929641684026;11281.492332845;11276.32342059479;11327.886721132765;11336.43317834109;11355.886441135566;11386.54453821846;11171.273867198646;11261.042811361043;11275.830862537068;11280.210385273034;11285.322880627147;8276.503409795432;8523.403361764678;10866.130709543297;11151.275167114112;11191.384473853936;38252;38646.033849153995;38658.22683546313;38667.22665546701;38697.613023869686;3249.301400198945;3327.317899830529;3392.457206846893;3908.8241029153755;3967.274691403918;28967;29372.706272937423;29771.404571908657;29780.086285762824;29865;3098.380323935222;3204.4872820348864;3260.2137240137836;3304.619968703606;3307.4542700454394;487455;487665;488708.556457219;489718;490374;53807.73096134494;53925.460745392826;54009.72995134999;54119;54201.728991354794;56060.71969640207;56149.71925140348;56208.43791562032;56212.875742484925;56262.685850839945;14813.62965925839;14992.550223493312;14998.325075371635;15000.849991500163;15027.624309392353;10586.947065264625;11764.941175294069;11778.293302401884;11862.584809531625;11866.169368144147;11672.190810424398;12199.14605977573;12650.620481385573;13048.586011587886;13048.716474617095;5792.94207057924;6665.800025999228;8131.7560473185895;8135.552544609985;8197.008092046479;825.9917400825915;921.6268109617761;967.8935317115112;983.9852402213829;1091.9181061420425;28594.14217573476;28620.99826506062;29061.564076538867;29527;29534;982.8427451607708;987.7185002274317;1001.9679729878237;1029.5675816157232;1108.778244351133;12226.526324175144;14142.85857141436;14731.558053258419;15101.39594416233;15127.697446051017;676008;676338;678378;678590;679794;46838;47644.52355476401;53587.46412535903;53706.462935370924;54814.177787333225;1294.1781968450102;1325.2048770737674;1353.627752368087;1355.9254241016445;1358.1511555278148;29181.562276565444;29556.852215738785;29732.405351893274;30293.394132117675;30408.847955760964;46146.76926615345;51988.74005629947;53328.4667153339;53418;56289.71855140698;615830;626726;653885.4611453825;819729;822128;39779.801100995464;40212.59787402089;40419.595804041586;40683.59316406798;40966.590334096276;34190.31619367649;44225.33661995008;44386.112277753615;44698.55301447074;45287.77356113198;30690;36533.63466365302;36827.63172368242;36845;37771.62228377791;35263.82368088143;36303.45544816777;36833.710820122236;36856.26287474289;37668;36122.59486805251;36711.26577468489;36906.63093369032;36965.815170923976;37036.44445333268;31188.844055779577;32980.50529242111;32980.845670401424;32986;33119;23903.76096239015;24295.27114186577;24409.51180976406;24628.876855615606;24818.50362992766 08:45:03 INFO - PROCESS | 1645 | |2;jquery.html;347.69924015726406;364.8577054948569;368.60190993726775;380.3989696279878;397.09264331003664;14502.637434064154;14925.701485970274;15358.769618455732;18875;19544.218231270766;19170.61658766824;19687.507812304662;20139.59720805583;20341.389758307236;20573.074211660474;5583.162525621159;5846.707664616773;5865.76536938522;5867.207926929853;5883.970580147094;4683.601893839028;5758.971205143968;5795.304563452391;5807.970960145193;5813.389594092623;5647.491725744682;5667.943320566804;5775.5957083004205;5778.971105144468;5788.27646544182;4680.461746899116;5685.800996965087;5730.169125476824;5731.426857314235;5741.138829175616;5007.298978143026;5012.04771093491;5015.3730783652045;5024.773885175176;5034.09386310464;12563.623091307276;12844.422001009976;13020.283884386356;13023.934880325633;13035.804462933063;2108.1462007886676;2132.76539580646;2174.9782502174935;2220.2673117871063;2252.8648281103187;9550.283728720304;9949.403035817873;11641.47613357401;13633.590992270249;15299.913647231444;1459.3287087939561;1812.1845169673568;1839.8344149026652;1902.391234804863;1905.237904838062;88985.98869718338;95751.56372654416;101058.9894101057;103183.96816031818;107870;10670.893291067145;11186;11348.716282092848;11362.318260904372;11558;14273.429062837578;14291.499797507038;14304.927130465048;14316.28418579067;14336.713265734836;8010.719624813103;8178.345732341399;8206.649485298038;8212.876806847902;8321.500709957421;8046.155153708776;8050.758477245692;8196.918030819736;8200.138985406566;8215.507069575844;4344.695871289043;4405.471343438744;4428.867133985986;4503.076869241798;4510.481294651091;1566.8119825621;1569.9058056516647;1824.963500729978;1869.2336142181912;1869.4111354923427;814.1898810683408;850.6299759604592;871.3073106880046;871.9825603487894;990.4948476277151;16730.247138878778;18900.432987010412;19202.61594768097;20648.48378790542;21155.153793848072;764.3044829205396;816.2979837339883;858.9398742087994;886.3352485635774;886.4946980221212;10138.18894488454;10459.803441277418;10645;10659.786804263871;10685.83971240432;474775;481453;485027;536892;540579;88481;120861;126527;137077;138764;928.7492377058292;969.3650658818626;998.4159266828841;1000.8448690452991;1002.1581871228058;18047;18105.456836294932;18201.817981820543;18306;18448.907755461136;49408;49657.75855603639;50167.74916125396;50948.490515094374;51090.97818043544;76373;77558.61220694086;78301;81297.18702812896;85473;6855.5543889647015;7105.928940710527;7162.964185179041;7313.963430182815;7692.19231980634;10687.465626718478;12356.25862448256;12409.510858697015;12592.937035314764;12624.55814046504;10482.947585262025;10953.178511611502;11088.33469991803;11143;11156.665300041012;9285.675001374919;9817.018298170125;9998;10368.896311037095;11022.889771102185;9357.672481463116;10614.787704245717;10955.397453140155;11119.83320250213;11417.543298267976;6984.196817366068;7051.929480705333;7158.212596614264;7270.745523906638;7398.260173982559;8746.737597872074;10559.788804224027;10746;10898.891011090105;10926.344419334866 08:45:03 INFO - PROCESS | 1645 | |3;mootools.html;1302.7524770293637;1303.1300084378918;1456.1772598481857;1580.3994482096803;1806.6747985362629;7346.338829505344;7686.269804368583;7978.601069946509;8238.588070596476;8248.835023299545;8124.675012999488;8213.753587392388;8221.794455138624;8226.712065077723;8243.835123297531;2021.5653634468586;2270.557241337944;2299.9655005174936;2305.043406986107;2313.5257272259146;2119.8198153157;2234.6089434349005;2294.9541009179807;2298.080767692928;2308.6075367187536;2261.8869056547187;2263.909443622253;2265;2266.0256089881345;2269.5914735347633;2237.5189334293123;2293.334932869466;2297.0811675329833;2300.8849557522226;2303.4241439640173;2287.4281429642588;2319.69843920291;2324.9186278480342;2327.7323107842644;2333.0551126793675;8076.919230807675;8241.546714930677;8245.381596380295;8263.669453221864;8268.710595129141;4973.602111831045;5129.230615407719;5132.28148059272;5147.279380886679;5164.715940623264;3262;3476.8609255629744;3558.964410355915;3572.142685755426;3578.1949061461223;869.5956380283199;1042.0933787604756;1059.3061544688242;1077.8275475923892;1081.259337353915;10705.892941070568;10715.571377144905;10720.249582529226;10725.946370268177;10768.138548916068;3630.43728222126;4495.056038231943;4568.771561421916;4645.628349732014;4651.558101980307;7878.763637090897;9350.766230844147;9358.859617105749;9365.765855853522;9377.921539022964;5144.871378215575;5171.276021357013;5172.069027575073;5180.989707007097;5184.481551844785;4254.404383386328;4405.449318835145;4483.932741008887;4565.931511027337;4696.624270058455;3519.964800352015;3749.643783840531;3820.2359528094494;3824.0822202671156;3832.5017747692623;1207.957721479744;1245.6014075495937;1248.5193200617646;1258.7475461915453;1260.8234847121228;838.2162677896187;840.6007146605435;860.6213266162994;928.6331898899897;935.2985261054209;4574.6340292776495;5760.107183386582;5765.88468230633;5905.320888097924;6043.758249669964;885.997645321565;939.910708482693;978.3933960944261;985.7190700650424;1032.6643840751785;3728.366177749789;3728.832202550892;3766.4350347447553;3842.8462861485227;3863;7987.8402431951035;10035;10050.899491004997;10067;10068;9976.80046399068;9997;10011.399316040915;10016.39901605906;10017.248706347053;7554.622268886644;7607.809804754815;7627.237276272328;7776.339011184113;7781.610919454005;5352.411234764095;5427.3215848019;5475.890482190413;5524.281843360337;5551.361593416808;9105.590248438704;9282.30382721285;9295.395799273025;9299.67451139207;9310.348275620641;8805.603747831492;8933.28533717314;9221.400608960395;9351.064893510867;9368;7480.663370148465;7709.036370453693;7718.729844455417;7726.111497177896;7727.343175830118;7012.018317435461;7250.274972502708;7470.439717021354;7674.347680447225;7698;6597.868042639217;6909.170899492093;6968.3728464438445;7027.964860175666;7103.573785572882;6788.830279243059;6800.863982720417;6825.215100263533;6981.720731170696;6997.755078572429;6397.168368112116;6489.707963141765;6532.477401807749;6591.209054913249;6622.602643841385;4594.448666160082;4752.738599377068;4795.496472870438;4798.49615790337;4876.780544875418;4733.431988161443;4789.664723469463;4862.222044472867;4884.1941079722865;4973.303737476828 08:45:03 INFO - PROCESS | 1645 | |4;prototype.html;252.90642462288955;298.8595360180716;310.67689602813067;313.92151962009495;316.77034150241093;4082.7142100053006;4301.773994411594;4702.553257440546;5193.5325820676135;5236.083685355066;4456.710313829599;5045.520675535819;5050.32332863582;5089.440161582223;5157.896842063156;3998.740081894682;3998.900027499307;4002.4596679448264;4020.336644453662;4048.5748996355255;2916.824990500566;3756.7558108722847;4012.9799351003203;4020.43713880057;4030.6976976726864;3330.4338262495435;3611;3900.921981560367;3950.506186726659;3978.5424676162324;3868.9806550967205;3954.7231693781446;3967.682585393162;3972.443857859902;3978.8010599469912;3291.5062740588864;3457.775244609092;3474.3051389722154;3493.2489514754197;3493.7903725776537;4196.559361267084;4240.978795106035;4761.59526440253;5047.899042019176;5081.542661160476;4541.318802179667;4552.928417569998;4557.9772101139615;4573.725576465389;4574.683354567945;4632.420947381577;4827.710337379768;5395.271638328814;5436.91844622331;5449.6730196188355;3659.396199627058;3810.5617853946874;3836.846526138951;3845.8269377878064;3864.4976153099915;4938.604911607063;5103.515166059218;5447;5758.769649214027;5801.564882633777;3193.2815116599045;3288.7338374725423;3306.851191696331;3894.7273690841935;3940.3498422760495;3520.887467519519;3977.204559088194;3991.341428664296;4017.8660644697184;4025.5571887092397;3852.499175107218;4416.558344165558;4543.636509079266;4567.817287308537;4589.931151032737;4556.8177272908715;4594.863388524353;4825.662203645781;5529.585281103933;5531.676695787779;1054.383185836279;1158.5365853658436;1188.5100714004147;1240.7332423528985;1268.7081971146504;848.6944699908029;860.9009963854112;864.1833467373398;867.7310033889514;895.8700988356652;4440.511543730187;4456.866294011184;4796.952030479651;4846.273059041172;4880.487548807324;4512;4782.665213435026;4971.502849715;5159.974200128975;5265.552428043659;4152.667786577066;4724.952750472451;4767.69010014348;4821.5178482151505;4835.492273311322;2768.806183567131;2787.484315401657;2791.2045067155764;2813.760830329445;2821.604975303459;5017.724025178577;5105.719185444762;5425.647332923348;5511.614187006871;5541.584381171348;4609.663197672638;4825.372701548847;5363.436839131913;5394.568434525228;5420.83737487876;4707.693999890064;4791.760411979387;5458.672479651074;5499.972500137474;5504.284443022381;4302.67729920251;4471.150481408522;4735.786889589908;5240.34495688039;5248.553872920845;4446.355278484666;4626.306054091913;5170.388953578419;5186.6369354144845;5227.398849132246;4860.8298709545;4905.3623029006;5293.708846013352;5297.920531191958;5474.753636086306;2988.686187950234;3201.759868009862;3445.3798316302305;3712.1462063726035;3732.2535492900984;5634.74643641029;5636.943630563642;5650.971745141248;5665.461781130786;5676.388861123929;4552.408186935677;5465.945340546544;5481.835544933659;5491.917621235605;5508.283923090133;4381.233284175193;5179.653290144514;5202;5400.83797486076;5515;4403.493598236116;4858.878528036827;5075.822346217865;5196.558292545024;5352.518273355417;4597.954020459752;4710.8351207707565;5518.392976772471;5565.5825813063375;5584.916226256528;4909.394430600191;5344.278522399426;5430.972845135749;5456.7544460498575;5472.522418946942 08:45:03 INFO - PROCESS | 1645 | |5;yui.html;636.3604577399714;731.5866535407495;751.6617522115049;797.9321757650599;813.2071230550213;14783.113013219201;15144.54566363011;15205.16371599563;15212.391504339826;15400.768988465183;14843.480478183239;15492.767608485854;15495.84504154958;15771.21143942801;15784;653.2781276689237;670.4736781626424;673.5958424945019;674.652553934724;839.4837175137308;812.2649002652608;832.2759199496446;837.1502924531575;846.5682501924032;847.8770578266148;877.995610021949;885.0618344554761;885.6014793342989;885.9734207973739;889.5907882374115;682.2631557917438;874.0210963720642;877.0834477970536;877.1184959116111;877.5042101212827;524.4336116993676;625.9906101408483;646.6701981989172;648.3872740260456;651.1307404614845;14596.70806583873;14892.553223403314;15083.698326033527;15154.848451515454;15203.93572449929;13288.3355832208;13446.596602101952;13461.394237259346;13493;13514.662133446644;10600;12742.108052436333;12805.359732013456;12996.610101696964;13118.081734278605;4343.717658352197;4435.60079592835;4507.301368287921;4640.559146881041;4645.233536466479;113416;114994.42502787516;117703.23445148244;118829.8117018836;120989;10486.265961382782;10562.366258024544;10576.312539684895;10639.840402393815;10990.450477476094;20316.187352505734;20569;20578.58842823165;20696.58606827855;20826.583468330547;7561.886571701429;7567.962160189274;7575.356094731899;7578.09062912454;7817.140114587391;3998.7302469074866;4005.639492445694;4238.19474299882;4268.701190916606;4281.721688090264;3249.7400207983305;3325.7339412846914;3367.6463971282665;3402.6086999994823;3407.3355695639607;618.9009758438629;623.8752249550017;626.79629120536;634.3909846547366;639.8752243312603;561.4666067236142;598.8143675460622;602.376540280816;617.3548641669466;620.6989610039218;8380.539070351067;8838.425502342327;9072.50101244438;9965.093909283847;10038.918670470195;581.8603535151618;587.1662239619665;621.3724138619936;634.8412896775806;660.8546119853625;4085.97957010219;4502.851772797981;4688.695234809727;4921.901561968741;5099.898002039939;102994;108695.82608347946;109314;110240;110941.3587961796;99695;101207.98792012133;101513.4772978406;101716;103204.48397757963;76540;81451.59274203591;81695.59152204201;82093;83662;9859.852102218616;9893.851592225978;9929.702108936743;9930.851037234303;9975.60097596088;53883;55046.29351890818;55267.44732552623;55338.44661553494;56170.43829561652;76236;78962;80214;81069;83707.74438383308;13045.282509462071;13248.536301229411;13360.064795464614;13467.86532134666;13757.862421375658;14689.60180941614;14732.779008315098;15005;15012.7748083781;15617.219139043229;13725.519606813714;13822.308884555932;13892.444302228201;13988.370523326272;14373.712525749217;13727.245001525012;13745.03784735059;13777.862221378058;14185.858141418454;14413.647322069275;12719.682007949876;12995.870041299466;13022.4139913706;13198.670033249246;13289.534866279633;9525.275292669254;10228.437435940798;11334.94332528332;11443.828342574701;11489.54041838317;10309.74225644335;11239.269447485887;11292.378919159197;11457.885421146015;11475.081993440672 08:45:03 INFO - PROCESS | 1645 | __end_tp_report 08:45:03 INFO - PROCESS | 1645 | __start_cc_report 08:45:03 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1722 08:45:03 INFO - PROCESS | 1645 | __end_cc_report 08:45:03 INFO - PROCESS | 1645 | __startTimestamp1480783503973__endTimestamp 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | ------- Summary: start ------- 08:45:03 INFO - PROCESS | 1645 | Number of tests: 6 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5648.71 Median:5820.24 stddev:618.45 (10.6%) stddev-sans-first:592.39 08:45:03 INFO - PROCESS | 1645 | Values: 3305.0 3309.9 3317.1 3329.2 3394.0 5535.7 5618.2 5620.7 5691.2 5697.7 5599.9 5604.1 5694.1 5697.7 5718.8 5047.0 5068.5 5103.3 5155.6 5176.9 5238.0 5259.6 5264.2 5271.4 5321.9 5058.1 5218.8 5243.6 5250.8 5324.0 5093.4 5128.6 5176.2 5177.9 5182.3 5098.8 5129.2 5144.5 5175.2 5194.6 5426.3 5613.3 5635.7 5649.5 5671.6 6024.2 6078.5 6098.6 6134.8 6139.5 6130.6 6141.0 6179.1 6190.4 6230.6 5657.1 5717.0 5732.9 5740.2 5764.1 6127.9 6177.1 6242.7 6247.0 6256.2 5557.0 5940.2 5983.6 5990.3 6048.2 5117.3 6142.9 6152.6 6156.5 6157.2 6032.1 6063.4 6071.7 6087.4 6092.8 5991.8 6045.9 6048.2 6097.7 6121.8 4800.3 4836.3 4843.6 4849.1 4852.5 4269.5 4319.5 4358.6 4373.1 4374.6 5533.3 5591.6 5601.5 5607.1 5627.4 6105.9 6106.6 6115.4 6117.5 6122.9 5620.1 5630.8 5644.9 5649.2 5652.1 5280.9 5285.3 5330.5 5346.8 5352.9 6238.1 6248.2 6262.3 6263.3 6276.5 5848.6 6120.6 6161.0 6163.5 6189.9 6142.6 6184.8 6204.5 6220.8 6239.9 6135.9 6137.3 6140.7 6149.9 6153.0 6048.8 6153.1 6192.4 6195.1 6197.5 5868.2 5956.0 5956.8 5967.4 6046.8 5921.7 6018.5 6030.5 6047.1 6087.9 5791.4 5820.2 5824.7 5828.8 5853.9 5377.8 5813.0 5839.2 6052.5 6097.3 5433.3 5788.8 5848.2 5858.3 5899.9 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:74022.27 Median:36936.22 stddev:170408.74 (461.4%) stddev-sans-first:170797.30 08:45:03 INFO - PROCESS | 1645 | Values: 473.4 503.7 507.7 517.9 531.2 29414.9 38002.2 39020.8 39021.0 40769.0 39631.0 39927.0 40150.8 40209.0 40287.8 9209.4 9345.6 9373.1 9381.6 9383.2 8361.5 8587.0 10979.1 11266.9 11281.5 11276.3 11327.9 11336.4 11355.9 11386.5 11171.3 11261.0 11275.8 11280.2 11285.3 8276.5 8523.4 10866.1 11151.3 11191.4 38252.0 38646.0 38658.2 38667.2 38697.6 3249.3 3327.3 3392.5 3908.8 3967.3 28967.0 29372.7 29771.4 29780.1 29865.0 3098.4 3204.5 3260.2 3304.6 3307.5 487455.0 487665.0 488708.6 489718.0 490374.0 53807.7 53925.5 54009.7 54119.0 54201.7 56060.7 56149.7 56208.4 56212.9 56262.7 14813.6 14992.6 14998.3 15000.8 15027.6 10586.9 11764.9 11778.3 11862.6 11866.2 11672.2 12199.1 12650.6 13048.6 13048.7 5792.9 6665.8 8131.8 8135.6 8197.0 826.0 921.6 967.9 984.0 1091.9 28594.1 28621.0 29061.6 29527.0 29534.0 982.8 987.7 1002.0 1029.6 1108.8 12226.5 14142.9 14731.6 15101.4 15127.7 676008.0 676338.0 678378.0 678590.0 679794.0 46838.0 47644.5 53587.5 53706.5 54814.2 1294.2 1325.2 1353.6 1355.9 1358.2 29181.6 29556.9 29732.4 30293.4 30408.8 46146.8 51988.7 53328.5 53418.0 56289.7 615830.0 626726.0 653885.5 819729.0 822128.0 39779.8 40212.6 40419.6 40683.6 40966.6 34190.3 44225.3 44386.1 44698.6 45287.8 30690.0 36533.6 36827.6 36845.0 37771.6 35263.8 36303.5 36833.7 36856.3 37668.0 36122.6 36711.3 36906.6 36965.8 37036.4 31188.8 32980.5 32980.8 32986.0 33119.0 23903.8 24295.3 24409.5 24628.9 24818.5 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:31013.82 Median:388.75 stddev:84767.80 (21805.5%) stddev-sans-first:84974.32 08:45:03 INFO - PROCESS | 1645 | Values: 347.7 364.9 368.6 380.4 397.1 14502.6 14925.7 15358.8 18875.0 19544.2 19170.6 19687.5 20139.6 20341.4 20573.1 5583.2 5846.7 5865.8 5867.2 5884.0 4683.6 5759.0 5795.3 5808.0 5813.4 5647.5 5667.9 5775.6 5779.0 5788.3 4680.5 5685.8 5730.2 5731.4 5741.1 5007.3 5012.0 5015.4 5024.8 5034.1 12563.6 12844.4 13020.3 13023.9 13035.8 2108.1 2132.8 2175.0 2220.3 2252.9 9550.3 9949.4 11641.5 13633.6 15299.9 1459.3 1812.2 1839.8 1902.4 1905.2 88986.0 95751.6 101059.0 103184.0 107870.0 10670.9 11186.0 11348.7 11362.3 11558.0 14273.4 14291.5 14304.9 14316.3 14336.7 8010.7 8178.3 8206.6 8212.9 8321.5 8046.2 8050.8 8196.9 8200.1 8215.5 4344.7 4405.5 4428.9 4503.1 4510.5 1566.8 1569.9 1825.0 1869.2 1869.4 814.2 850.6 871.3 872.0 990.5 16730.2 18900.4 19202.6 20648.5 21155.2 764.3 816.3 858.9 886.3 886.5 10138.2 10459.8 10645.0 10659.8 10685.8 474775.0 481453.0 485027.0 536892.0 540579.0 88481.0 120861.0 126527.0 137077.0 138764.0 928.7 969.4 998.4 1000.8 1002.2 18047.0 18105.5 18201.8 18306.0 18448.9 49408.0 49657.8 50167.7 50948.5 51091.0 76373.0 77558.6 78301.0 81297.2 85473.0 6855.6 7105.9 7163.0 7314.0 7692.2 10687.5 12356.3 12409.5 12592.9 12624.6 10482.9 10953.2 11088.3 11143.0 11156.7 9285.7 9817.0 9998.0 10368.9 11022.9 9357.7 10614.8 10955.4 11119.8 11417.5 6984.2 7051.9 7158.2 7270.7 7398.3 8746.7 10559.8 10746.0 10898.9 10926.3 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5363.62 Median:5138.58 stddev:2925.45 (56.9%) stddev-sans-first:2917.74 08:45:03 INFO - PROCESS | 1645 | Values: 1302.8 1303.1 1456.2 1580.4 1806.7 7346.3 7686.3 7978.6 8238.6 8248.8 8124.7 8213.8 8221.8 8226.7 8243.8 2021.6 2270.6 2300.0 2305.0 2313.5 2119.8 2234.6 2295.0 2298.1 2308.6 2261.9 2263.9 2265.0 2266.0 2269.6 2237.5 2293.3 2297.1 2300.9 2303.4 2287.4 2319.7 2324.9 2327.7 2333.1 8076.9 8241.5 8245.4 8263.7 8268.7 4973.6 5129.2 5132.3 5147.3 5164.7 3262.0 3476.9 3559.0 3572.1 3578.2 869.6 1042.1 1059.3 1077.8 1081.3 10705.9 10715.6 10720.2 10725.9 10768.1 3630.4 4495.1 4568.8 4645.6 4651.6 7878.8 9350.8 9358.9 9365.8 9377.9 5144.9 5171.3 5172.1 5181.0 5184.5 4254.4 4405.4 4483.9 4565.9 4696.6 3520.0 3749.6 3820.2 3824.1 3832.5 1208.0 1245.6 1248.5 1258.7 1260.8 838.2 840.6 860.6 928.6 935.3 4574.6 5760.1 5765.9 5905.3 6043.8 886.0 939.9 978.4 985.7 1032.7 3728.4 3728.8 3766.4 3842.8 3863.0 7987.8 10035.0 10050.9 10067.0 10068.0 9976.8 9997.0 10011.4 10016.4 10017.2 7554.6 7607.8 7627.2 7776.3 7781.6 5352.4 5427.3 5475.9 5524.3 5551.4 9105.6 9282.3 9295.4 9299.7 9310.3 8805.6 8933.3 9221.4 9351.1 9368.0 7480.7 7709.0 7718.7 7726.1 7727.3 7012.0 7250.3 7470.4 7674.3 7698.0 6597.9 6909.2 6968.4 7028.0 7103.6 6788.8 6800.9 6825.2 6981.7 6997.8 6397.2 6489.7 6532.5 6591.2 6622.6 4594.4 4752.7 4795.5 4798.5 4876.8 4733.4 4789.7 4862.2 4884.2 4973.3 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4276.45 Median:4667.49 stddev:1290.66 (27.7%) stddev-sans-first:1258.45 08:45:03 INFO - PROCESS | 1645 | Values: 252.9 298.9 310.7 313.9 316.8 4082.7 4301.8 4702.6 5193.5 5236.1 4456.7 5045.5 5050.3 5089.4 5157.9 3998.7 3998.9 4002.5 4020.3 4048.6 2916.8 3756.8 4013.0 4020.4 4030.7 3330.4 3611.0 3900.9 3950.5 3978.5 3869.0 3954.7 3967.7 3972.4 3978.8 3291.5 3457.8 3474.3 3493.2 3493.8 4196.6 4241.0 4761.6 5047.9 5081.5 4541.3 4552.9 4558.0 4573.7 4574.7 4632.4 4827.7 5395.3 5436.9 5449.7 3659.4 3810.6 3836.8 3845.8 3864.5 4938.6 5103.5 5447.0 5758.8 5801.6 3193.3 3288.7 3306.9 3894.7 3940.3 3520.9 3977.2 3991.3 4017.9 4025.6 3852.5 4416.6 4543.6 4567.8 4589.9 4556.8 4594.9 4825.7 5529.6 5531.7 1054.4 1158.5 1188.5 1240.7 1268.7 848.7 860.9 864.2 867.7 895.9 4440.5 4456.9 4797.0 4846.3 4880.5 4512.0 4782.7 4971.5 5160.0 5265.6 4152.7 4725.0 4767.7 4821.5 4835.5 2768.8 2787.5 2791.2 2813.8 2821.6 5017.7 5105.7 5425.6 5511.6 5541.6 4609.7 4825.4 5363.4 5394.6 5420.8 4707.7 4791.8 5458.7 5500.0 5504.3 4302.7 4471.2 4735.8 5240.3 5248.6 4446.4 4626.3 5170.4 5186.6 5227.4 4860.8 4905.4 5293.7 5297.9 5474.8 2988.7 3201.8 3445.4 3712.1 3732.3 5634.7 5636.9 5651.0 5665.5 5676.4 4552.4 5465.9 5481.8 5491.9 5508.3 4381.2 5179.7 5202.0 5400.8 5515.0 4403.5 4858.9 5075.8 5196.6 5352.5 4598.0 4710.8 5518.4 5565.6 5584.9 4909.4 5344.3 5431.0 5456.8 5472.5 08:45:03 INFO - PROCESS | 1645 | 08:45:03 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:21871.87 Median:4045.81 stddev:32455.04 (802.2%) stddev-sans-first:32506.92 08:45:03 INFO - PROCESS | 1645 | Values: 636.4 731.6 751.7 797.9 813.2 14783.1 15144.5 15205.2 15212.4 15400.8 14843.5 15492.8 15495.8 15771.2 15784.0 653.3 670.5 673.6 674.7 839.5 812.3 832.3 837.2 846.6 847.9 878.0 885.1 885.6 886.0 889.6 682.3 874.0 877.1 877.1 877.5 524.4 626.0 646.7 648.4 651.1 14596.7 14892.6 15083.7 15154.8 15203.9 13288.3 13446.6 13461.4 13493.0 13514.7 10600.0 12742.1 12805.4 12996.6 13118.1 4343.7 4435.6 4507.3 4640.6 4645.2 113416.0 114994.4 117703.2 118829.8 120989.0 10486.3 10562.4 10576.3 10639.8 10990.5 20316.2 20569.0 20578.6 20696.6 20826.6 7561.9 7568.0 7575.4 7578.1 7817.1 3998.7 4005.6 4238.2 4268.7 4281.7 3249.7 3325.7 3367.6 3402.6 3407.3 618.9 623.9 626.8 634.4 639.9 561.5 598.8 602.4 617.4 620.7 8380.5 8838.4 9072.5 9965.1 10038.9 581.9 587.2 621.4 634.8 660.9 4086.0 4502.9 4688.7 4921.9 5099.9 102994.0 108695.8 109314.0 110240.0 110941.4 99695.0 101208.0 101513.5 101716.0 103204.5 76540.0 81451.6 81695.6 82093.0 83662.0 9859.9 9893.9 9929.7 9930.9 9975.6 53883.0 55046.3 55267.4 55338.4 56170.4 76236.0 78962.0 80214.0 81069.0 83707.7 13045.3 13248.5 13360.1 13467.9 13757.9 14689.6 14732.8 15005.0 15012.8 15617.2 13725.5 13822.3 13892.4 13988.4 14373.7 13727.2 13745.0 13777.9 14185.9 14413.6 12719.7 12995.9 13022.4 13198.7 13289.5 9525.3 10228.4 11334.9 11443.8 11489.5 10309.7 11239.3 11292.4 11457.9 11475.1 08:45:03 INFO - PROCESS | 1645 | -------- Summary: end -------- 08:45:03 INFO - PROCESS | 1645 | 08:45:04 INFO - TEST-INFO | 1645: exit 0 08:45:04 INFO - TEST-OK | dromaeo_css | took 1119921ms 08:45:04 INFO - TEST-START | kraken 08:45:04 INFO - operating with platform_type : mac_ 08:45:04 INFO - Initialising browser for kraken test... 08:45:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpdydUYd/profile http://localhost:49242/getInfo.html) 08:45:07 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 08:45:07 INFO - PROCESS | 1651 | colorDepth:24 08:45:07 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 08:45:07 INFO - PROCESS | 1651 | __metrics 08:45:07 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:07 INFO - PROCESS | 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:08 INFO - TEST-INFO | 1651: exit 0 08:45:08 INFO - Browser initialized. 08:45:08 INFO - Running cycle 1/1 for kraken test... 08:45:08 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpdydUYd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:20 INFO - PROCESS | 1652 | RSS: Main: 244137984 08:45:20 INFO - PROCESS | 1652 | 08:45:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 08:45:24 INFO - PROCESS | 1652 | RSS: Main: 294342656 08:45:24 INFO - PROCESS | 1652 | 08:45:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 08:45:27 INFO - PROCESS | 1652 | RSS: Main: 295493632 08:45:27 INFO - PROCESS | 1652 | 08:45:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 08:45:31 INFO - PROCESS | 1652 | RSS: Main: 389713920 08:45:31 INFO - PROCESS | 1652 | 08:45:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 08:45:34 INFO - PROCESS | 1652 | RSS: Main: 290365440 08:45:34 INFO - PROCESS | 1652 | 08:45:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:45:36 INFO - PROCESS | 1652 | RSS: Main: 294019072 08:45:36 INFO - PROCESS | 1652 | 08:45:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 08:45:40 INFO - PROCESS | 1652 | RSS: Main: 337244160 08:45:40 INFO - PROCESS | 1652 | 08:45:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:43 INFO - PROCESS | 1652 | RSS: Main: 337465344 08:45:43 INFO - PROCESS | 1652 | 08:45:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 08:45:47 INFO - PROCESS | 1652 | RSS: Main: 334757888 08:45:47 INFO - PROCESS | 1652 | 08:45:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:49 INFO - PROCESS | 1652 | RSS: Main: 307433472 08:45:49 INFO - PROCESS | 1652 | 08:45:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:51 INFO - PROCESS | 1652 | RSS: Main: 311844864 08:45:51 INFO - PROCESS | 1652 | 08:45:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:54 INFO - PROCESS | 1652 | RSS: Main: 313458688 08:45:54 INFO - PROCESS | 1652 | 08:45:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:58 INFO - PROCESS | 1652 | RSS: Main: 332140544 08:45:58 INFO - PROCESS | 1652 | 08:46:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:46:02 INFO - PROCESS | 1652 | RSS: Main: 326258688 08:46:02 INFO - PROCESS | 1652 | 08:46:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 08:46:04 INFO - PROCESS | 1652 | RSS: Main: 370593792 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | __start_tp_report 08:46:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 08:46:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 08:46:04 INFO - PROCESS | 1652 | |i|pagename|runs| 08:46:04 INFO - PROCESS | 1652 | |0;ai-astar;113;116;115;114;114;116;113;112;113;113 08:46:04 INFO - PROCESS | 1652 | |1;audio-beat-detection;155;113;115;161;113;114;112;111;160;142 08:46:04 INFO - PROCESS | 1652 | |2;audio-dft;185;183;195;259;184;185;183;179;183;181 08:46:04 INFO - PROCESS | 1652 | |3;audio-fft;79;59;58;86;59;59;61;57;72;61 08:46:04 INFO - PROCESS | 1652 | |4;audio-oscillator;89;71;85;69;67;69;81;67;68;83 08:46:04 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;84;86;83;87;83;86;84;87;85 08:46:04 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;95;94;96;96;95;95;96;95;95 08:46:04 INFO - PROCESS | 1652 | |7;imaging-desaturate;138;99;86;85;84;88;88;84;85;85 08:46:04 INFO - PROCESS | 1652 | |8;json-parse-financial;56;53;54;53;54;55;55;55;55;53 08:46:04 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;65;75;74;75;73;69;70;72;70;70 08:46:04 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;91;103;108;88;93;91;88;84;87;88 08:46:04 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;151;152;144;149;150;154;161;145;200;150 08:46:04 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;174;173;174;172;173;175;172;175;174;228 08:46:04 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;70;69;69;68;69;70;67;67;67;69 08:46:04 INFO - PROCESS | 1652 | __end_tp_report 08:46:04 INFO - PROCESS | 1652 | __start_cc_report 08:46:04 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1955 08:46:04 INFO - PROCESS | 1652 | __end_cc_report 08:46:04 INFO - PROCESS | 1652 | __startTimestamp1480783564031__endTimestamp 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | ------- Summary: start ------- 08:46:04 INFO - PROCESS | 1652 | Number of tests: 14 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.37 (1.2%) stddev-sans-first:1.41 08:46:04 INFO - PROCESS | 1652 | Values: 113.0 116.0 115.0 114.0 114.0 116.0 113.0 112.0 113.0 113.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:128.50 stddev:22.04 (17.2%) stddev-sans-first:21.38 08:46:04 INFO - PROCESS | 1652 | Values: 155.0 113.0 115.0 161.0 113.0 114.0 112.0 111.0 160.0 142.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:191.70 Median:184.50 stddev:24.02 (13.0%) stddev-sans-first:25.35 08:46:04 INFO - PROCESS | 1652 | Values: 185.0 183.0 195.0 259.0 184.0 185.0 183.0 179.0 183.0 181.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.10 Median:61.00 stddev:10.21 (16.7%) stddev-sans-first:9.51 08:46:04 INFO - PROCESS | 1652 | Values: 79.0 59.0 58.0 86.0 59.0 59.0 61.0 57.0 72.0 61.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:76.00 stddev:8.57 (11.3%) stddev-sans-first:7.42 08:46:04 INFO - PROCESS | 1652 | Values: 89.0 71.0 85.0 69.0 67.0 69.0 81.0 67.0 68.0 83.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.00 stddev:1.77 (2.1%) stddev-sans-first:1.58 08:46:04 INFO - PROCESS | 1652 | Values: 88.0 84.0 86.0 83.0 87.0 83.0 86.0 84.0 87.0 85.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:46:04 INFO - PROCESS | 1652 | Values: 95.0 95.0 94.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:85.50 stddev:16.69 (19.5%) stddev-sans-first:4.70 08:46:04 INFO - PROCESS | 1652 | Values: 138.0 99.0 86.0 85.0 84.0 88.0 88.0 84.0 85.0 85.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:0.93 08:46:04 INFO - PROCESS | 1652 | Values: 56.0 53.0 54.0 53.0 54.0 55.0 55.0 55.0 55.0 53.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.50 stddev:3.13 (4.3%) stddev-sans-first:2.35 08:46:04 INFO - PROCESS | 1652 | Values: 65.0 75.0 74.0 75.0 73.0 69.0 70.0 72.0 70.0 70.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:88.00 stddev:7.58 (8.6%) stddev-sans-first:8.03 08:46:04 INFO - PROCESS | 1652 | Values: 91.0 103.0 108.0 88.0 93.0 91.0 88.0 84.0 87.0 88.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:151.50 stddev:16.30 (10.8%) stddev-sans-first:17.20 08:46:04 INFO - PROCESS | 1652 | Values: 151.0 152.0 144.0 149.0 150.0 154.0 161.0 145.0 200.0 150.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:174.00 stddev:17.25 (9.9%) stddev-sans-first:18.20 08:46:04 INFO - PROCESS | 1652 | Values: 174.0 173.0 174.0 172.0 173.0 175.0 172.0 175.0 174.0 228.0 08:46:04 INFO - PROCESS | 1652 | 08:46:04 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 08:46:04 INFO - PROCESS | 1652 | Values: 70.0 69.0 69.0 68.0 69.0 70.0 67.0 67.0 67.0 69.0 08:46:04 INFO - PROCESS | 1652 | -------- Summary: end -------- 08:46:04 INFO - PROCESS | 1652 | 08:46:05 INFO - TEST-INFO | 1652: exit 0 08:46:05 INFO - TEST-OK | kraken | took 60384ms 08:46:05 INFO - SUITE-END | took 1180s 08:46:05 INFO - Completed test suite (00:19:40) 08:46:05 INFO - javascript benchmark 08:46:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.9834750826244, 3309.9338013239735, 3317.1375442384974, 3329.217633856045, 3394.0496660934946, 5535.723213839312, 5618.18536312235, 5620.718964051802, 5691.231683722696, 5697.6866272355, 5599.944000559994, 5604.131359639263, 5694.088945768678, 5697.743601537931, 5718.79984200552, 5047.0, 5068.46781087986, 5103.26002729604, 5155.639105262633, 5176.948230517703, 5237.973810130963, 5259.552938000255, 5264.201840685499, 5271.367435907697, 5321.866953326159, 5058.114829904789, 5218.76515556797, 5243.580513558906, 5250.816221432251, 5324.0, 5093.439721630618, 5128.615353848476, 5176.197689358156, 5177.870553236162, 5182.274481572583, 5098.770555325019, 5129.179331306973, 5144.5369916707305, 5175.249588809602, 5194.584433245332, 5426.321709786277, 5613.326400831886, 5635.6618602883955, 5649.4633009864, 5671.574631902583, 6024.1566180734735, 6078.544109191828, 6098.634081955097, 6134.754609815602, 6139.478144357735, 6130.632162070246, 6141.039029825737, 6179.134921111048, 6190.350013248589, 6230.626162430269, 5657.066584013633, 5717.028105222123, 5732.914006289909, 5740.167675687086, 5764.135379693038, 6127.861529871541, 6177.104319873683, 6242.719077641517, 6247.031710084944, 6256.217972753406, 5557.0, 5940.227770389822, 5983.551233657493, 5990.341062483123, 6048.243969503812, 5117.334746483008, 6142.867137759775, 6152.569320147636, 6156.507479401637, 6157.230346206724, 6032.125341825411, 6063.423974722395, 6071.666058366833, 6087.391260873877, 6092.847678808065, 5991.820245392645, 6045.939540604626, 6048.183495228088, 6097.664628445389, 6121.8288776978925, 4800.255960326085, 4836.298736683161, 4843.564079232886, 4849.054434385332, 4852.514748525119, 4269.5090064642345, 4319.460067491564, 4358.629516491071, 4373.1472362888935, 4374.58441448062, 5533.3083364579425, 5591.552675785927, 5601.495865372136, 5607.074832652566, 5627.380988091307, 6105.8843398869, 6106.642687876681, 6115.392460734087, 6117.492485019875, 6122.947104152868, 5620.072688006515, 5630.774769009276, 5644.943550564524, 5649.152627105967, 5652.0674088774895, 5280.867978300574, 5285.2600635911, 5330.546903513167, 5346.759395827197, 5352.892942141136, 6238.1266622672865, 6248.156498872594, 6262.279837818709, 6263.342349053284, 6276.529260305495, 5848.64908105515, 6120.60216085953, 6161.014237721943, 6163.506919446523, 6189.938100618936, 6142.590862071594, 6184.783532576338, 6204.472619827185, 6220.782272620437, 6239.875202495834, 6135.875804921915, 6137.274298789996, 6140.749659041455, 6149.907751383822, 6153.046277826944, 6048.788292409745, 6153.095953665273, 6192.3807619239515, 6195.132681424514, 6197.504199663926, 5868.23712917318, 5956.047032474783, 5956.791512297049, 5967.373425790403, 6046.762697801842, 5921.733521991435, 6018.548608854266, 6030.48740857032, 6047.0627052806885, 6087.908681369871, 5791.420857914175, 5820.243368362086, 5824.650520968756, 5828.825135245949, 5853.853653658693, 5377.758000890048, 5813.0, 5839.211706419749, 6052.546059045677, 6097.2683278006925, 5433.347998240079, 5788.768449261982, 5848.181254624271, 5858.297004359504, 5899.941000590111], "value": 5609.625139674186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.4271531446949, 503.66779867251114, 507.73343994402956, 517.8891278208245, 531.2323692264677, 29414.85292573537, 38002.23995520088, 39020.80489597552, 39021.024474388156, 40769.0, 39631.0, 39927.0, 40150.7992460038, 40208.99477513064, 40287.798561007156, 9209.401388909733, 9345.626174952993, 9373.06269373064, 9381.577828997712, 9383.24934005278, 8361.498310101413, 8586.957065214665, 10979.121670266399, 11266.929641684026, 11281.492332845, 11276.32342059479, 11327.886721132765, 11336.43317834109, 11355.886441135566, 11386.54453821846, 11171.273867198646, 11261.042811361043, 11275.830862537068, 11280.210385273034, 11285.322880627147, 8276.503409795432, 8523.403361764678, 10866.130709543297, 11151.275167114112, 11191.384473853936, 38252.0, 38646.033849153995, 38658.22683546313, 38667.22665546701, 38697.613023869686, 3249.301400198945, 3327.317899830529, 3392.457206846893, 3908.8241029153755, 3967.274691403918, 28967.0, 29372.706272937423, 29771.404571908657, 29780.086285762824, 29865.0, 3098.380323935222, 3204.4872820348864, 3260.2137240137836, 3304.619968703606, 3307.4542700454394, 487455.0, 487665.0, 488708.556457219, 489718.0, 490374.0, 53807.73096134494, 53925.460745392826, 54009.72995134999, 54119.0, 54201.728991354794, 56060.71969640207, 56149.71925140348, 56208.43791562032, 56212.875742484925, 56262.685850839945, 14813.62965925839, 14992.550223493312, 14998.325075371635, 15000.849991500163, 15027.624309392353, 10586.947065264625, 11764.941175294069, 11778.293302401884, 11862.584809531625, 11866.169368144147, 11672.190810424398, 12199.14605977573, 12650.620481385573, 13048.586011587886, 13048.716474617095, 5792.94207057924, 6665.800025999228, 8131.7560473185895, 8135.552544609985, 8197.008092046479, 825.9917400825915, 921.6268109617761, 967.8935317115112, 983.9852402213829, 1091.9181061420425, 28594.14217573476, 28620.99826506062, 29061.564076538867, 29527.0, 29534.0, 982.8427451607708, 987.7185002274317, 1001.9679729878237, 1029.5675816157232, 1108.778244351133, 12226.526324175144, 14142.85857141436, 14731.558053258419, 15101.39594416233, 15127.697446051017, 676008.0, 676338.0, 678378.0, 678590.0, 679794.0, 46838.0, 47644.52355476401, 53587.46412535903, 53706.462935370924, 54814.177787333225, 1294.1781968450102, 1325.2048770737674, 1353.627752368087, 1355.9254241016445, 1358.1511555278148, 29181.562276565444, 29556.852215738785, 29732.405351893274, 30293.394132117675, 30408.847955760964, 46146.76926615345, 51988.74005629947, 53328.4667153339, 53418.0, 56289.71855140698, 615830.0, 626726.0, 653885.4611453825, 819729.0, 822128.0, 39779.801100995464, 40212.59787402089, 40419.595804041586, 40683.59316406798, 40966.590334096276, 34190.31619367649, 44225.33661995008, 44386.112277753615, 44698.55301447074, 45287.77356113198, 30690.0, 36533.63466365302, 36827.63172368242, 36845.0, 37771.62228377791, 35263.82368088143, 36303.45544816777, 36833.710820122236, 36856.26287474289, 37668.0, 36122.59486805251, 36711.26577468489, 36906.63093369032, 36965.815170923976, 37036.44445333268, 31188.844055779577, 32980.50529242111, 32980.845670401424, 32986.0, 33119.0, 23903.76096239015, 24295.27114186577, 24409.51180976406, 24628.876855615606, 24818.50362992766], "value": 19690.815011768394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.69924015726406, 364.8577054948569, 368.60190993726775, 380.3989696279878, 397.09264331003664, 14502.637434064154, 14925.701485970274, 15358.769618455732, 18875.0, 19544.218231270766, 19170.61658766824, 19687.507812304662, 20139.59720805583, 20341.389758307236, 20573.074211660474, 5583.162525621159, 5846.707664616773, 5865.76536938522, 5867.207926929853, 5883.970580147094, 4683.601893839028, 5758.971205143968, 5795.304563452391, 5807.970960145193, 5813.389594092623, 5647.491725744682, 5667.943320566804, 5775.5957083004205, 5778.971105144468, 5788.27646544182, 4680.461746899116, 5685.800996965087, 5730.169125476824, 5731.426857314235, 5741.138829175616, 5007.298978143026, 5012.04771093491, 5015.3730783652045, 5024.773885175176, 5034.09386310464, 12563.623091307276, 12844.422001009976, 13020.283884386356, 13023.934880325633, 13035.804462933063, 2108.1462007886676, 2132.76539580646, 2174.9782502174935, 2220.2673117871063, 2252.8648281103187, 9550.283728720304, 9949.403035817873, 11641.47613357401, 13633.590992270249, 15299.913647231444, 1459.3287087939561, 1812.1845169673568, 1839.8344149026652, 1902.391234804863, 1905.237904838062, 88985.98869718338, 95751.56372654416, 101058.9894101057, 103183.96816031818, 107870.0, 10670.893291067145, 11186.0, 11348.716282092848, 11362.318260904372, 11558.0, 14273.429062837578, 14291.499797507038, 14304.927130465048, 14316.28418579067, 14336.713265734836, 8010.719624813103, 8178.345732341399, 8206.649485298038, 8212.876806847902, 8321.500709957421, 8046.155153708776, 8050.758477245692, 8196.918030819736, 8200.138985406566, 8215.507069575844, 4344.695871289043, 4405.471343438744, 4428.867133985986, 4503.076869241798, 4510.481294651091, 1566.8119825621, 1569.9058056516647, 1824.963500729978, 1869.2336142181912, 1869.4111354923427, 814.1898810683408, 850.6299759604592, 871.3073106880046, 871.9825603487894, 990.4948476277151, 16730.247138878778, 18900.432987010412, 19202.61594768097, 20648.48378790542, 21155.153793848072, 764.3044829205396, 816.2979837339883, 858.9398742087994, 886.3352485635774, 886.4946980221212, 10138.18894488454, 10459.803441277418, 10645.0, 10659.786804263871, 10685.83971240432, 474775.0, 481453.0, 485027.0, 536892.0, 540579.0, 88481.0, 120861.0, 126527.0, 137077.0, 138764.0, 928.7492377058292, 969.3650658818626, 998.4159266828841, 1000.8448690452991, 1002.1581871228058, 18047.0, 18105.456836294932, 18201.817981820543, 18306.0, 18448.907755461136, 49408.0, 49657.75855603639, 50167.74916125396, 50948.490515094374, 51090.97818043544, 76373.0, 77558.61220694086, 78301.0, 81297.18702812896, 85473.0, 6855.5543889647015, 7105.928940710527, 7162.964185179041, 7313.963430182815, 7692.19231980634, 10687.465626718478, 12356.25862448256, 12409.510858697015, 12592.937035314764, 12624.55814046504, 10482.947585262025, 10953.178511611502, 11088.33469991803, 11143.0, 11156.665300041012, 9285.675001374919, 9817.018298170125, 9998.0, 10368.896311037095, 11022.889771102185, 9357.672481463116, 10614.787704245717, 10955.397453140155, 11119.83320250213, 11417.543298267976, 6984.196817366068, 7051.929480705333, 7158.212596614264, 7270.745523906638, 7398.260173982559, 8746.737597872074, 10559.788804224027, 10746.0, 10898.891011090105, 10926.344419334866], "value": 8918.27830070878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.7524770293637, 1303.1300084378918, 1456.1772598481857, 1580.3994482096803, 1806.6747985362629, 7346.338829505344, 7686.269804368583, 7978.601069946509, 8238.588070596476, 8248.835023299545, 8124.675012999488, 8213.753587392388, 8221.794455138624, 8226.712065077723, 8243.835123297531, 2021.5653634468586, 2270.557241337944, 2299.9655005174936, 2305.043406986107, 2313.5257272259146, 2119.8198153157, 2234.6089434349005, 2294.9541009179807, 2298.080767692928, 2308.6075367187536, 2261.8869056547187, 2263.909443622253, 2265.0, 2266.0256089881345, 2269.5914735347633, 2237.5189334293123, 2293.334932869466, 2297.0811675329833, 2300.8849557522226, 2303.4241439640173, 2287.4281429642588, 2319.69843920291, 2324.9186278480342, 2327.7323107842644, 2333.0551126793675, 8076.919230807675, 8241.546714930677, 8245.381596380295, 8263.669453221864, 8268.710595129141, 4973.602111831045, 5129.230615407719, 5132.28148059272, 5147.279380886679, 5164.715940623264, 3262.0, 3476.8609255629744, 3558.964410355915, 3572.142685755426, 3578.1949061461223, 869.5956380283199, 1042.0933787604756, 1059.3061544688242, 1077.8275475923892, 1081.259337353915, 10705.892941070568, 10715.571377144905, 10720.249582529226, 10725.946370268177, 10768.138548916068, 3630.43728222126, 4495.056038231943, 4568.771561421916, 4645.628349732014, 4651.558101980307, 7878.763637090897, 9350.766230844147, 9358.859617105749, 9365.765855853522, 9377.921539022964, 5144.871378215575, 5171.276021357013, 5172.069027575073, 5180.989707007097, 5184.481551844785, 4254.404383386328, 4405.449318835145, 4483.932741008887, 4565.931511027337, 4696.624270058455, 3519.964800352015, 3749.643783840531, 3820.2359528094494, 3824.0822202671156, 3832.5017747692623, 1207.957721479744, 1245.6014075495937, 1248.5193200617646, 1258.7475461915453, 1260.8234847121228, 838.2162677896187, 840.6007146605435, 860.6213266162994, 928.6331898899897, 935.2985261054209, 4574.6340292776495, 5760.107183386582, 5765.88468230633, 5905.320888097924, 6043.758249669964, 885.997645321565, 939.910708482693, 978.3933960944261, 985.7190700650424, 1032.6643840751785, 3728.366177749789, 3728.832202550892, 3766.4350347447553, 3842.8462861485227, 3863.0, 7987.8402431951035, 10035.0, 10050.899491004997, 10067.0, 10068.0, 9976.80046399068, 9997.0, 10011.399316040915, 10016.39901605906, 10017.248706347053, 7554.622268886644, 7607.809804754815, 7627.237276272328, 7776.339011184113, 7781.610919454005, 5352.411234764095, 5427.3215848019, 5475.890482190413, 5524.281843360337, 5551.361593416808, 9105.590248438704, 9282.30382721285, 9295.395799273025, 9299.67451139207, 9310.348275620641, 8805.603747831492, 8933.28533717314, 9221.400608960395, 9351.064893510867, 9368.0, 7480.663370148465, 7709.036370453693, 7718.729844455417, 7726.111497177896, 7727.343175830118, 7012.018317435461, 7250.274972502708, 7470.439717021354, 7674.347680447225, 7698.0, 6597.868042639217, 6909.170899492093, 6968.3728464438445, 7027.964860175666, 7103.573785572882, 6788.830279243059, 6800.863982720417, 6825.215100263533, 6981.720731170696, 6997.755078572429, 6397.168368112116, 6489.707963141765, 6532.477401807749, 6591.209054913249, 6622.602643841385, 4594.448666160082, 4752.738599377068, 4795.496472870438, 4798.49615790337, 4876.780544875418, 4733.431988161443, 4789.664723469463, 4862.222044472867, 4884.1941079722865, 4973.303737476828], "value": 4357.502046754723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.90642462288955, 298.8595360180716, 310.67689602813067, 313.92151962009495, 316.77034150241093, 4082.7142100053006, 4301.773994411594, 4702.553257440546, 5193.5325820676135, 5236.083685355066, 4456.710313829599, 5045.520675535819, 5050.32332863582, 5089.440161582223, 5157.896842063156, 3998.740081894682, 3998.900027499307, 4002.4596679448264, 4020.336644453662, 4048.5748996355255, 2916.824990500566, 3756.7558108722847, 4012.9799351003203, 4020.43713880057, 4030.6976976726864, 3330.4338262495435, 3611.0, 3900.921981560367, 3950.506186726659, 3978.5424676162324, 3868.9806550967205, 3954.7231693781446, 3967.682585393162, 3972.443857859902, 3978.8010599469912, 3291.5062740588864, 3457.775244609092, 3474.3051389722154, 3493.2489514754197, 3493.7903725776537, 4196.559361267084, 4240.978795106035, 4761.59526440253, 5047.899042019176, 5081.542661160476, 4541.318802179667, 4552.928417569998, 4557.9772101139615, 4573.725576465389, 4574.683354567945, 4632.420947381577, 4827.710337379768, 5395.271638328814, 5436.91844622331, 5449.6730196188355, 3659.396199627058, 3810.5617853946874, 3836.846526138951, 3845.8269377878064, 3864.4976153099915, 4938.604911607063, 5103.515166059218, 5447.0, 5758.769649214027, 5801.564882633777, 3193.2815116599045, 3288.7338374725423, 3306.851191696331, 3894.7273690841935, 3940.3498422760495, 3520.887467519519, 3977.204559088194, 3991.341428664296, 4017.8660644697184, 4025.5571887092397, 3852.499175107218, 4416.558344165558, 4543.636509079266, 4567.817287308537, 4589.931151032737, 4556.8177272908715, 4594.863388524353, 4825.662203645781, 5529.585281103933, 5531.676695787779, 1054.383185836279, 1158.5365853658436, 1188.5100714004147, 1240.7332423528985, 1268.7081971146504, 848.6944699908029, 860.9009963854112, 864.1833467373398, 867.7310033889514, 895.8700988356652, 4440.511543730187, 4456.866294011184, 4796.952030479651, 4846.273059041172, 4880.487548807324, 4512.0, 4782.665213435026, 4971.502849715, 5159.974200128975, 5265.552428043659, 4152.667786577066, 4724.952750472451, 4767.69010014348, 4821.5178482151505, 4835.492273311322, 2768.806183567131, 2787.484315401657, 2791.2045067155764, 2813.760830329445, 2821.604975303459, 5017.724025178577, 5105.719185444762, 5425.647332923348, 5511.614187006871, 5541.584381171348, 4609.663197672638, 4825.372701548847, 5363.436839131913, 5394.568434525228, 5420.83737487876, 4707.693999890064, 4791.760411979387, 5458.672479651074, 5499.972500137474, 5504.284443022381, 4302.67729920251, 4471.150481408522, 4735.786889589908, 5240.34495688039, 5248.553872920845, 4446.355278484666, 4626.306054091913, 5170.388953578419, 5186.6369354144845, 5227.398849132246, 4860.8298709545, 4905.3623029006, 5293.708846013352, 5297.920531191958, 5474.753636086306, 2988.686187950234, 3201.759868009862, 3445.3798316302305, 3712.1462063726035, 3732.2535492900984, 5634.74643641029, 5636.943630563642, 5650.971745141248, 5665.461781130786, 5676.388861123929, 4552.408186935677, 5465.945340546544, 5481.835544933659, 5491.917621235605, 5508.283923090133, 4381.233284175193, 5179.653290144514, 5202.0, 5400.83797486076, 5515.0, 4403.493598236116, 4858.878528036827, 5075.822346217865, 5196.558292545024, 5352.518273355417, 4597.954020459752, 4710.8351207707565, 5518.392976772471, 5565.5825813063375, 5584.916226256528, 4909.394430600191, 5344.278522399426, 5430.972845135749, 5456.7544460498575, 5472.522418946942], "value": 3868.5761630453367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.3604577399714, 731.5866535407495, 751.6617522115049, 797.9321757650599, 813.2071230550213, 14783.113013219201, 15144.54566363011, 15205.16371599563, 15212.391504339826, 15400.768988465183, 14843.480478183239, 15492.767608485854, 15495.84504154958, 15771.21143942801, 15784.0, 653.2781276689237, 670.4736781626424, 673.5958424945019, 674.652553934724, 839.4837175137308, 812.2649002652608, 832.2759199496446, 837.1502924531575, 846.5682501924032, 847.8770578266148, 877.995610021949, 885.0618344554761, 885.6014793342989, 885.9734207973739, 889.5907882374115, 682.2631557917438, 874.0210963720642, 877.0834477970536, 877.1184959116111, 877.5042101212827, 524.4336116993676, 625.9906101408483, 646.6701981989172, 648.3872740260456, 651.1307404614845, 14596.70806583873, 14892.553223403314, 15083.698326033527, 15154.848451515454, 15203.93572449929, 13288.3355832208, 13446.596602101952, 13461.394237259346, 13493.0, 13514.662133446644, 10600.0, 12742.108052436333, 12805.359732013456, 12996.610101696964, 13118.081734278605, 4343.717658352197, 4435.60079592835, 4507.301368287921, 4640.559146881041, 4645.233536466479, 113416.0, 114994.42502787516, 117703.23445148244, 118829.8117018836, 120989.0, 10486.265961382782, 10562.366258024544, 10576.312539684895, 10639.840402393815, 10990.450477476094, 20316.187352505734, 20569.0, 20578.58842823165, 20696.58606827855, 20826.583468330547, 7561.886571701429, 7567.962160189274, 7575.356094731899, 7578.09062912454, 7817.140114587391, 3998.7302469074866, 4005.639492445694, 4238.19474299882, 4268.701190916606, 4281.721688090264, 3249.7400207983305, 3325.7339412846914, 3367.6463971282665, 3402.6086999994823, 3407.3355695639607, 618.9009758438629, 623.8752249550017, 626.79629120536, 634.3909846547366, 639.8752243312603, 561.4666067236142, 598.8143675460622, 602.376540280816, 617.3548641669466, 620.6989610039218, 8380.539070351067, 8838.425502342327, 9072.50101244438, 9965.093909283847, 10038.918670470195, 581.8603535151618, 587.1662239619665, 621.3724138619936, 634.8412896775806, 660.8546119853625, 4085.97957010219, 4502.851772797981, 4688.695234809727, 4921.901561968741, 5099.898002039939, 102994.0, 108695.82608347946, 109314.0, 110240.0, 110941.3587961796, 99695.0, 101207.98792012133, 101513.4772978406, 101716.0, 103204.48397757963, 76540.0, 81451.59274203591, 81695.59152204201, 82093.0, 83662.0, 9859.852102218616, 9893.851592225978, 9929.702108936743, 9930.851037234303, 9975.60097596088, 53883.0, 55046.29351890818, 55267.44732552623, 55338.44661553494, 56170.43829561652, 76236.0, 78962.0, 80214.0, 81069.0, 83707.74438383308, 13045.282509462071, 13248.536301229411, 13360.064795464614, 13467.86532134666, 13757.862421375658, 14689.60180941614, 14732.779008315098, 15005.0, 15012.7748083781, 15617.219139043229, 13725.519606813714, 13822.308884555932, 13892.444302228201, 13988.370523326272, 14373.712525749217, 13727.245001525012, 13745.03784735059, 13777.862221378058, 14185.858141418454, 14413.647322069275, 12719.682007949876, 12995.870041299466, 13022.4139913706, 13198.670033249246, 13289.534866279633, 9525.275292669254, 10228.437435940798, 11334.94332528332, 11443.828342574701, 11489.54041838317, 10309.74225644335, 11239.269447485887, 11292.378919159197, 11457.885421146015, 11475.081993440672], "value": 7523.355249448786, "unit": "score"}], "name": "dromaeo_css", "value": 7070.574321855192, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 114.0, 114.0, 116.0, 113.0, 112.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 113.0, 115.0, 161.0, 113.0, 114.0, 112.0, 111.0, 160.0, 142.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 195.0, 259.0, 184.0, 185.0, 183.0, 179.0, 183.0, 181.0], "value": 191.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 86.0, 59.0, 59.0, 61.0, 57.0, 72.0, 61.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 69.0, 67.0, 69.0, 81.0, 67.0, 68.0, 83.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0, 84.0, 87.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 99.0, 86.0, 85.0, 84.0, 88.0, 88.0, 84.0, 85.0, 85.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 54.0, 55.0, 55.0, 55.0, 55.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 74.0, 75.0, 73.0, 69.0, 70.0, 72.0, 70.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 103.0, 108.0, 88.0, 93.0, 91.0, 88.0, 84.0, 87.0, 88.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 144.0, 149.0, 150.0, 154.0, 161.0, 145.0, 200.0, 150.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 174.0, 172.0, 173.0, 175.0, 172.0, 175.0, 174.0, 228.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 69.0, 70.0, 67.0, 67.0, 67.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1468.6999999999998, "alertThreshold": 2.0}]} 08:46:05 INFO - Return code: 0 08:46:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:46:05 INFO - # TBPL SUCCESS # 08:46:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:05 INFO - 2016-12-03 08:46:05.335 screenresolution[1656:10486] starting screenresolution argv=screenresolution get 08:46:05 INFO - 2016-12-03 08:46:05.338 screenresolution[1656:10486] Display 0: 1600x1200x32@60 08:46:05 INFO - 2016-12-03 08:46:05.344 screenresolution[1657:10489] starting screenresolution argv=screenresolution list 08:46:05 INFO - Available Modes on Display 0 08:46:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:05 INFO - Intel Iris: 08:46:05 INFO - Chipset Model: Intel Iris 08:46:05 INFO - Type: GPU 08:46:05 INFO - Bus: Built-In 08:46:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:05 INFO - Vendor: Intel (0x8086) 08:46:05 INFO - Device ID: 0x0a2e 08:46:05 INFO - Revision ID: 0x0009 08:46:05 INFO - Displays: 08:46:05 INFO - Display: 08:46:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:05 INFO - Display Serial Number: 1600x1200 60 08:46:05 INFO - Main Display: Yes 08:46:05 INFO - Mirror: Off 08:46:05 INFO - Online: Yes 08:46:05 INFO - Rotation: Supported 08:46:05 INFO - Return code: 0 08:46:05 INFO - Running post-action listener: _resource_record_post_action 08:46:05 INFO - [mozharness: 2016-12-03 16:46:05.588567Z] Finished run-tests step (success) 08:46:05 INFO - Running post-run listener: _resource_record_post_run 08:46:05 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 32304128; Write bytes: 695403520; Read time: 197; Write time: 1944 08:46:05 INFO - TinderboxPrint: CPU usage
53.8% 08:46:05 INFO - TinderboxPrint: I/O read bytes / time
32,304,128 / 197 08:46:05 INFO - TinderboxPrint: I/O write bytes / time
695,403,520 / 1,944 08:46:05 INFO - TinderboxPrint: CPU idle
2,244.6 (46.2%) 08:46:05 INFO - TinderboxPrint: CPU system
974.4 (20.1%) 08:46:05 INFO - TinderboxPrint: CPU user
1,638.6 (33.7%) 08:46:05 INFO - TinderboxPrint: Swap in / out
411,688,960 / 0 08:46:05 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384760320; Write bytes: 381556736; Read time: 28668; Write time: 775 08:46:05 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29092864; Write bytes: 306658304; Read time: 172; Write time: 1141 08:46:06 INFO - Running post-run listener: _upload_blobber_files 08:46:06 INFO - Blob upload gear active. 08:46:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:46:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:46:06 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:46:06 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:46:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:07 INFO - (blobuploader) - INFO - Done attempting. 08:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:08 INFO - (blobuploader) - INFO - Done attempting. 08:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:10 INFO - (blobuploader) - INFO - Done attempting. 08:46:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:46:10 INFO - Return code: 0 08:46:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:46:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:46:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb895b676c47188d591a2934948b025add7feea48f6e7d06c9799d67271ebd183019c87ee145af74e61d4746726e86aa3f9cb672d38ecedb562da3268d81c04c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18eb94f2e16c8ca104f4fd933b82fb5e95979cca665a27212d6f5d8959c66471050ab1c11e6f10f1379849ddd11676a50ea5f6ff9704ee203888941c145f5ed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f7bf6f2dc1ed0325c1e5ab421ad530d6bc9372445b008f4fc8afe55fa9ce89c18e2d6991a7cad3d86b719dadced8e7a265393297da53e2265b45aee324d5b6"} 08:46:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:46:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:46:10 INFO - Contents: 08:46:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb895b676c47188d591a2934948b025add7feea48f6e7d06c9799d67271ebd183019c87ee145af74e61d4746726e86aa3f9cb672d38ecedb562da3268d81c04c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18eb94f2e16c8ca104f4fd933b82fb5e95979cca665a27212d6f5d8959c66471050ab1c11e6f10f1379849ddd11676a50ea5f6ff9704ee203888941c145f5ed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f7bf6f2dc1ed0325c1e5ab421ad530d6bc9372445b008f4fc8afe55fa9ce89c18e2d6991a7cad3d86b719dadced8e7a265393297da53e2265b45aee324d5b6"} 08:46:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:46:10 INFO - Copying logs to upload dir... 08:46:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:46:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.891488 ========= master_lag: 1.78 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-03 08:46:12.291718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 08:46:12.294748) ========= 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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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/Firefox/sha512/fb895b676c47188d591a2934948b025add7feea48f6e7d06c9799d67271ebd183019c87ee145af74e61d4746726e86aa3f9cb672d38ecedb562da3268d81c04c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18eb94f2e16c8ca104f4fd933b82fb5e95979cca665a27212d6f5d8959c66471050ab1c11e6f10f1379849ddd11676a50ea5f6ff9704ee203888941c145f5ed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f7bf6f2dc1ed0325c1e5ab421ad530d6bc9372445b008f4fc8afe55fa9ce89c18e2d6991a7cad3d86b719dadced8e7a265393297da53e2265b45aee324d5b6"} build_url:https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/ET9juMEgTz2WW3aJbA-ECQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb895b676c47188d591a2934948b025add7feea48f6e7d06c9799d67271ebd183019c87ee145af74e61d4746726e86aa3f9cb672d38ecedb562da3268d81c04c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18eb94f2e16c8ca104f4fd933b82fb5e95979cca665a27212d6f5d8959c66471050ab1c11e6f10f1379849ddd11676a50ea5f6ff9704ee203888941c145f5ed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f7bf6f2dc1ed0325c1e5ab421ad530d6bc9372445b008f4fc8afe55fa9ce89c18e2d6991a7cad3d86b719dadced8e7a265393297da53e2265b45aee324d5b6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 08:46:12.336875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:46:12.337617) ========= 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.9iIq1tXLmC/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.g4UMkOzAjo/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.005061 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:46:12.392604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 08:46:12.393308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 08:46:12.393667) ========= ========= Total master_lag: 2.09 =========