builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0381 starttime: 1490441265.27 results: success (0) buildid: 20170325030203 builduid: 98b62b7ec1e34fa686d00fb27fe4295f revision: 65b0ac174753b22c01156d72fb42d2abd3176dd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:45.268850) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:45.269334) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:45.269622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:45.296597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-25 04:27:45.296981) ========= 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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-25 04:27:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-03-25 04:27:46 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.376272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-25 04:27:46.697782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:46.698095) ========= 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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.027450 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:46.746985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-25 04:27:46.747364) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 65b0ac174753b22c01156d72fb42d2abd3176dd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 65b0ac174753b22c01156d72fb42d2abd3176dd1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mn9grKQu2O/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.YQYhzBnJXC/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-25 04:27:46,866 truncating revision to first 12 chars 2017-03-25 04:27:46,866 Setting DEBUG logging. 2017-03-25 04:27:46,866 attempt 1/10 2017-03-25 04:27:46,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/65b0ac174753?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 04:27:51,401 unpacking tar archive at: mozilla-central-65b0ac174753/testing/mozharness/ program finished with exit code 0 elapsedTime=4.832539 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-25 04:27:51.603453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:51.603784) ========= script_repo_revision: 65b0ac174753b22c01156d72fb42d2abd3176dd1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:51.604209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:51.604508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 04:27:51.624628) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 25 mins, 37 secs) (at 2017-03-25 04:27:51.625042) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mn9grKQu2O/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.YQYhzBnJXC/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:27:51 INFO - MultiFileLogger online at 20170325 04:27:51 in /builds/slave/test 04:27:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:27:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:51 INFO - {'append_to_log': False, 04:27:51 INFO - 'base_work_dir': '/builds/slave/test', 04:27:51 INFO - 'blob_upload_branch': 'Firefox', 04:27:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:51 INFO - 'branch': 'Firefox', 04:27:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:51 INFO - 'config_files': ('talos/mac_config.py',), 04:27:51 INFO - 'default_actions': ('clobber', 04:27:51 INFO - 'read-buildbot-config', 04:27:51 INFO - 'download-and-extract', 04:27:51 INFO - 'populate-webroot', 04:27:51 INFO - 'create-virtualenv', 04:27:51 INFO - 'install', 04:27:51 INFO - 'run-tests'), 04:27:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:51 INFO - 'download_minidump_stackwalk': True, 04:27:51 INFO - 'download_symbols': 'ondemand', 04:27:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:51 INFO - 'gecko_profile': False, 04:27:51 INFO - 'gecko_profile_interval': 0, 04:27:51 INFO - 'installer_path': 'installer.exe', 04:27:51 INFO - 'log_level': 'info', 04:27:51 INFO - 'log_name': 'talos', 04:27:51 INFO - 'log_to_console': True, 04:27:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:27:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:27:51 INFO - 'opt_config_files': (), 04:27:51 INFO - 'pip_index': False, 04:27:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:51 INFO - 'cmd': ('bash', 04:27:51 INFO - '-c', 04:27:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:51 INFO - 'enabled': True, 04:27:51 INFO - 'halt_on_failure': False, 04:27:51 INFO - 'name': 'check_screen_resolution'},), 04:27:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:51 INFO - 'cmd': ('bash', 04:27:51 INFO - '-c', 04:27:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:51 INFO - 'enabled': True, 04:27:51 INFO - 'halt_on_failure': False, 04:27:51 INFO - 'name': 'check_screen_resolution'},), 04:27:51 INFO - 'run_cmd_checks_enabled': True, 04:27:51 INFO - 'suite': 'dromaeojs', 04:27:51 INFO - 'system_bits': '32', 04:27:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:51 INFO - 'title': 't-yosemite-r7-0381', 04:27:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:51 INFO - 'use_talos_json': True, 04:27:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:51 INFO - 'work_dir': 'build'} 04:27:51 INFO - [mozharness: 2017-03-25 11:27:51.851020Z] Running clobber step. 04:27:51 INFO - Running pre-action listener: _resource_record_pre_action 04:27:51 INFO - Running main action method: clobber 04:27:51 INFO - rmtree: /builds/slave/test/build 04:27:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:54 INFO - Running post-action listener: _resource_record_post_action 04:27:54 INFO - [mozharness: 2017-03-25 11:27:54.290616Z] Finished clobber step (success) 04:27:54 INFO - [mozharness: 2017-03-25 11:27:54.290696Z] Running read-buildbot-config step. 04:27:54 INFO - Running pre-action listener: _resource_record_pre_action 04:27:54 INFO - Running main action method: read_buildbot_config 04:27:54 INFO - Using buildbot properties: 04:27:54 INFO - { 04:27:54 INFO - "project": "", 04:27:54 INFO - "product": "firefox", 04:27:54 INFO - "script_repo_revision": "production", 04:27:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:27:54 INFO - "repository": "", 04:27:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:27:54 INFO - "buildid": "20170325030203", 04:27:54 INFO - "stage_platform": "macosx64", 04:27:54 INFO - "basedir": "/builds/slave/test", 04:27:54 INFO - "nightly_build": "True", 04:27:54 INFO - "buildnumber": 35, 04:27:54 INFO - "slavename": "t-yosemite-r7-0381", 04:27:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:27:54 INFO - "platform": "yosemite_r7", 04:27:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:27:54 INFO - "branch": "mozilla-central", 04:27:54 INFO - "repo_path": "mozilla-central", 04:27:54 INFO - "revision": "65b0ac174753b22c01156d72fb42d2abd3176dd1", 04:27:54 INFO - "pgo_build": "False", 04:27:54 INFO - "builduid": "98b62b7ec1e34fa686d00fb27fe4295f", 04:27:54 INFO - "slavebuilddir": "test" 04:27:54 INFO - } 04:27:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:27:54 INFO - Running post-action listener: _resource_record_post_action 04:27:54 INFO - [mozharness: 2017-03-25 11:27:54.294089Z] Finished read-buildbot-config step (success) 04:27:54 INFO - [mozharness: 2017-03-25 11:27:54.294199Z] Running download-and-extract step. 04:27:54 INFO - Running pre-action listener: _resource_record_pre_action 04:27:54 INFO - Running main action method: download_and_extract 04:27:54 INFO - mkdir: /builds/slave/test/build/tests 04:27: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')]} 04:27:54 INFO - trying https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:27:57 INFO - Downloaded 1325 bytes. 04:27:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:27:57 INFO - Using the following test package requirements: 04:27:57 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:27:57 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:27:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:27:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:27:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'jsshell-mac.zip'], 04:27:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:27:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:27:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:27:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:27:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:27:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:27:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:27:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:27:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:27:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:27:57 INFO - Fetch https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:27:59 INFO - Expected file size: 52413521 04:27:59 INFO - Obtained file size: 52413521 04:28:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:28:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:28:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:28:15 INFO - Fetch https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:28:47 INFO - retry: attempt #1 caught exception: '' 04:28:47 INFO - retry: Failed, sleeping 60 seconds before retrying 04:29:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #2 04:29:47 INFO - Fetch https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:30:23 INFO - retry: attempt #2 caught exception: '' 04:30:23 INFO - retry: Failed, sleeping 120 seconds before retrying 04:32:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #3 04:32:23 INFO - Fetch https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:32:25 INFO - Expected file size: 52413521 04:32:25 INFO - Obtained file size: 52413521 04:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:32:41 INFO - Expected file size: 14404171 04:32:41 INFO - Obtained file size: 14404171 04:32:41 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')]} 04:32:41 INFO - trying https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:41 INFO - Downloading https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:32:44 INFO - Downloaded 75667010 bytes. 04:32:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:44 INFO - mkdir: /builds/slave/test/properties 04:32:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:44 INFO - Contents: 04:32:44 INFO - build_url:https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:44 INFO - Running post-action listener: _resource_record_post_action 04:32:44 INFO - Running post-action listener: set_extra_try_arguments 04:32:44 INFO - [mozharness: 2017-03-25 11:32:44.755653Z] Finished download-and-extract step (success) 04:32:44 INFO - [mozharness: 2017-03-25 11:32:44.755763Z] Running populate-webroot step. 04:32:44 INFO - Running pre-action listener: _resource_record_pre_action 04:32:44 INFO - Running main action method: populate_webroot 04:32:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:44 INFO - '--tppagecycles', 04:32:44 INFO - '7'], 04:32:44 INFO - 'tests': ['tsvgm']}}, 04:32:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['damp', 'tps']}, 04:32:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'tests': ['damp', 'tps']}, 04:32:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['dromaeo_dom']}, 04:32:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['basic_compositor_video']}, 04:32:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['a11yr', 04:32:44 INFO - 'ts_paint', 04:32:44 INFO - 'tpaint', 04:32:44 INFO - 'sessionrestore', 04:32:44 INFO - 'sessionrestore_no_auto_restore', 04:32:44 INFO - 'tabpaint']}, 04:32:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:44 INFO - 'ts_paint', 04:32:44 INFO - 'tpaint', 04:32:44 INFO - 'sessionrestore', 04:32:44 INFO - 'sessionrestore_no_auto_restore', 04:32:44 INFO - 'tabpaint']}, 04:32:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:44 INFO - 'ts_paint', 04:32:44 INFO - 'tpaint', 04:32:44 INFO - 'sessionrestore', 04:32:44 INFO - 'sessionrestore_no_auto_restore', 04:32:44 INFO - 'tabpaint']}, 04:32:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:44 INFO - 'ts_paint', 04:32:44 INFO - 'tpaint', 04:32:44 INFO - 'sessionrestore', 04:32:44 INFO - 'sessionrestore_no_auto_restore', 04:32:44 INFO - 'tabpaint']}, 04:32:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['a11yr', 04:32:44 INFO - 'ts_paint', 04:32:44 INFO - 'tpaint', 04:32:44 INFO - 'sessionrestore', 04:32:44 INFO - 'sessionrestore_no_auto_restore', 04:32:44 INFO - 'tabpaint']}, 04:32:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['a11yr', 04:32:44 INFO - 'ts_paint', 04:32:44 INFO - 'tpaint', 04:32:44 INFO - 'sessionrestore', 04:32:44 INFO - 'sessionrestore_no_auto_restore', 04:32:44 INFO - 'tabpaint']}, 04:32:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['tsvgx', 04:32:44 INFO - 'tsvgr_opacity', 04:32:44 INFO - 'tart', 04:32:44 INFO - 'tscrollx', 04:32:44 INFO - 'cart', 04:32:44 INFO - 'tsvg_static']}, 04:32:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:44 INFO - 'tsvgr_opacity', 04:32:44 INFO - 'tart', 04:32:44 INFO - 'tscrollx', 04:32:44 INFO - 'cart', 04:32:44 INFO - 'tsvg_static']}, 04:32:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'talos_options': ['--disable-e10s'], 04:32:44 INFO - 'tests': ['tp5o']}, 04:32:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:32:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'talos_options': ['--disable-e10s', 04:32:44 INFO - '--xperf_path', 04:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:44 INFO - 'tests': ['tp5n']}, 04:32:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:32:44 INFO - 'talos_options': ['--xperf_path', 04:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:44 INFO - 'tests': ['tp5n']}}, 04:32:44 INFO - 'talos.zip': {'path': '', 04:32:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:44 INFO - Running post-action listener: _resource_record_post_action 04:32:44 INFO - [mozharness: 2017-03-25 11:32:44.774251Z] Finished populate-webroot step (success) 04:32:44 INFO - [mozharness: 2017-03-25 11:32:44.774382Z] Running create-virtualenv step. 04:32:44 INFO - Running pre-action listener: _resource_record_pre_action 04:32:44 INFO - Running main action method: create_virtualenv 04:32:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:44 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 04:32:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:44 INFO - Using real prefix '/tools/python27' 04:32:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:48 INFO - Installing pip.................done. 04:32:48 INFO - Return code: 0 04:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:48 INFO - Reading from file tmpfile_stdout 04:32:48 INFO - Output received: 04:32:48 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) 04:32:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:48 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')]} 04:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:48 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')]} 04:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:32: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', 'pip>=1.5'] in /builds/slave/test/build 04:32: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 pip>=1.5 04:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:49 INFO - 'HOME': '/Users/cltbld', 04:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:49 INFO - 'LOGNAME': 'cltbld', 04:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:49 INFO - 'MOZ_NO_REMOTE': '1', 04:32:49 INFO - 'NO_EM_RESTART': '1', 04:32:49 INFO - 'PAGER': '/bin/cat', 04:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:49 INFO - 'PWD': '/builds/slave/test', 04:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:49 INFO - 'SHELL': '/bin/bash', 04:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:32:49 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:49 INFO - 'USER': 'cltbld', 04:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:49 INFO - 'XPC_FLAGS': '0x0', 04:32:49 INFO - 'XPC_SERVICE_NAME': '0', 04:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:49 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 04:32:49 INFO - Cleaning up... 04:32:49 INFO - Return code: 0 04:32:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', '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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:32: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 psutil>=3.1.1 04:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:49 INFO - 'HOME': '/Users/cltbld', 04:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:49 INFO - 'LOGNAME': 'cltbld', 04:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:49 INFO - 'MOZ_NO_REMOTE': '1', 04:32:49 INFO - 'NO_EM_RESTART': '1', 04:32:49 INFO - 'PAGER': '/bin/cat', 04:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:49 INFO - 'PWD': '/builds/slave/test', 04:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:49 INFO - 'SHELL': '/bin/bash', 04:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:32:49 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:49 INFO - 'USER': 'cltbld', 04:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:49 INFO - 'XPC_FLAGS': '0x0', 04:32:49 INFO - 'XPC_SERVICE_NAME': '0', 04:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:49 INFO - Downloading/unpacking psutil>=3.1.1 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:54 INFO - Installing collected packages: psutil 04:32:54 INFO - Running setup.py install for psutil 04:32:54 INFO - building 'psutil._psutil_osx' extension 04:32:54 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 04:32:54 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 04:32:54 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 04:32:54 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 04:32:55 INFO - building 'psutil._psutil_posix' extension 04:32:55 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 04:32:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:55 INFO - ^ 04:32:55 INFO - 1 warning generated. 04:32:55 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 04:32:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:55 INFO - Successfully installed psutil 04:32:55 INFO - Cleaning up... 04:32:55 INFO - Return code: 0 04:32:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:55 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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:32:55 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 04:32:55 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 04:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:55 INFO - 'HOME': '/Users/cltbld', 04:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:55 INFO - 'LOGNAME': 'cltbld', 04:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:55 INFO - 'MOZ_NO_REMOTE': '1', 04:32:55 INFO - 'NO_EM_RESTART': '1', 04:32:55 INFO - 'PAGER': '/bin/cat', 04:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:55 INFO - 'PWD': '/builds/slave/test', 04:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:55 INFO - 'SHELL': '/bin/bash', 04:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:32:55 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:55 INFO - 'USER': 'cltbld', 04:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:55 INFO - 'XPC_FLAGS': '0x0', 04:32:55 INFO - 'XPC_SERVICE_NAME': '0', 04:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:55 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 04:32:55 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 04:32:55 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 04:32:55 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 04:32:55 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 04:32:55 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 04:32:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:58 INFO - Installing collected packages: mozsystemmonitor 04:32:58 INFO - Running setup.py install for mozsystemmonitor 04:32:58 INFO - Successfully installed mozsystemmonitor 04:32:58 INFO - Cleaning up... 04:32:58 INFO - Return code: 0 04:32:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:58 INFO - 'HOME': '/Users/cltbld', 04:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:58 INFO - 'LOGNAME': 'cltbld', 04:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:58 INFO - 'MOZ_NO_REMOTE': '1', 04:32:58 INFO - 'NO_EM_RESTART': '1', 04:32:58 INFO - 'PAGER': '/bin/cat', 04:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:58 INFO - 'PWD': '/builds/slave/test', 04:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:58 INFO - 'SHELL': '/bin/bash', 04:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:32:58 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:58 INFO - 'USER': 'cltbld', 04:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:58 INFO - 'XPC_FLAGS': '0x0', 04:32:58 INFO - 'XPC_SERVICE_NAME': '0', 04:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:58 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:01 INFO - warning: no files found matching '*.txt' 04:33:01 INFO - no previously-included directories found matching 'build' 04:33:01 INFO - no previously-included directories found matching 'dist' 04:33:01 INFO - no previously-included directories found matching '.git*' 04:33:01 INFO - Installing collected packages: jsonschema, functools32 04:33:01 INFO - Running setup.py install for functools32 04:33:02 INFO - warning: no files found matching '*.txt' 04:33:02 INFO - no previously-included directories found matching 'build' 04:33:02 INFO - no previously-included directories found matching 'dist' 04:33:02 INFO - no previously-included directories found matching '.git*' 04:33:02 INFO - Successfully installed jsonschema functools32 04:33:02 INFO - Cleaning up... 04:33:02 INFO - Return code: 0 04:33:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:02 INFO - 'HOME': '/Users/cltbld', 04:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:02 INFO - 'LOGNAME': 'cltbld', 04:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:02 INFO - 'MOZ_NO_REMOTE': '1', 04:33:02 INFO - 'NO_EM_RESTART': '1', 04:33:02 INFO - 'PAGER': '/bin/cat', 04:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:02 INFO - 'PWD': '/builds/slave/test', 04:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:02 INFO - 'SHELL': '/bin/bash', 04:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:02 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:02 INFO - 'USER': 'cltbld', 04:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:02 INFO - 'XPC_FLAGS': '0x0', 04:33:02 INFO - 'XPC_SERVICE_NAME': '0', 04:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:33:02 INFO - Cleaning up... 04:33:02 INFO - Return code: 0 04:33:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:02 INFO - 'HOME': '/Users/cltbld', 04:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:02 INFO - 'LOGNAME': 'cltbld', 04:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:02 INFO - 'MOZ_NO_REMOTE': '1', 04:33:02 INFO - 'NO_EM_RESTART': '1', 04:33:02 INFO - 'PAGER': '/bin/cat', 04:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:02 INFO - 'PWD': '/builds/slave/test', 04:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:02 INFO - 'SHELL': '/bin/bash', 04:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:02 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:02 INFO - 'USER': 'cltbld', 04:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:02 INFO - 'XPC_FLAGS': '0x0', 04:33:02 INFO - 'XPC_SERVICE_NAME': '0', 04:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33:05 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 04:33:05 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 04:33:05 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 04:33:05 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 04:33:05 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 04:33:05 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 04:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:06 INFO - Downloading docopt-0.6.1.tar.gz 04:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:06 INFO - Running setup.py install for blobuploader 04:33:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:06 INFO - Running setup.py install for requests 04:33:07 INFO - Running setup.py install for docopt 04:33:07 INFO - Successfully installed blobuploader requests docopt 04:33:07 INFO - Cleaning up... 04:33:07 INFO - Return code: 0 04:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:07 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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:33:07 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 04:33:07 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 04:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:07 INFO - 'HOME': '/Users/cltbld', 04:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:07 INFO - 'LOGNAME': 'cltbld', 04:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:07 INFO - 'MOZ_NO_REMOTE': '1', 04:33:07 INFO - 'NO_EM_RESTART': '1', 04:33:07 INFO - 'PAGER': '/bin/cat', 04:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:07 INFO - 'PWD': '/builds/slave/test', 04:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:07 INFO - 'SHELL': '/bin/bash', 04:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:07 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:07 INFO - 'USER': 'cltbld', 04:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:07 INFO - 'XPC_FLAGS': '0x0', 04:33:07 INFO - 'XPC_SERVICE_NAME': '0', 04:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:07 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-2gi2Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:07 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-3kYpm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-8oecga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-6KqOKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-tBEVb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-EZg6WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-tE02jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-q33jQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-miXkj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-SEqbpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-BqKI0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:08 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-OdPcX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-qSMq0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-3XzofG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-dsny62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-zBCCBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-RFS6DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:09 INFO - Running setup.py install for manifestparser 04:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:09 INFO - Running setup.py install for mozcrash 04:33:09 INFO - Running setup.py install for mozdebug 04:33:09 INFO - Running setup.py install for mozdevice 04:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Running setup.py install for mozfile 04:33:10 INFO - Running setup.py install for mozhttpd 04:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Running setup.py install for mozinfo 04:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Running setup.py install for mozInstall 04:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:10 INFO - Running setup.py install for mozleak 04:33:10 INFO - Running setup.py install for mozlog 04:33:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:11 INFO - Running setup.py install for moznetwork 04:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:11 INFO - Running setup.py install for mozprocess 04:33:11 INFO - Running setup.py install for mozprofile 04:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:11 INFO - Running setup.py install for mozrunner 04:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:11 INFO - Running setup.py install for mozscreenshot 04:33:11 INFO - Running setup.py install for moztest 04:33:11 INFO - Running setup.py install for mozversion 04:33:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:12 INFO - Cleaning up... 04:33:12 INFO - Return code: 0 04:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:12 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')]} 04:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:12 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')]} 04:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:12 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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:33:12 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 04:33:12 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 04:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:12 INFO - 'HOME': '/Users/cltbld', 04:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:12 INFO - 'LOGNAME': 'cltbld', 04:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:12 INFO - 'MOZ_NO_REMOTE': '1', 04:33:12 INFO - 'NO_EM_RESTART': '1', 04:33:12 INFO - 'PAGER': '/bin/cat', 04:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:12 INFO - 'PWD': '/builds/slave/test', 04:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:12 INFO - 'SHELL': '/bin/bash', 04:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:12 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:12 INFO - 'USER': 'cltbld', 04:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:12 INFO - 'XPC_FLAGS': '0x0', 04:33:12 INFO - 'XPC_SERVICE_NAME': '0', 04:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:12 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-pSkuck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:12 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)) 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:12 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-MQIwb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:12 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)) 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:12 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Cbo1oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:12 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)) 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:12 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-rPd1kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:12 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)) 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:12 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-cHHOtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:12 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)) 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:12 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-gnQ8Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-IDijr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-gTvyoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-MLcWGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-6UT24b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-CXLBM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-oerFrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-P992Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-iyl6Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:13 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)) 04:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:13 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-HXjpqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:14 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)) 04:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:14 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-6l358L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:14 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)) 04:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:14 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Ma6bmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:14 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)) 04:33:14 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)) 04:33:14 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)) 04:33:14 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)) 04:33:14 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)) 04:33:14 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)) 04:33:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:16 INFO - Downloading blessings-1.6.tar.gz 04:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:16 INFO - Installing collected packages: blessings 04:33:16 INFO - Running setup.py install for blessings 04:33:17 INFO - Successfully installed blessings 04:33:17 INFO - Cleaning up... 04:33:17 INFO - Return code: 0 04:33:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:17 INFO - Reading from file tmpfile_stdout 04:33:17 INFO - Current package versions: 04:33:17 INFO - blessings == 1.6 04:33:17 INFO - blobuploader == 1.2.4 04:33:17 INFO - docopt == 0.6.1 04:33:17 INFO - functools32 == 3.2.3-2 04:33:17 INFO - jsonschema == 2.5.1 04:33:17 INFO - manifestparser == 1.1 04:33:17 INFO - mozInstall == 1.12 04:33:17 INFO - mozcrash == 1.0 04:33:17 INFO - mozdebug == 0.1 04:33:17 INFO - mozdevice == 0.49 04:33:17 INFO - mozfile == 1.2 04:33:17 INFO - mozhttpd == 0.7 04:33:17 INFO - mozinfo == 0.9 04:33:17 INFO - mozleak == 0.1 04:33:17 INFO - mozlog == 3.4 04:33:17 INFO - moznetwork == 0.27 04:33:17 INFO - mozprocess == 0.25 04:33:17 INFO - mozprofile == 0.28 04:33:17 INFO - mozrunner == 6.13 04:33:17 INFO - mozscreenshot == 0.1 04:33:17 INFO - mozsystemmonitor == 0.3 04:33:17 INFO - moztest == 0.8 04:33:17 INFO - mozversion == 1.4 04:33:17 INFO - psutil == 3.1.1 04:33:17 INFO - requests == 1.2.3 04:33:17 INFO - wsgiref == 0.1.2 04:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:17 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')]} 04:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:17 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')]} 04:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:17 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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:33:17 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 04:33:17 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 04:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:17 INFO - 'HOME': '/Users/cltbld', 04:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:17 INFO - 'LOGNAME': 'cltbld', 04:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:17 INFO - 'MOZ_NO_REMOTE': '1', 04:33:17 INFO - 'NO_EM_RESTART': '1', 04:33:17 INFO - 'PAGER': '/bin/cat', 04:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:17 INFO - 'PWD': '/builds/slave/test', 04:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:17 INFO - 'SHELL': '/bin/bash', 04:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:17 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:17 INFO - 'USER': 'cltbld', 04:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:17 INFO - 'XPC_FLAGS': '0x0', 04:33:17 INFO - 'XPC_SERVICE_NAME': '0', 04:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 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)) 04:33:17 INFO - Cleaning up... 04:33:17 INFO - Return code: 0 04:33:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:17 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')]} 04:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:17 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')]} 04:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:17 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 0x109fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec30c9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, '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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 04:33:17 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 04:33:17 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 04:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:17 INFO - 'HOME': '/Users/cltbld', 04:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:17 INFO - 'LOGNAME': 'cltbld', 04:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:17 INFO - 'MOZ_NO_REMOTE': '1', 04:33:17 INFO - 'NO_EM_RESTART': '1', 04:33:17 INFO - 'PAGER': '/bin/cat', 04:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:17 INFO - 'PWD': '/builds/slave/test', 04:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:17 INFO - 'SHELL': '/bin/bash', 04:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:17 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:17 INFO - 'USER': 'cltbld', 04:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:17 INFO - 'XPC_FLAGS': '0x0', 04:33:17 INFO - 'XPC_SERVICE_NAME': '0', 04:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:33:18 INFO - Cleaning up... 04:33:18 INFO - Return code: 0 04:33:18 INFO - Running post-action listener: _resource_record_post_action 04:33:18 INFO - Running post-action listener: _start_resource_monitoring 04:33:18 INFO - Starting resource monitoring. 04:33:18 INFO - [mozharness: 2017-03-25 11:33:18.050191Z] Finished create-virtualenv step (success) 04:33:18 INFO - [mozharness: 2017-03-25 11:33:18.051137Z] Running install step. 04:33:18 INFO - Running pre-action listener: _resource_record_pre_action 04:33:18 INFO - Running main action method: install 04:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:18 INFO - Reading from file tmpfile_stdout 04:33:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:18 INFO - Reading from file tmpfile_stdout 04:33:18 INFO - Output received: 04:33:18 INFO - Usage: mozinstall [options] installer 04:33:18 INFO - Options: 04:33:18 INFO - -h, --help show this help message and exit 04:33:18 INFO - -d DEST, --destination=DEST 04:33:18 INFO - Directory to install application into. [default: 04:33:18 INFO - "/builds/slave/test"] 04:33:18 INFO - --app=APP Application being installed. [default: firefox] 04:33:18 INFO - mkdir: /builds/slave/test/build/application 04:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:39 INFO - Reading from file tmpfile_stdout 04:33:39 INFO - Output received: 04:33:39 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:33:39 INFO - Running post-action listener: _resource_record_post_action 04:33:39 INFO - [mozharness: 2017-03-25 11:33:39.608738Z] Finished install step (success) 04:33:39 INFO - [mozharness: 2017-03-25 11:33:39.608917Z] Running run-tests step. 04:33:39 INFO - Running pre-action listener: _resource_record_pre_action 04:33:39 INFO - Running main action method: run_tests 04:33:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:39 INFO - 2017-03-25 04:33:39.623 screenresolution[1676:11477] starting screenresolution argv=screenresolution get 04:33:39 INFO - 2017-03-25 04:33:39.626 screenresolution[1676:11477] Display 0: 1600x1200x32@60 04:33:39 INFO - 2017-03-25 04:33:39.632 screenresolution[1677:11480] starting screenresolution argv=screenresolution list 04:33:39 INFO - Available Modes on Display 0 04:33:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:39 INFO - Intel Iris: 04:33:39 INFO - Chipset Model: Intel Iris 04:33:39 INFO - Type: GPU 04:33:39 INFO - Bus: Built-In 04:33:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:39 INFO - Vendor: Intel (0x8086) 04:33:39 INFO - Device ID: 0x0a2e 04:33:39 INFO - Revision ID: 0x0009 04:33:39 INFO - Displays: 04:33:39 INFO - Display: 04:33:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:39 INFO - Display Serial Number: 1600x1200 60 04:33:39 INFO - Main Display: Yes 04:33:39 INFO - Mirror: Off 04:33:39 INFO - Online: Yes 04:33:39 INFO - Rotation: Supported 04:33:39 INFO - Return code: 0 04:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:39 INFO - Python 2.7.3 04:33:39 INFO - Return code: 0 04:33:39 INFO - grabbing minidump binary from tooltool 04:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:39 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 0x109dbad30>, '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 0x109ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109dafbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:39 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 04:33:39 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 04:33:39 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 04:33:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:39 INFO - Return code: 0 04:33:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:39 INFO - ENV: RUST_BACKTRACE is now 1 04:33:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 04:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0381 --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 04:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mn9grKQu2O/Render', 04:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:39 INFO - 'HOME': '/Users/cltbld', 04:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:39 INFO - 'LOGNAME': 'cltbld', 04:33:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:39 INFO - 'MOZ_NO_REMOTE': '1', 04:33:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:39 INFO - 'NO_EM_RESTART': '1', 04:33:39 INFO - 'PAGER': '/bin/cat', 04:33:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:39 INFO - 'PWD': '/builds/slave/test', 04:33:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:39 INFO - 'RUST_BACKTRACE': '1', 04:33:39 INFO - 'SHELL': '/bin/bash', 04:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YQYhzBnJXC/Listeners', 04:33:39 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 04:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:39 INFO - 'USER': 'cltbld', 04:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:39 INFO - 'XPC_FLAGS': '0x0', 04:33:39 INFO - 'XPC_SERVICE_NAME': '0', 04:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 04:33:40 INFO - mozversion application_buildid: 20170325030203 04:33:40 INFO - mozversion application_changeset: 65b0ac174753b22c01156d72fb42d2abd3176dd1 04:33:40 INFO - mozversion application_display_name: Nightly 04:33:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:40 INFO - mozversion application_name: Firefox 04:33:40 INFO - mozversion application_remotingname: firefox 04:33:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:40 INFO - mozversion application_vendor: Mozilla 04:33:40 INFO - mozversion application_version: 55.0a1 04:33:40 INFO - mozversion platform_buildid: 20170325030203 04:33:40 INFO - mozversion platform_changeset: 65b0ac174753b22c01156d72fb42d2abd3176dd1 04:33:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:40 INFO - mozversion platform_version: 55.0a1 04:33:40 INFO - using testdate: 1490441620 04:33:40 INFO - actual date: 1490441620 04:33:40 INFO - starting webserver on 'localhost:49248' 04:33:40 INFO - SUITE-START | Running 2 tests 04:33:40 INFO - TEST-START | dromaeo_css 04:33:40 INFO - operating with platform_type : mac_ 04:33:40 INFO - Initialising browser for dromaeo_css test... 04:33:40 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpai3pzS/profile http://localhost:49248/getInfo.html) 04:33:43 INFO - PID 1687 | __metrics Screen width/height:1600/1200 04:33:43 INFO - PID 1687 | colorDepth:24 04:33:43 INFO - PID 1687 | Browser inner width/height: 1024/689 04:33:43 INFO - PID 1687 | __metrics 04:33:43 INFO - PID 1687 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:43 INFO - PID 1687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:44 INFO - TEST-INFO | 1687: exit 0 04:33:44 INFO - Browser initialized. 04:33:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:44 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpai3pzS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:56 INFO - PID 1691 | RSS: Main: 234876928 04:33:56 INFO - PID 1691 | 04:37:00 INFO - PID 1691 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 04:37:02 INFO - PID 1691 | RSS: Main: 412119040 04:37:02 INFO - PID 1691 | 04:38:45 INFO - PID 1691 | ************************* 04:38:45 INFO - PID 1691 | A coding exception was thrown and uncaught in a Task. 04:38:45 INFO - PID 1691 | 04:38:45 ERROR - PID 1691 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:38:45 INFO - PID 1691 | Full stack: 04:38:45 INFO - PID 1691 | ************************* 04:40:05 INFO - PID 1691 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 04:40:06 INFO - PID 1691 | RSS: Main: 369119232 04:40:06 INFO - PID 1691 | 04:43:08 INFO - PID 1691 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 04:43:09 INFO - PID 1691 | RSS: Main: 360181760 04:43:09 INFO - PID 1691 | 04:46:11 INFO - PID 1691 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 04:46:12 INFO - PID 1691 | RSS: Main: 337571840 04:46:12 INFO - PID 1691 | 04:49:16 INFO - PID 1691 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 04:49:16 INFO - PID 1691 | RSS: Main: 333111296 04:49:16 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 04:52:20 INFO - PID 1691 | RSS: Main: 563122176 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | __start_tp_report 04:52:20 INFO - PID 1691 | _x_x_mozilla_page_load 04:52:20 INFO - PID 1691 | _x_x_mozilla_page_load_details 04:52:20 INFO - PID 1691 | |i|pagename|runs| 04:52:20 INFO - PID 1691 | |0;dojo.html;2936.721011503907;3477.6522347765226;3494.2138018945757;3532.222910959588;3544.1494041430064;6113.719560719397;6130.887362651064;6199.349068347826;6232.252129744431;6265.874682506347;6046.712972983609;6089.45194932456;6096.542759293048;6105.126180223406;6133.518290279282;5115;5413.972930135354;5580.497755202031;5616.52259557938;5791.507721843648;5631.18347839563;5663.603547751659;5734.684592347419;5736.684482353469;5748.080307150857;5385.78456861725;5425.810096646598;5456.290682211287;5516.531094856902;5541.113421852525;5496.258005169291;5510.421405752379;5512.255845460892;5585.525230355384;5623.915641265385;5445.101558242885;5459.071957767189;5488.725563721798;5504.724763761796;5518.889622207534;5974.462298393166;6050.183225264621;6056.909146362808;6079.726412311456;6083.513318934474;6504.154459920227;6521.902171467432;6525.053867189231;6527.706253218616;6529.314421985718;6497.415232629039;6624.304448032935;6634.502412319095;6637.867242655168;6641.302663220389;6102.298235702907;6111.205036150097;6176.227971503562;6185.752569897199;6187.195664563578;5695.914561281584;6461.547691661539;6569.211694596584;6648.16897887764;6696.8995465068065;6275.466585340206;6317.14718513004;6345.111684364193;6410.839729006812;6414.518911081687;6401;6541.672916354163;6546.70539825709;6563.638999855054;6576.8355791105605;6268.561200715906;6451.677416129175;6466.321036291216;6467.029945508118;6469.191351081115;5535.39110697831;6337.302896681362;6346.714397852015;6452.0967064610995;6465.903011454832;5244.5279924806955;5262.842114736564;5269.051570717231;5269.947300526946;5297.390800057966;4634.23535116702;4640.164770341371;4641.744704041243;4652.790624421841;4688.742119183409;6062.454379105901;6089.725962331706;6121.788327166048;6131.325554189036;6194;5494.36814766299;6379.106925030499;6402.9359706403275;6438.25960014595;6451.548391612542;6097.675918347081;6119.563485741643;6129.725578588854;6136.764169924236;6159.1069294951985;5789.131630255495;5793.275840519935;5797.884042319214;5806.970965145232;5858.062709966385;6688.36460536258;6701.0953521274005;6707.798766037026;6714.630695311805;6723.159605049369;6343;6396.360363963567;6408.551401401857;6533.640649764118;6534.215894092739;6625.834354140992;6690.732370705312;6712.39588437043;6712.463002959849;6715.529912906245;6469.7412103515335;6484.157059582413;6493.318201588954;6493.8701225976165;6504;6536.509761767791;6543.280239173782;6558.213014438298;6559.672016399257;6560.376764207393;6239.438450539473;6283.5601507895835;6300.495960323072;6307.053941908567;6317.842053948504;6380.521460890359;6391.552591318563;6403.903941440789;6408.231012278557;6413.1021656969;6257.4681152102585;6281.811545653638;6305.96847015762;6311.2426508819235;6324.905126423199;6114.145302971568;6178.505719542516;6381.266154392119;6386.105945167773;6388.616682999035;4903.725031491909;6172.598781079216;6207.6585787782105;6242.219722534684;6259.12372267892 04:52:20 INFO - PID 1691 | |1;ext.html;710.2542330552918;759.3014426727411;779.5439667794342;995.3629677006721;1097.9953342691438;27166.196732457447;27648.170554883334;27698.723012769868;27765.167044988684;27817.165485035457;27578.310542236453;27938.580921286197;37084.629153708454;37452;37586.43620345697;8558.400911936167;8720.694775682852;8726.956365218164;8729.34529910256;8765.7808554786;8632.266257368132;8792.47245165289;8800.911990880073;8805.867911981326;8832.646694132227;6111.052786818051;6225.564210505267;8506.914930850706;8726.301895848348;8741.825163496726;8703.60833762479;8777.824443511157;8786.73639790801;8795.560221988875;8801.64793408266;8508.276796472308;8602.31181505478;8607.913920860774;8611.698590549364;8616.439931404439;25460.108896188543;25812.09657661973;35086.47370289448;35480.29039419223;35577.64422355769;2870.354170311663;2878.136559032282;2899.2027192522014;2903.2596687844675;2941.911742647724;27658.446831063266;27792.30519237015;27864.721352786415;28157.01450449245;29010.854945725347;2782.7217278272215;2819.3233623930314;2833.107571115092;2871.4831330360525;2871.583620375034;325636.743632563;328579;329276.7072329294;330466;333147;49681;49772;49827.75086124546;49861.501384985684;49908.25137622938;51427;51498;51600.741996290526;51630.741846290526;51642.48357516452;13943.511977080754;14351.78472322916;14354.282285885663;14382;14388.712225755426;11497.482613282422;11524.135689823297;11524.827127593093;11536.134789890792;11563;10833.67498975032;12871.227726336263;12982;13018.739625207443;13071.477140914258;4809.519048095162;4832.178529649897;4849.951500485021;4853.611711063107;4867.245576935581;778.9415793815486;895.3061377432542;938.3900464698;974.6247694637616;976.9071938165863;22790.886045569667;23075.88462057679;23095.769042309697;23114.075436982668;23572.64641030386;955.8996305387973;1051.321897376188;1059.4490864750287;1090.487470888681;1096.8903109688968;9853.556589953469;10164.847527287096;11904.761904761855;12074.215176013531;12204.633860984184;355214;355267;355725;356251;356520;52654.68363290948;52661.7366913163;52664.68338291573;52762.68093297622;52828.47171528236;1423.4590855474853;1465;1469.4048910191602;1472.6244807574;1473.1087691946218;21570.784292157507;22402.551948960605;23023.769762302163;23369.76630233676;23380.298591042298;37540.24919501649;37644.68243611461;37696.811515942245;37701;37715.81142094272;358355.2082239572;361522.3847761489;362012;362205;363164;32130.518042229854;33170.33659326848;33188.50217246792;33222.16944576308;33311.00401927676;40511;40924.386134207416;41532.792336038125;42016.78991605023;42098;23239.651405228597;28257.43485130327;28912.42175156527;29002.129936101952;29315.12054638364;26678.733212667627;28211.858940705166;28969.420611588073;29053.983110591027;29101.272468188465;29212.561811572417;34107.82946085254;34421.82789086038;35190.824045879606;36024.459633106046;29491;29548.113556593336;29739.810407583453;30198;30585.23536911506;23932.88033559821;24059.157929472385;24208.87895560511;24318.75681243165;24673.25980220596 04:52:20 INFO - PID 1691 | |2;jquery.html;388.38053304978547;417.49274631322953;423.1874800383264;426.8143357639427;441.8740658912209;13233.735325293488;14985.850141498582;21278.89360553199;21529;21545.569088618216;21401;21676.674849877225;22045.559088818212;22993;23325.300240992754;5990.131430942511;6377;6384.3934826191435;6440.516961227903;6456.870862582746;6080.087986801971;6259.71831267594;6267.247930248376;6386.968065159667;6404.967975160118;6303.3066362700065;6306.905396419034;6309.400606942356;6312.810615681514;6324.494040476774;6135.631862088289;6230.127782110508;6233.781817636361;6295.716692748837;6308.93691063088;5065.936153407789;5484.698341591211;5614.691191984439;5614.971925140389;5620.831375058755;26588.867055664792;26933;27067.593986090225;27132.321691957663;27385.767640456226;1931.7971612980716;1937.2638397409034;1948.1136083082163;1960.6274807786474;2022.5853699991467;13028.80456793149;16153.273102710406;16472;16472.588185295343;17120.31518739249;1545.5749668841158;1600.447845493303;1633.787607611003;1668.799744030724;1707.1890851845399;104902;137515;142662;150140;170526;12215.633530993906;12331.375734099713;12355.196912200678;12372.566960156531;12546.309952952675;16289.348426062825;16290.185490725416;16301.673966520602;16328.101954392385;16343.509694709177;7008.684609192598;8804.515751633593;8806.842323630623;8971.282297416321;8998.460092394478;8342.916570834335;8353.37349698775;8372.874406883902;8522.48865068098;8541.743747687578;6539.82283189021;6877.277885821916;7708.884366734504;7717.421193410517;7763.883541746878;1805.2598434641995;1916.6070955454377;2039.3372154049994;2054.270733889448;2202.614542455096;870.6691457246205;899.910008999108;913.899471058183;916.5188276154938;958.7219706285239;16592.272594412774;17270.740938885927;20952.476188095116;21188.94055297229;21201.15195392167;927.3184209605935;950.4724877692809;952.1383148250844;961.1829944547079;966.7293157915794;10341.017603327671;10696.197785166143;10717.83923241152;10737.463126843626;10800.891991079989;689200.5539972268;691186;693723;698648;713083;102791;114298;124129;155402;159991.20004399904;1156.5142640091183;1165.7260543772206;1210.7336385995243;1210.9576164834364;1214.8056310990198;16916.23876925566;21360.35918922435;21749;22007.559848803256;22062.66905996379;59950.80344376026;61001.779964399575;61514.384856150864;61720.38279617146;62071.379286208365;67087.66456167688;86562.56718716366;87130;89254.55372723094;89687.55156224177;8038.397120216124;8055.959720201361;8383.329333653415;8393.286570641563;8873.467591944504;8523.74428767138;13213.405396757362;13366.264855433044;13686.247256400993;13711.177329360271;11296.548138074386;11491.885081149081;11648.767024659628;11663;11765.647030589096;10603.94698026505;10612.097971672494;10712.946435268086;10951.069159121564;11016.17378696617;9207.849018872641;11462.713432164262;11839.881601183877;11870.109741769575;11872.881271187178;7653.502522336031;8438.789030274293;8561.22948934599;8622.482651040958;8742.8429176002;11466.484008219484;11538;11761.000629892767;11791.528338866692;11806.881931180578 04:52:20 INFO - PID 1691 | |3;mootools.html;1335.6794369351355;1401.1312985948714;1417.348019910841;1425.2090090000045;1428.2715814934384;10481.842772358421;10923.508442120105;10924.399158046304;10930.180236482276;10946.945265273662;8820.426672266298;10727.409992450412;10772.676819695422;10988.835167472495;11009.504572294247;2295.6455691142223;2442.0476014354417;2492.9127480538186;2494.0397946790436;2496.987515062422;2288.6910267113976;2335.988320058397;2511.635812807151;2514.0697941761573;2515.987420062897;1986.9568476549782;2028.9797102028938;2098.8740675559516;2184.650455927052;2187.835912306575;2127.936161915145;2162.027087810484;2401.8558886466867;2487.7885379742743;2488.6267059940974;2476.170482888235;2479.2686157583557;2480.8263421560496;2484.850908945469;2492.1277552856536;10918.672439826818;10987.890121098766;11001.559937602486;11048.668539943814;11074.833877491845;5281.9207711884355;5450.700211488366;6131.693415329216;6210.882041232577;6386.42522173002;3654.196076863086;3987.983064318609;3997.8400863965408;4062.2484840304637;4075.796210189508;1052.6210564196883;1127.610974213895;1174.3071587763175;1201.285235285004;1204.175140029074;15193.392264309414;15372.385104595804;15414.306356213998;15422.845771542254;15432.459863904709;5120.718360490208;5369.24830523727;5446.2375267462585;5448.42791506894;5466.3440387153005;11360.431978401048;11367;11369.147313951487;11385.259958102697;11390.715232119263;5319.361676598833;6285.560010799291;6300.716467758962;6303.9684801575695;6307.211598550181;5683.318001839806;5791.594588378773;5845.386234445407;5919.348871624118;5952.5833191676165;3583.7491375603977;4055.8972386124638;4188.706790524695;4192.832286708497;4251.489821221473;1253.9498420063278;1256.1709271880516;1256.742367814614;1277;1281.8461784585722;752.6424948149695;752.8117970507374;777.3431450424382;787.5314188058096;791.3629528229715;6021.42796434338;6044.1840351552855;6058.091286307001;6145.907811382833;6195.070739389128;579.7130420441908;586.8356860079184;868.4919322196586;875.7810547363159;900.6622516556291;3675.4119340905327;3769.869039288257;3795.2978698940783;4035.556088830226;4040.9797951010055;13501.662458438617;14049.438022478986;14056.508022219174;14057.78913316301;14064.507742228972;13896.444142234197;13898.444062237599;13914.30428478572;13935.88512918964;13946.86053139476;9970.853351864484;9971.45157016371;10035.845877724156;10129.290949633454;10237.897621023694;6657.3342665733035;6743.9325606743305;6856.9314306856295;6939.444844412334;6958.199807022257;12395.442205100611;12471;12744.61766147017;12745.490180393052;12779.294004738522;12848.678783030498;13014.284214368301;13096.345182740633;13184.40670169864;13198.60404187876;8990.32572557074;9292.814143717223;9294.070592940652;9297.30270229749;9323.813523729352;9935.900640993497;10051.296409251574;10225.233107517115;10231.897681023393;10242.948785256027;7999.760037194244;8422.494650321001;8487.066422693375;8592.570371481526;8814.823703526023;7330.633468326456;7668.501547399401;8352.955880514935;8403.327733781405;8539.914600854161;7673.2710392514855;7761.650725717243;7779.338756205786;7842.725504607311;7889.6449659766595;4650.325702773147;5851.093080572518;6050.7277172526465;6069.514438844793;6151.661658608819;5481.232627432242;6079.969600151971;6094.878102437838;6107.54193435503;6179.876402472015 04:52:20 INFO - PID 1691 | |4;prototype.html;392.6426951474158;396.16409376216177;400.3587372843984;409.8811344710034;410.03027839160393;5207.765650545725;5375.543078838298;5503.6147469677135;6116.357782432841;6292.150559674443;4605.3092036194585;5561.416051314604;5964.970175149118;6089.421504957022;6135.29444113927;4100.753954762708;4728.219843725781;4773.92839107412;4788.3535722677425;4793.3049707792525;4795.5444232798;4797.880052998686;4814.2056560667625;4816.771723210576;4818.951810481903;3963.702722295825;4634.30485427187;4720.362751028619;4735.550122738335;4752.881177970561;4715.481297057321;4730.739809310504;4742.407199100113;4745.928811067837;4753.3582966299455;3471.444568868969;4185.204811085884;4214.7681877496725;4236.4492615959725;4237.8304867805255;5774.488097677524;5934.554908381845;5993.910091348634;6015.909761353583;6096.7561297548045;4955.513345996187;5174.715390653512;5515.310586176728;5517.296524702907;5530.391656917735;6022.397760223987;6106.6336019838955;6343.619382837044;6561.835954101138;6614.784047344146;3851.711121665858;3895.4935858338235;4048.2308361411237;4330.155619654137;4406.867793966154;5893.996041345963;6547.562529671913;6712.456135088859;6721.4958878084335;6962.930370696279;4292.163028209469;4363.192809330284;4400.515943246241;4438.844640437569;4440.178566965122;3797.9050523736573;4119.423280740699;4458.621017213508;4467.530909254547;4484.641228701696;4945.579625731782;5221.216817477409;5272.367315922113;5280.910667259696;5304.575633949275;6387.457066149429;6486.416222539994;6499.38255865692;6504.414602685781;6515.804525864231;1512.5840393891767;1533.3100104952816;1536.508317338441;1540.7072656195287;1543.3440787665197;977.3305285879195;1007.219404961161;1014.700663304327;1016.0804471952895;1024.7386916336436;5187.507186817246;6180.351063138306;6185.597936134137;6196.20310110063;6218.720157592919;6095.573309868267;6770.966145169243;6774.627395493197;6778.22050464193;6809.353111454404;5162.380514338303;5846;6055.212822333068;6159.5072394208355;6186.566940314135;3228.8869889553753;3298.9175270618425;3500.1599616092462;3531.52324436203;3538.893833184957;6447.645379504079;6855.691493882688;6928.549644273106;6928.757493487704;6958.590290757493;5826.679532625746;6080.604760690541;7019.403350715144;7026.683799229047;7033;5660.603757737002;5785.479306862402;6719.832004199934;6968.303169683194;6980;5763.7982670606325;6750.662466876538;6801.795946121624;6823.761168359084;6825.761098361533;5194.857111447671;6634.848446987835;6646.4350530205475;6684.933150668431;6791.049253104668;6037.45662890342;6650.767223147167;6829.009793580002;6895.241523432519;6926.515143939876;3638.7816730996224;4460.955390446184;4463.285874260103;4471.239889218906;4481.887952801206;5546.918350921532;6175.752969881334;6615.801525954229;6714.314274290323;6802.285759995327;6523.31505191967;6535.3464653534265;6535.856225160483;6550.377714117342;6557.409833115043;5140.946106048176;5292.576593872558;6380.585261957958;6522.836929076811;6546.639934803631;5409.675419474844;6316.536550745305;6399.456046236122;6403.6798160090875;6410.711517981796;6167.84580385494;6554.213494380705;6574.309697481887;6587.868242635216;6597.60414375139;6271.24745030581;6386.329435409215;6410.935890641221;6417.2299324081405;6436.517261205522 04:52:20 INFO - PID 1691 | |5;yui.html;614.2628845385537;682.4233522673339;686.1183379357526;688.1845013658811;720.614471257877;14416.567502974902;15586.766198507032;15827.287772050257;15828.05031698096;15841.970271932316;13775.931120344409;14421.278936053182;14617.561473155796;14623.561293161221;14644.67981945326;874.0560194989396;894.0165817600653;898.0435835834847;898.3486971945352;898.865170224465;871.7079778274285;884.186548375496;902.7833320003185;914.4284821986258;914.6935776514842;931.5901003558447;944.3106532231475;944.6788092048702;944.8204841080172;945.1871390604075;931.683227702581;941.4492521874712;941.5857022909897;941.9576119074658;942.3544871762864;691.7440546997593;696.1506961506954;696.9756058537978;697.1146643762444;700.8458139209416;14664;14718.190499522521;15489.92255038729;15812.841871581251;15825.446109386115;13951.860481395259;13990.370433330525;14256.786148207786;14401.20793356365;14485.42058317666;11666.883331166664;11744.177907546475;11751.294922304689;11952.581659641957;12211.816822747665;2927.8536073196256;2955.4827905116517;2991.760659147263;3077.538369244631;3118.23603217211;95106.52446737791;97101.21184139355;97597.0240297595;98029;99385.50307248489;11082.560052485402;11113.333200008025;11179.273347232403;11291.887081129247;11539.19225654196;23578.646320305208;23622.763772362057;23653;23707.7629223709;23871.403214919766;7529.435292352986;7579.696812127563;7589.544627322378;7686.231376862269;7718.228177182349;3558.181618227822;3924.60753924611;4018.799060046986;4023.2556976959354;4131.380292956081;4002.639762421396;4036.6972477064337;4038.8586399476467;4117.444145040441;4126.319157339066;686.2279935073043;753.2881427051384;753.857905273511;769.819092513259;778.5523324088672;532.9760160792696;549.7828357798647;549.8069189858018;566.8469513231487;592.570386469806;9525.476098814494;9682.806343873082;9955.900440995641;10003.799924001625;10038.247131465168;527.9656822306615;563.6111083352474;569.7094481814305;582.9766809327664;591.9674417906971;3808.733388662767;4408.953659571295;4471.888202794956;4675.44867300206;4768.737719425465;76631;95761;96143.51928240314;96235;99094.5045274769;71121.64439177874;71255.64372178106;71930.9210361845;85797;87072;62791.05813412803;69983.95024074643;71345.08186476691;71598;72115;8822.426542274732;10336.629707321887;10668.519916603927;10776.245662803842;10911.618093366695;24577;33897.830510847285;34001.65998339985;34377.453014614905;35556.798210576686;47701.522984769705;47802.04395912132;47846;47941;48080;12247;12553.497860085494;12618.684532886751;12710.173838700824;12840.871591283967;13920.303984800921;13945;14003.22982235946;14270.500532481314;14665.340059697553;13118.278494682503;13141.73716525645;13252.801207981694;13298.534551290659;13880.93059534696;13046.152000119962;13224.404901779251;13410.195388276734;13705.794413083613;13792.172469651452;12990.090693651731;13093.214407135602;13119.344032798514;13531.458741650618;13789.724205515633;9046;9193.908060919306;9531.259341929492;9541.188998934891;9713.56288966984;9295.488748118647;9438.716838494856;10675.004963271542;10998.615048473264;11028.669139925814 04:52:20 INFO - PID 1691 | __end_tp_report 04:52:20 INFO - PID 1691 | __start_cc_report 04:52:20 INFO - PID 1691 | _x_x_mozilla_cycle_collect,1992 04:52:20 INFO - PID 1691 | __end_cc_report 04:52:20 INFO - PID 1691 | __startTimestamp1490442740298__endTimestamp 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | ------- Summary: start ------- 04:52:20 INFO - PID 1691 | Number of tests: 6 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | [#0] dojo.html Cycles:165 Average:6029.72 Median:6239.44 stddev:671.81 (10.8%) stddev-sans-first:628.53 04:52:20 INFO - PID 1691 | Values: 2936.7 3477.7 3494.2 3532.2 3544.1 6113.7 6130.9 6199.3 6232.3 6265.9 6046.7 6089.5 6096.5 6105.1 6133.5 5115.0 5414.0 5580.5 5616.5 5791.5 5631.2 5663.6 5734.7 5736.7 5748.1 5385.8 5425.8 5456.3 5516.5 5541.1 5496.3 5510.4 5512.3 5585.5 5623.9 5445.1 5459.1 5488.7 5504.7 5518.9 5974.5 6050.2 6056.9 6079.7 6083.5 6504.2 6521.9 6525.1 6527.7 6529.3 6497.4 6624.3 6634.5 6637.9 6641.3 6102.3 6111.2 6176.2 6185.8 6187.2 5695.9 6461.5 6569.2 6648.2 6696.9 6275.5 6317.1 6345.1 6410.8 6414.5 6401.0 6541.7 6546.7 6563.6 6576.8 6268.6 6451.7 6466.3 6467.0 6469.2 5535.4 6337.3 6346.7 6452.1 6465.9 5244.5 5262.8 5269.1 5269.9 5297.4 4634.2 4640.2 4641.7 4652.8 4688.7 6062.5 6089.7 6121.8 6131.3 6194.0 5494.4 6379.1 6402.9 6438.3 6451.5 6097.7 6119.6 6129.7 6136.8 6159.1 5789.1 5793.3 5797.9 5807.0 5858.1 6688.4 6701.1 6707.8 6714.6 6723.2 6343.0 6396.4 6408.6 6533.6 6534.2 6625.8 6690.7 6712.4 6712.5 6715.5 6469.7 6484.2 6493.3 6493.9 6504.0 6536.5 6543.3 6558.2 6559.7 6560.4 6239.4 6283.6 6300.5 6307.1 6317.8 6380.5 6391.6 6403.9 6408.2 6413.1 6257.5 6281.8 6306.0 6311.2 6324.9 6114.1 6178.5 6381.3 6386.1 6388.6 4903.7 6172.6 6207.7 6242.2 6259.1 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | [#1] ext.html Cycles:180 Average:48069.64 Median:33205.34 stddev:92260.80 (277.8%) stddev-sans-first:92451.09 04:52:20 INFO - PID 1691 | Values: 710.3 759.3 779.5 995.4 1098.0 27166.2 27648.2 27698.7 27765.2 27817.2 27578.3 27938.6 37084.6 37452.0 37586.4 8558.4 8720.7 8727.0 8729.3 8765.8 8632.3 8792.5 8800.9 8805.9 8832.6 6111.1 6225.6 8506.9 8726.3 8741.8 8703.6 8777.8 8786.7 8795.6 8801.6 8508.3 8602.3 8607.9 8611.7 8616.4 25460.1 25812.1 35086.5 35480.3 35577.6 2870.4 2878.1 2899.2 2903.3 2941.9 27658.4 27792.3 27864.7 28157.0 29010.9 2782.7 2819.3 2833.1 2871.5 2871.6 325636.7 328579.0 329276.7 330466.0 333147.0 49681.0 49772.0 49827.8 49861.5 49908.3 51427.0 51498.0 51600.7 51630.7 51642.5 13943.5 14351.8 14354.3 14382.0 14388.7 11497.5 11524.1 11524.8 11536.1 11563.0 10833.7 12871.2 12982.0 13018.7 13071.5 4809.5 4832.2 4850.0 4853.6 4867.2 778.9 895.3 938.4 974.6 976.9 22790.9 23075.9 23095.8 23114.1 23572.6 955.9 1051.3 1059.4 1090.5 1096.9 9853.6 10164.8 11904.8 12074.2 12204.6 355214.0 355267.0 355725.0 356251.0 356520.0 52654.7 52661.7 52664.7 52762.7 52828.5 1423.5 1465.0 1469.4 1472.6 1473.1 21570.8 22402.6 23023.8 23369.8 23380.3 37540.2 37644.7 37696.8 37701.0 37715.8 358355.2 361522.4 362012.0 362205.0 363164.0 32130.5 33170.3 33188.5 33222.2 33311.0 40511.0 40924.4 41532.8 42016.8 42098.0 23239.7 28257.4 28912.4 29002.1 29315.1 26678.7 28211.9 28969.4 29054.0 29101.3 29212.6 34107.8 34421.8 35190.8 36024.5 29491.0 29548.1 29739.8 30198.0 30585.2 23932.9 24059.2 24208.9 24318.8 24673.3 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | [#2] jquery.html Cycles:180 Average:39350.27 Median:22527.83 stddev:116247.55 (516.0%) stddev-sans-first:116536.84 04:52:20 INFO - PID 1691 | Values: 388.4 417.5 423.2 426.8 441.9 13233.7 14985.9 21278.9 21529.0 21545.6 21401.0 21676.7 22045.6 22993.0 23325.3 5990.1 6377.0 6384.4 6440.5 6456.9 6080.1 6259.7 6267.2 6387.0 6405.0 6303.3 6306.9 6309.4 6312.8 6324.5 6135.6 6230.1 6233.8 6295.7 6308.9 5065.9 5484.7 5614.7 5615.0 5620.8 26588.9 26933.0 27067.6 27132.3 27385.8 1931.8 1937.3 1948.1 1960.6 2022.6 13028.8 16153.3 16472.0 16472.6 17120.3 1545.6 1600.4 1633.8 1668.8 1707.2 104902.0 137515.0 142662.0 150140.0 170526.0 12215.6 12331.4 12355.2 12372.6 12546.3 16289.3 16290.2 16301.7 16328.1 16343.5 7008.7 8804.5 8806.8 8971.3 8998.5 8342.9 8353.4 8372.9 8522.5 8541.7 6539.8 6877.3 7708.9 7717.4 7763.9 1805.3 1916.6 2039.3 2054.3 2202.6 870.7 899.9 913.9 916.5 958.7 16592.3 17270.7 20952.5 21188.9 21201.2 927.3 950.5 952.1 961.2 966.7 10341.0 10696.2 10717.8 10737.5 10800.9 689200.6 691186.0 693723.0 698648.0 713083.0 102791.0 114298.0 124129.0 155402.0 159991.2 1156.5 1165.7 1210.7 1211.0 1214.8 16916.2 21360.4 21749.0 22007.6 22062.7 59950.8 61001.8 61514.4 61720.4 62071.4 67087.7 86562.6 87130.0 89254.6 89687.6 8038.4 8056.0 8383.3 8393.3 8873.5 8523.7 13213.4 13366.3 13686.2 13711.2 11296.5 11491.9 11648.8 11663.0 11765.6 10603.9 10612.1 10712.9 10951.1 11016.2 9207.8 11462.7 11839.9 11870.1 11872.9 7653.5 8438.8 8561.2 8622.5 8742.8 11466.5 11538.0 11761.0 11791.5 11806.9 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | [#3] mootools.html Cycles:180 Average:6757.25 Median:3049.87 stddev:4247.58 (139.3%) stddev-sans-first:4239.96 04:52:20 INFO - PID 1691 | Values: 1335.7 1401.1 1417.3 1425.2 1428.3 10481.8 10923.5 10924.4 10930.2 10946.9 8820.4 10727.4 10772.7 10988.8 11009.5 2295.6 2442.0 2492.9 2494.0 2497.0 2288.7 2336.0 2511.6 2514.1 2516.0 1987.0 2029.0 2098.9 2184.7 2187.8 2127.9 2162.0 2401.9 2487.8 2488.6 2476.2 2479.3 2480.8 2484.9 2492.1 10918.7 10987.9 11001.6 11048.7 11074.8 5281.9 5450.7 6131.7 6210.9 6386.4 3654.2 3988.0 3997.8 4062.2 4075.8 1052.6 1127.6 1174.3 1201.3 1204.2 15193.4 15372.4 15414.3 15422.8 15432.5 5120.7 5369.2 5446.2 5448.4 5466.3 11360.4 11367.0 11369.1 11385.3 11390.7 5319.4 6285.6 6300.7 6304.0 6307.2 5683.3 5791.6 5845.4 5919.3 5952.6 3583.7 4055.9 4188.7 4192.8 4251.5 1253.9 1256.2 1256.7 1277.0 1281.8 752.6 752.8 777.3 787.5 791.4 6021.4 6044.2 6058.1 6145.9 6195.1 579.7 586.8 868.5 875.8 900.7 3675.4 3769.9 3795.3 4035.6 4041.0 13501.7 14049.4 14056.5 14057.8 14064.5 13896.4 13898.4 13914.3 13935.9 13946.9 9970.9 9971.5 10035.8 10129.3 10237.9 6657.3 6743.9 6856.9 6939.4 6958.2 12395.4 12471.0 12744.6 12745.5 12779.3 12848.7 13014.3 13096.3 13184.4 13198.6 8990.3 9292.8 9294.1 9297.3 9323.8 9935.9 10051.3 10225.2 10231.9 10242.9 7999.8 8422.5 8487.1 8592.6 8814.8 7330.6 7668.5 8353.0 8403.3 8539.9 7673.3 7761.7 7779.3 7842.7 7889.6 4650.3 5851.1 6050.7 6069.5 6151.7 5481.2 6080.0 6094.9 6107.5 6179.9 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | [#4] prototype.html Cycles:180 Average:5262.94 Median:5836.34 stddev:1630.69 (27.9%) stddev-sans-first:1593.77 04:52:20 INFO - PID 1691 | Values: 392.6 396.2 400.4 409.9 410.0 5207.8 5375.5 5503.6 6116.4 6292.2 4605.3 5561.4 5965.0 6089.4 6135.3 4100.8 4728.2 4773.9 4788.4 4793.3 4795.5 4797.9 4814.2 4816.8 4819.0 3963.7 4634.3 4720.4 4735.6 4752.9 4715.5 4730.7 4742.4 4745.9 4753.4 3471.4 4185.2 4214.8 4236.4 4237.8 5774.5 5934.6 5993.9 6015.9 6096.8 4955.5 5174.7 5515.3 5517.3 5530.4 6022.4 6106.6 6343.6 6561.8 6614.8 3851.7 3895.5 4048.2 4330.2 4406.9 5894.0 6547.6 6712.5 6721.5 6962.9 4292.2 4363.2 4400.5 4438.8 4440.2 3797.9 4119.4 4458.6 4467.5 4484.6 4945.6 5221.2 5272.4 5280.9 5304.6 6387.5 6486.4 6499.4 6504.4 6515.8 1512.6 1533.3 1536.5 1540.7 1543.3 977.3 1007.2 1014.7 1016.1 1024.7 5187.5 6180.4 6185.6 6196.2 6218.7 6095.6 6771.0 6774.6 6778.2 6809.4 5162.4 5846.0 6055.2 6159.5 6186.6 3228.9 3298.9 3500.2 3531.5 3538.9 6447.6 6855.7 6928.5 6928.8 6958.6 5826.7 6080.6 7019.4 7026.7 7033.0 5660.6 5785.5 6719.8 6968.3 6980.0 5763.8 6750.7 6801.8 6823.8 6825.8 5194.9 6634.8 6646.4 6684.9 6791.0 6037.5 6650.8 6829.0 6895.2 6926.5 3638.8 4461.0 4463.3 4471.2 4481.9 5546.9 6175.8 6615.8 6714.3 6802.3 6523.3 6535.3 6535.9 6550.4 6557.4 5140.9 5292.6 6380.6 6522.8 6546.6 5409.7 6316.5 6399.5 6403.7 6410.7 6167.8 6554.2 6574.3 6587.9 6597.6 6271.2 6386.3 6410.9 6417.2 6436.5 04:52:20 INFO - PID 1691 | 04:52:20 INFO - PID 1691 | [#5] yui.html Cycles:180 Average:18345.93 Median:4440.42 stddev:25593.67 (576.4%) stddev-sans-first:25630.84 04:52:20 INFO - PID 1691 | Values: 614.3 682.4 686.1 688.2 720.6 14416.6 15586.8 15827.3 15828.1 15842.0 13775.9 14421.3 14617.6 14623.6 14644.7 874.1 894.0 898.0 898.3 898.9 871.7 884.2 902.8 914.4 914.7 931.6 944.3 944.7 944.8 945.2 931.7 941.4 941.6 942.0 942.4 691.7 696.2 697.0 697.1 700.8 14664.0 14718.2 15489.9 15812.8 15825.4 13951.9 13990.4 14256.8 14401.2 14485.4 11666.9 11744.2 11751.3 11952.6 12211.8 2927.9 2955.5 2991.8 3077.5 3118.2 95106.5 97101.2 97597.0 98029.0 99385.5 11082.6 11113.3 11179.3 11291.9 11539.2 23578.6 23622.8 23653.0 23707.8 23871.4 7529.4 7579.7 7589.5 7686.2 7718.2 3558.2 3924.6 4018.8 4023.3 4131.4 4002.6 4036.7 4038.9 4117.4 4126.3 686.2 753.3 753.9 769.8 778.6 533.0 549.8 549.8 566.8 592.6 9525.5 9682.8 9955.9 10003.8 10038.2 528.0 563.6 569.7 583.0 592.0 3808.7 4409.0 4471.9 4675.4 4768.7 76631.0 95761.0 96143.5 96235.0 99094.5 71121.6 71255.6 71930.9 85797.0 87072.0 62791.1 69984.0 71345.1 71598.0 72115.0 8822.4 10336.6 10668.5 10776.2 10911.6 24577.0 33897.8 34001.7 34377.5 35556.8 47701.5 47802.0 47846.0 47941.0 48080.0 12247.0 12553.5 12618.7 12710.2 12840.9 13920.3 13945.0 14003.2 14270.5 14665.3 13118.3 13141.7 13252.8 13298.5 13880.9 13046.2 13224.4 13410.2 13705.8 13792.2 12990.1 13093.2 13119.3 13531.5 13789.7 9046.0 9193.9 9531.3 9541.2 9713.6 9295.5 9438.7 10675.0 10998.6 11028.7 04:52:20 INFO - PID 1691 | -------- Summary: end -------- 04:52:20 INFO - PID 1691 | 04:52:20 INFO - TEST-INFO | 1691: exit 0 04:52:21 INFO - TEST-OK | dromaeo_css | took 1120783ms 04:52:21 INFO - TEST-START | kraken 04:52:21 INFO - operating with platform_type : mac_ 04:52:21 INFO - Initialising browser for kraken test... 04:52:21 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpakmno8/profile http://localhost:49248/getInfo.html) 04:52:23 INFO - PID 1698 | __metrics Screen width/height:1600/1200 04:52:23 INFO - PID 1698 | colorDepth:24 04:52:23 INFO - PID 1698 | Browser inner width/height: 1024/689 04:52:23 INFO - PID 1698 | __metrics 04:52:23 INFO - PID 1698 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:52:23 INFO - PID 1698 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:24 INFO - TEST-INFO | 1698: exit 0 04:52:24 INFO - Browser initialized. 04:52:24 INFO - Running cycle 1/1 for kraken test... 04:52:24 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpakmno8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:36 INFO - PID 1700 | RSS: Main: 233963520 04:52:36 INFO - PID 1700 | 04:52:39 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:40 INFO - PID 1700 | RSS: Main: 284860416 04:52:40 INFO - PID 1700 | 04:52:42 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 04:52:43 INFO - PID 1700 | RSS: Main: 287019008 04:52:43 INFO - PID 1700 | 04:52:46 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 04:52:47 INFO - PID 1700 | RSS: Main: 377585664 04:52:47 INFO - PID 1700 | 04:52:49 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 04:52:49 INFO - PID 1700 | RSS: Main: 281645056 04:52:49 INFO - PID 1700 | 04:52:51 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:52 INFO - PID 1700 | RSS: Main: 284856320 04:52:52 INFO - PID 1700 | 04:52:55 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:56 INFO - PID 1700 | RSS: Main: 326676480 04:52:56 INFO - PID 1700 | 04:52:59 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:59 INFO - PID 1700 | RSS: Main: 333058048 04:52:59 INFO - PID 1700 | 04:53:02 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 04:53:03 INFO - PID 1700 | RSS: Main: 332840960 04:53:03 INFO - PID 1700 | 04:53:05 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:05 INFO - PID 1700 | RSS: Main: 304054272 04:53:05 INFO - PID 1700 | 04:53:07 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:08 INFO - PID 1700 | RSS: Main: 304873472 04:53:08 INFO - PID 1700 | 04:53:10 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:11 INFO - PID 1700 | RSS: Main: 306196480 04:53:11 INFO - PID 1700 | 04:53:14 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:14 INFO - PID 1700 | RSS: Main: 325201920 04:53:14 INFO - PID 1700 | 04:53:17 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:18 INFO - PID 1700 | RSS: Main: 319111168 04:53:18 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 04:53:20 INFO - PID 1700 | RSS: Main: 381657088 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | __start_tp_report 04:53:20 INFO - PID 1700 | _x_x_mozilla_page_load 04:53:20 INFO - PID 1700 | _x_x_mozilla_page_load_details 04:53:20 INFO - PID 1700 | |i|pagename|runs| 04:53:20 INFO - PID 1700 | |0;ai-astar;113;110;111;113;112;110;113;113;111;113 04:53:20 INFO - PID 1700 | |1;audio-beat-detection;140;108;110;149;113;110;104;109;132;110 04:53:20 INFO - PID 1700 | |2;audio-dft;187;184;186;182;186;183;182;184;185;185 04:53:20 INFO - PID 1700 | |3;audio-fft;80;60;58;93;56;58;58;61;78;56 04:53:20 INFO - PID 1700 | |4;audio-oscillator;90;70;87;70;70;71;113;102;75;85 04:53:20 INFO - PID 1700 | |5;imaging-gaussian-blur;91;90;95;131;130;90;90;91;90;90 04:53:20 INFO - PID 1700 | |6;imaging-darkroom;97;98;97;96;96;97;97;95;97;97 04:53:20 INFO - PID 1700 | |7;imaging-desaturate;85;85;85;82;83;84;83;85;86;84 04:53:20 INFO - PID 1700 | |8;json-parse-financial;63;63;61;79;84;94;94;92;64;63 04:53:20 INFO - PID 1700 | |9;json-stringify-tinderbox;55;70;63;64;60;57;56;54;56;59 04:53:20 INFO - PID 1700 | |10;stanford-crypto-aes;81;82;84;83;83;81;81;80;82;83 04:53:20 INFO - PID 1700 | |11;stanford-crypto-ccm;143;127;142;142;146;140;137;138;182;152 04:53:20 INFO - PID 1700 | |12;stanford-crypto-pbkdf2;186;185;185;184;189;187;187;187;184;180 04:53:20 INFO - PID 1700 | |13;stanford-crypto-sha256-iterative;67;68;68;83;90;96;72;67;68;66 04:53:20 INFO - PID 1700 | __end_tp_report 04:53:20 INFO - PID 1700 | __start_cc_report 04:53:20 INFO - PID 1700 | _x_x_mozilla_cycle_collect,2141 04:53:20 INFO - PID 1700 | __end_cc_report 04:53:20 INFO - PID 1700 | __startTimestamp1490442800661__endTimestamp 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | ------- Summary: start ------- 04:53:20 INFO - PID 1700 | Number of tests: 14 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:1.29 (1.1%) stddev-sans-first:1.30 04:53:20 INFO - PID 1700 | Values: 113.0 110.0 111.0 113.0 112.0 110.0 113.0 113.0 111.0 113.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:111.50 stddev:15.75 (14.1%) stddev-sans-first:14.66 04:53:20 INFO - PID 1700 | Values: 140.0 108.0 110.0 149.0 113.0 110.0 104.0 109.0 132.0 110.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.71 (0.9%) stddev-sans-first:1.54 04:53:20 INFO - PID 1700 | Values: 187.0 184.0 186.0 182.0 186.0 183.0 182.0 184.0 185.0 185.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:13.00 (21.5%) stddev-sans-first:12.74 04:53:20 INFO - PID 1700 | Values: 80.0 60.0 58.0 93.0 56.0 58.0 58.0 61.0 78.0 56.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:73.00 stddev:15.07 (20.6%) stddev-sans-first:15.79 04:53:20 INFO - PID 1700 | Values: 90.0 70.0 87.0 70.0 70.0 71.0 113.0 102.0 75.0 85.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:90.00 stddev:16.78 (18.6%) stddev-sans-first:17.56 04:53:20 INFO - PID 1700 | Values: 91.0 90.0 95.0 131.0 130.0 90.0 90.0 91.0 90.0 90.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 04:53:20 INFO - PID 1700 | Values: 97.0 98.0 97.0 96.0 96.0 97.0 97.0 95.0 97.0 97.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:85.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 04:53:20 INFO - PID 1700 | Values: 85.0 85.0 85.0 82.0 83.0 84.0 83.0 85.0 86.0 84.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#8] json-parse-financial Cycles:10 Average:75.70 Median:81.50 stddev:14.35 (17.6%) stddev-sans-first:14.46 04:53:20 INFO - PID 1700 | Values: 63.0 63.0 61.0 79.0 84.0 94.0 94.0 92.0 64.0 63.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:4.99 (8.4%) stddev-sans-first:5.04 04:53:20 INFO - PID 1700 | Values: 55.0 70.0 63.0 64.0 60.0 57.0 56.0 54.0 56.0 59.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.25 (1.5%) stddev-sans-first:1.27 04:53:20 INFO - PID 1700 | Values: 81.0 82.0 84.0 83.0 83.0 81.0 81.0 80.0 82.0 83.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:142.50 stddev:14.54 (10.2%) stddev-sans-first:15.41 04:53:20 INFO - PID 1700 | Values: 143.0 127.0 142.0 142.0 146.0 140.0 137.0 138.0 182.0 152.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:186.50 stddev:2.46 (1.3%) stddev-sans-first:2.60 04:53:20 INFO - PID 1700 | Values: 186.0 185.0 185.0 184.0 189.0 187.0 187.0 187.0 184.0 180.0 04:53:20 INFO - PID 1700 | 04:53:20 INFO - PID 1700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:70.00 stddev:11.02 (15.7%) stddev-sans-first:11.35 04:53:20 INFO - PID 1700 | Values: 67.0 68.0 68.0 83.0 90.0 96.0 72.0 67.0 68.0 66.0 04:53:20 INFO - PID 1700 | -------- Summary: end -------- 04:53:20 INFO - PID 1700 | 04:53:21 INFO - TEST-INFO | 1700: exit 0 04:53:21 INFO - TEST-OK | kraken | took 60725ms 04:53:21 INFO - SUITE-END | took 1181s 04:53:21 INFO - Completed test suite (00:19:41) 04:53:21 INFO - javascript benchmark 04:53:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7499.367878531055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2936.721011503907, 3477.6522347765226, 3494.2138018945757, 3532.222910959588, 3544.1494041430064, 6113.719560719397, 6130.887362651064, 6199.349068347826, 6232.252129744431, 6265.874682506347, 6046.712972983609, 6089.45194932456, 6096.542759293048, 6105.126180223406, 6133.518290279282, 5115.0, 5413.972930135354, 5580.497755202031, 5616.52259557938, 5791.507721843648, 5631.18347839563, 5663.603547751659, 5734.684592347419, 5736.684482353469, 5748.080307150857, 5385.78456861725, 5425.810096646598, 5456.290682211287, 5516.531094856902, 5541.113421852525, 5496.258005169291, 5510.421405752379, 5512.255845460892, 5585.525230355384, 5623.915641265385, 5445.101558242885, 5459.071957767189, 5488.725563721798, 5504.724763761796, 5518.889622207534, 5974.462298393166, 6050.183225264621, 6056.909146362808, 6079.726412311456, 6083.513318934474, 6504.154459920227, 6521.902171467432, 6525.053867189231, 6527.706253218616, 6529.314421985718, 6497.415232629039, 6624.304448032935, 6634.502412319095, 6637.867242655168, 6641.302663220389, 6102.298235702907, 6111.205036150097, 6176.227971503562, 6185.752569897199, 6187.195664563578, 5695.914561281584, 6461.547691661539, 6569.211694596584, 6648.16897887764, 6696.8995465068065, 6275.466585340206, 6317.14718513004, 6345.111684364193, 6410.839729006812, 6414.518911081687, 6401.0, 6541.672916354163, 6546.70539825709, 6563.638999855054, 6576.8355791105605, 6268.561200715906, 6451.677416129175, 6466.321036291216, 6467.029945508118, 6469.191351081115, 5535.39110697831, 6337.302896681362, 6346.714397852015, 6452.0967064610995, 6465.903011454832, 5244.5279924806955, 5262.842114736564, 5269.051570717231, 5269.947300526946, 5297.390800057966, 4634.23535116702, 4640.164770341371, 4641.744704041243, 4652.790624421841, 4688.742119183409, 6062.454379105901, 6089.725962331706, 6121.788327166048, 6131.325554189036, 6194.0, 5494.36814766299, 6379.106925030499, 6402.9359706403275, 6438.25960014595, 6451.548391612542, 6097.675918347081, 6119.563485741643, 6129.725578588854, 6136.764169924236, 6159.1069294951985, 5789.131630255495, 5793.275840519935, 5797.884042319214, 5806.970965145232, 5858.062709966385, 6688.36460536258, 6701.0953521274005, 6707.798766037026, 6714.630695311805, 6723.159605049369, 6343.0, 6396.360363963567, 6408.551401401857, 6533.640649764118, 6534.215894092739, 6625.834354140992, 6690.732370705312, 6712.39588437043, 6712.463002959849, 6715.529912906245, 6469.7412103515335, 6484.157059582413, 6493.318201588954, 6493.8701225976165, 6504.0, 6536.509761767791, 6543.280239173782, 6558.213014438298, 6559.672016399257, 6560.376764207393, 6239.438450539473, 6283.5601507895835, 6300.495960323072, 6307.053941908567, 6317.842053948504, 6380.521460890359, 6391.552591318563, 6403.903941440789, 6408.231012278557, 6413.1021656969, 6257.4681152102585, 6281.811545653638, 6305.96847015762, 6311.2426508819235, 6324.905126423199, 6114.145302971568, 6178.505719542516, 6381.266154392119, 6386.105945167773, 6388.616682999035, 4903.725031491909, 6172.598781079216, 6207.6585787782105, 6242.219722534684, 6259.12372267892], "value": 5986.356760029419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.2542330552918, 759.3014426727411, 779.5439667794342, 995.3629677006721, 1097.9953342691438, 27166.196732457447, 27648.170554883334, 27698.723012769868, 27765.167044988684, 27817.165485035457, 27578.310542236453, 27938.580921286197, 37084.629153708454, 37452.0, 37586.43620345697, 8558.400911936167, 8720.694775682852, 8726.956365218164, 8729.34529910256, 8765.7808554786, 8632.266257368132, 8792.47245165289, 8800.911990880073, 8805.867911981326, 8832.646694132227, 6111.052786818051, 6225.564210505267, 8506.914930850706, 8726.301895848348, 8741.825163496726, 8703.60833762479, 8777.824443511157, 8786.73639790801, 8795.560221988875, 8801.64793408266, 8508.276796472308, 8602.31181505478, 8607.913920860774, 8611.698590549364, 8616.439931404439, 25460.108896188543, 25812.09657661973, 35086.47370289448, 35480.29039419223, 35577.64422355769, 2870.354170311663, 2878.136559032282, 2899.2027192522014, 2903.2596687844675, 2941.911742647724, 27658.446831063266, 27792.30519237015, 27864.721352786415, 28157.01450449245, 29010.854945725347, 2782.7217278272215, 2819.3233623930314, 2833.107571115092, 2871.4831330360525, 2871.583620375034, 325636.743632563, 328579.0, 329276.7072329294, 330466.0, 333147.0, 49681.0, 49772.0, 49827.75086124546, 49861.501384985684, 49908.25137622938, 51427.0, 51498.0, 51600.741996290526, 51630.741846290526, 51642.48357516452, 13943.511977080754, 14351.78472322916, 14354.282285885663, 14382.0, 14388.712225755426, 11497.482613282422, 11524.135689823297, 11524.827127593093, 11536.134789890792, 11563.0, 10833.67498975032, 12871.227726336263, 12982.0, 13018.739625207443, 13071.477140914258, 4809.519048095162, 4832.178529649897, 4849.951500485021, 4853.611711063107, 4867.245576935581, 778.9415793815486, 895.3061377432542, 938.3900464698, 974.6247694637616, 976.9071938165863, 22790.886045569667, 23075.88462057679, 23095.769042309697, 23114.075436982668, 23572.64641030386, 955.8996305387973, 1051.321897376188, 1059.4490864750287, 1090.487470888681, 1096.8903109688968, 9853.556589953469, 10164.847527287096, 11904.761904761855, 12074.215176013531, 12204.633860984184, 355214.0, 355267.0, 355725.0, 356251.0, 356520.0, 52654.68363290948, 52661.7366913163, 52664.68338291573, 52762.68093297622, 52828.47171528236, 1423.4590855474853, 1465.0, 1469.4048910191602, 1472.6244807574, 1473.1087691946218, 21570.784292157507, 22402.551948960605, 23023.769762302163, 23369.76630233676, 23380.298591042298, 37540.24919501649, 37644.68243611461, 37696.811515942245, 37701.0, 37715.81142094272, 358355.2082239572, 361522.3847761489, 362012.0, 362205.0, 363164.0, 32130.518042229854, 33170.33659326848, 33188.50217246792, 33222.16944576308, 33311.00401927676, 40511.0, 40924.386134207416, 41532.792336038125, 42016.78991605023, 42098.0, 23239.651405228597, 28257.43485130327, 28912.42175156527, 29002.129936101952, 29315.12054638364, 26678.733212667627, 28211.858940705166, 28969.420611588073, 29053.983110591027, 29101.272468188465, 29212.561811572417, 34107.82946085254, 34421.82789086038, 35190.824045879606, 36024.459633106046, 29491.0, 29548.113556593336, 29739.810407583453, 30198.0, 30585.23536911506, 23932.88033559821, 24059.157929472385, 24208.87895560511, 24318.75681243165, 24673.25980220596], "value": 16774.88088375751, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.38053304978547, 417.49274631322953, 423.1874800383264, 426.8143357639427, 441.8740658912209, 13233.735325293488, 14985.850141498582, 21278.89360553199, 21529.0, 21545.569088618216, 21401.0, 21676.674849877225, 22045.559088818212, 22993.0, 23325.300240992754, 5990.131430942511, 6377.0, 6384.3934826191435, 6440.516961227903, 6456.870862582746, 6080.087986801971, 6259.71831267594, 6267.247930248376, 6386.968065159667, 6404.967975160118, 6303.3066362700065, 6306.905396419034, 6309.400606942356, 6312.810615681514, 6324.494040476774, 6135.631862088289, 6230.127782110508, 6233.781817636361, 6295.716692748837, 6308.93691063088, 5065.936153407789, 5484.698341591211, 5614.691191984439, 5614.971925140389, 5620.831375058755, 26588.867055664792, 26933.0, 27067.593986090225, 27132.321691957663, 27385.767640456226, 1931.7971612980716, 1937.2638397409034, 1948.1136083082163, 1960.6274807786474, 2022.5853699991467, 13028.80456793149, 16153.273102710406, 16472.0, 16472.588185295343, 17120.31518739249, 1545.5749668841158, 1600.447845493303, 1633.787607611003, 1668.799744030724, 1707.1890851845399, 104902.0, 137515.0, 142662.0, 150140.0, 170526.0, 12215.633530993906, 12331.375734099713, 12355.196912200678, 12372.566960156531, 12546.309952952675, 16289.348426062825, 16290.185490725416, 16301.673966520602, 16328.101954392385, 16343.509694709177, 7008.684609192598, 8804.515751633593, 8806.842323630623, 8971.282297416321, 8998.460092394478, 8342.916570834335, 8353.37349698775, 8372.874406883902, 8522.48865068098, 8541.743747687578, 6539.82283189021, 6877.277885821916, 7708.884366734504, 7717.421193410517, 7763.883541746878, 1805.2598434641995, 1916.6070955454377, 2039.3372154049994, 2054.270733889448, 2202.614542455096, 870.6691457246205, 899.910008999108, 913.899471058183, 916.5188276154938, 958.7219706285239, 16592.272594412774, 17270.740938885927, 20952.476188095116, 21188.94055297229, 21201.15195392167, 927.3184209605935, 950.4724877692809, 952.1383148250844, 961.1829944547079, 966.7293157915794, 10341.017603327671, 10696.197785166143, 10717.83923241152, 10737.463126843626, 10800.891991079989, 689200.5539972268, 691186.0, 693723.0, 698648.0, 713083.0, 102791.0, 114298.0, 124129.0, 155402.0, 159991.20004399904, 1156.5142640091183, 1165.7260543772206, 1210.7336385995243, 1210.9576164834364, 1214.8056310990198, 16916.23876925566, 21360.35918922435, 21749.0, 22007.559848803256, 22062.66905996379, 59950.80344376026, 61001.779964399575, 61514.384856150864, 61720.38279617146, 62071.379286208365, 67087.66456167688, 86562.56718716366, 87130.0, 89254.55372723094, 89687.55156224177, 8038.397120216124, 8055.959720201361, 8383.329333653415, 8393.286570641563, 8873.467591944504, 8523.74428767138, 13213.405396757362, 13366.264855433044, 13686.247256400993, 13711.177329360271, 11296.548138074386, 11491.885081149081, 11648.767024659628, 11663.0, 11765.647030589096, 10603.94698026505, 10612.097971672494, 10712.946435268086, 10951.069159121564, 11016.17378696617, 9207.849018872641, 11462.713432164262, 11839.881601183877, 11870.109741769575, 11872.881271187178, 7653.502522336031, 8438.789030274293, 8561.22948934599, 8622.482651040958, 8742.8429176002, 11466.484008219484, 11538.0, 11761.000629892767, 11791.528338866692, 11806.881931180578], "value": 10172.45195585533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.6794369351355, 1401.1312985948714, 1417.348019910841, 1425.2090090000045, 1428.2715814934384, 10481.842772358421, 10923.508442120105, 10924.399158046304, 10930.180236482276, 10946.945265273662, 8820.426672266298, 10727.409992450412, 10772.676819695422, 10988.835167472495, 11009.504572294247, 2295.6455691142223, 2442.0476014354417, 2492.9127480538186, 2494.0397946790436, 2496.987515062422, 2288.6910267113976, 2335.988320058397, 2511.635812807151, 2514.0697941761573, 2515.987420062897, 1986.9568476549782, 2028.9797102028938, 2098.8740675559516, 2184.650455927052, 2187.835912306575, 2127.936161915145, 2162.027087810484, 2401.8558886466867, 2487.7885379742743, 2488.6267059940974, 2476.170482888235, 2479.2686157583557, 2480.8263421560496, 2484.850908945469, 2492.1277552856536, 10918.672439826818, 10987.890121098766, 11001.559937602486, 11048.668539943814, 11074.833877491845, 5281.9207711884355, 5450.700211488366, 6131.693415329216, 6210.882041232577, 6386.42522173002, 3654.196076863086, 3987.983064318609, 3997.8400863965408, 4062.2484840304637, 4075.796210189508, 1052.6210564196883, 1127.610974213895, 1174.3071587763175, 1201.285235285004, 1204.175140029074, 15193.392264309414, 15372.385104595804, 15414.306356213998, 15422.845771542254, 15432.459863904709, 5120.718360490208, 5369.24830523727, 5446.2375267462585, 5448.42791506894, 5466.3440387153005, 11360.431978401048, 11367.0, 11369.147313951487, 11385.259958102697, 11390.715232119263, 5319.361676598833, 6285.560010799291, 6300.716467758962, 6303.9684801575695, 6307.211598550181, 5683.318001839806, 5791.594588378773, 5845.386234445407, 5919.348871624118, 5952.5833191676165, 3583.7491375603977, 4055.8972386124638, 4188.706790524695, 4192.832286708497, 4251.489821221473, 1253.9498420063278, 1256.1709271880516, 1256.742367814614, 1277.0, 1281.8461784585722, 752.6424948149695, 752.8117970507374, 777.3431450424382, 787.5314188058096, 791.3629528229715, 6021.42796434338, 6044.1840351552855, 6058.091286307001, 6145.907811382833, 6195.070739389128, 579.7130420441908, 586.8356860079184, 868.4919322196586, 875.7810547363159, 900.6622516556291, 3675.4119340905327, 3769.869039288257, 3795.2978698940783, 4035.556088830226, 4040.9797951010055, 13501.662458438617, 14049.438022478986, 14056.508022219174, 14057.78913316301, 14064.507742228972, 13896.444142234197, 13898.444062237599, 13914.30428478572, 13935.88512918964, 13946.86053139476, 9970.853351864484, 9971.45157016371, 10035.845877724156, 10129.290949633454, 10237.897621023694, 6657.3342665733035, 6743.9325606743305, 6856.9314306856295, 6939.444844412334, 6958.199807022257, 12395.442205100611, 12471.0, 12744.61766147017, 12745.490180393052, 12779.294004738522, 12848.678783030498, 13014.284214368301, 13096.345182740633, 13184.40670169864, 13198.60404187876, 8990.32572557074, 9292.814143717223, 9294.070592940652, 9297.30270229749, 9323.813523729352, 9935.900640993497, 10051.296409251574, 10225.233107517115, 10231.897681023393, 10242.948785256027, 7999.760037194244, 8422.494650321001, 8487.066422693375, 8592.570371481526, 8814.823703526023, 7330.633468326456, 7668.501547399401, 8352.955880514935, 8403.327733781405, 8539.914600854161, 7673.2710392514855, 7761.650725717243, 7779.338756205786, 7842.725504607311, 7889.6449659766595, 4650.325702773147, 5851.093080572518, 6050.7277172526465, 6069.514438844793, 6151.661658608819, 5481.232627432242, 6079.969600151971, 6094.878102437838, 6107.54193435503, 6179.876402472015], "value": 5104.40301050599, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.6426951474158, 396.16409376216177, 400.3587372843984, 409.8811344710034, 410.03027839160393, 5207.765650545725, 5375.543078838298, 5503.6147469677135, 6116.357782432841, 6292.150559674443, 4605.3092036194585, 5561.416051314604, 5964.970175149118, 6089.421504957022, 6135.29444113927, 4100.753954762708, 4728.219843725781, 4773.92839107412, 4788.3535722677425, 4793.3049707792525, 4795.5444232798, 4797.880052998686, 4814.2056560667625, 4816.771723210576, 4818.951810481903, 3963.702722295825, 4634.30485427187, 4720.362751028619, 4735.550122738335, 4752.881177970561, 4715.481297057321, 4730.739809310504, 4742.407199100113, 4745.928811067837, 4753.3582966299455, 3471.444568868969, 4185.204811085884, 4214.7681877496725, 4236.4492615959725, 4237.8304867805255, 5774.488097677524, 5934.554908381845, 5993.910091348634, 6015.909761353583, 6096.7561297548045, 4955.513345996187, 5174.715390653512, 5515.310586176728, 5517.296524702907, 5530.391656917735, 6022.397760223987, 6106.6336019838955, 6343.619382837044, 6561.835954101138, 6614.784047344146, 3851.711121665858, 3895.4935858338235, 4048.2308361411237, 4330.155619654137, 4406.867793966154, 5893.996041345963, 6547.562529671913, 6712.456135088859, 6721.4958878084335, 6962.930370696279, 4292.163028209469, 4363.192809330284, 4400.515943246241, 4438.844640437569, 4440.178566965122, 3797.9050523736573, 4119.423280740699, 4458.621017213508, 4467.530909254547, 4484.641228701696, 4945.579625731782, 5221.216817477409, 5272.367315922113, 5280.910667259696, 5304.575633949275, 6387.457066149429, 6486.416222539994, 6499.38255865692, 6504.414602685781, 6515.804525864231, 1512.5840393891767, 1533.3100104952816, 1536.508317338441, 1540.7072656195287, 1543.3440787665197, 977.3305285879195, 1007.219404961161, 1014.700663304327, 1016.0804471952895, 1024.7386916336436, 5187.507186817246, 6180.351063138306, 6185.597936134137, 6196.20310110063, 6218.720157592919, 6095.573309868267, 6770.966145169243, 6774.627395493197, 6778.22050464193, 6809.353111454404, 5162.380514338303, 5846.0, 6055.212822333068, 6159.5072394208355, 6186.566940314135, 3228.8869889553753, 3298.9175270618425, 3500.1599616092462, 3531.52324436203, 3538.893833184957, 6447.645379504079, 6855.691493882688, 6928.549644273106, 6928.757493487704, 6958.590290757493, 5826.679532625746, 6080.604760690541, 7019.403350715144, 7026.683799229047, 7033.0, 5660.603757737002, 5785.479306862402, 6719.832004199934, 6968.303169683194, 6980.0, 5763.7982670606325, 6750.662466876538, 6801.795946121624, 6823.761168359084, 6825.761098361533, 5194.857111447671, 6634.848446987835, 6646.4350530205475, 6684.933150668431, 6791.049253104668, 6037.45662890342, 6650.767223147167, 6829.009793580002, 6895.241523432519, 6926.515143939876, 3638.7816730996224, 4460.955390446184, 4463.285874260103, 4471.239889218906, 4481.887952801206, 5546.918350921532, 6175.752969881334, 6615.801525954229, 6714.314274290323, 6802.285759995327, 6523.31505191967, 6535.3464653534265, 6535.856225160483, 6550.377714117342, 6557.409833115043, 5140.946106048176, 5292.576593872558, 6380.585261957958, 6522.836929076811, 6546.639934803631, 5409.675419474844, 6316.536550745305, 6399.456046236122, 6403.6798160090875, 6410.711517981796, 6167.84580385494, 6554.213494380705, 6574.309697481887, 6587.868242635216, 6597.60414375139, 6271.24745030581, 6386.329435409215, 6410.935890641221, 6417.2299324081405, 6436.517261205522], "value": 4757.082328039313, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.2628845385537, 682.4233522673339, 686.1183379357526, 688.1845013658811, 720.614471257877, 14416.567502974902, 15586.766198507032, 15827.287772050257, 15828.05031698096, 15841.970271932316, 13775.931120344409, 14421.278936053182, 14617.561473155796, 14623.561293161221, 14644.67981945326, 874.0560194989396, 894.0165817600653, 898.0435835834847, 898.3486971945352, 898.865170224465, 871.7079778274285, 884.186548375496, 902.7833320003185, 914.4284821986258, 914.6935776514842, 931.5901003558447, 944.3106532231475, 944.6788092048702, 944.8204841080172, 945.1871390604075, 931.683227702581, 941.4492521874712, 941.5857022909897, 941.9576119074658, 942.3544871762864, 691.7440546997593, 696.1506961506954, 696.9756058537978, 697.1146643762444, 700.8458139209416, 14664.0, 14718.190499522521, 15489.92255038729, 15812.841871581251, 15825.446109386115, 13951.860481395259, 13990.370433330525, 14256.786148207786, 14401.20793356365, 14485.42058317666, 11666.883331166664, 11744.177907546475, 11751.294922304689, 11952.581659641957, 12211.816822747665, 2927.8536073196256, 2955.4827905116517, 2991.760659147263, 3077.538369244631, 3118.23603217211, 95106.52446737791, 97101.21184139355, 97597.0240297595, 98029.0, 99385.50307248489, 11082.560052485402, 11113.333200008025, 11179.273347232403, 11291.887081129247, 11539.19225654196, 23578.646320305208, 23622.763772362057, 23653.0, 23707.7629223709, 23871.403214919766, 7529.435292352986, 7579.696812127563, 7589.544627322378, 7686.231376862269, 7718.228177182349, 3558.181618227822, 3924.60753924611, 4018.799060046986, 4023.2556976959354, 4131.380292956081, 4002.639762421396, 4036.6972477064337, 4038.8586399476467, 4117.444145040441, 4126.319157339066, 686.2279935073043, 753.2881427051384, 753.857905273511, 769.819092513259, 778.5523324088672, 532.9760160792696, 549.7828357798647, 549.8069189858018, 566.8469513231487, 592.570386469806, 9525.476098814494, 9682.806343873082, 9955.900440995641, 10003.799924001625, 10038.247131465168, 527.9656822306615, 563.6111083352474, 569.7094481814305, 582.9766809327664, 591.9674417906971, 3808.733388662767, 4408.953659571295, 4471.888202794956, 4675.44867300206, 4768.737719425465, 76631.0, 95761.0, 96143.51928240314, 96235.0, 99094.5045274769, 71121.64439177874, 71255.64372178106, 71930.9210361845, 85797.0, 87072.0, 62791.05813412803, 69983.95024074643, 71345.08186476691, 71598.0, 72115.0, 8822.426542274732, 10336.629707321887, 10668.519916603927, 10776.245662803842, 10911.618093366695, 24577.0, 33897.830510847285, 34001.65998339985, 34377.453014614905, 35556.798210576686, 47701.522984769705, 47802.04395912132, 47846.0, 47941.0, 48080.0, 12247.0, 12553.497860085494, 12618.684532886751, 12710.173838700824, 12840.871591283967, 13920.303984800921, 13945.0, 14003.22982235946, 14270.500532481314, 14665.340059697553, 13118.278494682503, 13141.73716525645, 13252.801207981694, 13298.534551290659, 13880.93059534696, 13046.152000119962, 13224.404901779251, 13410.195388276734, 13705.794413083613, 13792.172469651452, 12990.090693651731, 13093.214407135602, 13119.344032798514, 13531.458741650618, 13789.724205515633, 9046.0, 9193.908060919306, 9531.259341929492, 9541.188998934891, 9713.56288966984, 9295.488748118647, 9438.716838494856, 10675.004963271542, 10998.615048473264, 11028.669139925814], "value": 7171.071327714292, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 111.0, 113.0, 112.0, 110.0, 113.0, 113.0, 111.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 110.0, 149.0, 113.0, 110.0, 104.0, 109.0, 132.0, 110.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 186.0, 182.0, 186.0, 183.0, 182.0, 184.0, 185.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 93.0, 56.0, 58.0, 58.0, 61.0, 78.0, 56.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 70.0, 70.0, 71.0, 113.0, 102.0, 75.0, 85.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 95.0, 131.0, 130.0, 90.0, 90.0, 91.0, 90.0, 90.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 96.0, 96.0, 97.0, 97.0, 95.0, 97.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 82.0, 83.0, 84.0, 83.0, 85.0, 86.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 79.0, 84.0, 94.0, 94.0, 92.0, 64.0, 63.0], "value": 75.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 70.0, 63.0, 64.0, 60.0, 57.0, 56.0, 54.0, 56.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 84.0, 83.0, 83.0, 81.0, 81.0, 80.0, 82.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 127.0, 142.0, 142.0, 146.0, 140.0, 137.0, 138.0, 182.0, 152.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 184.0, 189.0, 187.0, 187.0, 187.0, 184.0, 180.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 83.0, 90.0, 96.0, 72.0, 67.0, 68.0, 66.0], "value": 74.5, "unit": "score"}]}]} 04:53:21 INFO - Return code: 0 04:53:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:53:21 ERROR - # TBPL SUCCESS # 04:53:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:21 INFO - 2017-03-25 04:53:21.994 screenresolution[1704:13769] starting screenresolution argv=screenresolution get 04:53:21 INFO - 2017-03-25 04:53:21.997 screenresolution[1704:13769] Display 0: 1600x1200x32@60 04:53:22 INFO - 2017-03-25 04:53:22.003 screenresolution[1705:13772] starting screenresolution argv=screenresolution list 04:53:22 INFO - Available Modes on Display 0 04:53:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:22 INFO - Intel Iris: 04:53:22 INFO - Chipset Model: Intel Iris 04:53:22 INFO - Type: GPU 04:53:22 INFO - Bus: Built-In 04:53:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:22 INFO - Vendor: Intel (0x8086) 04:53:22 INFO - Device ID: 0x0a2e 04:53:22 INFO - Revision ID: 0x0009 04:53:22 INFO - Displays: 04:53:22 INFO - Display: 04:53:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:22 INFO - Display Serial Number: 1600x1200 60 04:53:22 INFO - Main Display: Yes 04:53:22 INFO - Mirror: Off 04:53:22 INFO - Online: Yes 04:53:22 INFO - Rotation: Supported 04:53:22 INFO - Return code: 0 04:53:22 INFO - Running post-action listener: _resource_record_post_action 04:53:22 INFO - [mozharness: 2017-03-25 11:53:22.248012Z] Finished run-tests step (success) 04:53:22 INFO - Running post-run listener: _resource_record_post_run 04:53:22 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 32627712; Write bytes: 514752512; Read time: 204; Write time: 1578 04:53:22 INFO - TinderboxPrint: CPU usage
53.4% 04:53:22 INFO - TinderboxPrint: I/O read bytes / time
32,627,712 / 204 04:53:22 INFO - TinderboxPrint: I/O write bytes / time
514,752,512 / 1,578 04:53:22 INFO - TinderboxPrint: CPU idle
2,243.4 (46.6%) 04:53:22 INFO - TinderboxPrint: CPU system
958.8 (19.9%) 04:53:22 INFO - TinderboxPrint: CPU user
1,611.5 (33.5%) 04:53:22 INFO - TinderboxPrint: Swap in / out
239,902,720 / 0 04:53:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 207061504; Write bytes: 205236224; Read time: 16958; Write time: 449 04:53:22 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 30731264; Write bytes: 298694656; Read time: 188; Write time: 1094 04:53:22 INFO - Running post-run listener: _upload_blobber_files 04:53:22 INFO - Blob upload gear active. 04:53:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:22 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 04:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:53:23 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:24 INFO - (blobuploader) - INFO - Done attempting. 04:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:25 INFO - (blobuploader) - INFO - Done attempting. 04:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:26 INFO - (blobuploader) - INFO - Done attempting. 04:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:29 INFO - (blobuploader) - INFO - Done attempting. 04:53:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:29 INFO - Return code: 0 04:53:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15339abe025eb30ea148d2c422e7bef99e219a22b29e8cb5e39da8e1160192a053926127a3ad14e7fef25f727f51a1c6aa63968c53f87b88bce2c9d93394e6f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d19c967078992c70e5930f9bf97a958239231e2777e9c7e64cee068b349ad5e33c3b407a62179a873c7c82815a935aa57b2aba5ca678dff0aa7abb37659507a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c629582af6149dae7b94e7f72e91d39fc4a74ad6439abd6025b6c31b5fdffd9f3fcad620bd4c3ffc69d58c16f9802b90ae2e38ef0dacc867483d9f3714c0978", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e3eceadd8a0f54ea8fa47db951875fcf3d5566e4be1231af2e1e8e25ff87527fb92352300413d22140e9bae1fd8c1c8b22c9278edfb75f96e0b53fc065e52c3"} 04:53:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:29 INFO - Contents: 04:53:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15339abe025eb30ea148d2c422e7bef99e219a22b29e8cb5e39da8e1160192a053926127a3ad14e7fef25f727f51a1c6aa63968c53f87b88bce2c9d93394e6f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d19c967078992c70e5930f9bf97a958239231e2777e9c7e64cee068b349ad5e33c3b407a62179a873c7c82815a935aa57b2aba5ca678dff0aa7abb37659507a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c629582af6149dae7b94e7f72e91d39fc4a74ad6439abd6025b6c31b5fdffd9f3fcad620bd4c3ffc69d58c16f9802b90ae2e38ef0dacc867483d9f3714c0978", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e3eceadd8a0f54ea8fa47db951875fcf3d5566e4be1231af2e1e8e25ff87527fb92352300413d22140e9bae1fd8c1c8b22c9278edfb75f96e0b53fc065e52c3"} 04:53:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:29 INFO - Copying logs to upload dir... 04:53:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1537.396542 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 25 mins, 37 secs) (at 2017-03-25 04:53:29.060896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 04:53:29.066839) ========= 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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15339abe025eb30ea148d2c422e7bef99e219a22b29e8cb5e39da8e1160192a053926127a3ad14e7fef25f727f51a1c6aa63968c53f87b88bce2c9d93394e6f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d19c967078992c70e5930f9bf97a958239231e2777e9c7e64cee068b349ad5e33c3b407a62179a873c7c82815a935aa57b2aba5ca678dff0aa7abb37659507a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c629582af6149dae7b94e7f72e91d39fc4a74ad6439abd6025b6c31b5fdffd9f3fcad620bd4c3ffc69d58c16f9802b90ae2e38ef0dacc867483d9f3714c0978", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e3eceadd8a0f54ea8fa47db951875fcf3d5566e4be1231af2e1e8e25ff87527fb92352300413d22140e9bae1fd8c1c8b22c9278edfb75f96e0b53fc065e52c3"} build_url:https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/JKepcFohQUiC_8HCzeI2vw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15339abe025eb30ea148d2c422e7bef99e219a22b29e8cb5e39da8e1160192a053926127a3ad14e7fef25f727f51a1c6aa63968c53f87b88bce2c9d93394e6f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d19c967078992c70e5930f9bf97a958239231e2777e9c7e64cee068b349ad5e33c3b407a62179a873c7c82815a935aa57b2aba5ca678dff0aa7abb37659507a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c629582af6149dae7b94e7f72e91d39fc4a74ad6439abd6025b6c31b5fdffd9f3fcad620bd4c3ffc69d58c16f9802b90ae2e38ef0dacc867483d9f3714c0978", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e3eceadd8a0f54ea8fa47db951875fcf3d5566e4be1231af2e1e8e25ff87527fb92352300413d22140e9bae1fd8c1c8b22c9278edfb75f96e0b53fc065e52c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 04:53:29.101514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 04:53:29.101846) ========= 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.Mn9grKQu2O/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.YQYhzBnJXC/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 04:53:29.150343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 04:53:29.150664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 04:53:29.151342) ========= ========= Total master_lag: 0.18 =========