builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0207 starttime: 1485253323.62 results: success (0) buildid: 20170124004008 builduid: c44803023a9c4e27974bc29c7137d476 revision: 4b053b4106a9b99268312c5fcf8ac1048cc80430 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:03.619466) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:03.620004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:03.620285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:03.762385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:03.762677) ========= 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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 02:22:03-- 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% 190M=0s 2017-01-24 02:22:04 (190 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.692730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:04.478552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:04.478977) ========= 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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.025745 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:04.527751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-24 02:22:04.528122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b053b4106a9b99268312c5fcf8ac1048cc80430 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b053b4106a9b99268312c5fcf8ac1048cc80430 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N7XVVuKG8u/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.jcy8Nzks7p/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 02:22:04,726 truncating revision to first 12 chars 2017-01-24 02:22:04,726 Setting DEBUG logging. 2017-01-24 02:22:04,726 attempt 1/10 2017-01-24 02:22:04,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b053b4106a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 02:22:07,511 unpacking tar archive at: mozilla-aurora-4b053b4106a9/testing/mozharness/ program finished with exit code 0 elapsedTime=3.062942 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-24 02:22:07.616450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:07.616776) ========= script_repo_revision: 4b053b4106a9b99268312c5fcf8ac1048cc80430 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:07.617242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:07.617736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 02:22:07.638543) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 02:22:07.639133) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N7XVVuKG8u/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.jcy8Nzks7p/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:22:07 INFO - MultiFileLogger online at 20170124 02:22:07 in /builds/slave/test 02:22:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:22:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:07 INFO - {'append_to_log': False, 02:22:07 INFO - 'base_work_dir': '/builds/slave/test', 02:22:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:22:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:07 INFO - 'branch': 'Mozilla-Aurora', 02:22:07 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:07 INFO - 'config_files': ('talos/mac_config.py',), 02:22:07 INFO - 'default_actions': ('clobber', 02:22:07 INFO - 'read-buildbot-config', 02:22:07 INFO - 'download-and-extract', 02:22:07 INFO - 'populate-webroot', 02:22:07 INFO - 'create-virtualenv', 02:22:07 INFO - 'install', 02:22:07 INFO - 'run-tests'), 02:22:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:07 INFO - 'download_minidump_stackwalk': True, 02:22:07 INFO - 'download_symbols': 'ondemand', 02:22:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:07 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:07 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:07 INFO - 'installer_path': 'installer.exe', 02:22:07 INFO - 'log_level': 'info', 02:22:07 INFO - 'log_name': 'talos', 02:22:07 INFO - 'log_to_console': True, 02:22:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:22:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:22:07 INFO - 'opt_config_files': (), 02:22:07 INFO - 'pip_index': False, 02:22:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:22:07 INFO - 'cmd': ('bash', 02:22:07 INFO - '-c', 02:22:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:22:07 INFO - 'enabled': True, 02:22:07 INFO - 'halt_on_failure': False, 02:22:07 INFO - 'name': 'check_screen_resolution'},), 02:22:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:22:07 INFO - 'cmd': ('bash', 02:22:07 INFO - '-c', 02:22:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:22:07 INFO - 'enabled': True, 02:22:07 INFO - 'halt_on_failure': False, 02:22:07 INFO - 'name': 'check_screen_resolution'},), 02:22:07 INFO - 'run_cmd_checks_enabled': True, 02:22:07 INFO - 'sps_profile': False, 02:22:07 INFO - 'sps_profile_interval': 0, 02:22:07 INFO - 'suite': 'dromaeojs', 02:22:07 INFO - 'system_bits': '32', 02:22:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:07 INFO - 'title': 't-yosemite-r7-0207', 02:22:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:07 INFO - 'use_talos_json': True, 02:22:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:07 INFO - 'work_dir': 'build'} 02:22:07 INFO - [mozharness: 2017-01-24 10:22:07.948062Z] Running clobber step. 02:22:07 INFO - Running pre-action listener: _resource_record_pre_action 02:22:07 INFO - Running main action method: clobber 02:22:07 INFO - rmtree: /builds/slave/test/build 02:22:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:10 INFO - Running post-action listener: _resource_record_post_action 02:22:10 INFO - [mozharness: 2017-01-24 10:22:10.327161Z] Finished clobber step (success) 02:22:10 INFO - [mozharness: 2017-01-24 10:22:10.327290Z] Running read-buildbot-config step. 02:22:10 INFO - Running pre-action listener: _resource_record_pre_action 02:22:10 INFO - Running main action method: read_buildbot_config 02:22:10 INFO - Using buildbot properties: 02:22:10 INFO - { 02:22:10 INFO - "project": "", 02:22:10 INFO - "product": "firefox", 02:22:10 INFO - "script_repo_revision": "production", 02:22:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:22:10 INFO - "repository": "", 02:22:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:22:10 INFO - "buildid": "20170124004008", 02:22:10 INFO - "stage_platform": "macosx64", 02:22:10 INFO - "basedir": "/builds/slave/test", 02:22:10 INFO - "nightly_build": "True", 02:22:10 INFO - "buildnumber": 46, 02:22:10 INFO - "slavename": "t-yosemite-r7-0207", 02:22:10 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:22:10 INFO - "platform": "yosemite_r7", 02:22:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:22:10 INFO - "branch": "mozilla-aurora", 02:22:10 INFO - "repo_path": "releases/mozilla-aurora", 02:22:10 INFO - "revision": "4b053b4106a9b99268312c5fcf8ac1048cc80430", 02:22:10 INFO - "pgo_build": "False", 02:22:10 INFO - "builduid": "c44803023a9c4e27974bc29c7137d476", 02:22:10 INFO - "slavebuilddir": "test" 02:22:10 INFO - } 02:22:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:22:10 INFO - Running post-action listener: _resource_record_post_action 02:22:10 INFO - [mozharness: 2017-01-24 10:22:10.330785Z] Finished read-buildbot-config step (success) 02:22:10 INFO - [mozharness: 2017-01-24 10:22:10.330915Z] Running download-and-extract step. 02:22:10 INFO - Running pre-action listener: _resource_record_pre_action 02:22:10 INFO - Running main action method: download_and_extract 02:22:10 INFO - mkdir: /builds/slave/test/build/tests 02:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:10 INFO - trying https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:22:10 INFO - Downloading https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:22:12 INFO - Downloaded 1199 bytes. 02:22:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:22:12 INFO - Using the following test package requirements: 02:22:12 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:22:12 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:22:12 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:22:12 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'jsshell-mac.zip'], 02:22:12 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:22:12 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:22:12 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:22:12 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:22:12 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:22:12 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:22:12 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:22:12 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:22:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:22:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:22:12 INFO - Fetch https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:22:13 INFO - Expected file size: 16349577 02:22:13 INFO - Obtained file size: 16349577 02:22:20 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:22:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:22:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:22:20 INFO - Fetch https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:22:21 INFO - Expected file size: 16349577 02:22:21 INFO - Obtained file size: 16349577 02:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:22:29 INFO - Expected file size: 14403485 02:22:29 INFO - Obtained file size: 14403485 02:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:29 INFO - trying https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:22:32 INFO - Downloaded 73915647 bytes. 02:22:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:22:32 INFO - mkdir: /builds/slave/test/properties 02:22:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:32 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:32 INFO - Contents: 02:22:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:22:32 INFO - Running post-action listener: _resource_record_post_action 02:22:32 INFO - Running post-action listener: set_extra_try_arguments 02:22:32 INFO - [mozharness: 2017-01-24 10:22:32.790853Z] Finished download-and-extract step (success) 02:22:32 INFO - [mozharness: 2017-01-24 10:22:32.790990Z] Running populate-webroot step. 02:22:32 INFO - Running pre-action listener: _resource_record_pre_action 02:22:32 INFO - Running main action method: populate_webroot 02:22:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:32 INFO - '--tppagecycles', 02:22:32 INFO - '7'], 02:22:32 INFO - 'tests': ['tsvgm']}}, 02:22:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['damp', 'tps']}, 02:22:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'tests': ['damp', 'tps']}, 02:22:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['dromaeo_dom']}, 02:22:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['basic_compositor_video']}, 02:22:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:22:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['a11yr', 02:22:32 INFO - 'ts_paint', 02:22:32 INFO - 'tpaint', 02:22:32 INFO - 'sessionrestore', 02:22:32 INFO - 'sessionrestore_no_auto_restore', 02:22:32 INFO - 'tabpaint']}, 02:22:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tsvgx', 02:22:32 INFO - 'tsvgr_opacity', 02:22:32 INFO - 'tart', 02:22:32 INFO - 'tscrollx', 02:22:32 INFO - 'cart', 02:22:32 INFO - 'tsvg_static']}, 02:22:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:32 INFO - 'tsvgr_opacity', 02:22:32 INFO - 'tart', 02:22:32 INFO - 'tscrollx', 02:22:32 INFO - 'cart', 02:22:32 INFO - 'tsvg_static']}, 02:22:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s'], 02:22:32 INFO - 'tests': ['tp5o']}, 02:22:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:22:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'talos_options': ['--disable-e10s', 02:22:32 INFO - '--xperf_path', 02:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:32 INFO - 'tests': ['tp5n']}, 02:22:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:22:32 INFO - 'talos_options': ['--xperf_path', 02:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:32 INFO - 'tests': ['tp5n']}}, 02:22:32 INFO - 'talos.zip': {'path': '', 02:22:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:32 INFO - Running post-action listener: _resource_record_post_action 02:22:32 INFO - [mozharness: 2017-01-24 10:22:32.809639Z] Finished populate-webroot step (success) 02:22:32 INFO - [mozharness: 2017-01-24 10:22:32.809767Z] Running create-virtualenv step. 02:22:32 INFO - Running pre-action listener: _resource_record_pre_action 02:22:32 INFO - Running main action method: create_virtualenv 02:22:32 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:22:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:32 INFO - Using real prefix '/tools/python27' 02:22:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:33 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:36 INFO - Installing pip.................done. 02:22:36 INFO - Return code: 0 02:22:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:22:36 INFO - Reading from file tmpfile_stdout 02:22:36 INFO - Output received: 02:22:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:22:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:36 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:22:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:36 INFO - 'HOME': '/Users/cltbld', 02:22:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:36 INFO - 'LOGNAME': 'cltbld', 02:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:36 INFO - 'MOZ_NO_REMOTE': '1', 02:22:36 INFO - 'NO_EM_RESTART': '1', 02:22:36 INFO - 'PAGER': '/bin/cat', 02:22:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:36 INFO - 'PWD': '/builds/slave/test', 02:22:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:36 INFO - 'SHELL': '/bin/bash', 02:22:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:36 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:36 INFO - 'USER': 'cltbld', 02:22:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:36 INFO - 'XPC_FLAGS': '0x0', 02:22:36 INFO - 'XPC_SERVICE_NAME': '0', 02:22:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:22:37 INFO - Cleaning up... 02:22:37 INFO - Return code: 0 02:22:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:22:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:37 INFO - 'HOME': '/Users/cltbld', 02:22:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:37 INFO - 'LOGNAME': 'cltbld', 02:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:37 INFO - 'MOZ_NO_REMOTE': '1', 02:22:37 INFO - 'NO_EM_RESTART': '1', 02:22:37 INFO - 'PAGER': '/bin/cat', 02:22:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:37 INFO - 'PWD': '/builds/slave/test', 02:22:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:37 INFO - 'SHELL': '/bin/bash', 02:22:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:37 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:37 INFO - 'USER': 'cltbld', 02:22:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:37 INFO - 'XPC_FLAGS': '0x0', 02:22:37 INFO - 'XPC_SERVICE_NAME': '0', 02:22:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:37 INFO - Downloading/unpacking psutil>=3.1.1 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:41 INFO - Installing collected packages: psutil 02:22:41 INFO - Running setup.py install for psutil 02:22:41 INFO - building 'psutil._psutil_osx' extension 02:22:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:22:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:22:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:22:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:22:41 INFO - building 'psutil._psutil_posix' extension 02:22:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:22:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:22:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:22:42 INFO - ^ 02:22:42 INFO - 1 warning generated. 02:22:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:22:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:42 INFO - Successfully installed psutil 02:22:42 INFO - Cleaning up... 02:22:42 INFO - Return code: 0 02:22:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:42 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:42 INFO - 'HOME': '/Users/cltbld', 02:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:42 INFO - 'LOGNAME': 'cltbld', 02:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:42 INFO - 'MOZ_NO_REMOTE': '1', 02:22:42 INFO - 'NO_EM_RESTART': '1', 02:22:42 INFO - 'PAGER': '/bin/cat', 02:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:42 INFO - 'PWD': '/builds/slave/test', 02:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:42 INFO - 'SHELL': '/bin/bash', 02:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:42 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:42 INFO - 'USER': 'cltbld', 02:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:42 INFO - 'XPC_FLAGS': '0x0', 02:22:42 INFO - 'XPC_SERVICE_NAME': '0', 02:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:45 INFO - Installing collected packages: mozsystemmonitor 02:22:45 INFO - Running setup.py install for mozsystemmonitor 02:22:45 INFO - Successfully installed mozsystemmonitor 02:22:45 INFO - Cleaning up... 02:22:45 INFO - Return code: 0 02:22:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:22:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:45 INFO - 'HOME': '/Users/cltbld', 02:22:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:45 INFO - 'LOGNAME': 'cltbld', 02:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:45 INFO - 'MOZ_NO_REMOTE': '1', 02:22:45 INFO - 'NO_EM_RESTART': '1', 02:22:45 INFO - 'PAGER': '/bin/cat', 02:22:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:45 INFO - 'PWD': '/builds/slave/test', 02:22:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:45 INFO - 'SHELL': '/bin/bash', 02:22:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:45 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:45 INFO - 'USER': 'cltbld', 02:22:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:45 INFO - 'XPC_FLAGS': '0x0', 02:22:45 INFO - 'XPC_SERVICE_NAME': '0', 02:22:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:45 INFO - Downloading/unpacking jsonschema==2.5.1 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:48 INFO - warning: no files found matching '*.txt' 02:22:48 INFO - no previously-included directories found matching 'build' 02:22:48 INFO - no previously-included directories found matching 'dist' 02:22:48 INFO - no previously-included directories found matching '.git*' 02:22:48 INFO - Installing collected packages: jsonschema, functools32 02:22:49 INFO - Running setup.py install for functools32 02:22:49 INFO - warning: no files found matching '*.txt' 02:22:49 INFO - no previously-included directories found matching 'build' 02:22:49 INFO - no previously-included directories found matching 'dist' 02:22:49 INFO - no previously-included directories found matching '.git*' 02:22:49 INFO - Successfully installed jsonschema functools32 02:22:49 INFO - Cleaning up... 02:22:49 INFO - Return code: 0 02:22:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:49 INFO - 'HOME': '/Users/cltbld', 02:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:49 INFO - 'LOGNAME': 'cltbld', 02:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:49 INFO - 'MOZ_NO_REMOTE': '1', 02:22:49 INFO - 'NO_EM_RESTART': '1', 02:22:49 INFO - 'PAGER': '/bin/cat', 02:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:49 INFO - 'PWD': '/builds/slave/test', 02:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:49 INFO - 'SHELL': '/bin/bash', 02:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:49 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:49 INFO - 'USER': 'cltbld', 02:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:49 INFO - 'XPC_FLAGS': '0x0', 02:22:49 INFO - 'XPC_SERVICE_NAME': '0', 02:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:22:49 INFO - Cleaning up... 02:22:49 INFO - Return code: 0 02:22:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:49 INFO - 'HOME': '/Users/cltbld', 02:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:49 INFO - 'LOGNAME': 'cltbld', 02:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:49 INFO - 'MOZ_NO_REMOTE': '1', 02:22:49 INFO - 'NO_EM_RESTART': '1', 02:22:49 INFO - 'PAGER': '/bin/cat', 02:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:49 INFO - 'PWD': '/builds/slave/test', 02:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:49 INFO - 'SHELL': '/bin/bash', 02:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:49 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:49 INFO - 'USER': 'cltbld', 02:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:49 INFO - 'XPC_FLAGS': '0x0', 02:22:49 INFO - 'XPC_SERVICE_NAME': '0', 02:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:53 INFO - Downloading docopt-0.6.1.tar.gz 02:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:53 INFO - Running setup.py install for blobuploader 02:22:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:53 INFO - Running setup.py install for requests 02:22:54 INFO - Running setup.py install for docopt 02:22:54 INFO - Successfully installed blobuploader requests docopt 02:22:54 INFO - Cleaning up... 02:22:54 INFO - Return code: 0 02:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:55 INFO - 'HOME': '/Users/cltbld', 02:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:55 INFO - 'LOGNAME': 'cltbld', 02:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:55 INFO - 'MOZ_NO_REMOTE': '1', 02:22:55 INFO - 'NO_EM_RESTART': '1', 02:22:55 INFO - 'PAGER': '/bin/cat', 02:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:55 INFO - 'PWD': '/builds/slave/test', 02:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:55 INFO - 'SHELL': '/bin/bash', 02:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:22:55 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:55 INFO - 'USER': 'cltbld', 02:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:55 INFO - 'XPC_FLAGS': '0x0', 02:22:55 INFO - 'XPC_SERVICE_NAME': '0', 02:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-rmPzrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-N7_42P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-qhKqVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-9xXpo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-5jDhVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-jiJwLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-NRjzN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-o8fni4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-QMiFjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-EcRxs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-RJYoZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-dfJD9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-i_snHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-cgVjMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-g5nj94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-pq4R6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-VWlEYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:57 INFO - Running setup.py install for manifestparser 02:22:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for mozcrash 02:22:57 INFO - Running setup.py install for mozdebug 02:22:57 INFO - Running setup.py install for mozdevice 02:22:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for mozfile 02:22:58 INFO - Running setup.py install for mozhttpd 02:22:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for mozinfo 02:22:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for mozInstall 02:22:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for mozleak 02:22:58 INFO - Running setup.py install for mozlog 02:22:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for moznetwork 02:22:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:59 INFO - Running setup.py install for mozprocess 02:22:59 INFO - Running setup.py install for mozprofile 02:22:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:59 INFO - Running setup.py install for mozrunner 02:22:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:59 INFO - Running setup.py install for mozscreenshot 02:22:59 INFO - Running setup.py install for moztest 02:22:59 INFO - Running setup.py install for mozversion 02:22:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:23:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:00 INFO - Cleaning up... 02:23:00 INFO - Return code: 0 02:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:00 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:00 INFO - 'HOME': '/Users/cltbld', 02:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:00 INFO - 'LOGNAME': 'cltbld', 02:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:00 INFO - 'MOZ_NO_REMOTE': '1', 02:23:00 INFO - 'NO_EM_RESTART': '1', 02:23:00 INFO - 'PAGER': '/bin/cat', 02:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:00 INFO - 'PWD': '/builds/slave/test', 02:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:00 INFO - 'SHELL': '/bin/bash', 02:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:23:00 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:00 INFO - 'USER': 'cltbld', 02:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:00 INFO - 'XPC_FLAGS': '0x0', 02:23:00 INFO - 'XPC_SERVICE_NAME': '0', 02:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:00 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-_6zDyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:00 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-f8MNnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:00 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-m6SjYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-RfzkK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-dxUwHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-qgmAiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-do51Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-_WPoSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-ocPuDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-P1TXe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-GXmHx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-TEfquK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:01 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-rPRhHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:02 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-NGSACX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:02 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-n2LDoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:02 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-uIffYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:02 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-qu2b5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:23:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:05 INFO - Downloading blessings-1.6.tar.gz 02:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:05 INFO - Installing collected packages: blessings 02:23:05 INFO - Running setup.py install for blessings 02:23:05 INFO - Successfully installed blessings 02:23:05 INFO - Cleaning up... 02:23:05 INFO - Return code: 0 02:23:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:06 INFO - Reading from file tmpfile_stdout 02:23:06 INFO - Current package versions: 02:23:06 INFO - blessings == 1.6 02:23:06 INFO - blobuploader == 1.2.4 02:23:06 INFO - docopt == 0.6.1 02:23:06 INFO - functools32 == 3.2.3-2 02:23:06 INFO - jsonschema == 2.5.1 02:23:06 INFO - manifestparser == 1.1 02:23:06 INFO - mozInstall == 1.12 02:23:06 INFO - mozcrash == 1.0 02:23:06 INFO - mozdebug == 0.1 02:23:06 INFO - mozdevice == 0.49 02:23:06 INFO - mozfile == 1.2 02:23:06 INFO - mozhttpd == 0.7 02:23:06 INFO - mozinfo == 0.9 02:23:06 INFO - mozleak == 0.1 02:23:06 INFO - mozlog == 3.4 02:23:06 INFO - moznetwork == 0.27 02:23:06 INFO - mozprocess == 0.24 02:23:06 INFO - mozprofile == 0.28 02:23:06 INFO - mozrunner == 6.13 02:23:06 INFO - mozscreenshot == 0.1 02:23:06 INFO - mozsystemmonitor == 0.3 02:23:06 INFO - moztest == 0.8 02:23:06 INFO - mozversion == 1.4 02:23:06 INFO - psutil == 3.1.1 02:23:06 INFO - requests == 1.2.3 02:23:06 INFO - wsgiref == 0.1.2 02:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:06 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 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:06 INFO - 'HOME': '/Users/cltbld', 02:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:06 INFO - 'LOGNAME': 'cltbld', 02:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:06 INFO - 'MOZ_NO_REMOTE': '1', 02:23:06 INFO - 'NO_EM_RESTART': '1', 02:23:06 INFO - 'PAGER': '/bin/cat', 02:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:06 INFO - 'PWD': '/builds/slave/test', 02:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:06 INFO - 'SHELL': '/bin/bash', 02:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:23:06 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:06 INFO - 'USER': 'cltbld', 02:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:06 INFO - 'XPC_FLAGS': '0x0', 02:23:06 INFO - 'XPC_SERVICE_NAME': '0', 02:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:23:06 INFO - Cleaning up... 02:23:06 INFO - Return code: 0 02:23:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7a0c5c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, '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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:06 INFO - 'HOME': '/Users/cltbld', 02:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:06 INFO - 'LOGNAME': 'cltbld', 02:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:06 INFO - 'MOZ_NO_REMOTE': '1', 02:23:06 INFO - 'NO_EM_RESTART': '1', 02:23:06 INFO - 'PAGER': '/bin/cat', 02:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:06 INFO - 'PWD': '/builds/slave/test', 02:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:06 INFO - 'SHELL': '/bin/bash', 02:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:23:06 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:06 INFO - 'USER': 'cltbld', 02:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:06 INFO - 'XPC_FLAGS': '0x0', 02:23:06 INFO - 'XPC_SERVICE_NAME': '0', 02:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:23:06 INFO - Cleaning up... 02:23:06 INFO - Return code: 0 02:23:06 INFO - Running post-action listener: _resource_record_post_action 02:23:06 INFO - Running post-action listener: _start_resource_monitoring 02:23:06 INFO - Starting resource monitoring. 02:23:06 INFO - [mozharness: 2017-01-24 10:23:06.682180Z] Finished create-virtualenv step (success) 02:23:06 INFO - [mozharness: 2017-01-24 10:23:06.683145Z] Running install step. 02:23:06 INFO - Running pre-action listener: _resource_record_pre_action 02:23:06 INFO - Running main action method: install 02:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:06 INFO - Reading from file tmpfile_stdout 02:23:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:07 INFO - Reading from file tmpfile_stdout 02:23:07 INFO - Output received: 02:23:07 INFO - Usage: mozinstall [options] installer 02:23:07 INFO - Options: 02:23:07 INFO - -h, --help show this help message and exit 02:23:07 INFO - -d DEST, --destination=DEST 02:23:07 INFO - Directory to install application into. [default: 02:23:07 INFO - "/builds/slave/test"] 02:23:07 INFO - --app=APP Application being installed. [default: firefox] 02:23:07 INFO - mkdir: /builds/slave/test/build/application 02:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:23:27 INFO - Reading from file tmpfile_stdout 02:23:27 INFO - Output received: 02:23:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:23:27 INFO - Running post-action listener: _resource_record_post_action 02:23:27 INFO - [mozharness: 2017-01-24 10:23:27.003731Z] Finished install step (success) 02:23:27 INFO - [mozharness: 2017-01-24 10:23:27.003899Z] Running run-tests step. 02:23:27 INFO - Running pre-action listener: _resource_record_pre_action 02:23:27 INFO - Running main action method: run_tests 02:23:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:23:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:23:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:23:27 INFO - 2017-01-24 02:23:27.018 screenresolution[1623:7406] starting screenresolution argv=screenresolution get 02:23:27 INFO - 2017-01-24 02:23:27.021 screenresolution[1623:7406] Display 0: 1600x1200x32@60 02:23:27 INFO - 2017-01-24 02:23:27.027 screenresolution[1624:7409] starting screenresolution argv=screenresolution list 02:23:27 INFO - Available Modes on Display 0 02:23:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:23:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:23:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:23:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:23:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:23:27 INFO - Intel Iris: 02:23:27 INFO - Chipset Model: Intel Iris 02:23:27 INFO - Type: GPU 02:23:27 INFO - Bus: Built-In 02:23:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:23:27 INFO - Vendor: Intel (0x8086) 02:23:27 INFO - Device ID: 0x0a2e 02:23:27 INFO - Revision ID: 0x0009 02:23:27 INFO - Displays: 02:23:27 INFO - Display: 02:23:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:23:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:23:27 INFO - Display Serial Number: 1600x1200 60 02:23:27 INFO - Main Display: Yes 02:23:27 INFO - Mirror: Off 02:23:27 INFO - Online: Yes 02:23:27 INFO - Rotation: Supported 02:23:27 INFO - Return code: 0 02:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:27 INFO - Python 2.7.3 02:23:27 INFO - Return code: 0 02:23:27 INFO - grabbing minidump binary from tooltool 02:23: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')]} 02:23:27 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 0x10c6c8d30>, '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 0x10c5efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:23:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:23:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:23:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:27 INFO - Return code: 0 02:23:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:23:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:23:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7XVVuKG8u/Render', 02:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:27 INFO - 'HOME': '/Users/cltbld', 02:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:27 INFO - 'LOGNAME': 'cltbld', 02:23:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:27 INFO - 'MOZ_NO_REMOTE': '1', 02:23:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:27 INFO - 'NO_EM_RESTART': '1', 02:23:27 INFO - 'PAGER': '/bin/cat', 02:23:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:27 INFO - 'PWD': '/builds/slave/test', 02:23:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:27 INFO - 'SHELL': '/bin/bash', 02:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jcy8Nzks7p/Listeners', 02:23:27 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 02:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:27 INFO - 'USER': 'cltbld', 02:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:27 INFO - 'XPC_FLAGS': '0x0', 02:23:27 INFO - 'XPC_SERVICE_NAME': '0', 02:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:23:27 INFO - mozversion application_buildid: 20170124004008 02:23:27 INFO - mozversion application_changeset: 4b053b4106a9b99268312c5fcf8ac1048cc80430 02:23:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:23:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:27 INFO - mozversion application_name: Firefox 02:23:27 INFO - mozversion application_remotingname: firefox-dev 02:23:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:23:27 INFO - mozversion application_vendor: Mozilla 02:23:27 INFO - mozversion application_version: 53.0a2 02:23:27 INFO - mozversion platform_buildid: 20170124004008 02:23:27 INFO - mozversion platform_changeset: 4b053b4106a9b99268312c5fcf8ac1048cc80430 02:23:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:23:27 INFO - mozversion platform_version: 53.0a2 02:23:27 INFO - using testdate: 1485253407 02:23:27 INFO - actual date: 1485253407 02:23:27 INFO - starting webserver on 'localhost:49242' 02:23:27 INFO - SUITE-START | Running 2 tests 02:23:27 INFO - TEST-START | dromaeo_css 02:23:27 INFO - operating with platform_type : mac_ 02:23:27 INFO - Initialising browser for dromaeo_css test... 02:23:27 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpcHbZar/profile http://localhost:49242/getInfo.html) 02:23:30 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 02:23:30 INFO - PROCESS | 1634 | colorDepth:24 02:23:30 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 02:23:30 INFO - PROCESS | 1634 | __metrics 02:23:30 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 02:23:30 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:23:30 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:31 INFO - TEST-INFO | 1634: exit 0 02:23:31 INFO - Browser initialized. 02:23:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:31 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpcHbZar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:43 INFO - PROCESS | 1637 | RSS: Main: 212914176 02:23:43 INFO - PROCESS | 1637 | 02:26:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 02:26:47 INFO - PROCESS | 1637 | RSS: Main: 345128960 02:26:47 INFO - PROCESS | 1637 | 02:28:32 INFO - PROCESS | 1637 | ************************* 02:28:32 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 02:28:32 INFO - PROCESS | 1637 | 02:28:32 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:28:32 INFO - PROCESS | 1637 | Full stack: 02:28:32 INFO - PROCESS | 1637 | ************************* 02:29:50 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 02:29:51 INFO - PROCESS | 1637 | RSS: Main: 346918912 02:29:51 INFO - PROCESS | 1637 | 02:32:53 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 02:32:54 INFO - PROCESS | 1637 | RSS: Main: 320286720 02:32:54 INFO - PROCESS | 1637 | 02:35:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 02:35:57 INFO - PROCESS | 1637 | RSS: Main: 346824704 02:35:57 INFO - PROCESS | 1637 | 02:39:00 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 02:39:00 INFO - PROCESS | 1637 | RSS: Main: 310910976 02:39:00 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 02:42:04 INFO - PROCESS | 1637 | RSS: Main: 363614208 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | __start_tp_report 02:42:04 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 02:42:04 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 02:42:04 INFO - PROCESS | 1637 | |i|pagename|runs| 02:42:04 INFO - PROCESS | 1637 | |0;dojo.html;2861.585070164826;3284.967150328496;3288.1943923738686;3290.4899740540195;3331.400347937372;5698.886022279552;5717.714114294289;5752.223449834271;5766.279215098113;5766.567507436943;5241.768184476645;5408.080626293529;5710.628809127404;5788.334341550723;5818.883622327551;5206.661566998152;5207.401148867872;5230.790768369261;5255.894882102356;5301.390340110879;5130.56390206831;5130.640855140142;5144.254083157958;5297.020051290504;5309.203619457093;5190.896182076356;5202.687838729669;5258.710770907599;5269.8946021079555;5274.81538146165;5242.501962313574;5282.894342113174;5293.920591191135;5306.071437498442;5317.680939143625;5133.178691409394;5198.298229738974;5206.193040078794;5242.659227150223;5260.421353651095;5594.944050559483;5615.859603509904;5630.521405680522;5657.23627310312;5657.66054036755;6153.984592542225;6203.379662033805;6233.0338797486465;6240.781572644935;6250.281217659936;5493.945060549423;6198.318184999646;6203.131561581382;6219.942609756352;6220.222472190976;4924.704517728947;5716.5998380113;5809.302883653989;5810.041343178328;5935.910961335583;6162.22972128484;6195.380461953859;6195.752169913153;6278.6860656966965;6281.214848143982;6217.129601855744;6225.501959843202;6234.625922444668;6238.1266622672865;6246.156768836149;6163.445289923929;6174;6191.597546159485;6246.3441338659695;6253.6560489172625;5415.972920135374;6027.517798576104;6174.753009879554;6207.6275423473835;6232.3144454110015;6239.781607643801;6328;6328.968355158195;6331.113644089831;6336.936630633634;4283.250431174532;4919.532644398776;5031.723255220924;5033.974830125826;5050.191969284897;4421.513633500313;4423.314386270134;4491.685582009293;4494.303382975644;4519.344695019204;5665.49010589049;5762.942370576325;5797.855053623609;5797.942020579824;5812.738426770806;6168.383161683796;6174.475169610633;6197.380261973857;6337.809865704036;6363;5653.208550802891;5663.773449061991;5710.971445142748;5715.799947001835;5748.741306641211;5466;5489.039418101896;5491.0116179088145;5512.062949298629;5512.448755124536;6199.5040396767245;6226.782062627786;6252.906206406817;6264.060390941395;6333.334999825044;6353.7140828661895;6356.396142366468;6372.840678983062;6375.979843225062;6387.489000880011;6331.620102793847;6337.556371053982;6345.904811427925;6350.047492876106;6351.96824015877;4795.784189711401;6116.755329786936;6163.19878415821;6271.6550589718;6277.089821975879;4615.676902616919;5804.3432637438145;5965.821025369246;6262.3737626238835;6374.808755737336;6135.601185922901;6150.10823430609;6163.845903852261;6182.28903676083;6189.1954045975535;6036.185115009417;6061.939380606137;6190.50475961913;6194.101855231056;6201.255849298113;5972;5977.133315669291;6038.879222415615;6046.062860256668;6116.14373987651;6131.558495904967;6175;6178.196834411498;6182;6192.071189321638;5824.388439213822;6013.6692481913915;6041.9395806041375;6049.969750151221;6083.6349819011 02:42:04 INFO - PROCESS | 1637 | |1;ext.html;459.86184194119545;474.1086756897033;498.62603047714214;501.2556353814585;533.3280067115434;31416.214594635145;37020.99999999996;41773.373399398995;43050.138997220034;45278.86802829931;44621.55378446223;45159;45193.09613807722;45270.094598108015;45328.09343813122;8387.203215694499;8595.785105372353;9350.205232555223;9552.57013434397;9570;8596.097409771977;8672.219500244977;8687.087855775148;11192.272502287366;11481.483333249982;11373.886261137366;11376.431178441086;11420.942895285512;11440.256383335098;11462.14033947453;11401.771964560703;11494.540218391254;11501.654950351503;11502.654920352403;11511.654650360502;11366.318020918772;11458.598949036743;11475.311481311064;11479.655610331703;11481.88518114825;41913.79043104765;42158.78920605408;42309;42369.57630423687;42448.787756061334;3968.603139686037;3991.980040099781;4003.919921601552;4012.61880121388;4064.6748260139416;29015.839366425316;29794.255143621365;30236.127567881016;31221;32239;3000.7149320814488;3018.894338698157;3030.7878448508613;3126.1403114143563;3130.2956834712236;483881;485474;486873.5656321731;489246;490266.99999999645;63901;64165;64245.678771605846;64297.67851160714;64309.67845160838;67686.32313676899;67944;67964.32035679679;68005.3199467999;68082.65958670175;16527.83472165263;17033.91483042577;17061.48815535536;17073.829261707226;17076.2315695794;13222.338883056002;13282.601521954357;13300;13333.133346332652;13357.66605834862;15002.69994600102;15384.692306153815;15385.230738463031;16934.407295744837;17389.65220695579;5431.6740995540395;6256.124142620037;6398.840028999219;6426.4216220540375;6474.5791523550815;887.4453466583385;898.23201163006;908.2143945487238;909.5997760985146;927.4388994658135;29525.044851629285;30431.69568304333;30442.238944026576;30692.693073068982;31366;1009.9394036357695;1056.5404049238605;1074.4412905289205;1087.9020888120108;1231.4027696567157;12549;14187.645308867155;14645.48740794067;15038.04505414289;15076.698466030617;421157;423035;423554;423742;427429;57564.424355756746;57625;57762;57769.711151443975;57777.71111144417;1230.698478872682;1397.0779285671408;1433.4481224728347;1442.9639259018609;1443.4659176104908;21992.34022979313;23613.29160125199;27073.615798025246;28514.85742571274;28520.85916563314;46201.53798462107;46293.07413851772;46306.37927672515;46310.30534542052;46602;359729;360758;361258;361552;361643;24191.758082419656;24855.37861553403;24954.62568061517;25625.743742562336;37178.653921147226;37678.203686938046;37756;42798.35802463028;43757;44936.101277973605;31659;33851.83074084614;36244.27511449703;36475.45286820647;36554.45168322531;36184.81907590445;36432.45351319679;36488;37113;37163.25673486569;34723.4791478123;35310.823445882605;35516.11209719778;35767.821160894026;36081;30589.694103058686;32168.03495895127;32267;32294.515582265816;32346.191345216557;24079.638805417584;24290;24322.27033189007;24661.26016219516;24674.13640522573 02:42:04 INFO - PROCESS | 1637 | |2;jquery.html;394.8006256840295;395.54117224020126;397.9462772525712;403.63471058691886;421.57507624230095;14883.851161488408;20016.399508014765;20657.896710516427;21411.608245464035;21539.138434462642;16234.51296461108;18983.81016189838;21058.262960796375;21245.468863278387;21599.892000540014;5184.196449550307;5636.830895073144;5963.582549221556;5969.850753731148;5971.313298970609;5744.885102297952;5786.768529258825;5913.881722365551;5919;6010.8797824043495;6114.266288045441;6127.142200091991;6128.356522565134;6128.662923539204;6140.140380346755;6078.817635470921;6131.080337949321;6517.608943463384;6540.803775886731;6577.572457790228;5656.547476201894;5878.147668588073;5881.558883083786;5892.911606325909;5901.557383196235;13356.799648005288;13372.398242079129;13400.463981440731;13486.19082855022;13722.382492787849;2563.218218443374;2569.486102779452;2588.2364702412833;2628.3297759071506;2780.374415756459;9926.305158638897;10021.444740081755;10124.746881327952;10420.322679025914;10422.583096676124;1823.6990896502061;1835.330104511857;1836.9540761480937;1874.6344462829754;1890.3236028042984;121897.17154242694;127177;130540;130887.99999999905;132165;11850.407479626158;12001.819972700416;12007.279563226235;12017;12167.209131406607;15566.766498502531;15588.844111558967;15609.453669121527;15626.68746625061;15634.98372605777;7310.378617817545;7672;7675.385969122457;7782.143964163937;8383.245507904196;7373;7389.334959853639;7548.282913123245;8532.8720069199;8578.613962371708;4577.3362862384765;4608.216603177468;4674.789634466457;4794.4486384065585;4804.327394164819;1669.8580620647137;2002.779694233633;2006.1042315012464;2006.2175751456944;2012.9295474658609;1034.4362322534237;1042.280826229914;1049.6746008737316;1062.665260442958;1095.912327013837;17451.825481745273;18444.538886527946;20651.17395304201;21167.364979050653;21251.256206032715;1028.9742756431149;1045.6601604478424;1051.5951358726793;1078.5038882114316;1088.1566785740956;10935.398553079498;11136.164787640959;11206.943965280121;11209.21535492524;11223.71940701489;698048;704176;710196;713357;725605;115760;144000;145069;145428;156502;1016.3546148195949;1061.7451811565168;1076.2412499188054;1076.6662334676275;1078.6063086973197;18410.63178736391;19416.4175074748;19834.504137396103;19899.701504477733;19915.60168796645;56274;57551.84896301967;58124;58503;59907.700461497414;82222;83261.16738832534;84695;88182;90159.54920225356;5750.597458178055;7603.2776886195725;8148.3888708348295;8262.091169971418;8576.44253123545;7483.476156668981;11281.09751219884;12206.81689774672;12793.168444051107;12914.67713307175;11065.225434219527;11121.27711698737;11237.831432528355;11423.029042531478;11471.770564588494;10961.56153753841;11061.668149955514;11076.5569377224;11187.552497899993;11507.712307192387;9280.95359523198;9530.761730956781;10321.948390258302;11043.447827608426;11738.58914937973;7597.430192735456;7979.441439099207;8042.356611470951;8108.878366824384;8624.439411438236;9234.584443699916;10645.840312395165;10841.241113122005;10903.836442453528;11068.23294176456 02:42:04 INFO - PROCESS | 1637 | |3;mootools.html;1452.3028946105876;1459.8394176640568;1462.8756555692767;1480.8223013238405;1484.1466156959748;7980.600969951501;8403.95798021009;8409.369297302705;8410.663573457063;8410.873836892451;7335.853282934351;7624;7974.202579742023;8210.343172546196;8224.177582241788;2281.315605318402;2328.871912044837;2332.218706733238;2335.2293743064747;2339.1345202275184;2321.779430954057;2349.447879748258;2351.882405879699;2353.8352315337934;2361.551305251997;2254.380045487496;2262.513559584689;2284.132029828663;2286.4855407533255;2292.5071109711407;2272.4659704969404;2283.189467738962;2288.9771102289014;2313.3175713164655;2313.3869524575834;1981.2570286142698;2267.7958983691547;2323.3494621506006;2331.044271848551;2331.4870728439714;7203.279672032807;7761.45669803114;8051.798705032363;8271.503709777433;8356.415050946436;4995.625328100371;5153.072446959546;5166.225066240057;5169.508896654812;5188.688678679254;3152.5428812822242;3232.272738633812;3323.21904352477;3370.7303415726683;3380.6957373836226;1117.3184357541893;1117.4412793603199;1148.1274231584057;1163.5229555882133;1170.3329102411628;10765.677029689123;10793.406362650052;10812.135029197645;10814;10821.404822734747;4376.540463251313;4571.474280457724;4620.561046700558;4642.396488456479;4684.110019096361;7757.806054848561;9115.453072815651;9147.725568232963;9151.45091294511;9166.312526560401;5089.982003599295;5104;5108.770105345194;5111.821086261963;5134.152864777345;4215.662746980234;4373.6282415994365;4573.611243044312;4645.605123564535;4714.481407045222;3773.1887644156636;3809;3845.3462911305146;3901.785401802928;3914.706397020178;1213.205350495427;1213.6723084767063;1214.5931113077218;1221.5907670930337;1222.8349172861729;778.9415793815486;792.5165648954134;800.2277801921174;806.9677212911536;812.756173148065;4978.352814134139;5336.786528538815;5393.487618676219;5527.44725527444;5541.944580554224;502.6029436744931;565.6153815405564;572.1417873190214;579.982600521985;595.169738215196;3650.142216579102;3709.7774133552075;3713.2202237530423;3803.220339830328;3848.6536211741077;9674.806503870024;9961.501924903725;10098.697039088838;10120.898791012143;10135.797284054424;10034.799304013879;10041.648542300984;10065.4464004479;10081.69754907354;10093.495325233709;6555.508336874754;6582.572132811352;7801.765947021599;7875.488093273919;7937.563434011185;5673.77304907799;5715.2855893013375;5769.567282453917;5881.206037184926;5919.644821310735;8855.867161992704;9179.31155163352;9193.586288616894;9277.48973806447;9287.62849486013;9167.44995300284;9288.489133097744;9309.115634014757;9413.246940244628;9559.761005974906;6277.591956522811;6411.487081033413;7157.141143062866;7239;7321.890171647323;8024.2376974187355;8104.635291411782;8106.067802202586;8120.106788253405;8124.878126828221;7046.295370463118;7153.177384600837;7172.820679483055;7174.892376614251;7252.963735181291;6658.3674550917585;6686.899696504654;6917.071027776202;6992.510524263253;7020.122484689414;6372.808815735535;6383.744650213939;6483;6490.51321150925;6490.7079181436;4970;4991.900161996812;5012.724300163526;5018.222175562793;5032.823851165192;4867.367242258484;4950.430700469492;4960.181570040902;5082.720450375265;5154.123798954111 02:42:04 INFO - PROCESS | 1637 | |4;prototype.html;352.9047157267538;358.51421324105837;362.89838845123364;370.8442454169249;373.73464839963606;5023.899522009558;5226.268322434862;5272.420033796284;5329.467053294674;5381.623286369956;5069.695818250908;5133.82031628893;5192.40287366952;5205.505476979691;5232.97956898404;3487.57009626054;3879.262940041397;4097;4105.2815757242515;4124.1957818225455;3481.6692414220734;3781.7687564337034;3961.2671655743634;4142.71001029928;4170.332746760504;4038.5961403859674;4092.4270602115726;4104.030065568514;4121.793910304487;4130.215259100762;3281.802142218073;3697.3899306614376;4068.6948478864206;4081.632653061224;4133.132042271127;2979.508381117113;3249.335544853221;3488.843002064913;3643.41705327149;3672.4491326301;4329.480462344507;4961.429435614915;5105.744712764384;5141.383034035902;5177.119889618773;4541.955350269456;4639.605633521155;4820.903581928342;4883.975580122076;4886.413630364379;5247.7667748079175;5521.613487055908;5584.91622625661;5610.32523696975;5623.100303951389;3794.886153415402;3965.3147412349635;4021.4571032910476;4041.7777022263763;4082.510098788164;4955.801767929279;4957.652964292501;5685.459881311269;5783.334916484616;5786.826395208151;3529.6999755020597;4104.486939132608;4113.663059505672;4124.381342798604;4148;3614.295212433603;3686.668199862025;3744.194998075427;4176.791160441966;4181.686373521998;4376.868693939187;4588.242939914877;4605.516420775771;4630.86107416778;4638.884027899262;5614.803481878196;5712.514436272963;5729.9713501432225;5730.455606717355;5741.971290143606;1151.6660168551193;1155.5839897636845;1192.6106086409236;1252.6596541700294;1281.743890986838;744.6202436757293;762.1349768013345;829.6888666749969;849.4181485682327;849.7805648893857;4496.123255965121;4655.4878963314;4678.625709943196;4888.682235654671;4983.90032199354;4579.847471688301;4711.7879695413785;5074.147936003332;5129.640925135204;5150.6595055682565;4435.756033418193;4479.865604031885;4868.391451068616;4897.779599917941;4930.9506904930495;2538.5684433646325;2557.3223095879607;2667.99950018743;2814.958465367827;2917.2706823294175;5059.87350316245;5098.031374038921;5323.441038690959;5506.834794956158;5571.359293681197;4799.784009719571;4878.487668822676;5456.653638935217;5475.838362844267;5742.626729262668;5183.948160518422;5301.787928482818;5722.420639876087;5723.370429252862;5730.283714535683;4337.674674399495;5078.901869859309;5278.917821846436;5377.677339359651;5401.945980540144;4561.384213131318;4982.4768399317545;5049.106585030613;5331.333583302087;5419.729013549386;4952.4304704959395;5603.917845185213;5694.515966142759;5729.312482502127;5738.9096071746235;3289.6216935052776;3524.6122926477556;3579.9463008055423;3605.6574625410544;3716.1452865840465;4845.951540484691;5362.82017956049;5381.838544843661;5386.299781028441;5416.941562206336;4484.641228701631;4955.5044495550155;4997.150484417585;5014.52362025607;5119.0273847968765;4993.251012348177;5090.778213228872;5244.47910106065;5660.37735849048;5681;5248.317718696698;5257;5427.267318911896;5441.428649991693;5537.320963785594;5605.467480589337;5611.831645050655;5640.633358831663;5658.603897727119;5748;4410.580994805488;5151.974240128776;5282.520894149644;5527.645726796961;5573.888522229451 02:42:04 INFO - PROCESS | 1637 | |5;yui.html;667.732906837265;741.992580074199;742.7660287009588;836.799168199632;859.2395729779148;14900.403983840646;15472.149031803247;15517.379304827822;15523.990940588854;15638.687226255483;14149.434022639109;14196.432142714304;14351.995360324781;14364.281785910689;15448.922755386235;691.2085661917101;710.0839916507699;844.2781421884308;844.9619767110495;861.4917198852676;841.7222316635526;865.2385900407664;865.6623916672503;867.4361664917791;867.6442658510013;893.0712059458156;894.8031433084711;895.9462432254053;921.262989608314;931.74842792446;721.9566825990431;743.0822933676905;880.3221519430067;905.5336501701629;912.0286894457448;656.0258016844981;657.0275991532511;672.579637726421;679.0493309366876;679.7824696097201;15384.923075384664;15603.765943510743;15646.374145034299;15735.134567598778;15778.526644200692;13532;13694.52069177584;13824.963127765457;13923.512677056255;13956.67411595907;11461.312321260668;11688.123390745643;11932.88067119335;11967.581134660331;11999.160058795887;3616.6383361663884;3718.4608231806237;3743.101655602663;3908.4332771748223;3922.293987082324;82209.58895205545;98878;104215;105175;107050;10781;10848.78302433947;10848.837267440995;10849.891501084889;10951.561937522569;21615.891920540296;21689.45776355572;21739;21791.23730669419;21977.780222197573;7305.525140865827;7791.220877912164;7958.442908996431;8111.351091912633;8177.018757749108;4145.357469592218;4154.335306350969;4191.476065491814;4243.915121697611;4272.295071313199;3540.4866294387684;3635.890923272253;3638.017735211531;3645.143391303042;3645.434957581579;652.6280020388429;653.6404977262582;660.5904339309659;669.2136739331266;686.3411125319749;705.5378726933867;709.8331892005375;731.9560826350436;746.9626518674045;759.7264984605538;9389.480166672467;10226.23303252259;10432.165426765841;10528.889332402048;10745.946270268754;707.7204504220804;732.8351120997839;738.8263758016861;741.6069483173926;746.8580969615756;5016.849494515171;5051.87370315745;5075.2387141929;5076.670016448919;5078.390593128848;101290.49354753326;102869.48565257275;103266;103711.48144259231;104474;61568;64303;69830.65084674544;74165;74783.50432991418;68200.6589967057;72446.63776681083;72502.54994900072;73114.70983805848;73238.16904577428;10438.582456701646;10701.785964280514;11098.72921799181;11145.38700371455;11329.830052549383;31308;38659.806700966314;39415.620453284;48054.27918581154;48814.7796305081;59690;60641.393586063576;60656.69671651613;61009;62598;12346.876531234931;12729.29988850622;13116.540921067717;13244.00669949777;13274.93362533181;13959.441622334993;14507.637309067357;14609.26953652292;15641.765373519178;15812.446564370191;13596.252206128758;13618.455261789813;14140.78788818148;14348.354324055234;14446.566603001927;13333.86666133365;13672.52146174879;13931.930340348234;14303.925930740192;14492.202928839015;12988.545400910923;13188.472461101832;13830.65423364424;14411.42354305816;14458.710825783635;10233.539490722786;11076.446177691245;11422.200445968703;11718.472668729757;11884.762304753684;10871.891281087404;11333.150013749168;11474.483648236017;11613.883861161281;12001.63995080149 02:42:04 INFO - PROCESS | 1637 | __end_tp_report 02:42:04 INFO - PROCESS | 1637 | __start_cc_report 02:42:04 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1303 02:42:04 INFO - PROCESS | 1637 | __end_cc_report 02:42:04 INFO - PROCESS | 1637 | __startTimestamp1485254524465__endTimestamp 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | ------- Summary: start ------- 02:42:04 INFO - PROCESS | 1637 | Number of tests: 6 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5727.53 Median:5972.00 stddev:672.34 (11.3%) stddev-sans-first:635.70 02:42:04 INFO - PROCESS | 1637 | Values: 2861.6 3285.0 3288.2 3290.5 3331.4 5698.9 5717.7 5752.2 5766.3 5766.6 5241.8 5408.1 5710.6 5788.3 5818.9 5206.7 5207.4 5230.8 5255.9 5301.4 5130.6 5130.6 5144.3 5297.0 5309.2 5190.9 5202.7 5258.7 5269.9 5274.8 5242.5 5282.9 5293.9 5306.1 5317.7 5133.2 5198.3 5206.2 5242.7 5260.4 5594.9 5615.9 5630.5 5657.2 5657.7 6154.0 6203.4 6233.0 6240.8 6250.3 5493.9 6198.3 6203.1 6219.9 6220.2 4924.7 5716.6 5809.3 5810.0 5935.9 6162.2 6195.4 6195.8 6278.7 6281.2 6217.1 6225.5 6234.6 6238.1 6246.2 6163.4 6174.0 6191.6 6246.3 6253.7 5416.0 6027.5 6174.8 6207.6 6232.3 6239.8 6328.0 6329.0 6331.1 6336.9 4283.3 4919.5 5031.7 5034.0 5050.2 4421.5 4423.3 4491.7 4494.3 4519.3 5665.5 5762.9 5797.9 5797.9 5812.7 6168.4 6174.5 6197.4 6337.8 6363.0 5653.2 5663.8 5711.0 5715.8 5748.7 5466.0 5489.0 5491.0 5512.1 5512.4 6199.5 6226.8 6252.9 6264.1 6333.3 6353.7 6356.4 6372.8 6376.0 6387.5 6331.6 6337.6 6345.9 6350.0 6352.0 4795.8 6116.8 6163.2 6271.7 6277.1 4615.7 5804.3 5965.8 6262.4 6374.8 6135.6 6150.1 6163.8 6182.3 6189.2 6036.2 6061.9 6190.5 6194.1 6201.3 5972.0 5977.1 6038.9 6046.1 6116.1 6131.6 6175.0 6178.2 6182.0 6192.1 5824.4 6013.7 6041.9 6050.0 6083.6 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:57921.28 Median:198669.50 stddev:113124.30 (56.9%) stddev-sans-first:113359.37 02:42:04 INFO - PROCESS | 1637 | Values: 459.9 474.1 498.6 501.3 533.3 31416.2 37021.0 41773.4 43050.1 45278.9 44621.6 45159.0 45193.1 45270.1 45328.1 8387.2 8595.8 9350.2 9552.6 9570.0 8596.1 8672.2 8687.1 11192.3 11481.5 11373.9 11376.4 11420.9 11440.3 11462.1 11401.8 11494.5 11501.7 11502.7 11511.7 11366.3 11458.6 11475.3 11479.7 11481.9 41913.8 42158.8 42309.0 42369.6 42448.8 3968.6 3992.0 4003.9 4012.6 4064.7 29015.8 29794.3 30236.1 31221.0 32239.0 3000.7 3018.9 3030.8 3126.1 3130.3 483881.0 485474.0 486873.6 489246.0 490267.0 63901.0 64165.0 64245.7 64297.7 64309.7 67686.3 67944.0 67964.3 68005.3 68082.7 16527.8 17033.9 17061.5 17073.8 17076.2 13222.3 13282.6 13300.0 13333.1 13357.7 15002.7 15384.7 15385.2 16934.4 17389.7 5431.7 6256.1 6398.8 6426.4 6474.6 887.4 898.2 908.2 909.6 927.4 29525.0 30431.7 30442.2 30692.7 31366.0 1009.9 1056.5 1074.4 1087.9 1231.4 12549.0 14187.6 14645.5 15038.0 15076.7 421157.0 423035.0 423554.0 423742.0 427429.0 57564.4 57625.0 57762.0 57769.7 57777.7 1230.7 1397.1 1433.4 1443.0 1443.5 21992.3 23613.3 27073.6 28514.9 28520.9 46201.5 46293.1 46306.4 46310.3 46602.0 359729.0 360758.0 361258.0 361552.0 361643.0 24191.8 24855.4 24954.6 25625.7 37178.7 37678.2 37756.0 42798.4 43757.0 44936.1 31659.0 33851.8 36244.3 36475.5 36554.5 36184.8 36432.5 36488.0 37113.0 37163.3 34723.5 35310.8 35516.1 35767.8 36081.0 30589.7 32168.0 32267.0 32294.5 32346.2 24079.6 24290.0 24322.3 24661.3 24674.1 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:38774.36 Median:11332.05 stddev:118335.34 (1044.3%) stddev-sans-first:118632.21 02:42:04 INFO - PROCESS | 1637 | Values: 394.8 395.5 397.9 403.6 421.6 14883.9 20016.4 20657.9 21411.6 21539.1 16234.5 18983.8 21058.3 21245.5 21599.9 5184.2 5636.8 5963.6 5969.9 5971.3 5744.9 5786.8 5913.9 5919.0 6010.9 6114.3 6127.1 6128.4 6128.7 6140.1 6078.8 6131.1 6517.6 6540.8 6577.6 5656.5 5878.1 5881.6 5892.9 5901.6 13356.8 13372.4 13400.5 13486.2 13722.4 2563.2 2569.5 2588.2 2628.3 2780.4 9926.3 10021.4 10124.7 10420.3 10422.6 1823.7 1835.3 1837.0 1874.6 1890.3 121897.2 127177.0 130540.0 130888.0 132165.0 11850.4 12001.8 12007.3 12017.0 12167.2 15566.8 15588.8 15609.5 15626.7 15635.0 7310.4 7672.0 7675.4 7782.1 8383.2 7373.0 7389.3 7548.3 8532.9 8578.6 4577.3 4608.2 4674.8 4794.4 4804.3 1669.9 2002.8 2006.1 2006.2 2012.9 1034.4 1042.3 1049.7 1062.7 1095.9 17451.8 18444.5 20651.2 21167.4 21251.3 1029.0 1045.7 1051.6 1078.5 1088.2 10935.4 11136.2 11206.9 11209.2 11223.7 698048.0 704176.0 710196.0 713357.0 725605.0 115760.0 144000.0 145069.0 145428.0 156502.0 1016.4 1061.7 1076.2 1076.7 1078.6 18410.6 19416.4 19834.5 19899.7 19915.6 56274.0 57551.8 58124.0 58503.0 59907.7 82222.0 83261.2 84695.0 88182.0 90159.5 5750.6 7603.3 8148.4 8262.1 8576.4 7483.5 11281.1 12206.8 12793.2 12914.7 11065.2 11121.3 11237.8 11423.0 11471.8 10961.6 11061.7 11076.6 11187.6 11507.7 9281.0 9530.8 10321.9 11043.4 11738.6 7597.4 7979.4 8042.4 8108.9 8624.4 9234.6 10645.8 10841.2 10903.8 11068.2 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5366.60 Median:5096.99 stddev:2949.06 (57.9%) stddev-sans-first:2942.66 02:42:04 INFO - PROCESS | 1637 | Values: 1452.3 1459.8 1462.9 1480.8 1484.1 7980.6 8404.0 8409.4 8410.7 8410.9 7335.9 7624.0 7974.2 8210.3 8224.2 2281.3 2328.9 2332.2 2335.2 2339.1 2321.8 2349.4 2351.9 2353.8 2361.6 2254.4 2262.5 2284.1 2286.5 2292.5 2272.5 2283.2 2289.0 2313.3 2313.4 1981.3 2267.8 2323.3 2331.0 2331.5 7203.3 7761.5 8051.8 8271.5 8356.4 4995.6 5153.1 5166.2 5169.5 5188.7 3152.5 3232.3 3323.2 3370.7 3380.7 1117.3 1117.4 1148.1 1163.5 1170.3 10765.7 10793.4 10812.1 10814.0 10821.4 4376.5 4571.5 4620.6 4642.4 4684.1 7757.8 9115.5 9147.7 9151.5 9166.3 5090.0 5104.0 5108.8 5111.8 5134.2 4215.7 4373.6 4573.6 4645.6 4714.5 3773.2 3809.0 3845.3 3901.8 3914.7 1213.2 1213.7 1214.6 1221.6 1222.8 778.9 792.5 800.2 807.0 812.8 4978.4 5336.8 5393.5 5527.4 5541.9 502.6 565.6 572.1 580.0 595.2 3650.1 3709.8 3713.2 3803.2 3848.7 9674.8 9961.5 10098.7 10120.9 10135.8 10034.8 10041.6 10065.4 10081.7 10093.5 6555.5 6582.6 7801.8 7875.5 7937.6 5673.8 5715.3 5769.6 5881.2 5919.6 8855.9 9179.3 9193.6 9277.5 9287.6 9167.4 9288.5 9309.1 9413.2 9559.8 6277.6 6411.5 7157.1 7239.0 7321.9 8024.2 8104.6 8106.1 8120.1 8124.9 7046.3 7153.2 7172.8 7174.9 7253.0 6658.4 6686.9 6917.1 6992.5 7020.1 6372.8 6383.7 6483.0 6490.5 6490.7 4970.0 4991.9 5012.7 5018.2 5032.8 4867.4 4950.4 4960.2 5082.7 5154.1 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4416.44 Median:4955.65 stddev:1334.67 (26.9%) stddev-sans-first:1303.10 02:42:04 INFO - PROCESS | 1637 | Values: 352.9 358.5 362.9 370.8 373.7 5023.9 5226.3 5272.4 5329.5 5381.6 5069.7 5133.8 5192.4 5205.5 5233.0 3487.6 3879.3 4097.0 4105.3 4124.2 3481.7 3781.8 3961.3 4142.7 4170.3 4038.6 4092.4 4104.0 4121.8 4130.2 3281.8 3697.4 4068.7 4081.6 4133.1 2979.5 3249.3 3488.8 3643.4 3672.4 4329.5 4961.4 5105.7 5141.4 5177.1 4542.0 4639.6 4820.9 4884.0 4886.4 5247.8 5521.6 5584.9 5610.3 5623.1 3794.9 3965.3 4021.5 4041.8 4082.5 4955.8 4957.7 5685.5 5783.3 5786.8 3529.7 4104.5 4113.7 4124.4 4148.0 3614.3 3686.7 3744.2 4176.8 4181.7 4376.9 4588.2 4605.5 4630.9 4638.9 5614.8 5712.5 5730.0 5730.5 5742.0 1151.7 1155.6 1192.6 1252.7 1281.7 744.6 762.1 829.7 849.4 849.8 4496.1 4655.5 4678.6 4888.7 4983.9 4579.8 4711.8 5074.1 5129.6 5150.7 4435.8 4479.9 4868.4 4897.8 4931.0 2538.6 2557.3 2668.0 2815.0 2917.3 5059.9 5098.0 5323.4 5506.8 5571.4 4799.8 4878.5 5456.7 5475.8 5742.6 5183.9 5301.8 5722.4 5723.4 5730.3 4337.7 5078.9 5278.9 5377.7 5401.9 4561.4 4982.5 5049.1 5331.3 5419.7 4952.4 5603.9 5694.5 5729.3 5738.9 3289.6 3524.6 3579.9 3605.7 3716.1 4846.0 5362.8 5381.8 5386.3 5416.9 4484.6 4955.5 4997.2 5014.5 5119.0 4993.3 5090.8 5244.5 5660.4 5681.0 5248.3 5257.0 5427.3 5441.4 5537.3 5605.5 5611.8 5640.6 5658.6 5748.0 4410.6 5152.0 5282.5 5527.6 5573.9 02:42:04 INFO - PROCESS | 1637 | 02:42:04 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19289.22 Median:3636.95 stddev:26866.32 (738.7%) stddev-sans-first:26905.30 02:42:04 INFO - PROCESS | 1637 | Values: 667.7 742.0 742.8 836.8 859.2 14900.4 15472.1 15517.4 15524.0 15638.7 14149.4 14196.4 14352.0 14364.3 15448.9 691.2 710.1 844.3 845.0 861.5 841.7 865.2 865.7 867.4 867.6 893.1 894.8 895.9 921.3 931.7 722.0 743.1 880.3 905.5 912.0 656.0 657.0 672.6 679.0 679.8 15384.9 15603.8 15646.4 15735.1 15778.5 13532.0 13694.5 13825.0 13923.5 13956.7 11461.3 11688.1 11932.9 11967.6 11999.2 3616.6 3718.5 3743.1 3908.4 3922.3 82209.6 98878.0 104215.0 105175.0 107050.0 10781.0 10848.8 10848.8 10849.9 10951.6 21615.9 21689.5 21739.0 21791.2 21977.8 7305.5 7791.2 7958.4 8111.4 8177.0 4145.4 4154.3 4191.5 4243.9 4272.3 3540.5 3635.9 3638.0 3645.1 3645.4 652.6 653.6 660.6 669.2 686.3 705.5 709.8 732.0 747.0 759.7 9389.5 10226.2 10432.2 10528.9 10745.9 707.7 732.8 738.8 741.6 746.9 5016.8 5051.9 5075.2 5076.7 5078.4 101290.5 102869.5 103266.0 103711.5 104474.0 61568.0 64303.0 69830.7 74165.0 74783.5 68200.7 72446.6 72502.5 73114.7 73238.2 10438.6 10701.8 11098.7 11145.4 11329.8 31308.0 38659.8 39415.6 48054.3 48814.8 59690.0 60641.4 60656.7 61009.0 62598.0 12346.9 12729.3 13116.5 13244.0 13274.9 13959.4 14507.6 14609.3 15641.8 15812.4 13596.3 13618.5 14140.8 14348.4 14446.6 13333.9 13672.5 13931.9 14303.9 14492.2 12988.5 13188.5 13830.7 14411.4 14458.7 10233.5 11076.4 11422.2 11718.5 11884.8 10871.9 11333.2 11474.5 11613.9 12001.6 02:42:04 INFO - PROCESS | 1637 | -------- Summary: end -------- 02:42:04 INFO - PROCESS | 1637 | 02:42:05 INFO - TEST-INFO | 1637: exit 0 02:42:05 INFO - TEST-OK | dromaeo_css | took 1117515ms 02:42:05 INFO - TEST-START | kraken 02:42:05 INFO - operating with platform_type : mac_ 02:42:05 INFO - Initialising browser for kraken test... 02:42:05 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpXaVRxX/profile http://localhost:49242/getInfo.html) 02:42:07 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 02:42:07 INFO - PROCESS | 1648 | colorDepth:24 02:42:07 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 02:42:07 INFO - PROCESS | 1648 | __metrics 02:42:07 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 02:42:07 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:42:07 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:42:08 INFO - TEST-INFO | 1648: exit 0 02:42:08 INFO - Browser initialized. 02:42:08 INFO - Running cycle 1/1 for kraken test... 02:42:08 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpXaVRxX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:20 INFO - PROCESS | 1650 | RSS: Main: 212512768 02:42:20 INFO - PROCESS | 1650 | 02:42:23 INFO - PROCESS | 1650 | 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) 02:42:24 INFO - PROCESS | 1650 | RSS: Main: 263405568 02:42:24 INFO - PROCESS | 1650 | 02:42:26 INFO - PROCESS | 1650 | 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) 02:42:27 INFO - PROCESS | 1650 | RSS: Main: 276054016 02:42:27 INFO - PROCESS | 1650 | 02:42:30 INFO - PROCESS | 1650 | 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) 02:42:30 INFO - PROCESS | 1650 | RSS: Main: 372137984 02:42:30 INFO - PROCESS | 1650 | 02:42:32 INFO - PROCESS | 1650 | 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) 02:42:33 INFO - PROCESS | 1650 | RSS: Main: 277450752 02:42:33 INFO - PROCESS | 1650 | 02:42:35 INFO - PROCESS | 1650 | 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) 02:42:36 INFO - PROCESS | 1650 | RSS: Main: 278790144 02:42:36 INFO - PROCESS | 1650 | 02:42:39 INFO - PROCESS | 1650 | 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) 02:42:39 INFO - PROCESS | 1650 | RSS: Main: 321372160 02:42:39 INFO - PROCESS | 1650 | 02:42:42 INFO - PROCESS | 1650 | 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) 02:42:43 INFO - PROCESS | 1650 | RSS: Main: 321286144 02:42:43 INFO - PROCESS | 1650 | 02:42:45 INFO - PROCESS | 1650 | 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) 02:42:46 INFO - PROCESS | 1650 | RSS: Main: 318050304 02:42:46 INFO - PROCESS | 1650 | 02:42:48 INFO - PROCESS | 1650 | 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) 02:42:48 INFO - PROCESS | 1650 | RSS: Main: 294330368 02:42:48 INFO - PROCESS | 1650 | 02:42:50 INFO - PROCESS | 1650 | 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) 02:42:51 INFO - PROCESS | 1650 | RSS: Main: 297177088 02:42:51 INFO - PROCESS | 1650 | 02:42:53 INFO - PROCESS | 1650 | 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) 02:42:54 INFO - PROCESS | 1650 | RSS: Main: 300093440 02:42:54 INFO - PROCESS | 1650 | 02:42:56 INFO - PROCESS | 1650 | 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) 02:42:57 INFO - PROCESS | 1650 | RSS: Main: 316153856 02:42:57 INFO - PROCESS | 1650 | 02:43:00 INFO - PROCESS | 1650 | 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) 02:43:01 INFO - PROCESS | 1650 | RSS: Main: 310398976 02:43:01 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | 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) 02:43:03 INFO - PROCESS | 1650 | RSS: Main: 354533376 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | __start_tp_report 02:43:03 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 02:43:03 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 02:43:03 INFO - PROCESS | 1650 | |i|pagename|runs| 02:43:03 INFO - PROCESS | 1650 | |0;ai-astar;114;116;116;116;116;117;115;114;116;115 02:43:03 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;111;108;144;111;109;107;110;128;108 02:43:03 INFO - PROCESS | 1650 | |2;audio-dft;186;184;186;184;185;184;185;184;184;187 02:43:03 INFO - PROCESS | 1650 | |3;audio-fft;80;58;58;89;60;59;58;58;72;57 02:43:03 INFO - PROCESS | 1650 | |4;audio-oscillator;87;72;86;70;68;70;81;68;69;81 02:43:03 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;93;132;90;87;88;90;136;87;88;85 02:43:03 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;95;98;94;95;94;95;95;95;94 02:43:03 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;88;88;88;86;87;88;88;89;85 02:43:03 INFO - PROCESS | 1650 | |8;json-parse-financial;57;54;56;53;53;57;58;54;56;58 02:43:03 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;78;77;75;72;70;71;69;70;72 02:43:03 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;84;84;84;85;84;83;84;87;86 02:43:03 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;138;142;136;139;140;137;141;141;189;139 02:43:03 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;168;168;170;169;172;211;168;170;167;168 02:43:03 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;68;70;80;82;82;61;60;83;80 02:43:03 INFO - PROCESS | 1650 | __end_tp_report 02:43:03 INFO - PROCESS | 1650 | __start_cc_report 02:43:03 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2065 02:43:03 INFO - PROCESS | 1650 | __end_cc_report 02:43:03 INFO - PROCESS | 1650 | __startTimestamp1485254583432__endTimestamp 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | ------- Summary: start ------- 02:43:03 INFO - PROCESS | 1650 | Number of tests: 14 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:0.97 (0.8%) stddev-sans-first:0.87 02:43:03 INFO - PROCESS | 1650 | Values: 114.0 116.0 116.0 116.0 116.0 117.0 115.0 114.0 116.0 115.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:111.00 stddev:14.59 (13.1%) stddev-sans-first:12.57 02:43:03 INFO - PROCESS | 1650 | Values: 142.0 111.0 108.0 144.0 111.0 109.0 107.0 110.0 128.0 108.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.10 (0.6%) stddev-sans-first:1.09 02:43:03 INFO - PROCESS | 1650 | Values: 186.0 184.0 186.0 184.0 185.0 184.0 185.0 184.0 184.0 187.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:64.90 Median:59.50 stddev:11.41 (19.2%) stddev-sans-first:10.71 02:43:03 INFO - PROCESS | 1650 | Values: 80.0 58.0 58.0 89.0 60.0 59.0 58.0 58.0 72.0 57.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.50 stddev:7.67 (10.0%) stddev-sans-first:6.85 02:43:03 INFO - PROCESS | 1650 | Values: 87.0 72.0 86.0 70.0 68.0 70.0 81.0 68.0 69.0 81.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:97.60 Median:88.00 stddev:19.33 (22.0%) stddev-sans-first:20.43 02:43:03 INFO - PROCESS | 1650 | Values: 93.0 132.0 90.0 87.0 88.0 90.0 136.0 87.0 88.0 85.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.22 02:43:03 INFO - PROCESS | 1650 | Values: 94.0 95.0 98.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:88.00 stddev:1.17 (1.3%) stddev-sans-first:1.24 02:43:03 INFO - PROCESS | 1650 | Values: 87.0 88.0 88.0 88.0 86.0 87.0 88.0 88.0 89.0 85.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:1.96 (3.5%) stddev-sans-first:2.01 02:43:03 INFO - PROCESS | 1650 | Values: 57.0 54.0 56.0 53.0 53.0 57.0 58.0 54.0 56.0 58.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:3.90 (5.4%) stddev-sans-first:3.24 02:43:03 INFO - PROCESS | 1650 | Values: 65.0 78.0 77.0 75.0 72.0 70.0 71.0 69.0 70.0 72.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:1.40 (1.7%) stddev-sans-first:1.24 02:43:03 INFO - PROCESS | 1650 | Values: 87.0 84.0 84.0 84.0 85.0 84.0 83.0 84.0 87.0 86.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:140.50 stddev:15.85 (11.3%) stddev-sans-first:16.65 02:43:03 INFO - PROCESS | 1650 | Values: 138.0 142.0 136.0 139.0 140.0 137.0 141.0 141.0 189.0 139.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:169.50 stddev:13.40 (7.9%) stddev-sans-first:14.08 02:43:03 INFO - PROCESS | 1650 | Values: 168.0 168.0 170.0 169.0 172.0 211.0 168.0 170.0 167.0 168.0 02:43:03 INFO - PROCESS | 1650 | 02:43:03 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:80.00 stddev:9.26 (11.6%) stddev-sans-first:9.34 02:43:03 INFO - PROCESS | 1650 | Values: 65.0 68.0 70.0 80.0 82.0 82.0 61.0 60.0 83.0 80.0 02:43:03 INFO - PROCESS | 1650 | -------- Summary: end -------- 02:43:03 INFO - PROCESS | 1650 | 02:43:04 INFO - TEST-INFO | 1650: exit 0 02:43:04 INFO - TEST-OK | kraken | took 59259ms 02:43:04 INFO - SUITE-END | took 1176s 02:43:04 INFO - Completed test suite (00:19:36) 02:43:04 INFO - javascript benchmark 02:43:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2861.585070164826, 3284.967150328496, 3288.1943923738686, 3290.4899740540195, 3331.400347937372, 5698.886022279552, 5717.714114294289, 5752.223449834271, 5766.279215098113, 5766.567507436943, 5241.768184476645, 5408.080626293529, 5710.628809127404, 5788.334341550723, 5818.883622327551, 5206.661566998152, 5207.401148867872, 5230.790768369261, 5255.894882102356, 5301.390340110879, 5130.56390206831, 5130.640855140142, 5144.254083157958, 5297.020051290504, 5309.203619457093, 5190.896182076356, 5202.687838729669, 5258.710770907599, 5269.8946021079555, 5274.81538146165, 5242.501962313574, 5282.894342113174, 5293.920591191135, 5306.071437498442, 5317.680939143625, 5133.178691409394, 5198.298229738974, 5206.193040078794, 5242.659227150223, 5260.421353651095, 5594.944050559483, 5615.859603509904, 5630.521405680522, 5657.23627310312, 5657.66054036755, 6153.984592542225, 6203.379662033805, 6233.0338797486465, 6240.781572644935, 6250.281217659936, 5493.945060549423, 6198.318184999646, 6203.131561581382, 6219.942609756352, 6220.222472190976, 4924.704517728947, 5716.5998380113, 5809.302883653989, 5810.041343178328, 5935.910961335583, 6162.22972128484, 6195.380461953859, 6195.752169913153, 6278.6860656966965, 6281.214848143982, 6217.129601855744, 6225.501959843202, 6234.625922444668, 6238.1266622672865, 6246.156768836149, 6163.445289923929, 6174.0, 6191.597546159485, 6246.3441338659695, 6253.6560489172625, 5415.972920135374, 6027.517798576104, 6174.753009879554, 6207.6275423473835, 6232.3144454110015, 6239.781607643801, 6328.0, 6328.968355158195, 6331.113644089831, 6336.936630633634, 4283.250431174532, 4919.532644398776, 5031.723255220924, 5033.974830125826, 5050.191969284897, 4421.513633500313, 4423.314386270134, 4491.685582009293, 4494.303382975644, 4519.344695019204, 5665.49010589049, 5762.942370576325, 5797.855053623609, 5797.942020579824, 5812.738426770806, 6168.383161683796, 6174.475169610633, 6197.380261973857, 6337.809865704036, 6363.0, 5653.208550802891, 5663.773449061991, 5710.971445142748, 5715.799947001835, 5748.741306641211, 5466.0, 5489.039418101896, 5491.0116179088145, 5512.062949298629, 5512.448755124536, 6199.5040396767245, 6226.782062627786, 6252.906206406817, 6264.060390941395, 6333.334999825044, 6353.7140828661895, 6356.396142366468, 6372.840678983062, 6375.979843225062, 6387.489000880011, 6331.620102793847, 6337.556371053982, 6345.904811427925, 6350.047492876106, 6351.96824015877, 4795.784189711401, 6116.755329786936, 6163.19878415821, 6271.6550589718, 6277.089821975879, 4615.676902616919, 5804.3432637438145, 5965.821025369246, 6262.3737626238835, 6374.808755737336, 6135.601185922901, 6150.10823430609, 6163.845903852261, 6182.28903676083, 6189.1954045975535, 6036.185115009417, 6061.939380606137, 6190.50475961913, 6194.101855231056, 6201.255849298113, 5972.0, 5977.133315669291, 6038.879222415615, 6046.062860256668, 6116.14373987651, 6131.558495904967, 6175.0, 6178.196834411498, 6182.0, 6192.071189321638, 5824.388439213822, 6013.6692481913915, 6041.9395806041375, 6049.969750151221, 6083.6349819011], "value": 5683.722783508057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.86184194119545, 474.1086756897033, 498.62603047714214, 501.2556353814585, 533.3280067115434, 31416.214594635145, 37020.99999999996, 41773.373399398995, 43050.138997220034, 45278.86802829931, 44621.55378446223, 45159.0, 45193.09613807722, 45270.094598108015, 45328.09343813122, 8387.203215694499, 8595.785105372353, 9350.205232555223, 9552.57013434397, 9570.0, 8596.097409771977, 8672.219500244977, 8687.087855775148, 11192.272502287366, 11481.483333249982, 11373.886261137366, 11376.431178441086, 11420.942895285512, 11440.256383335098, 11462.14033947453, 11401.771964560703, 11494.540218391254, 11501.654950351503, 11502.654920352403, 11511.654650360502, 11366.318020918772, 11458.598949036743, 11475.311481311064, 11479.655610331703, 11481.88518114825, 41913.79043104765, 42158.78920605408, 42309.0, 42369.57630423687, 42448.787756061334, 3968.603139686037, 3991.980040099781, 4003.919921601552, 4012.61880121388, 4064.6748260139416, 29015.839366425316, 29794.255143621365, 30236.127567881016, 31221.0, 32239.0, 3000.7149320814488, 3018.894338698157, 3030.7878448508613, 3126.1403114143563, 3130.2956834712236, 483881.0, 485474.0, 486873.5656321731, 489246.0, 490266.99999999645, 63901.0, 64165.0, 64245.678771605846, 64297.67851160714, 64309.67845160838, 67686.32313676899, 67944.0, 67964.32035679679, 68005.3199467999, 68082.65958670175, 16527.83472165263, 17033.91483042577, 17061.48815535536, 17073.829261707226, 17076.2315695794, 13222.338883056002, 13282.601521954357, 13300.0, 13333.133346332652, 13357.66605834862, 15002.69994600102, 15384.692306153815, 15385.230738463031, 16934.407295744837, 17389.65220695579, 5431.6740995540395, 6256.124142620037, 6398.840028999219, 6426.4216220540375, 6474.5791523550815, 887.4453466583385, 898.23201163006, 908.2143945487238, 909.5997760985146, 927.4388994658135, 29525.044851629285, 30431.69568304333, 30442.238944026576, 30692.693073068982, 31366.0, 1009.9394036357695, 1056.5404049238605, 1074.4412905289205, 1087.9020888120108, 1231.4027696567157, 12549.0, 14187.645308867155, 14645.48740794067, 15038.04505414289, 15076.698466030617, 421157.0, 423035.0, 423554.0, 423742.0, 427429.0, 57564.424355756746, 57625.0, 57762.0, 57769.711151443975, 57777.71111144417, 1230.698478872682, 1397.0779285671408, 1433.4481224728347, 1442.9639259018609, 1443.4659176104908, 21992.34022979313, 23613.29160125199, 27073.615798025246, 28514.85742571274, 28520.85916563314, 46201.53798462107, 46293.07413851772, 46306.37927672515, 46310.30534542052, 46602.0, 359729.0, 360758.0, 361258.0, 361552.0, 361643.0, 24191.758082419656, 24855.37861553403, 24954.62568061517, 25625.743742562336, 37178.653921147226, 37678.203686938046, 37756.0, 42798.35802463028, 43757.0, 44936.101277973605, 31659.0, 33851.83074084614, 36244.27511449703, 36475.45286820647, 36554.45168322531, 36184.81907590445, 36432.45351319679, 36488.0, 37113.0, 37163.25673486569, 34723.4791478123, 35310.823445882605, 35516.11209719778, 35767.821160894026, 36081.0, 30589.694103058686, 32168.03495895127, 32267.0, 32294.515582265816, 32346.191345216557, 24079.638805417584, 24290.0, 24322.27033189007, 24661.26016219516, 24674.13640522573], "value": 19392.484791001327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8006256840295, 395.54117224020126, 397.9462772525712, 403.63471058691886, 421.57507624230095, 14883.851161488408, 20016.399508014765, 20657.896710516427, 21411.608245464035, 21539.138434462642, 16234.51296461108, 18983.81016189838, 21058.262960796375, 21245.468863278387, 21599.892000540014, 5184.196449550307, 5636.830895073144, 5963.582549221556, 5969.850753731148, 5971.313298970609, 5744.885102297952, 5786.768529258825, 5913.881722365551, 5919.0, 6010.8797824043495, 6114.266288045441, 6127.142200091991, 6128.356522565134, 6128.662923539204, 6140.140380346755, 6078.817635470921, 6131.080337949321, 6517.608943463384, 6540.803775886731, 6577.572457790228, 5656.547476201894, 5878.147668588073, 5881.558883083786, 5892.911606325909, 5901.557383196235, 13356.799648005288, 13372.398242079129, 13400.463981440731, 13486.19082855022, 13722.382492787849, 2563.218218443374, 2569.486102779452, 2588.2364702412833, 2628.3297759071506, 2780.374415756459, 9926.305158638897, 10021.444740081755, 10124.746881327952, 10420.322679025914, 10422.583096676124, 1823.6990896502061, 1835.330104511857, 1836.9540761480937, 1874.6344462829754, 1890.3236028042984, 121897.17154242694, 127177.0, 130540.0, 130887.99999999905, 132165.0, 11850.407479626158, 12001.819972700416, 12007.279563226235, 12017.0, 12167.209131406607, 15566.766498502531, 15588.844111558967, 15609.453669121527, 15626.68746625061, 15634.98372605777, 7310.378617817545, 7672.0, 7675.385969122457, 7782.143964163937, 8383.245507904196, 7373.0, 7389.334959853639, 7548.282913123245, 8532.8720069199, 8578.613962371708, 4577.3362862384765, 4608.216603177468, 4674.789634466457, 4794.4486384065585, 4804.327394164819, 1669.8580620647137, 2002.779694233633, 2006.1042315012464, 2006.2175751456944, 2012.9295474658609, 1034.4362322534237, 1042.280826229914, 1049.6746008737316, 1062.665260442958, 1095.912327013837, 17451.825481745273, 18444.538886527946, 20651.17395304201, 21167.364979050653, 21251.256206032715, 1028.9742756431149, 1045.6601604478424, 1051.5951358726793, 1078.5038882114316, 1088.1566785740956, 10935.398553079498, 11136.164787640959, 11206.943965280121, 11209.21535492524, 11223.71940701489, 698048.0, 704176.0, 710196.0, 713357.0, 725605.0, 115760.0, 144000.0, 145069.0, 145428.0, 156502.0, 1016.3546148195949, 1061.7451811565168, 1076.2412499188054, 1076.6662334676275, 1078.6063086973197, 18410.63178736391, 19416.4175074748, 19834.504137396103, 19899.701504477733, 19915.60168796645, 56274.0, 57551.84896301967, 58124.0, 58503.0, 59907.700461497414, 82222.0, 83261.16738832534, 84695.0, 88182.0, 90159.54920225356, 5750.597458178055, 7603.2776886195725, 8148.3888708348295, 8262.091169971418, 8576.44253123545, 7483.476156668981, 11281.09751219884, 12206.81689774672, 12793.168444051107, 12914.67713307175, 11065.225434219527, 11121.27711698737, 11237.831432528355, 11423.029042531478, 11471.770564588494, 10961.56153753841, 11061.668149955514, 11076.5569377224, 11187.552497899993, 11507.712307192387, 9280.95359523198, 9530.761730956781, 10321.948390258302, 11043.447827608426, 11738.58914937973, 7597.430192735456, 7979.441439099207, 8042.356611470951, 8108.878366824384, 8624.439411438236, 9234.584443699916, 10645.840312395165, 10841.241113122005, 10903.836442453528, 11068.23294176456], "value": 9641.23452187002, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.3028946105876, 1459.8394176640568, 1462.8756555692767, 1480.8223013238405, 1484.1466156959748, 7980.600969951501, 8403.95798021009, 8409.369297302705, 8410.663573457063, 8410.873836892451, 7335.853282934351, 7624.0, 7974.202579742023, 8210.343172546196, 8224.177582241788, 2281.315605318402, 2328.871912044837, 2332.218706733238, 2335.2293743064747, 2339.1345202275184, 2321.779430954057, 2349.447879748258, 2351.882405879699, 2353.8352315337934, 2361.551305251997, 2254.380045487496, 2262.513559584689, 2284.132029828663, 2286.4855407533255, 2292.5071109711407, 2272.4659704969404, 2283.189467738962, 2288.9771102289014, 2313.3175713164655, 2313.3869524575834, 1981.2570286142698, 2267.7958983691547, 2323.3494621506006, 2331.044271848551, 2331.4870728439714, 7203.279672032807, 7761.45669803114, 8051.798705032363, 8271.503709777433, 8356.415050946436, 4995.625328100371, 5153.072446959546, 5166.225066240057, 5169.508896654812, 5188.688678679254, 3152.5428812822242, 3232.272738633812, 3323.21904352477, 3370.7303415726683, 3380.6957373836226, 1117.3184357541893, 1117.4412793603199, 1148.1274231584057, 1163.5229555882133, 1170.3329102411628, 10765.677029689123, 10793.406362650052, 10812.135029197645, 10814.0, 10821.404822734747, 4376.540463251313, 4571.474280457724, 4620.561046700558, 4642.396488456479, 4684.110019096361, 7757.806054848561, 9115.453072815651, 9147.725568232963, 9151.45091294511, 9166.312526560401, 5089.982003599295, 5104.0, 5108.770105345194, 5111.821086261963, 5134.152864777345, 4215.662746980234, 4373.6282415994365, 4573.611243044312, 4645.605123564535, 4714.481407045222, 3773.1887644156636, 3809.0, 3845.3462911305146, 3901.785401802928, 3914.706397020178, 1213.205350495427, 1213.6723084767063, 1214.5931113077218, 1221.5907670930337, 1222.8349172861729, 778.9415793815486, 792.5165648954134, 800.2277801921174, 806.9677212911536, 812.756173148065, 4978.352814134139, 5336.786528538815, 5393.487618676219, 5527.44725527444, 5541.944580554224, 502.6029436744931, 565.6153815405564, 572.1417873190214, 579.982600521985, 595.169738215196, 3650.142216579102, 3709.7774133552075, 3713.2202237530423, 3803.220339830328, 3848.6536211741077, 9674.806503870024, 9961.501924903725, 10098.697039088838, 10120.898791012143, 10135.797284054424, 10034.799304013879, 10041.648542300984, 10065.4464004479, 10081.69754907354, 10093.495325233709, 6555.508336874754, 6582.572132811352, 7801.765947021599, 7875.488093273919, 7937.563434011185, 5673.77304907799, 5715.2855893013375, 5769.567282453917, 5881.206037184926, 5919.644821310735, 8855.867161992704, 9179.31155163352, 9193.586288616894, 9277.48973806447, 9287.62849486013, 9167.44995300284, 9288.489133097744, 9309.115634014757, 9413.246940244628, 9559.761005974906, 6277.591956522811, 6411.487081033413, 7157.141143062866, 7239.0, 7321.890171647323, 8024.2376974187355, 8104.635291411782, 8106.067802202586, 8120.106788253405, 8124.878126828221, 7046.295370463118, 7153.177384600837, 7172.820679483055, 7174.892376614251, 7252.963735181291, 6658.3674550917585, 6686.899696504654, 6917.071027776202, 6992.510524263253, 7020.122484689414, 6372.808815735535, 6383.744650213939, 6483.0, 6490.51321150925, 6490.7079181436, 4970.0, 4991.900161996812, 5012.724300163526, 5018.222175562793, 5032.823851165192, 4867.367242258484, 4950.430700469492, 4960.181570040902, 5082.720450375265, 5154.123798954111], "value": 4302.8034678510785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9047157267538, 358.51421324105837, 362.89838845123364, 370.8442454169249, 373.73464839963606, 5023.899522009558, 5226.268322434862, 5272.420033796284, 5329.467053294674, 5381.623286369956, 5069.695818250908, 5133.82031628893, 5192.40287366952, 5205.505476979691, 5232.97956898404, 3487.57009626054, 3879.262940041397, 4097.0, 4105.2815757242515, 4124.1957818225455, 3481.6692414220734, 3781.7687564337034, 3961.2671655743634, 4142.71001029928, 4170.332746760504, 4038.5961403859674, 4092.4270602115726, 4104.030065568514, 4121.793910304487, 4130.215259100762, 3281.802142218073, 3697.3899306614376, 4068.6948478864206, 4081.632653061224, 4133.132042271127, 2979.508381117113, 3249.335544853221, 3488.843002064913, 3643.41705327149, 3672.4491326301, 4329.480462344507, 4961.429435614915, 5105.744712764384, 5141.383034035902, 5177.119889618773, 4541.955350269456, 4639.605633521155, 4820.903581928342, 4883.975580122076, 4886.413630364379, 5247.7667748079175, 5521.613487055908, 5584.91622625661, 5610.32523696975, 5623.100303951389, 3794.886153415402, 3965.3147412349635, 4021.4571032910476, 4041.7777022263763, 4082.510098788164, 4955.801767929279, 4957.652964292501, 5685.459881311269, 5783.334916484616, 5786.826395208151, 3529.6999755020597, 4104.486939132608, 4113.663059505672, 4124.381342798604, 4148.0, 3614.295212433603, 3686.668199862025, 3744.194998075427, 4176.791160441966, 4181.686373521998, 4376.868693939187, 4588.242939914877, 4605.516420775771, 4630.86107416778, 4638.884027899262, 5614.803481878196, 5712.514436272963, 5729.9713501432225, 5730.455606717355, 5741.971290143606, 1151.6660168551193, 1155.5839897636845, 1192.6106086409236, 1252.6596541700294, 1281.743890986838, 744.6202436757293, 762.1349768013345, 829.6888666749969, 849.4181485682327, 849.7805648893857, 4496.123255965121, 4655.4878963314, 4678.625709943196, 4888.682235654671, 4983.90032199354, 4579.847471688301, 4711.7879695413785, 5074.147936003332, 5129.640925135204, 5150.6595055682565, 4435.756033418193, 4479.865604031885, 4868.391451068616, 4897.779599917941, 4930.9506904930495, 2538.5684433646325, 2557.3223095879607, 2667.99950018743, 2814.958465367827, 2917.2706823294175, 5059.87350316245, 5098.031374038921, 5323.441038690959, 5506.834794956158, 5571.359293681197, 4799.784009719571, 4878.487668822676, 5456.653638935217, 5475.838362844267, 5742.626729262668, 5183.948160518422, 5301.787928482818, 5722.420639876087, 5723.370429252862, 5730.283714535683, 4337.674674399495, 5078.901869859309, 5278.917821846436, 5377.677339359651, 5401.945980540144, 4561.384213131318, 4982.4768399317545, 5049.106585030613, 5331.333583302087, 5419.729013549386, 4952.4304704959395, 5603.917845185213, 5694.515966142759, 5729.312482502127, 5738.9096071746235, 3289.6216935052776, 3524.6122926477556, 3579.9463008055423, 3605.6574625410544, 3716.1452865840465, 4845.951540484691, 5362.82017956049, 5381.838544843661, 5386.299781028441, 5416.941562206336, 4484.641228701631, 4955.5044495550155, 4997.150484417585, 5014.52362025607, 5119.0273847968765, 4993.251012348177, 5090.778213228872, 5244.47910106065, 5660.37735849048, 5681.0, 5248.317718696698, 5257.0, 5427.267318911896, 5441.428649991693, 5537.320963785594, 5605.467480589337, 5611.831645050655, 5640.633358831663, 5658.603897727119, 5748.0, 4410.580994805488, 5151.974240128776, 5282.520894149644, 5527.645726796961, 5573.888522229451], "value": 3997.8666242049317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.732906837265, 741.992580074199, 742.7660287009588, 836.799168199632, 859.2395729779148, 14900.403983840646, 15472.149031803247, 15517.379304827822, 15523.990940588854, 15638.687226255483, 14149.434022639109, 14196.432142714304, 14351.995360324781, 14364.281785910689, 15448.922755386235, 691.2085661917101, 710.0839916507699, 844.2781421884308, 844.9619767110495, 861.4917198852676, 841.7222316635526, 865.2385900407664, 865.6623916672503, 867.4361664917791, 867.6442658510013, 893.0712059458156, 894.8031433084711, 895.9462432254053, 921.262989608314, 931.74842792446, 721.9566825990431, 743.0822933676905, 880.3221519430067, 905.5336501701629, 912.0286894457448, 656.0258016844981, 657.0275991532511, 672.579637726421, 679.0493309366876, 679.7824696097201, 15384.923075384664, 15603.765943510743, 15646.374145034299, 15735.134567598778, 15778.526644200692, 13532.0, 13694.52069177584, 13824.963127765457, 13923.512677056255, 13956.67411595907, 11461.312321260668, 11688.123390745643, 11932.88067119335, 11967.581134660331, 11999.160058795887, 3616.6383361663884, 3718.4608231806237, 3743.101655602663, 3908.4332771748223, 3922.293987082324, 82209.58895205545, 98878.0, 104215.0, 105175.0, 107050.0, 10781.0, 10848.78302433947, 10848.837267440995, 10849.891501084889, 10951.561937522569, 21615.891920540296, 21689.45776355572, 21739.0, 21791.23730669419, 21977.780222197573, 7305.525140865827, 7791.220877912164, 7958.442908996431, 8111.351091912633, 8177.018757749108, 4145.357469592218, 4154.335306350969, 4191.476065491814, 4243.915121697611, 4272.295071313199, 3540.4866294387684, 3635.890923272253, 3638.017735211531, 3645.143391303042, 3645.434957581579, 652.6280020388429, 653.6404977262582, 660.5904339309659, 669.2136739331266, 686.3411125319749, 705.5378726933867, 709.8331892005375, 731.9560826350436, 746.9626518674045, 759.7264984605538, 9389.480166672467, 10226.23303252259, 10432.165426765841, 10528.889332402048, 10745.946270268754, 707.7204504220804, 732.8351120997839, 738.8263758016861, 741.6069483173926, 746.8580969615756, 5016.849494515171, 5051.87370315745, 5075.2387141929, 5076.670016448919, 5078.390593128848, 101290.49354753326, 102869.48565257275, 103266.0, 103711.48144259231, 104474.0, 61568.0, 64303.0, 69830.65084674544, 74165.0, 74783.50432991418, 68200.6589967057, 72446.63776681083, 72502.54994900072, 73114.70983805848, 73238.16904577428, 10438.582456701646, 10701.785964280514, 11098.72921799181, 11145.38700371455, 11329.830052549383, 31308.0, 38659.806700966314, 39415.620453284, 48054.27918581154, 48814.7796305081, 59690.0, 60641.393586063576, 60656.69671651613, 61009.0, 62598.0, 12346.876531234931, 12729.29988850622, 13116.540921067717, 13244.00669949777, 13274.93362533181, 13959.441622334993, 14507.637309067357, 14609.26953652292, 15641.765373519178, 15812.446564370191, 13596.252206128758, 13618.455261789813, 14140.78788818148, 14348.354324055234, 14446.566603001927, 13333.86666133365, 13672.52146174879, 13931.930340348234, 14303.925930740192, 14492.202928839015, 12988.545400910923, 13188.472461101832, 13830.65423364424, 14411.42354305816, 14458.710825783635, 10233.539490722786, 11076.446177691245, 11422.200445968703, 11718.472668729757, 11884.762304753684, 10871.891281087404, 11333.150013749168, 11474.483648236017, 11613.883861161281, 12001.63995080149], "value": 7475.486218053955, "unit": "score"}], "name": "dromaeo_css", "value": 7177.024788651202, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 116.0, 116.0, 117.0, 115.0, 114.0, 116.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 108.0, 144.0, 111.0, 109.0, 107.0, 110.0, 128.0, 108.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 186.0, 184.0, 185.0, 184.0, 185.0, 184.0, 184.0, 187.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 89.0, 60.0, 59.0, 58.0, 58.0, 72.0, 57.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 86.0, 70.0, 68.0, 70.0, 81.0, 68.0, 69.0, 81.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 132.0, 90.0, 87.0, 88.0, 90.0, 136.0, 87.0, 88.0, 85.0], "value": 97.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 98.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 88.0, 86.0, 87.0, 88.0, 88.0, 89.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 53.0, 53.0, 57.0, 58.0, 54.0, 56.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 77.0, 75.0, 72.0, 70.0, 71.0, 69.0, 70.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 84.0, 85.0, 84.0, 83.0, 84.0, 87.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 136.0, 139.0, 140.0, 137.0, 141.0, 141.0, 189.0, 139.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 170.0, 169.0, 172.0, 211.0, 168.0, 170.0, 167.0, 168.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 70.0, 80.0, 82.0, 82.0, 61.0, 60.0, 83.0, 80.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1440.8999999999999, "alertThreshold": 2.0}]} 02:43:04 INFO - Return code: 0 02:43:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:43:04 ERROR - # TBPL SUCCESS # 02:43:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:43:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:43:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:43:04 INFO - 2017-01-24 02:43:04.709 screenresolution[1654:10111] starting screenresolution argv=screenresolution get 02:43:04 INFO - 2017-01-24 02:43:04.712 screenresolution[1654:10111] Display 0: 1600x1200x32@60 02:43:04 INFO - 2017-01-24 02:43:04.718 screenresolution[1655:10114] starting screenresolution argv=screenresolution list 02:43:04 INFO - Available Modes on Display 0 02:43:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:43:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:43:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:43:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:43:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:43:04 INFO - Intel Iris: 02:43:04 INFO - Chipset Model: Intel Iris 02:43:04 INFO - Type: GPU 02:43:04 INFO - Bus: Built-In 02:43:04 INFO - VRAM (Dynamic, Max): 1536 MB 02:43:04 INFO - Vendor: Intel (0x8086) 02:43:04 INFO - Device ID: 0x0a2e 02:43:04 INFO - Revision ID: 0x0009 02:43:04 INFO - Displays: 02:43:04 INFO - Display: 02:43:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:43:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:43:04 INFO - Display Serial Number: 1600x1200 60 02:43:04 INFO - Main Display: Yes 02:43:04 INFO - Mirror: Off 02:43:04 INFO - Online: Yes 02:43:04 INFO - Rotation: Supported 02:43:04 INFO - Return code: 0 02:43:04 INFO - Running post-action listener: _resource_record_post_action 02:43:04 INFO - [mozharness: 2017-01-24 10:43:04.958891Z] Finished run-tests step (success) 02:43:04 INFO - Running post-run listener: _resource_record_post_run 02:43:05 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 37889024; Write bytes: 506249216; Read time: 236; Write time: 1585 02:43:05 INFO - TinderboxPrint: CPU usage
53.7% 02:43:05 INFO - TinderboxPrint: I/O read bytes / time
37,889,024 / 236 02:43:05 INFO - TinderboxPrint: I/O write bytes / time
506,249,216 / 1,585 02:43:05 INFO - TinderboxPrint: CPU idle
2,219.6 (46.3%) 02:43:05 INFO - TinderboxPrint: CPU system
958.5 (20.0%) 02:43:05 INFO - TinderboxPrint: CPU user
1,611.7 (33.6%) 02:43:05 INFO - TinderboxPrint: Swap in / out
245,051,392 / 0 02:43:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205236736; Write bytes: 200283648; Read time: 15694; Write time: 444 02:43:05 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35783680; Write bytes: 295012864; Read time: 216; Write time: 1109 02:43:05 INFO - Running post-run listener: _upload_blobber_files 02:43:05 INFO - Blob upload gear active. 02:43:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:43:05 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:06 INFO - (blobuploader) - INFO - Done attempting. 02:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:07 INFO - (blobuploader) - INFO - Done attempting. 02:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:08 INFO - (blobuploader) - INFO - Done attempting. 02:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:11 INFO - (blobuploader) - INFO - Done attempting. 02:43:11 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:11 INFO - Return code: 0 02:43:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b005275f5000be635f43cdfa7df75feb2c0b897655a8278106208dfe3c6ff9acde4adfa1da97ffe0946bf30101ac80281e230bac1961d78d325cbeaf8cfbc5a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8daeb008e75e1b1fce78cebba63f3e775d763bdeaafeb6cbd27cd4641f6fc1ca1d2dc38683d19e4c64559a2e7f5077708f7454b308e8bcd7354006c0c327f952", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1aee5363edb6b540a340bfe0f52668dbd85fdcebc44f71f7fbddfc17f73d40cf9b4f3baaf4055293322ae160c252d41252dfd3323d937141a8f5ccbc8d646e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95064102301928ec036b02cb14b6ea4ae2192feeb416d481140126435b3198460545075506aeb981ccc6820387cbd3d8e9ac6f349c3b7898d02229c52329cce4"} 02:43:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:11 INFO - Contents: 02:43:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b005275f5000be635f43cdfa7df75feb2c0b897655a8278106208dfe3c6ff9acde4adfa1da97ffe0946bf30101ac80281e230bac1961d78d325cbeaf8cfbc5a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8daeb008e75e1b1fce78cebba63f3e775d763bdeaafeb6cbd27cd4641f6fc1ca1d2dc38683d19e4c64559a2e7f5077708f7454b308e8bcd7354006c0c327f952", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1aee5363edb6b540a340bfe0f52668dbd85fdcebc44f71f7fbddfc17f73d40cf9b4f3baaf4055293322ae160c252d41252dfd3323d937141a8f5ccbc8d646e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95064102301928ec036b02cb14b6ea4ae2192feeb416d481140126435b3198460545075506aeb981ccc6820387cbd3d8e9ac6f349c3b7898d02229c52329cce4"} 02:43:11 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:11 INFO - Copying logs to upload dir... 02:43:11 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.333123 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 02:43:11.074671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 02:43:11.078070) ========= 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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b005275f5000be635f43cdfa7df75feb2c0b897655a8278106208dfe3c6ff9acde4adfa1da97ffe0946bf30101ac80281e230bac1961d78d325cbeaf8cfbc5a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8daeb008e75e1b1fce78cebba63f3e775d763bdeaafeb6cbd27cd4641f6fc1ca1d2dc38683d19e4c64559a2e7f5077708f7454b308e8bcd7354006c0c327f952", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1aee5363edb6b540a340bfe0f52668dbd85fdcebc44f71f7fbddfc17f73d40cf9b4f3baaf4055293322ae160c252d41252dfd3323d937141a8f5ccbc8d646e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95064102301928ec036b02cb14b6ea4ae2192feeb416d481140126435b3198460545075506aeb981ccc6820387cbd3d8e9ac6f349c3b7898d02229c52329cce4"} build_url:https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/bNBgwzamR9WvX12BAr5LsA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b005275f5000be635f43cdfa7df75feb2c0b897655a8278106208dfe3c6ff9acde4adfa1da97ffe0946bf30101ac80281e230bac1961d78d325cbeaf8cfbc5a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8daeb008e75e1b1fce78cebba63f3e775d763bdeaafeb6cbd27cd4641f6fc1ca1d2dc38683d19e4c64559a2e7f5077708f7454b308e8bcd7354006c0c327f952", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1aee5363edb6b540a340bfe0f52668dbd85fdcebc44f71f7fbddfc17f73d40cf9b4f3baaf4055293322ae160c252d41252dfd3323d937141a8f5ccbc8d646e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95064102301928ec036b02cb14b6ea4ae2192feeb416d481140126435b3198460545075506aeb981ccc6820387cbd3d8e9ac6f349c3b7898d02229c52329cce4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 02:43:11.113815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 02:43:11.114134) ========= 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.N7XVVuKG8u/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.jcy8Nzks7p/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 02:43:11.162592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 02:43:11.162912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 02:43:11.163213) ========= ========= Total master_lag: 0.24 =========