builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0059 starttime: 1487793254.69 results: success (0) buildid: 20170222091722 builduid: 95f5430a21df4d6e993c71b9d40613bd revision: 10bce9625147fe39903884dfe20c04eb7f899a98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.686871) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.687300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.687589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.710846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.711109) ========= 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.y42fbNHcij/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.cwJCNEnN8K/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-22 11:54:14-- 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% 151M=0s 2017-02-22 11:54:14 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.884571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.884889) ========= 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.y42fbNHcij/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.cwJCNEnN8K/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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.019684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:14.932909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 11:54:14.933209) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 10bce9625147fe39903884dfe20c04eb7f899a98 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 10bce9625147fe39903884dfe20c04eb7f899a98 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y42fbNHcij/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.cwJCNEnN8K/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-22 11:54:15,025 truncating revision to first 12 chars 2017-02-22 11:54:15,025 Setting DEBUG logging. 2017-02-22 11:54:15,025 attempt 1/10 2017-02-22 11:54:15,025 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/10bce9625147?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 11:54:16,428 unpacking tar archive at: mozilla-beta-10bce9625147/testing/mozharness/ program finished with exit code 0 elapsedTime=1.651495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 11:54:16.609381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:16.610185) ========= script_repo_revision: 10bce9625147fe39903884dfe20c04eb7f899a98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:16.611120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:16.611830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 11:54:16.632011) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-22 11:54:16.632908) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y42fbNHcij/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.cwJCNEnN8K/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54:16 INFO - MultiFileLogger online at 20170222 11:54:16 in /builds/slave/test 11:54:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:54:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:16 INFO - {'append_to_log': False, 11:54:16 INFO - 'base_work_dir': '/builds/slave/test', 11:54:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:54:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:16 INFO - 'branch': 'Mozilla-Beta', 11:54:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:16 INFO - 'config_files': ('talos/mac_config.py',), 11:54:16 INFO - 'default_actions': ('clobber', 11:54:16 INFO - 'read-buildbot-config', 11:54:16 INFO - 'download-and-extract', 11:54:16 INFO - 'populate-webroot', 11:54:16 INFO - 'create-virtualenv', 11:54:16 INFO - 'install', 11:54:16 INFO - 'run-tests'), 11:54:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:16 INFO - 'download_minidump_stackwalk': True, 11:54:16 INFO - 'download_symbols': 'ondemand', 11:54:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:16 INFO - 'installer_path': 'installer.exe', 11:54:16 INFO - 'log_level': 'info', 11:54:16 INFO - 'log_name': 'talos', 11:54:16 INFO - 'log_to_console': True, 11:54:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:54:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:54:16 INFO - 'opt_config_files': (), 11:54:16 INFO - 'pip_index': False, 11:54:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:16 INFO - 'cmd': ('bash', 11:54:16 INFO - '-c', 11:54:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:16 INFO - 'enabled': True, 11:54:16 INFO - 'halt_on_failure': False, 11:54:16 INFO - 'name': 'check_screen_resolution'},), 11:54:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:16 INFO - 'cmd': ('bash', 11:54:16 INFO - '-c', 11:54:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:16 INFO - 'enabled': True, 11:54:16 INFO - 'halt_on_failure': False, 11:54:16 INFO - 'name': 'check_screen_resolution'},), 11:54:16 INFO - 'run_cmd_checks_enabled': True, 11:54:16 INFO - 'sps_profile': False, 11:54:16 INFO - 'sps_profile_interval': 0, 11:54:16 INFO - 'suite': 'dromaeojs', 11:54:16 INFO - 'system_bits': '32', 11:54:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:16 INFO - 'title': 't-yosemite-r7-0059', 11:54:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:16 INFO - 'use_talos_json': True, 11:54:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:16 INFO - 'work_dir': 'build'} 11:54:16 INFO - [mozharness: 2017-02-22 19:54:16.843382Z] Running clobber step. 11:54:16 INFO - Running pre-action listener: _resource_record_pre_action 11:54:16 INFO - Running main action method: clobber 11:54:16 INFO - rmtree: /builds/slave/test/build 11:54:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:17 INFO - Running post-action listener: _resource_record_post_action 11:54:17 INFO - [mozharness: 2017-02-22 19:54:17.726623Z] Finished clobber step (success) 11:54:17 INFO - [mozharness: 2017-02-22 19:54:17.726787Z] Running read-buildbot-config step. 11:54:17 INFO - Running pre-action listener: _resource_record_pre_action 11:54:17 INFO - Running main action method: read_buildbot_config 11:54:17 INFO - Using buildbot properties: 11:54:17 INFO - { 11:54:17 INFO - "project": "", 11:54:17 INFO - "product": "firefox", 11:54:17 INFO - "script_repo_revision": "production", 11:54:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:54:17 INFO - "repository": "", 11:54:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:54:17 INFO - "buildid": "20170222091722", 11:54:17 INFO - "pgo_build": "False", 11:54:17 INFO - "basedir": "/builds/slave/test", 11:54:17 INFO - "buildnumber": 42, 11:54:17 INFO - "slavename": "t-yosemite-r7-0059", 11:54:17 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:54:17 INFO - "platform": "yosemite_r7", 11:54:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:54:17 INFO - "branch": "mozilla-beta", 11:54:17 INFO - "repo_path": "releases/mozilla-beta", 11:54:17 INFO - "revision": "10bce9625147fe39903884dfe20c04eb7f899a98", 11:54:17 INFO - "stage_platform": "macosx64", 11:54:17 INFO - "builduid": "95f5430a21df4d6e993c71b9d40613bd", 11:54:17 INFO - "slavebuilddir": "test" 11:54:17 INFO - } 11:54:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:54:17 INFO - Running post-action listener: _resource_record_post_action 11:54:17 INFO - [mozharness: 2017-02-22 19:54:17.729938Z] Finished read-buildbot-config step (success) 11:54:17 INFO - [mozharness: 2017-02-22 19:54:17.730046Z] Running download-and-extract step. 11:54:17 INFO - Running pre-action listener: _resource_record_pre_action 11:54:17 INFO - Running main action method: download_and_extract 11:54:17 INFO - mkdir: /builds/slave/test/build/tests 11:54: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')]} 11:54:17 INFO - trying https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:54:17 INFO - Downloading https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 11:54:18 INFO - Downloaded 1165 bytes. 11:54:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:54:18 INFO - Using the following test package requirements: 11:54:18 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:54:18 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:54:18 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:54:18 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:54:18 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:54:18 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:54:18 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:54:18 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:54:18 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:54:18 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:54:18 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:54:18 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:54:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:54:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:54:18 INFO - Fetch https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:54:19 INFO - Http code: 200 11:54:19 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 11:54:19 INFO - x-amz-cf-id: dyc6V1D3pF-WLyQtDFhY7zDZTRgITR7wdKzr627-4ULF_GtkqnNH2g== 11:54:19 INFO - x-amz-version-id: Y8ewd3NAUXqwdoAmLpCjKxOl_gfjkWJv 11:54:19 INFO - Expected file size: 16093039 11:54:19 INFO - Obtained file size: 16093039 11:54:26 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:54:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:54:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:54:26 INFO - Fetch https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:54:27 INFO - Http code: 200 11:54:27 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 11:54:27 INFO - x-amz-cf-id: NEXncDsJ5NBYNOhxkJizQTndbsDKDL76oLMgPdtik5P0R3z2Tnzh3Q== 11:54:27 INFO - x-amz-version-id: Y8ewd3NAUXqwdoAmLpCjKxOl_gfjkWJv 11:54:27 INFO - Expected file size: 16093039 11:54:27 INFO - Obtained file size: 16093039 11:54:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:54:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:54:33 INFO - Fetch https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:54:34 INFO - Http code: 200 11:54:34 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 11:54:34 INFO - x-amz-cf-id: 6K1fTwojeYgm9P1gE8JJRJYeQjHZanQ9JLkrcdUaaSHpR2h94XZqUg== 11:54:34 INFO - x-amz-version-id: qG8bjlCsaQKhJ.rlfgKSKTyKCRjwSLns 11:54:34 INFO - Expected file size: 14403005 11:54:34 INFO - Obtained file size: 14403005 11:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:35 INFO - trying https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:54:35 INFO - Downloading https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 11:54:38 INFO - Downloaded 82109944 bytes. 11:54:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:54:38 INFO - mkdir: /builds/slave/test/properties 11:54:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:38 INFO - Contents: 11:54:38 INFO - build_url:https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:54:39 INFO - Running post-action listener: _resource_record_post_action 11:54:39 INFO - Running post-action listener: set_extra_try_arguments 11:54:39 INFO - [mozharness: 2017-02-22 19:54:39.206967Z] Finished download-and-extract step (success) 11:54:39 INFO - [mozharness: 2017-02-22 19:54:39.207086Z] Running populate-webroot step. 11:54:39 INFO - Running pre-action listener: _resource_record_pre_action 11:54:39 INFO - Running main action method: populate_webroot 11:54:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:39 INFO - '--tppagecycles', 11:54:39 INFO - '7'], 11:54:39 INFO - 'tests': ['tsvgm']}}, 11:54:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:54:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:54:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:54:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['damp', 'tps']}, 11:54:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'tests': ['damp', 'tps']}, 11:54:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['dromaeo_dom']}, 11:54:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['basic_compositor_video']}, 11:54:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:54:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['a11yr', 11:54:39 INFO - 'ts_paint', 11:54:39 INFO - 'tpaint', 11:54:39 INFO - 'sessionrestore', 11:54:39 INFO - 'sessionrestore_no_auto_restore', 11:54:39 INFO - 'tabpaint']}, 11:54:39 INFO - 'other-e10s': {'tests': ['a11yr', 11:54:39 INFO - 'ts_paint', 11:54:39 INFO - 'tpaint', 11:54:39 INFO - 'sessionrestore', 11:54:39 INFO - 'sessionrestore_no_auto_restore', 11:54:39 INFO - 'tabpaint']}, 11:54:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:54:39 INFO - 'ts_paint', 11:54:39 INFO - 'tpaint', 11:54:39 INFO - 'sessionrestore', 11:54:39 INFO - 'sessionrestore_no_auto_restore', 11:54:39 INFO - 'tabpaint']}, 11:54:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:54:39 INFO - 'ts_paint', 11:54:39 INFO - 'tpaint', 11:54:39 INFO - 'sessionrestore', 11:54:39 INFO - 'sessionrestore_no_auto_restore', 11:54:39 INFO - 'tabpaint']}, 11:54:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['a11yr', 11:54:39 INFO - 'ts_paint', 11:54:39 INFO - 'tpaint', 11:54:39 INFO - 'sessionrestore', 11:54:39 INFO - 'sessionrestore_no_auto_restore', 11:54:39 INFO - 'tabpaint']}, 11:54:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['a11yr', 11:54:39 INFO - 'ts_paint', 11:54:39 INFO - 'tpaint', 11:54:39 INFO - 'sessionrestore', 11:54:39 INFO - 'sessionrestore_no_auto_restore', 11:54:39 INFO - 'tabpaint']}, 11:54:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['tsvgx', 11:54:39 INFO - 'tsvgr_opacity', 11:54:39 INFO - 'tart', 11:54:39 INFO - 'tscrollx', 11:54:39 INFO - 'cart']}, 11:54:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:54:39 INFO - 'tsvgr_opacity', 11:54:39 INFO - 'tart', 11:54:39 INFO - 'tscrollx', 11:54:39 INFO - 'cart']}, 11:54:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'talos_options': ['--disable-e10s'], 11:54:39 INFO - 'tests': ['tp5o']}, 11:54:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'tests': ['tp5o']}, 11:54:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'talos_options': ['--disable-e10s', 11:54:39 INFO - '--xperf_path', 11:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:39 INFO - 'tests': ['tp5n']}, 11:54:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:39 INFO - 'talos_options': ['--xperf_path', 11:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:39 INFO - 'tests': ['tp5n']}}, 11:54:39 INFO - 'talos.zip': {'path': '', 11:54:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:39 INFO - Running post-action listener: _resource_record_post_action 11:54:39 INFO - [mozharness: 2017-02-22 19:54:39.226552Z] Finished populate-webroot step (success) 11:54:39 INFO - [mozharness: 2017-02-22 19:54:39.226635Z] Running create-virtualenv step. 11:54:39 INFO - Running pre-action listener: _resource_record_pre_action 11:54:39 INFO - Running main action method: create_virtualenv 11:54:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:39 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 11:54:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:39 INFO - Using real prefix '/tools/python27' 11:54:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:42 INFO - Installing pip.................done. 11:54:43 INFO - Return code: 0 11:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:54:43 INFO - Reading from file tmpfile_stdout 11:54:43 INFO - Output received: 11:54:43 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) 11:54:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54:43 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')]} 11:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:43 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')]} 11:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:43 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54:43 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 11:54:43 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 11:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:43 INFO - 'HOME': '/Users/cltbld', 11:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:43 INFO - 'LOGNAME': 'cltbld', 11:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:43 INFO - 'MOZ_NO_REMOTE': '1', 11:54:43 INFO - 'NO_EM_RESTART': '1', 11:54:43 INFO - 'PAGER': '/bin/cat', 11:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:43 INFO - 'PWD': '/builds/slave/test', 11:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:43 INFO - 'SHELL': '/bin/bash', 11:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:54:43 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:43 INFO - 'USER': 'cltbld', 11:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:43 INFO - 'XPC_FLAGS': '0x0', 11:54:43 INFO - 'XPC_SERVICE_NAME': '0', 11:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:43 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 11:54:43 INFO - Cleaning up... 11:54:43 INFO - Return code: 0 11:54:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:54:43 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')]} 11:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:43 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')]} 11:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:43 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54:43 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 11:54:43 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 11:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:43 INFO - 'HOME': '/Users/cltbld', 11:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:43 INFO - 'LOGNAME': 'cltbld', 11:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:43 INFO - 'MOZ_NO_REMOTE': '1', 11:54:43 INFO - 'NO_EM_RESTART': '1', 11:54:43 INFO - 'PAGER': '/bin/cat', 11:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:43 INFO - 'PWD': '/builds/slave/test', 11:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:43 INFO - 'SHELL': '/bin/bash', 11:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:54:43 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:43 INFO - 'USER': 'cltbld', 11:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:43 INFO - 'XPC_FLAGS': '0x0', 11:54:43 INFO - 'XPC_SERVICE_NAME': '0', 11:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:43 INFO - Downloading/unpacking psutil>=3.1.1 11:54:43 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 11:54:43 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 11:54:43 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 11:54:43 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 11:54:43 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 11:54:43 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 11:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:47 INFO - Installing collected packages: psutil 11:54:47 INFO - Running setup.py install for psutil 11:54:47 INFO - building 'psutil._psutil_osx' extension 11:54:47 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 11:54:47 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 11:54:47 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 11:54:47 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 11:54:47 INFO - building 'psutil._psutil_posix' extension 11:54:47 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 11:54:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:54:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:54:47 INFO - ^ 11:54:47 INFO - 1 warning generated. 11:54:47 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 11:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:48 INFO - Successfully installed psutil 11:54:48 INFO - Cleaning up... 11:54:48 INFO - Return code: 0 11:54:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:48 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54:48 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 11:54:48 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 11:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:48 INFO - 'HOME': '/Users/cltbld', 11:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:48 INFO - 'LOGNAME': 'cltbld', 11:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:48 INFO - 'MOZ_NO_REMOTE': '1', 11:54:48 INFO - 'NO_EM_RESTART': '1', 11:54:48 INFO - 'PAGER': '/bin/cat', 11:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:48 INFO - 'PWD': '/builds/slave/test', 11:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:48 INFO - 'SHELL': '/bin/bash', 11:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:54:48 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:48 INFO - 'USER': 'cltbld', 11:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:48 INFO - 'XPC_FLAGS': '0x0', 11:54:48 INFO - 'XPC_SERVICE_NAME': '0', 11:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:54:51 INFO - Installing collected packages: mozsystemmonitor 11:54:51 INFO - Running setup.py install for mozsystemmonitor 11:54:51 INFO - Successfully installed mozsystemmonitor 11:54:51 INFO - Cleaning up... 11:54:51 INFO - Return code: 0 11:54:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:54:51 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')]} 11:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 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')]} 11:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54:51 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 11:54:51 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 11:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:51 INFO - 'HOME': '/Users/cltbld', 11:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:51 INFO - 'LOGNAME': 'cltbld', 11:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:51 INFO - 'MOZ_NO_REMOTE': '1', 11:54:51 INFO - 'NO_EM_RESTART': '1', 11:54:51 INFO - 'PAGER': '/bin/cat', 11:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:51 INFO - 'PWD': '/builds/slave/test', 11:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:51 INFO - 'SHELL': '/bin/bash', 11:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:54:51 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:51 INFO - 'USER': 'cltbld', 11:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:51 INFO - 'XPC_FLAGS': '0x0', 11:54:51 INFO - 'XPC_SERVICE_NAME': '0', 11:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:54:51 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 11:54:51 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 11:54:51 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 11:54:51 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 11:54:51 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 11:54:51 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 11:54:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:54 INFO - warning: no files found matching '*.txt' 11:54:54 INFO - no previously-included directories found matching 'build' 11:54:54 INFO - no previously-included directories found matching 'dist' 11:54:54 INFO - no previously-included directories found matching '.git*' 11:54:54 INFO - Installing collected packages: jsonschema, functools32 11:54:54 INFO - Running setup.py install for functools32 11:54:54 INFO - warning: no files found matching '*.txt' 11:54:54 INFO - no previously-included directories found matching 'build' 11:54:54 INFO - no previously-included directories found matching 'dist' 11:54:54 INFO - no previously-included directories found matching '.git*' 11:54:54 INFO - Successfully installed jsonschema functools32 11:54:54 INFO - Cleaning up... 11:54:55 INFO - Return code: 0 11:54:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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', '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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:54: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 functools32==3.2.3-2 11:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:55 INFO - 'HOME': '/Users/cltbld', 11:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:55 INFO - 'LOGNAME': 'cltbld', 11:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:55 INFO - 'MOZ_NO_REMOTE': '1', 11:54:55 INFO - 'NO_EM_RESTART': '1', 11:54:55 INFO - 'PAGER': '/bin/cat', 11:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:55 INFO - 'PWD': '/builds/slave/test', 11:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:55 INFO - 'SHELL': '/bin/bash', 11:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:54:55 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:55 INFO - 'USER': 'cltbld', 11:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:55 INFO - 'XPC_FLAGS': '0x0', 11:54:55 INFO - 'XPC_SERVICE_NAME': '0', 11:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:54:55 INFO - Cleaning up... 11:54:55 INFO - Return code: 0 11:54:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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', '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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:54: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 blobuploader==1.2.4 11:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:55 INFO - 'HOME': '/Users/cltbld', 11:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:55 INFO - 'LOGNAME': 'cltbld', 11:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:55 INFO - 'MOZ_NO_REMOTE': '1', 11:54:55 INFO - 'NO_EM_RESTART': '1', 11:54:55 INFO - 'PAGER': '/bin/cat', 11:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:55 INFO - 'PWD': '/builds/slave/test', 11:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:55 INFO - 'SHELL': '/bin/bash', 11:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:54:55 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:55 INFO - 'USER': 'cltbld', 11:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:55 INFO - 'XPC_FLAGS': '0x0', 11:54:55 INFO - 'XPC_SERVICE_NAME': '0', 11:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54:59 INFO - Downloading docopt-0.6.1.tar.gz 11:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:59 INFO - Running setup.py install for blobuploader 11:54:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:59 INFO - Running setup.py install for requests 11:55:00 INFO - Running setup.py install for docopt 11:55:00 INFO - Successfully installed blobuploader requests docopt 11:55:00 INFO - Cleaning up... 11:55:00 INFO - Return code: 0 11:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:00 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:55:00 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 11:55:00 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 11:55:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:55:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:00 INFO - 'HOME': '/Users/cltbld', 11:55:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:00 INFO - 'LOGNAME': 'cltbld', 11:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:00 INFO - 'MOZ_NO_REMOTE': '1', 11:55:00 INFO - 'NO_EM_RESTART': '1', 11:55:00 INFO - 'PAGER': '/bin/cat', 11:55:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:00 INFO - 'PWD': '/builds/slave/test', 11:55:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:00 INFO - 'SHELL': '/bin/bash', 11:55:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:55:00 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:55:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:00 INFO - 'USER': 'cltbld', 11:55:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:00 INFO - 'XPC_FLAGS': '0x0', 11:55:00 INFO - 'XPC_SERVICE_NAME': '0', 11:55:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:00 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Bk5QHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:00 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-qaG2bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:00 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-MF95cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:00 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Zaye6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-XFobjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-A6ZQSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-yiEx8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-qyg79C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-RDtyrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-9YHL6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-gz4LKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-3YSxSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pLBy2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:01 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-RCnozK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:02 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-M010Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:02 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Q0W7vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:02 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-dGkoqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:02 INFO - Running setup.py install for manifestparser 11:55:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:02 INFO - Running setup.py install for mozcrash 11:55:02 INFO - Running setup.py install for mozdebug 11:55:02 INFO - Running setup.py install for mozdevice 11:55:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:02 INFO - Running setup.py install for mozfile 11:55:03 INFO - Running setup.py install for mozhttpd 11:55:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Running setup.py install for mozinfo 11:55:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Running setup.py install for mozInstall 11:55:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Running setup.py install for mozleak 11:55:03 INFO - Running setup.py install for mozlog 11:55:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:03 INFO - Running setup.py install for moznetwork 11:55:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Running setup.py install for mozprocess 11:55:04 INFO - Running setup.py install for mozprofile 11:55:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Running setup.py install for mozrunner 11:55:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Running setup.py install for mozscreenshot 11:55:04 INFO - Running setup.py install for moztest 11:55:04 INFO - Running setup.py install for mozversion 11:55:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:04 INFO - Cleaning up... 11:55:04 INFO - Return code: 0 11:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:04 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')]} 11:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:04 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')]} 11:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:04 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:55:04 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 11:55:04 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 11:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:04 INFO - 'HOME': '/Users/cltbld', 11:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:04 INFO - 'LOGNAME': 'cltbld', 11:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:04 INFO - 'MOZ_NO_REMOTE': '1', 11:55:04 INFO - 'NO_EM_RESTART': '1', 11:55:04 INFO - 'PAGER': '/bin/cat', 11:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:04 INFO - 'PWD': '/builds/slave/test', 11:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:04 INFO - 'SHELL': '/bin/bash', 11:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:55:04 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:04 INFO - 'USER': 'cltbld', 11:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:04 INFO - 'XPC_FLAGS': '0x0', 11:55:04 INFO - 'XPC_SERVICE_NAME': '0', 11:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-gXHfHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:05 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pDtJXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:05 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-gLVIQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:05 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-VRRhwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-2pdtjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:05 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-tEooiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:05 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Qnzueh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:05 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)) 11:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:05 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-DqJPHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-_4NDkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-mV0N3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-U0eVN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-hJvH4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-ej8NdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-PNbo0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-CUYMY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-oGPNLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:06 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-6u2Q_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:07 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)) 11:55:07 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)) 11:55:07 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)) 11:55:07 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)) 11:55:07 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:07 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:09 INFO - Downloading blessings-1.6.tar.gz 11:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:09 INFO - Installing collected packages: blessings 11:55:09 INFO - Running setup.py install for blessings 11:55:09 INFO - Successfully installed blessings 11:55:09 INFO - Cleaning up... 11:55:10 INFO - Return code: 0 11:55:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:10 INFO - Reading from file tmpfile_stdout 11:55:10 INFO - Current package versions: 11:55:10 INFO - blessings == 1.6 11:55:10 INFO - blobuploader == 1.2.4 11:55:10 INFO - docopt == 0.6.1 11:55:10 INFO - functools32 == 3.2.3-2 11:55:10 INFO - jsonschema == 2.5.1 11:55:10 INFO - manifestparser == 1.1 11:55:10 INFO - mozInstall == 1.12 11:55:10 INFO - mozcrash == 1.0 11:55:10 INFO - mozdebug == 0.1 11:55:10 INFO - mozdevice == 0.48 11:55:10 INFO - mozfile == 1.2 11:55:10 INFO - mozhttpd == 0.7 11:55:10 INFO - mozinfo == 0.9 11:55:10 INFO - mozleak == 0.1 11:55:10 INFO - mozlog == 3.4 11:55:10 INFO - moznetwork == 0.27 11:55:10 INFO - mozprocess == 0.23 11:55:10 INFO - mozprofile == 0.28 11:55:10 INFO - mozrunner == 6.13 11:55:10 INFO - mozscreenshot == 0.1 11:55:10 INFO - mozsystemmonitor == 0.3 11:55:10 INFO - moztest == 0.8 11:55:10 INFO - mozversion == 1.4 11:55:10 INFO - psutil == 3.1.1 11:55:10 INFO - requests == 1.2.3 11:55:10 INFO - wsgiref == 0.1.2 11:55:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:10 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 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:55:10 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 11:55:10 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 11:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:10 INFO - 'HOME': '/Users/cltbld', 11:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:10 INFO - 'LOGNAME': 'cltbld', 11:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:10 INFO - 'MOZ_NO_REMOTE': '1', 11:55:10 INFO - 'NO_EM_RESTART': '1', 11:55:10 INFO - 'PAGER': '/bin/cat', 11:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:10 INFO - 'PWD': '/builds/slave/test', 11:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:10 INFO - 'SHELL': '/bin/bash', 11:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:55:10 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:10 INFO - 'USER': 'cltbld', 11:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:10 INFO - 'XPC_FLAGS': '0x0', 11:55:10 INFO - 'XPC_SERVICE_NAME': '0', 11:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 INFO - Cleaning up... 11:55:10 INFO - Return code: 0 11:55:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd58d616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, '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.y42fbNHcij/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.cwJCNEnN8K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 11:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:10 INFO - 'HOME': '/Users/cltbld', 11:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:10 INFO - 'LOGNAME': 'cltbld', 11:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:10 INFO - 'MOZ_NO_REMOTE': '1', 11:55:10 INFO - 'NO_EM_RESTART': '1', 11:55:10 INFO - 'PAGER': '/bin/cat', 11:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:10 INFO - 'PWD': '/builds/slave/test', 11:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:10 INFO - 'SHELL': '/bin/bash', 11:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:55:10 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:10 INFO - 'USER': 'cltbld', 11:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:10 INFO - 'XPC_FLAGS': '0x0', 11:55:10 INFO - 'XPC_SERVICE_NAME': '0', 11:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:10 INFO - Cleaning up... 11:55:10 INFO - Return code: 0 11:55:10 INFO - Running post-action listener: _resource_record_post_action 11:55:10 INFO - Running post-action listener: _start_resource_monitoring 11:55:10 INFO - Starting resource monitoring. 11:55:10 INFO - [mozharness: 2017-02-22 19:55:10.870033Z] Finished create-virtualenv step (success) 11:55:10 INFO - [mozharness: 2017-02-22 19:55:10.871040Z] Running install step. 11:55:10 INFO - Running pre-action listener: _resource_record_pre_action 11:55:10 INFO - Running main action method: install 11:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:11 INFO - Reading from file tmpfile_stdout 11:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:11 INFO - Reading from file tmpfile_stdout 11:55:11 INFO - Output received: 11:55:11 INFO - Usage: mozinstall [options] installer 11:55:11 INFO - Options: 11:55:11 INFO - -h, --help show this help message and exit 11:55:11 INFO - -d DEST, --destination=DEST 11:55:11 INFO - Directory to install application into. [default: 11:55:11 INFO - "/builds/slave/test"] 11:55:11 INFO - --app=APP Application being installed. [default: firefox] 11:55:11 INFO - mkdir: /builds/slave/test/build/application 11:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:55:32 INFO - Reading from file tmpfile_stdout 11:55:32 INFO - Output received: 11:55:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:55:32 INFO - Running post-action listener: _resource_record_post_action 11:55:32 INFO - [mozharness: 2017-02-22 19:55:32.420247Z] Finished install step (success) 11:55:32 INFO - [mozharness: 2017-02-22 19:55:32.420381Z] Running run-tests step. 11:55:32 INFO - Running pre-action listener: _resource_record_pre_action 11:55:32 INFO - Running main action method: run_tests 11:55:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:55:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:55:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:55:32 INFO - 2017-02-22 11:55:32.434 screenresolution[1915:13993] starting screenresolution argv=screenresolution get 11:55:32 INFO - 2017-02-22 11:55:32.437 screenresolution[1915:13993] Display 0: 1600x1200x32@60 11:55:32 INFO - 2017-02-22 11:55:32.443 screenresolution[1916:13995] starting screenresolution argv=screenresolution list 11:55:32 INFO - Available Modes on Display 0 11:55:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:55:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:55:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:55:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:55:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:55:32 INFO - Intel Iris: 11:55:32 INFO - Chipset Model: Intel Iris 11:55:32 INFO - Type: GPU 11:55:32 INFO - Bus: Built-In 11:55:32 INFO - VRAM (Dynamic, Max): 1536 MB 11:55:32 INFO - Vendor: Intel (0x8086) 11:55:32 INFO - Device ID: 0x0a2e 11:55:32 INFO - Revision ID: 0x0009 11:55:32 INFO - Displays: 11:55:32 INFO - Display: 11:55:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:55:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:55:32 INFO - Display Serial Number: 1600x1200 60 11:55:32 INFO - Main Display: Yes 11:55:32 INFO - Mirror: Off 11:55:32 INFO - Online: Yes 11:55:32 INFO - Rotation: Supported 11:55:32 INFO - Return code: 0 11:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:32 INFO - Python 2.7.3 11:55:32 INFO - Return code: 0 11:55:32 INFO - grabbing minidump binary from tooltool 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 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 0x10729ad30>, '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 0x107100db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107292b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:32 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 11:55:32 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 11:55:32 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 11:55:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:32 INFO - Return code: 0 11:55:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:55:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:55:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 11:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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 11:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y42fbNHcij/Render', 11:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:32 INFO - 'HOME': '/Users/cltbld', 11:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:32 INFO - 'LOGNAME': 'cltbld', 11:55:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:32 INFO - 'MOZ_NO_REMOTE': '1', 11:55:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:32 INFO - 'NO_EM_RESTART': '1', 11:55:32 INFO - 'PAGER': '/bin/cat', 11:55:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:32 INFO - 'PWD': '/builds/slave/test', 11:55:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:32 INFO - 'SHELL': '/bin/bash', 11:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cwJCNEnN8K/Listeners', 11:55:32 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 11:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:32 INFO - 'USER': 'cltbld', 11:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:32 INFO - 'XPC_FLAGS': '0x0', 11:55:32 INFO - 'XPC_SERVICE_NAME': '0', 11:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 11:55:33 INFO - mozversion application_buildid: 20170222091722 11:55:33 INFO - mozversion application_changeset: 10bce9625147fe39903884dfe20c04eb7f899a98 11:55:33 INFO - mozversion application_display_name: Firefox 11:55:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:33 INFO - mozversion application_name: Firefox 11:55:33 INFO - mozversion application_remotingname: firefox 11:55:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:55:33 INFO - mozversion application_vendor: Mozilla 11:55:33 INFO - mozversion application_version: 52.0 11:55:33 INFO - mozversion platform_buildid: 20170222091722 11:55:33 INFO - mozversion platform_changeset: 10bce9625147fe39903884dfe20c04eb7f899a98 11:55:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:55:33 INFO - mozversion platform_version: 52.0 11:55:33 INFO - using testdate: 1487793333 11:55:33 INFO - actual date: 1487793333 11:55:33 INFO - starting webserver on 'localhost:52731' 11:55:33 INFO - SUITE-START | Running 2 tests 11:55:33 INFO - TEST-START | dromaeo_css 11:55:33 INFO - operating with platform_type : mac_ 11:55:33 INFO - Initialising browser for dromaeo_css test... 11:55:33 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpQHH8CB/profile http://localhost:52731/getInfo.html) 11:55:35 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 11:55:35 INFO - PROCESS | 1926 | colorDepth:24 11:55:35 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 11:55:35 INFO - PROCESS | 1926 | __metrics 11:55:35 INFO - PROCESS | 1926 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:55:35 INFO - PROCESS | 1926 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:36 INFO - TEST-INFO | 1926: exit 0 11:55:36 INFO - Browser initialized. 11:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:55:36 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpQHH8CB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:48 INFO - PROCESS | 1929 | RSS: Main: 172138496 11:55:48 INFO - PROCESS | 1929 | 11:58:52 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52731/tests/dromaeo/cssquery-ext.html) 11:58:53 INFO - PROCESS | 1929 | RSS: Main: 284323840 11:58:53 INFO - PROCESS | 1929 | 12:01:56 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52731/tests/dromaeo/cssquery-ext.html (next: http://localhost:52731/tests/dromaeo/cssquery-jquery.html) 12:01:57 INFO - PROCESS | 1929 | RSS: Main: 303255552 12:01:57 INFO - PROCESS | 1929 | 12:04:59 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52731/tests/dromaeo/cssquery-mootools.html) 12:05:00 INFO - PROCESS | 1929 | RSS: Main: 299409408 12:05:00 INFO - PROCESS | 1929 | 12:08:02 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52731/tests/dromaeo/cssquery-prototype.html) 12:08:03 INFO - PROCESS | 1929 | RSS: Main: 272035840 12:08:03 INFO - PROCESS | 1929 | 12:11:06 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52731/tests/dromaeo/cssquery-yui.html) 12:11:06 INFO - PROCESS | 1929 | RSS: Main: 258433024 12:11:07 INFO - PROCESS | 1929 | 12:14:09 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52731/tests/dromaeo/cssquery-yui.html (next: http://localhost:52731/tests/dromaeo/cssquery-dojo.html) 12:14:10 INFO - PROCESS | 1929 | RSS: Main: 387395584 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | __start_tp_report 12:14:10 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 12:14:10 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 12:14:10 INFO - PROCESS | 1929 | |i|pagename|runs| 12:14:10 INFO - PROCESS | 1929 | |0;dojo.html;3301.8349082545874;3417.7265818734504;3430.1081718753126;3433.3305005523935;3477.269773347597;5737.770489180428;5777.191193232946;5785.884282314361;5788.18965344852;5808.767649294028;5717.456841600041;5790.797322093727;5801.303843538782;5803.767849286023;5810.709464526778;5193.195054766517;5220.712860792655;5271.262023316739;5274.4461831507715;5295.973520132394;4172.603602657743;5197.896042079156;5203.739813009353;5314.229436731672;5323.254744335796;5215.739213039352;5231.424543300234;5246.50158234969;5246.658967167122;5324.988252232083;5251.632385733019;5267.315249017642;5306.681599104066;5307.230451584499;5316.893662126736;5117.360329958755;5171.741412929338;5248.950209958024;5253.4221235664045;5279.894402111936;5598.020346439397;5657.038303488417;5676.517496012802;5678.43215678433;5746.856328591777;6218.720157592919;6282.905756413657;6285.8742825143245;6287.465565426898;6333.9683301583655;5257.5005374489365;6286.87426251477;6315.778947736807;6340.048992651139;6365.29981702017;5673.773049078073;5743.4256574342235;5779.450952159538;5822.0684690449325;5902.763889444417;6301.180846489927;6323.873522529524;6324.209473815773;6328.240611126695;6334.556581039283;6227.813165605039;6238.844028899223;6249.437550620375;6251.218597675291;6270.6864656766975;5237.633365664443;6107.886786452505;6138.817583427312;6282.151909492251;6302.716377763011;6154.323024467305;6193.566450348522;6226.688665566794;6240.7503699852405;6298.937010629835;6209.59637623553;6276.246850377984;6294.276158241861;6300.558960872695;6311.400416960473;4448;4780.904381912343;4907.1657818171;4960.255961605716;4968.826091086867;4406.986393129534;4417.889552761142;4459.799309031101;4499.887502812456;4516.322551617283;5798.536117110621;5801.7099145042575;5802.506786923159;5812.215350927655;5815.563832712479;6227.1282020517165;6276.340984196594;6278.497720182374;6286.277078135981;6288.213973253343;5668.518175955008;5775.249217601769;5837.066069428871;5867.589268751147;5922.822315330547;5457.399686034533;5471.2887324647545;5478.342598888159;5480.013597552399;5491.643043202179;5346.866328341823;6348;6382.234131904202;6382.457491113308;6405.487560995202;6081.6351018939;6142.038385241405;6216.968915155395;6253.093301471352;6327.209098862642;6295.276043254901;6316.273628532594;6336.08126821599;6343.175387199819;6362.236531616236;6233.002719564848;6233.345498722569;6250.249970003629;6265.906011409741;6281.842953926189;6141.977005061692;6216.347283535345;6224.968875155595;6321.956877115224;6323.620582765049;6100.908486372797;6184.474319682878;6199.473044791062;6201.875962480635;6208.441240288215;5115.514026167508;6151.630902145886;6169.96915015422;6173;6174.289956655042;5737.8565535861935;5879.470847623735;5966.850828729316;6037;6051.697415129314;4720.716756994591;6110.480609148272;6158.137860699416;6176.505879529537;6278.8430289241305;6035.849103772441;6049.485793707408;6053.334133245251;6054.122152287806;6085.087236914498 12:14:10 INFO - PROCESS | 1929 | |1;ext.html;507.254336125895;507.7359772918082;507.8146476536064;554.7198664674341;566.3486989961547;30268.243293917636;32300.83849580752;32547.837260813663;40491.797541012325;40648;41982;42284.36573451393;42404.57595424045;42422;42522.57477425225;8055.395845311596;9571.760705982337;9573.904260957406;9577.281703872202;9590.184834289093;8756.387052906268;8928.419652722552;8932.910670893272;9003.864942025875;9288.396254243453;8927.866082008743;11207.943960280187;11419.771604567904;11460.656180314603;11627.069834413227;11466.08271338291;11533.884661153406;11542.134339924456;11554.422278886022;11567.074634029257;11336.886631133666;11400.372979486125;11406.372649504274;11406.54373825046;11414.086873050135;32709;40011;40095;40100.799496002626;40138.197236055115;3271.8200498972546;3357.84889679965;3742.419924911643;3906.238283534712;3936.094698219397;28946;29011.709882901323;29109.708902910912;30617.38765224683;30903.072907812802;3111.424386488507;3203.855826487814;3334.733221342287;3370.7640465167447;3405.4381027130494;495564;500432;501403;502797;505751;57624.71187644035;58017.12974305389;58052;58086.7095664519;58139.418605814244;59831;59887.70056149692;59939;59971.80056398847;60113.69943150344;16159.596010099842;16367.345306187857;16369.918150409172;16372.754408683879;16427.425040123537;12784.424700888483;12825.102242842911;12843.871561284455;12855.935720321339;12866.806997895039;11955.282683039046;13479.393427295796;13723.313834308245;15122.470713524974;15263;5533.280673512498;5549.223108764776;6577.585819048927;6624.105745724362;6655.43428808547;870.216804875617;926.967556135532;966.7244835221928;1028.7993841200894;1073.6295977887617;28623.427531449255;29101.21990113218;29267.121986340444;29302.97439589647;29389.853050735037;953.2469349214043;1021.1779517488493;1055.9577616895392;1068.9412082335546;1118.0887576625187;14425.855741442661;14928;15125.44587991964;15258.465953691568;15359.001664891746;661206;667262;667299;667576;668291;52093.95812083737;53219.46780532222;56050;56895.146572801445;56942.861142776914;1358.2529608715167;1380.1443105274593;1413.5971248194421;1415.405529677538;1417.093060441339;29482.26294342573;30118;30422.695773042873;30548.84725576358;30556.84721576378;47809.80475488141;48350.75824620854;48365.5163448361;48394.75802621105;48449.75775121102;574102;578398;584516;615903;618486;37098.258034839695;37287.81356093202;37478.43782343213;37661.81169094137;38050;44780;44962.100757984;44997;45565.77217113893;45615.771921140185;36222;36424.45363319499;36431.635683642824;37311.44032839564;37846.864594061124;36503;36595.634043660284;37454.876353709435;37756.811215943744;37898;35614.64385356113;36157.09607259734;36169.45745813762;36535.81732091322;36952.26095478021;31894.043178704676;32314.35371292608;32538.86113985999;32653.510197347536;32973.83513082419;21343;24195.15316963968;24284.39289017718;24787.876060619583;24801.62797558074 12:14:10 INFO - PROCESS | 1929 | |2;jquery.html;379.51232666024146;380.5585520795877;394.6152501311222;401.89148929788956;405.49718349246945;18764.71852922207;20712.689309660367;21117.049732762025;21153.894230528866;21413.892930535345;20263.898680506612;20750.75495470273;20881.269155579557;21225.68161477579;21321.893390533063;5809.9709501452435;5947.583669143161;6046.304674962392;6099.512039036888;6104.206453161083;4371.912561748763;4597.885052873671;4601.608863246612;6061.696915154247;6170.197874276338;6409.198850143732;6679.365460281289;6706.832329191785;6770.1537307836525;6776.864462710742;6610.272869984298;6703.162104736933;6709;6762.932370676329;6778.76274330401;5848.97075514624;5858.707064646751;5912.290525137011;5912.4974377178;5920.407959204088;25779;25938.351541211432;26133.216003519923;26135.477290454084;26377.868110659325;2149.6023235701446;2206.7682893296133;2325.4186453386656;2479.801615870726;2652.071774878777;10095.798084038279;10445.26883118182;10619.469026548719;11621.302721836717;15109.168995705231;1848.4454663601;1860.2466001269509;1862.1620270878159;1864.2449807827716;1865.3750993417223;126432;127117;130534;130623;133921.99999999904;9381.842176299353;11194.272372295774;11690.298582085103;11759.37949322626;11902.761944761056;14942.25288735559;14951.252437378087;14990.8756843235;15000.924995374953;15016.699666006838;8358.122397148212;8625.568721563897;8658.437201582003;8789;8808.5595720215;8445.324374050184;8466.74599762008;8503;8651.918510186226;8670;4523.84166554169;4640.767961601907;4645.279981602857;4681.485036645966;4720.858374248778;1635.3703824027834;1666.7916510436196;1785.259117466237;1802.9733416116192;1836.3389179895228;873.6680061576687;897.7396554998977;908.3868388837508;910.4901255297054;922.2207234886511;20582.867942263318;20974;21576.784232157792;21590.892045539673;21749;890.9287257019423;908.977275568116;937.1659223291276;944.759086432969;964.798825462304;11104.944475277573;11510.19428640004;11573.710657233469;11577.710557236136;11602.76794464106;541120;603866;609427;622709;626129;118050.32672876236;118565;121859;122462;131170.99999999808;962.1436921140191;966.5312323523086;971.8785151856018;985.0494273026563;985.522021819417;15572.065676059472;18779.061046947325;19290;19313.324033658755;19398.93305868191;53374.733126335675;53665.7316713414;54134.72932635312;55288;56047.43952560422;74710.50578988499;75021.87467187888;75808.24191758012;77280.61359693391;77725.83411248722;7080.867061270172;8076.515409075474;8085.39359548048;8166.4283500154415;8467.407281490237;12522.686932826753;12690.984721222096;12837.614871553867;13008.21950682962;13210.471581136648;10765.461726913467;11052.502637381176;11106.389148596905;11238.213325067167;11269;8122.593870306579;11005.284656497302;11034.724131896766;11070.612528561462;11225.775484490428;11060;11140.554377824796;11343.376114313462;11450.141239406912;11678.474468649101;8027.678892844221;8087.191280872101;8178.918210817816;8353.624086916225;8596.35527335465;8344.374171937008;10967.396793176453;11111.827072253198;11297.604583839526;11355.205135640426 12:14:10 INFO - PROCESS | 1929 | |3;mootools.html;1292.5476083370818;1532.0695923136848;1655.8675305975523;1730.1176400035993;1880.1069491991307;7948.92051079489;8394.370422218328;8412.99044114707;8415.70545030924;8422.11567785382;7457.291557302047;7651.120121186065;7946.324562412202;8140.837183256332;8199.22107399796;2314.166899916033;2354.281944007077;2356.575816353056;2358.516504116652;2359.3629719975597;2341.75411581784;2365.290412876139;2377;2395.3053614451787;2395.760423957599;2333.474968132165;2346.401667574766;2368.3131891751373;2369.6919400477914;2371.8576885386847;2331.825113116515;2338.4153961509624;2362.9054837806552;2363.6690863279155;2369.5379401016808;2360.9173678921156;2385.1294277588727;2385.248646676309;2385.7852793248517;2386.832921695482;8223.95888020562;8227.42408031438;8325.708600199025;8341.374396920255;8373.120822313631;4937.382827146606;5102.056119617845;5102.489751024905;5105.259737338065;5108.182690769459;3195.6165260168696;3308.9503657445157;3580.9283814323826;3587.820608969541;3592.76647017943;1073.8067147913373;1074.355386767933;1099.2854644481072;1115.6262652011585;1122.0798944865214;10708.46457677113;10809;10812.72968175794;10828.187885908588;10844.2951208172;4472.865814025519;4625.560571745679;4730.337752714623;4750.904981900412;4764.785584648699;9300.20948219409;9306.488143152057;9308.348415610842;9319.02150274225;9325.766855828659;5196;5198.532132108128;5204.8959020819375;5213.348331458567;5219.530242278213;3995.3607422812793;4217.0511634881905;4728.1252968201;4779.378680771478;4785.569298763058;3145.9528107078413;3784.810759462016;3863.2466668999277;3900.317444447267;3912.158885839558;1280.5390059578544;1289.7613941420868;1290.4128621477205;1298.3832679477173;1310.2531557012412;798.8921495598136;895.7044175422095;914.6387177065155;923.0999775219108;925.4817302310593;4819.060283244804;5657.462541058593;5663.207150998864;5741.024025915604;5777.133429985536;972.0959507657946;985.8274801909637;1008.0121480948565;1043.994780026095;1080.357187473452;3740.8129593520757;3781.9432708509394;3787.9242415152094;3920.3923391874305;3923.5684074751753;9773.364731292444;10004.399736015717;10076;10122.190224782;10128.392296462236;10070.798584028278;10074.44590547527;10076.546555405024;10084.49577521121;10088.49557522121;7656.846863062708;7762.262585054411;7771.222877712184;7935.682572697027;7949.682012719427;5435.945640543544;5479.178123281539;5513.696746678811;5656.095024796013;5768.3078030634915;9144.862827057466;9241.815163696823;9313.674021409219;9331.113544213289;9413.905860941302;9362.157405833508;9376.437413755197;9465.148136667733;9486.430814151174;9530.1899338557;6266.905996409966;6333.968330158504;6465.870682586416;6483.448906842783;6760.01979712929;7732.961335193288;7905.723299684713;7905.841883162419;7911.248431399008;7939.047314322318;6175.104609831639;6434.742610295536;6931.445484361138;7045.225025247116;7173.461990350849;6345.1434056401795;6980.546264492995;6993.615351155735;7049.718011279491;7051.5063945523325;6527;6585.341465853377;6621.106150669791;6703.631300278336;6708.932910671026;4782.37829082231;4808.110499557593;4850.981293928174;4904.141775189399;4955.603551715926;4590.563896429834;4795.9280610790165;4850.902981940271;4953.2570114483115;5064.41759197697 12:14:10 INFO - PROCESS | 1929 | |4;prototype.html;298.72218836482074;311.9438501069807;313.3075902256014;325.8729095652696;327.52181814550784;4845.394325709286;5179.922301165486;5314.229436731681;5359.169328754039;5375.467991622389;4798.304245884345;5237.528622423981;5265.262863199146;5284.191385838887;5294.708791016493;4075.510938687347;4096.3855421686685;4099.975006248438;4122.340425531916;4154.626083652471;3420.4698271767916;3911.2568611963634;3934.9606503935024;4125.019990404608;4149.64727998119;3827.8086095695244;4079.2453396121664;4085.9387109193385;4096.713230073896;4132.2768515509815;3551.4850346699714;4053.432519447265;4055.5944405559503;4062.4921884764403;4107.849802055429;3584.301061293049;3592.2995015971633;3609.9458508122398;3610.7833529988284;3616.7829930204007;4963.553280204763;5088.872778180538;5207.765650545697;5215.0873597120735;5262.894742105136;3798.4872042274214;4659.906801863977;4661.254199328091;4720.952790472085;4724.173269677793;5460.372057213432;5509.283793106871;5546.63946843458;5557.360903496069;5566.721663916788;3288.2765791525826;3709.8330575124182;3917.6865850731874;3934.7998860347584;3942.980285098585;5516.834494965157;5798.4344227058455;5803.4330730702895;5807.680577568232;5818.330891947396;3524.8942531724088;3930.6762561182472;3944.1322908959983;3991.960080399217;4051.171642797587;3603.94594081089;3812.1422679897355;4082.4692789937117;4090.775007374623;4092.2020206059533;4116.300228961084;4471;4483.55164483549;4509.842155524607;4549.475925564972;4568.657350698711;5452.591055670761;5504;5514.944850551524;5532.972335138379;1123.8258069999163;1200.9399530023463;1237.2390979547513;1246.4827096754927;1264.134068163311;787.1656044592636;787.9645415956296;826.2316046077086;858.4377232912452;864.5374724522351;4428.671398580477;4847.079054979543;4861.683990540603;4882.462929077798;4883.8290659826735;4710.4347478302825;5120.948790512121;5297.496737809902;5298.867528311823;5309.840644816328;4314.633256173198;4852.296417019513;4866.977934633695;4904.60763138948;4916.819963208804;2485;2652.8938842446087;2797.8041537092613;2819.7744180465515;2902.708294808832;5250.2411692082815;5632.859178520488;5702.315722113373;5774.68239246837;5782.739776709974;4898.975505122452;5018.372703412074;5079.5428411443145;5194.714290713971;5689.070128883628;4977.875553111129;5267.023397334988;5268.841934741964;5465.918011229915;5530.870614813326;4882.707037577757;5141.38303403594;5463.617546771847;5531.9723401382735;5548.9722551386985;5244.112119637004;5435.776950186335;5458.4792808639;5616.03438796418;5644.407337229532;5985.348937148423;6009.175687426902;6025.698715064142;6033.668148251888;6043.576949613484;4067.349224124126;4088.918221635491;4094.9385759214233;4115.526714427879;4121;5642.745896729449;5676.517496012885;5718.541771848152;5754.597178197486;5770.855728606818;5022.874428139326;5345.423100185377;5529.889402212014;5532.806351777668;5538.944610553843;5348.171033489815;5493.505584497414;5519.420460851713;5668.603197776116;5670.914936276042;4643.141018911512;5357.7301402218245;5559.749811258584;5610.579206559442;5611.943880561305;4894.6682186266125;5191.351081114861;5242.397124330599;5651.85870353228;5673.347565030074;4828.396450443694;5343.679379237258;5510.586705996986;5552.417560995097;5558.666480011212 12:14:10 INFO - PROCESS | 1929 | |5;yui.html;710.1229980973494;710.1407297170424;768.7501561992352;769.99615001925;770.653206057274;14019.228942408163;15198.468053618126;15200.467983620576;15231.162286074275;15253.23733813309;13539.323033848317;13715.451381944735;13735.931320343409;13750;13788.379522921468;717.3113810741668;743.0117943135643;743.22704387437;845.9365547583925;864.5158711121792;738.6860584251698;740.3669862267765;740.3928778401713;863.3309185381316;893.964241430342;944.3908678902104;949.0082863407755;954.3939598355059;957.3920560444134;962.451402700461;950.6815216902346;953.4612943686794;954.7708549947962;958.0515289863055;959.1128206409079;708.7979925721145;709.3296834491408;709.4714437743862;709.7090193020888;711.7224282529818;13504.459821607124;13863.098898571561;13869.167849929037;13872.861271387257;14564.92717536416;13658.248796316198;13752;13822.447102115902;13883.236421996786;14183.361748721332;11231.708353539367;11328.207025508218;11465.598704045318;11740.589079382265;12137.635870923887;3701.648343407372;3706.2031663192274;3774.1319496515957;3835.5589107252745;3924.529056513208;79486;79962;80019.5999020007;80486;81000;10640.627578034731;10714.196435267386;10814;10844.511996959998;10855.348679079281;20991.790082098985;21024.474388140112;21263.36209913705;21285.46786330354;21332;7503.5873026982945;7598.278163574562;7640.503367281109;7787.415943804124;7820.882686759704;3534.5228394166975;4232.746035237896;4233.767142807175;4282.721623094489;4362.149380870763;2946.6316710411197;3322.069820450278;3377.5778027746533;3378.1048022274117;3463.480477928331;620.9130721698966;625.3215261441296;636.898096304589;638.3680156644888;647.0649910878735;561.7163332517134;646.3181343682367;660.9966950165218;679.9864002719918;694.4513834071028;8963.910360896438;9140.771480713036;9152.81694366109;9213;9636.132748052569;559.6921693068796;581.2937281203358;640.9775657851952;669.3908543225641;673.1585518102372;4195.496540415109;4234.978825105916;4449.310356894686;4453.821847126143;4459.821607135678;68549;94165;107091.46454267678;109956.45021775;111407;97031.02968970362;100661;102502.48748756209;103779;105962;77556.61221693855;91552.54223728839;92532;93206;94527.52736236274;8596.527191004305;8602.354823388147;8686.739397818075;8704.651813927625;8806.691765788166;55836.88326233534;56177.43822561722;56390.59023524445;58382.4161758377;59057;74502.25497744953;78997;81610.59194703988;81860.59069704614;82974;11081;11087.057600103759;11484.770304594029;11829.408529573659;11874.940625296818;12045;12219.45012474423;12400.75198496007;12470.937645311715;12547.560835370718;11479.483423246142;11527.193096483166;11799.410029498318;11850.229735067192;12283.75432491363;11544.191906566795;11671.59149429766;11740;11926.821097683369;12496.312702801433;8587.828243434971;12339.197952133083;12883.935580322039;13023.869761302265;13249.602511924657;10184.267289691526;10495.959656124085;10510.474476276002;10919.344839309666;11242.550297988317;10685.198610104118;10882;11058.39996817429;11128.777424451628;11164.609238676607 12:14:10 INFO - PROCESS | 1929 | __end_tp_report 12:14:10 INFO - PROCESS | 1929 | __start_cc_report 12:14:10 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,1177 12:14:10 INFO - PROCESS | 1929 | __end_cc_report 12:14:10 INFO - PROCESS | 1929 | __startTimestamp1487794450231__endTimestamp 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | ------- Summary: start ------- 12:14:10 INFO - PROCESS | 1929 | Number of tests: 6 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5752.27 Median:5966.85 stddev:661.43 (11.1%) stddev-sans-first:634.91 12:14:10 INFO - PROCESS | 1929 | Values: 3301.8 3417.7 3430.1 3433.3 3477.3 5737.8 5777.2 5785.9 5788.2 5808.8 5717.5 5790.8 5801.3 5803.8 5810.7 5193.2 5220.7 5271.3 5274.4 5296.0 4172.6 5197.9 5203.7 5314.2 5323.3 5215.7 5231.4 5246.5 5246.7 5325.0 5251.6 5267.3 5306.7 5307.2 5316.9 5117.4 5171.7 5249.0 5253.4 5279.9 5598.0 5657.0 5676.5 5678.4 5746.9 6218.7 6282.9 6285.9 6287.5 6334.0 5257.5 6286.9 6315.8 6340.0 6365.3 5673.8 5743.4 5779.5 5822.1 5902.8 6301.2 6323.9 6324.2 6328.2 6334.6 6227.8 6238.8 6249.4 6251.2 6270.7 5237.6 6107.9 6138.8 6282.2 6302.7 6154.3 6193.6 6226.7 6240.8 6298.9 6209.6 6276.2 6294.3 6300.6 6311.4 4448.0 4780.9 4907.2 4960.3 4968.8 4407.0 4417.9 4459.8 4499.9 4516.3 5798.5 5801.7 5802.5 5812.2 5815.6 6227.1 6276.3 6278.5 6286.3 6288.2 5668.5 5775.2 5837.1 5867.6 5922.8 5457.4 5471.3 5478.3 5480.0 5491.6 5346.9 6348.0 6382.2 6382.5 6405.5 6081.6 6142.0 6217.0 6253.1 6327.2 6295.3 6316.3 6336.1 6343.2 6362.2 6233.0 6233.3 6250.2 6265.9 6281.8 6142.0 6216.3 6225.0 6322.0 6323.6 6100.9 6184.5 6199.5 6201.9 6208.4 5115.5 6151.6 6170.0 6173.0 6174.3 5737.9 5879.5 5966.9 6037.0 6051.7 4720.7 6110.5 6158.1 6176.5 6278.8 6035.8 6049.5 6053.3 6054.1 6085.1 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:71250.34 Median:37025.26 stddev:158211.11 (427.3%) stddev-sans-first:158565.77 12:14:10 INFO - PROCESS | 1929 | Values: 507.3 507.7 507.8 554.7 566.3 30268.2 32300.8 32547.8 40491.8 40648.0 41982.0 42284.4 42404.6 42422.0 42522.6 8055.4 9571.8 9573.9 9577.3 9590.2 8756.4 8928.4 8932.9 9003.9 9288.4 8927.9 11207.9 11419.8 11460.7 11627.1 11466.1 11533.9 11542.1 11554.4 11567.1 11336.9 11400.4 11406.4 11406.5 11414.1 32709.0 40011.0 40095.0 40100.8 40138.2 3271.8 3357.8 3742.4 3906.2 3936.1 28946.0 29011.7 29109.7 30617.4 30903.1 3111.4 3203.9 3334.7 3370.8 3405.4 495564.0 500432.0 501403.0 502797.0 505751.0 57624.7 58017.1 58052.0 58086.7 58139.4 59831.0 59887.7 59939.0 59971.8 60113.7 16159.6 16367.3 16369.9 16372.8 16427.4 12784.4 12825.1 12843.9 12855.9 12866.8 11955.3 13479.4 13723.3 15122.5 15263.0 5533.3 5549.2 6577.6 6624.1 6655.4 870.2 927.0 966.7 1028.8 1073.6 28623.4 29101.2 29267.1 29303.0 29389.9 953.2 1021.2 1056.0 1068.9 1118.1 14425.9 14928.0 15125.4 15258.5 15359.0 661206.0 667262.0 667299.0 667576.0 668291.0 52094.0 53219.5 56050.0 56895.1 56942.9 1358.3 1380.1 1413.6 1415.4 1417.1 29482.3 30118.0 30422.7 30548.8 30556.8 47809.8 48350.8 48365.5 48394.8 48449.8 574102.0 578398.0 584516.0 615903.0 618486.0 37098.3 37287.8 37478.4 37661.8 38050.0 44780.0 44962.1 44997.0 45565.8 45615.8 36222.0 36424.5 36431.6 37311.4 37846.9 36503.0 36595.6 37454.9 37756.8 37898.0 35614.6 36157.1 36169.5 36535.8 36952.3 31894.0 32314.4 32538.9 32653.5 32973.8 21343.0 24195.2 24284.4 24787.9 24801.6 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:35389.74 Median:14514.97 stddev:100468.56 (692.2%) stddev-sans-first:100716.01 12:14:10 INFO - PROCESS | 1929 | Values: 379.5 380.6 394.6 401.9 405.5 18764.7 20712.7 21117.0 21153.9 21413.9 20263.9 20750.8 20881.3 21225.7 21321.9 5810.0 5947.6 6046.3 6099.5 6104.2 4371.9 4597.9 4601.6 6061.7 6170.2 6409.2 6679.4 6706.8 6770.2 6776.9 6610.3 6703.2 6709.0 6762.9 6778.8 5849.0 5858.7 5912.3 5912.5 5920.4 25779.0 25938.4 26133.2 26135.5 26377.9 2149.6 2206.8 2325.4 2479.8 2652.1 10095.8 10445.3 10619.5 11621.3 15109.2 1848.4 1860.2 1862.2 1864.2 1865.4 126432.0 127117.0 130534.0 130623.0 133922.0 9381.8 11194.3 11690.3 11759.4 11902.8 14942.3 14951.3 14990.9 15000.9 15016.7 8358.1 8625.6 8658.4 8789.0 8808.6 8445.3 8466.7 8503.0 8651.9 8670.0 4523.8 4640.8 4645.3 4681.5 4720.9 1635.4 1666.8 1785.3 1803.0 1836.3 873.7 897.7 908.4 910.5 922.2 20582.9 20974.0 21576.8 21590.9 21749.0 890.9 909.0 937.2 944.8 964.8 11104.9 11510.2 11573.7 11577.7 11602.8 541120.0 603866.0 609427.0 622709.0 626129.0 118050.3 118565.0 121859.0 122462.0 131171.0 962.1 966.5 971.9 985.0 985.5 15572.1 18779.1 19290.0 19313.3 19398.9 53374.7 53665.7 54134.7 55288.0 56047.4 74710.5 75021.9 75808.2 77280.6 77725.8 7080.9 8076.5 8085.4 8166.4 8467.4 12522.7 12691.0 12837.6 13008.2 13210.5 10765.5 11052.5 11106.4 11238.2 11269.0 8122.6 11005.3 11034.7 11070.6 11225.8 11060.0 11140.6 11343.4 11450.1 11678.5 8027.7 8087.2 8178.9 8353.6 8596.4 8344.4 10967.4 11111.8 11297.6 11355.2 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5412.88 Median:4945.32 stddev:2934.59 (59.3%) stddev-sans-first:2926.48 12:14:10 INFO - PROCESS | 1929 | Values: 1292.5 1532.1 1655.9 1730.1 1880.1 7948.9 8394.4 8413.0 8415.7 8422.1 7457.3 7651.1 7946.3 8140.8 8199.2 2314.2 2354.3 2356.6 2358.5 2359.4 2341.8 2365.3 2377.0 2395.3 2395.8 2333.5 2346.4 2368.3 2369.7 2371.9 2331.8 2338.4 2362.9 2363.7 2369.5 2360.9 2385.1 2385.2 2385.8 2386.8 8224.0 8227.4 8325.7 8341.4 8373.1 4937.4 5102.1 5102.5 5105.3 5108.2 3195.6 3309.0 3580.9 3587.8 3592.8 1073.8 1074.4 1099.3 1115.6 1122.1 10708.5 10809.0 10812.7 10828.2 10844.3 4472.9 4625.6 4730.3 4750.9 4764.8 9300.2 9306.5 9308.3 9319.0 9325.8 5196.0 5198.5 5204.9 5213.3 5219.5 3995.4 4217.1 4728.1 4779.4 4785.6 3146.0 3784.8 3863.2 3900.3 3912.2 1280.5 1289.8 1290.4 1298.4 1310.3 798.9 895.7 914.6 923.1 925.5 4819.1 5657.5 5663.2 5741.0 5777.1 972.1 985.8 1008.0 1044.0 1080.4 3740.8 3781.9 3787.9 3920.4 3923.6 9773.4 10004.4 10076.0 10122.2 10128.4 10070.8 10074.4 10076.5 10084.5 10088.5 7656.8 7762.3 7771.2 7935.7 7949.7 5435.9 5479.2 5513.7 5656.1 5768.3 9144.9 9241.8 9313.7 9331.1 9413.9 9362.2 9376.4 9465.1 9486.4 9530.2 6266.9 6334.0 6465.9 6483.4 6760.0 7733.0 7905.7 7905.8 7911.2 7939.0 6175.1 6434.7 6931.4 7045.2 7173.5 6345.1 6980.5 6993.6 7049.7 7051.5 6527.0 6585.3 6621.1 6703.6 6708.9 4782.4 4808.1 4851.0 4904.1 4955.6 4590.6 4795.9 4850.9 4953.3 5064.4 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:4493.89 Median:4998.12 stddev:1364.13 (27.3%) stddev-sans-first:1331.12 12:14:10 INFO - PROCESS | 1929 | Values: 298.7 311.9 313.3 325.9 327.5 4845.4 5179.9 5314.2 5359.2 5375.5 4798.3 5237.5 5265.3 5284.2 5294.7 4075.5 4096.4 4100.0 4122.3 4154.6 3420.5 3911.3 3935.0 4125.0 4149.6 3827.8 4079.2 4085.9 4096.7 4132.3 3551.5 4053.4 4055.6 4062.5 4107.8 3584.3 3592.3 3609.9 3610.8 3616.8 4963.6 5088.9 5207.8 5215.1 5262.9 3798.5 4659.9 4661.3 4721.0 4724.2 5460.4 5509.3 5546.6 5557.4 5566.7 3288.3 3709.8 3917.7 3934.8 3943.0 5516.8 5798.4 5803.4 5807.7 5818.3 3524.9 3930.7 3944.1 3992.0 4051.2 3603.9 3812.1 4082.5 4090.8 4092.2 4116.3 4471.0 4483.6 4509.8 4549.5 4568.7 5452.6 5504.0 5514.9 5533.0 1123.8 1200.9 1237.2 1246.5 1264.1 787.2 788.0 826.2 858.4 864.5 4428.7 4847.1 4861.7 4882.5 4883.8 4710.4 5120.9 5297.5 5298.9 5309.8 4314.6 4852.3 4867.0 4904.6 4916.8 2485.0 2652.9 2797.8 2819.8 2902.7 5250.2 5632.9 5702.3 5774.7 5782.7 4899.0 5018.4 5079.5 5194.7 5689.1 4977.9 5267.0 5268.8 5465.9 5530.9 4882.7 5141.4 5463.6 5532.0 5549.0 5244.1 5435.8 5458.5 5616.0 5644.4 5985.3 6009.2 6025.7 6033.7 6043.6 4067.3 4088.9 4094.9 4115.5 4121.0 5642.7 5676.5 5718.5 5754.6 5770.9 5022.9 5345.4 5529.9 5532.8 5538.9 5348.2 5493.5 5519.4 5668.6 5670.9 4643.1 5357.7 5559.7 5610.6 5611.9 4894.7 5191.4 5242.4 5651.9 5673.3 4828.4 5343.7 5510.6 5552.4 5558.7 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:20461.03 Median:4258.85 stddev:29991.13 (704.2%) stddev-sans-first:30038.60 12:14:10 INFO - PROCESS | 1929 | Values: 710.1 710.1 768.8 770.0 770.7 14019.2 15198.5 15200.5 15231.2 15253.2 13539.3 13715.5 13735.9 13750.0 13788.4 717.3 743.0 743.2 845.9 864.5 738.7 740.4 740.4 863.3 894.0 944.4 949.0 954.4 957.4 962.5 950.7 953.5 954.8 958.1 959.1 708.8 709.3 709.5 709.7 711.7 13504.5 13863.1 13869.2 13872.9 14564.9 13658.2 13752.0 13822.4 13883.2 14183.4 11231.7 11328.2 11465.6 11740.6 12137.6 3701.6 3706.2 3774.1 3835.6 3924.5 79486.0 79962.0 80019.6 80486.0 81000.0 10640.6 10714.2 10814.0 10844.5 10855.3 20991.8 21024.5 21263.4 21285.5 21332.0 7503.6 7598.3 7640.5 7787.4 7820.9 3534.5 4232.7 4233.8 4282.7 4362.1 2946.6 3322.1 3377.6 3378.1 3463.5 620.9 625.3 636.9 638.4 647.1 561.7 646.3 661.0 680.0 694.5 8963.9 9140.8 9152.8 9213.0 9636.1 559.7 581.3 641.0 669.4 673.2 4195.5 4235.0 4449.3 4453.8 4459.8 68549.0 94165.0 107091.5 109956.5 111407.0 97031.0 100661.0 102502.5 103779.0 105962.0 77556.6 91552.5 92532.0 93206.0 94527.5 8596.5 8602.4 8686.7 8704.7 8806.7 55836.9 56177.4 56390.6 58382.4 59057.0 74502.3 78997.0 81610.6 81860.6 82974.0 11081.0 11087.1 11484.8 11829.4 11874.9 12045.0 12219.5 12400.8 12470.9 12547.6 11479.5 11527.2 11799.4 11850.2 12283.8 11544.2 11671.6 11740.0 11926.8 12496.3 8587.8 12339.2 12883.9 13023.9 13249.6 10184.3 10496.0 10510.5 10919.3 11242.6 10685.2 10882.0 11058.4 11128.8 11164.6 12:14:10 INFO - PROCESS | 1929 | -------- Summary: end -------- 12:14:10 INFO - PROCESS | 1929 | 12:14:10 INFO - TEST-INFO | 1929: exit 0 12:14:10 INFO - TEST-OK | dromaeo_css | took 1117821ms 12:14:10 INFO - TEST-START | kraken 12:14:10 INFO - operating with platform_type : mac_ 12:14:10 INFO - Initialising browser for kraken test... 12:14:10 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpv7oiLM/profile http://localhost:52731/getInfo.html) 12:14:13 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 12:14:13 INFO - PROCESS | 1934 | colorDepth:24 12:14:13 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 12:14:13 INFO - PROCESS | 1934 | __metrics 12:14:13 INFO - PROCESS | 1934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:14:13 INFO - PROCESS | 1934 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:14 INFO - TEST-INFO | 1934: exit 0 12:14:14 INFO - Browser initialized. 12:14:14 INFO - Running cycle 1/1 for kraken test... 12:14:14 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpv7oiLM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:26 INFO - PROCESS | 1936 | RSS: Main: 172466176 12:14:26 INFO - PROCESS | 1936 | 12:14:29 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52731/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:30 INFO - PROCESS | 1936 | RSS: Main: 222466048 12:14:30 INFO - PROCESS | 1936 | 12:14:32 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52731/tests/kraken/driver.html?testName=audio-dft) 12:14:33 INFO - PROCESS | 1936 | RSS: Main: 234393600 12:14:33 INFO - PROCESS | 1936 | 12:14:36 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52731/tests/kraken/driver.html?testName=audio-fft) 12:14:36 INFO - PROCESS | 1936 | RSS: Main: 330739712 12:14:36 INFO - PROCESS | 1936 | 12:14:39 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52731/tests/kraken/driver.html?testName=audio-oscillator) 12:14:39 INFO - PROCESS | 1936 | RSS: Main: 234598400 12:14:39 INFO - PROCESS | 1936 | 12:14:41 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:14:42 INFO - PROCESS | 1936 | RSS: Main: 236032000 12:14:42 INFO - PROCESS | 1936 | 12:14:44 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52731/tests/kraken/driver.html?testName=imaging-darkroom) 12:14:45 INFO - PROCESS | 1936 | RSS: Main: 276180992 12:14:45 INFO - PROCESS | 1936 | 12:14:48 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52731/tests/kraken/driver.html?testName=imaging-desaturate) 12:14:49 INFO - PROCESS | 1936 | RSS: Main: 277463040 12:14:49 INFO - PROCESS | 1936 | 12:14:51 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52731/tests/kraken/driver.html?testName=json-parse-financial) 12:14:52 INFO - PROCESS | 1936 | RSS: Main: 275058688 12:14:52 INFO - PROCESS | 1936 | 12:14:53 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:54 INFO - PROCESS | 1936 | RSS: Main: 250277888 12:14:54 INFO - PROCESS | 1936 | 12:14:56 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:57 INFO - PROCESS | 1936 | RSS: Main: 249839616 12:14:57 INFO - PROCESS | 1936 | 12:14:59 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:59 INFO - PROCESS | 1936 | RSS: Main: 254091264 12:14:59 INFO - PROCESS | 1936 | 12:15:02 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:03 INFO - PROCESS | 1936 | RSS: Main: 269189120 12:15:03 INFO - PROCESS | 1936 | 12:15:06 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:06 INFO - PROCESS | 1936 | RSS: Main: 263106560 12:15:06 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52731/tests/kraken/driver.html?testName=ai-astar) 12:15:08 INFO - PROCESS | 1936 | RSS: Main: 307322880 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | __start_tp_report 12:15:08 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 12:15:08 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 12:15:08 INFO - PROCESS | 1936 | |i|pagename|runs| 12:15:08 INFO - PROCESS | 1936 | |0;ai-astar;115;113;113;114;114;114;112;113;114;114 12:15:08 INFO - PROCESS | 1936 | |1;audio-beat-detection;141;108;108;143;108;108;108;107;137;107 12:15:08 INFO - PROCESS | 1936 | |2;audio-dft;183;184;183;185;183;183;184;182;183;180 12:15:08 INFO - PROCESS | 1936 | |3;audio-fft;81;60;77;112;86;59;58;57;81;59 12:15:08 INFO - PROCESS | 1936 | |4;audio-oscillator;86;71;92;68;67;69;89;67;69;90 12:15:08 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;88;87;89;87;80;113;135;87;89;85 12:15:08 INFO - PROCESS | 1936 | |6;imaging-darkroom;94;94;94;93;94;108;129;93;93;101 12:15:08 INFO - PROCESS | 1936 | |7;imaging-desaturate;83;81;79;83;83;80;85;83;85;83 12:15:08 INFO - PROCESS | 1936 | |8;json-parse-financial;58;54;50;51;52;56;58;57;57;55 12:15:08 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;64;71;79;75;70;68;68;69;68;70 12:15:08 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;82;82;81;83;84;81;85;81;81;88 12:15:08 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;141;160;145;142;137;139;138;138;186;136 12:15:08 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;161;162;158;167;162;159;160;162;159;161 12:15:08 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;66;65;66;65;66;67;66;64;65;63 12:15:08 INFO - PROCESS | 1936 | __end_tp_report 12:15:08 INFO - PROCESS | 1936 | __start_cc_report 12:15:08 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1944 12:15:08 INFO - PROCESS | 1936 | __end_cc_report 12:15:08 INFO - PROCESS | 1936 | __startTimestamp1487794508673__endTimestamp 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | ------- Summary: start ------- 12:15:08 INFO - PROCESS | 1936 | Number of tests: 14 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.73 12:15:08 INFO - PROCESS | 1936 | Values: 115.0 113.0 113.0 114.0 114.0 114.0 112.0 113.0 114.0 114.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:108.00 stddev:15.83 (14.7%) stddev-sans-first:14.32 12:15:08 INFO - PROCESS | 1936 | Values: 141.0 108.0 108.0 143.0 108.0 108.0 108.0 107.0 137.0 107.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.33 (0.7%) stddev-sans-first:1.41 12:15:08 INFO - PROCESS | 1936 | Values: 183.0 184.0 183.0 185.0 183.0 183.0 184.0 182.0 183.0 180.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:73.00 Median:68.50 stddev:17.88 (26.1%) stddev-sans-first:18.72 12:15:08 INFO - PROCESS | 1936 | Values: 81.0 60.0 77.0 112.0 86.0 59.0 58.0 57.0 81.0 59.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.50 stddev:10.87 (13.8%) stddev-sans-first:11.01 12:15:08 INFO - PROCESS | 1936 | Values: 86.0 71.0 92.0 68.0 67.0 69.0 89.0 67.0 69.0 90.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:87.00 stddev:16.84 (19.4%) stddev-sans-first:17.72 12:15:08 INFO - PROCESS | 1936 | Values: 88.0 87.0 89.0 87.0 80.0 113.0 135.0 87.0 89.0 85.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:93.50 stddev:11.51 (12.3%) stddev-sans-first:12.05 12:15:08 INFO - PROCESS | 1936 | Values: 94.0 94.0 94.0 93.0 94.0 108.0 129.0 93.0 93.0 101.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:82.50 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.07 12:15:08 INFO - PROCESS | 1936 | Values: 83.0 81.0 79.0 83.0 83.0 80.0 85.0 83.0 85.0 83.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.50 stddev:2.94 (5.2%) stddev-sans-first:2.88 12:15:08 INFO - PROCESS | 1936 | Values: 58.0 54.0 50.0 51.0 52.0 56.0 58.0 57.0 57.0 55.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:4.16 (5.9%) stddev-sans-first:3.76 12:15:08 INFO - PROCESS | 1936 | Values: 64.0 71.0 79.0 75.0 70.0 68.0 68.0 69.0 68.0 70.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.30 (2.8%) stddev-sans-first:2.42 12:15:08 INFO - PROCESS | 1936 | Values: 82.0 82.0 81.0 83.0 84.0 81.0 85.0 81.0 81.0 88.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:141.50 stddev:15.62 (11.0%) stddev-sans-first:16.45 12:15:08 INFO - PROCESS | 1936 | Values: 141.0 160.0 145.0 142.0 137.0 139.0 138.0 138.0 186.0 136.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.51 (1.6%) stddev-sans-first:2.67 12:15:08 INFO - PROCESS | 1936 | Values: 161.0 162.0 158.0 167.0 162.0 159.0 160.0 162.0 159.0 161.0 12:15:08 INFO - PROCESS | 1936 | 12:15:08 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 12:15:08 INFO - PROCESS | 1936 | Values: 66.0 65.0 66.0 65.0 66.0 67.0 66.0 64.0 65.0 63.0 12:15:08 INFO - PROCESS | 1936 | -------- Summary: end -------- 12:15:08 INFO - PROCESS | 1936 | 12:15:09 INFO - TEST-INFO | 1936: exit 0 12:15:09 INFO - TEST-OK | kraken | took 58810ms 12:15:09 INFO - SUITE-END | took 1176s 12:15:09 INFO - Completed test suite (00:19:36) 12:15:09 INFO - javascript benchmark 12:15:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.8349082545874, 3417.7265818734504, 3430.1081718753126, 3433.3305005523935, 3477.269773347597, 5737.770489180428, 5777.191193232946, 5785.884282314361, 5788.18965344852, 5808.767649294028, 5717.456841600041, 5790.797322093727, 5801.303843538782, 5803.767849286023, 5810.709464526778, 5193.195054766517, 5220.712860792655, 5271.262023316739, 5274.4461831507715, 5295.973520132394, 4172.603602657743, 5197.896042079156, 5203.739813009353, 5314.229436731672, 5323.254744335796, 5215.739213039352, 5231.424543300234, 5246.50158234969, 5246.658967167122, 5324.988252232083, 5251.632385733019, 5267.315249017642, 5306.681599104066, 5307.230451584499, 5316.893662126736, 5117.360329958755, 5171.741412929338, 5248.950209958024, 5253.4221235664045, 5279.894402111936, 5598.020346439397, 5657.038303488417, 5676.517496012802, 5678.43215678433, 5746.856328591777, 6218.720157592919, 6282.905756413657, 6285.8742825143245, 6287.465565426898, 6333.9683301583655, 5257.5005374489365, 6286.87426251477, 6315.778947736807, 6340.048992651139, 6365.29981702017, 5673.773049078073, 5743.4256574342235, 5779.450952159538, 5822.0684690449325, 5902.763889444417, 6301.180846489927, 6323.873522529524, 6324.209473815773, 6328.240611126695, 6334.556581039283, 6227.813165605039, 6238.844028899223, 6249.437550620375, 6251.218597675291, 6270.6864656766975, 5237.633365664443, 6107.886786452505, 6138.817583427312, 6282.151909492251, 6302.716377763011, 6154.323024467305, 6193.566450348522, 6226.688665566794, 6240.7503699852405, 6298.937010629835, 6209.59637623553, 6276.246850377984, 6294.276158241861, 6300.558960872695, 6311.400416960473, 4448.0, 4780.904381912343, 4907.1657818171, 4960.255961605716, 4968.826091086867, 4406.986393129534, 4417.889552761142, 4459.799309031101, 4499.887502812456, 4516.322551617283, 5798.536117110621, 5801.7099145042575, 5802.506786923159, 5812.215350927655, 5815.563832712479, 6227.1282020517165, 6276.340984196594, 6278.497720182374, 6286.277078135981, 6288.213973253343, 5668.518175955008, 5775.249217601769, 5837.066069428871, 5867.589268751147, 5922.822315330547, 5457.399686034533, 5471.2887324647545, 5478.342598888159, 5480.013597552399, 5491.643043202179, 5346.866328341823, 6348.0, 6382.234131904202, 6382.457491113308, 6405.487560995202, 6081.6351018939, 6142.038385241405, 6216.968915155395, 6253.093301471352, 6327.209098862642, 6295.276043254901, 6316.273628532594, 6336.08126821599, 6343.175387199819, 6362.236531616236, 6233.002719564848, 6233.345498722569, 6250.249970003629, 6265.906011409741, 6281.842953926189, 6141.977005061692, 6216.347283535345, 6224.968875155595, 6321.956877115224, 6323.620582765049, 6100.908486372797, 6184.474319682878, 6199.473044791062, 6201.875962480635, 6208.441240288215, 5115.514026167508, 6151.630902145886, 6169.96915015422, 6173.0, 6174.289956655042, 5737.8565535861935, 5879.470847623735, 5966.850828729316, 6037.0, 6051.697415129314, 4720.716756994591, 6110.480609148272, 6158.137860699416, 6176.505879529537, 6278.8430289241305, 6035.849103772441, 6049.485793707408, 6053.334133245251, 6054.122152287806, 6085.087236914498], "value": 5711.5168489875505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.254336125895, 507.7359772918082, 507.8146476536064, 554.7198664674341, 566.3486989961547, 30268.243293917636, 32300.83849580752, 32547.837260813663, 40491.797541012325, 40648.0, 41982.0, 42284.36573451393, 42404.57595424045, 42422.0, 42522.57477425225, 8055.395845311596, 9571.760705982337, 9573.904260957406, 9577.281703872202, 9590.184834289093, 8756.387052906268, 8928.419652722552, 8932.910670893272, 9003.864942025875, 9288.396254243453, 8927.866082008743, 11207.943960280187, 11419.771604567904, 11460.656180314603, 11627.069834413227, 11466.08271338291, 11533.884661153406, 11542.134339924456, 11554.422278886022, 11567.074634029257, 11336.886631133666, 11400.372979486125, 11406.372649504274, 11406.54373825046, 11414.086873050135, 32709.0, 40011.0, 40095.0, 40100.799496002626, 40138.197236055115, 3271.8200498972546, 3357.84889679965, 3742.419924911643, 3906.238283534712, 3936.094698219397, 28946.0, 29011.709882901323, 29109.708902910912, 30617.38765224683, 30903.072907812802, 3111.424386488507, 3203.855826487814, 3334.733221342287, 3370.7640465167447, 3405.4381027130494, 495564.0, 500432.0, 501403.0, 502797.0, 505751.0, 57624.71187644035, 58017.12974305389, 58052.0, 58086.7095664519, 58139.418605814244, 59831.0, 59887.70056149692, 59939.0, 59971.80056398847, 60113.69943150344, 16159.596010099842, 16367.345306187857, 16369.918150409172, 16372.754408683879, 16427.425040123537, 12784.424700888483, 12825.102242842911, 12843.871561284455, 12855.935720321339, 12866.806997895039, 11955.282683039046, 13479.393427295796, 13723.313834308245, 15122.470713524974, 15263.0, 5533.280673512498, 5549.223108764776, 6577.585819048927, 6624.105745724362, 6655.43428808547, 870.216804875617, 926.967556135532, 966.7244835221928, 1028.7993841200894, 1073.6295977887617, 28623.427531449255, 29101.21990113218, 29267.121986340444, 29302.97439589647, 29389.853050735037, 953.2469349214043, 1021.1779517488493, 1055.9577616895392, 1068.9412082335546, 1118.0887576625187, 14425.855741442661, 14928.0, 15125.44587991964, 15258.465953691568, 15359.001664891746, 661206.0, 667262.0, 667299.0, 667576.0, 668291.0, 52093.95812083737, 53219.46780532222, 56050.0, 56895.146572801445, 56942.861142776914, 1358.2529608715167, 1380.1443105274593, 1413.5971248194421, 1415.405529677538, 1417.093060441339, 29482.26294342573, 30118.0, 30422.695773042873, 30548.84725576358, 30556.84721576378, 47809.80475488141, 48350.75824620854, 48365.5163448361, 48394.75802621105, 48449.75775121102, 574102.0, 578398.0, 584516.0, 615903.0, 618486.0, 37098.258034839695, 37287.81356093202, 37478.43782343213, 37661.81169094137, 38050.0, 44780.0, 44962.100757984, 44997.0, 45565.77217113893, 45615.771921140185, 36222.0, 36424.45363319499, 36431.635683642824, 37311.44032839564, 37846.864594061124, 36503.0, 36595.634043660284, 37454.876353709435, 37756.811215943744, 37898.0, 35614.64385356113, 36157.09607259734, 36169.45745813762, 36535.81732091322, 36952.26095478021, 31894.043178704676, 32314.35371292608, 32538.86113985999, 32653.510197347536, 32973.83513082419, 21343.0, 24195.15316963968, 24284.39289017718, 24787.876060619583, 24801.62797558074], "value": 19855.304130643988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.51232666024146, 380.5585520795877, 394.6152501311222, 401.89148929788956, 405.49718349246945, 18764.71852922207, 20712.689309660367, 21117.049732762025, 21153.894230528866, 21413.892930535345, 20263.898680506612, 20750.75495470273, 20881.269155579557, 21225.68161477579, 21321.893390533063, 5809.9709501452435, 5947.583669143161, 6046.304674962392, 6099.512039036888, 6104.206453161083, 4371.912561748763, 4597.885052873671, 4601.608863246612, 6061.696915154247, 6170.197874276338, 6409.198850143732, 6679.365460281289, 6706.832329191785, 6770.1537307836525, 6776.864462710742, 6610.272869984298, 6703.162104736933, 6709.0, 6762.932370676329, 6778.76274330401, 5848.97075514624, 5858.707064646751, 5912.290525137011, 5912.4974377178, 5920.407959204088, 25779.0, 25938.351541211432, 26133.216003519923, 26135.477290454084, 26377.868110659325, 2149.6023235701446, 2206.7682893296133, 2325.4186453386656, 2479.801615870726, 2652.071774878777, 10095.798084038279, 10445.26883118182, 10619.469026548719, 11621.302721836717, 15109.168995705231, 1848.4454663601, 1860.2466001269509, 1862.1620270878159, 1864.2449807827716, 1865.3750993417223, 126432.0, 127117.0, 130534.0, 130623.0, 133921.99999999904, 9381.842176299353, 11194.272372295774, 11690.298582085103, 11759.37949322626, 11902.761944761056, 14942.25288735559, 14951.252437378087, 14990.8756843235, 15000.924995374953, 15016.699666006838, 8358.122397148212, 8625.568721563897, 8658.437201582003, 8789.0, 8808.5595720215, 8445.324374050184, 8466.74599762008, 8503.0, 8651.918510186226, 8670.0, 4523.84166554169, 4640.767961601907, 4645.279981602857, 4681.485036645966, 4720.858374248778, 1635.3703824027834, 1666.7916510436196, 1785.259117466237, 1802.9733416116192, 1836.3389179895228, 873.6680061576687, 897.7396554998977, 908.3868388837508, 910.4901255297054, 922.2207234886511, 20582.867942263318, 20974.0, 21576.784232157792, 21590.892045539673, 21749.0, 890.9287257019423, 908.977275568116, 937.1659223291276, 944.759086432969, 964.798825462304, 11104.944475277573, 11510.19428640004, 11573.710657233469, 11577.710557236136, 11602.76794464106, 541120.0, 603866.0, 609427.0, 622709.0, 626129.0, 118050.32672876236, 118565.0, 121859.0, 122462.0, 131170.99999999808, 962.1436921140191, 966.5312323523086, 971.8785151856018, 985.0494273026563, 985.522021819417, 15572.065676059472, 18779.061046947325, 19290.0, 19313.324033658755, 19398.93305868191, 53374.733126335675, 53665.7316713414, 54134.72932635312, 55288.0, 56047.43952560422, 74710.50578988499, 75021.87467187888, 75808.24191758012, 77280.61359693391, 77725.83411248722, 7080.867061270172, 8076.515409075474, 8085.39359548048, 8166.4283500154415, 8467.407281490237, 12522.686932826753, 12690.984721222096, 12837.614871553867, 13008.21950682962, 13210.471581136648, 10765.461726913467, 11052.502637381176, 11106.389148596905, 11238.213325067167, 11269.0, 8122.593870306579, 11005.284656497302, 11034.724131896766, 11070.612528561462, 11225.775484490428, 11060.0, 11140.554377824796, 11343.376114313462, 11450.141239406912, 11678.474468649101, 8027.678892844221, 8087.191280872101, 8178.918210817816, 8353.624086916225, 8596.35527335465, 8344.374171937008, 10967.396793176453, 11111.827072253198, 11297.604583839526, 11355.205135640426], "value": 9688.05635891393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.5476083370818, 1532.0695923136848, 1655.8675305975523, 1730.1176400035993, 1880.1069491991307, 7948.92051079489, 8394.370422218328, 8412.99044114707, 8415.70545030924, 8422.11567785382, 7457.291557302047, 7651.120121186065, 7946.324562412202, 8140.837183256332, 8199.22107399796, 2314.166899916033, 2354.281944007077, 2356.575816353056, 2358.516504116652, 2359.3629719975597, 2341.75411581784, 2365.290412876139, 2377.0, 2395.3053614451787, 2395.760423957599, 2333.474968132165, 2346.401667574766, 2368.3131891751373, 2369.6919400477914, 2371.8576885386847, 2331.825113116515, 2338.4153961509624, 2362.9054837806552, 2363.6690863279155, 2369.5379401016808, 2360.9173678921156, 2385.1294277588727, 2385.248646676309, 2385.7852793248517, 2386.832921695482, 8223.95888020562, 8227.42408031438, 8325.708600199025, 8341.374396920255, 8373.120822313631, 4937.382827146606, 5102.056119617845, 5102.489751024905, 5105.259737338065, 5108.182690769459, 3195.6165260168696, 3308.9503657445157, 3580.9283814323826, 3587.820608969541, 3592.76647017943, 1073.8067147913373, 1074.355386767933, 1099.2854644481072, 1115.6262652011585, 1122.0798944865214, 10708.46457677113, 10809.0, 10812.72968175794, 10828.187885908588, 10844.2951208172, 4472.865814025519, 4625.560571745679, 4730.337752714623, 4750.904981900412, 4764.785584648699, 9300.20948219409, 9306.488143152057, 9308.348415610842, 9319.02150274225, 9325.766855828659, 5196.0, 5198.532132108128, 5204.8959020819375, 5213.348331458567, 5219.530242278213, 3995.3607422812793, 4217.0511634881905, 4728.1252968201, 4779.378680771478, 4785.569298763058, 3145.9528107078413, 3784.810759462016, 3863.2466668999277, 3900.317444447267, 3912.158885839558, 1280.5390059578544, 1289.7613941420868, 1290.4128621477205, 1298.3832679477173, 1310.2531557012412, 798.8921495598136, 895.7044175422095, 914.6387177065155, 923.0999775219108, 925.4817302310593, 4819.060283244804, 5657.462541058593, 5663.207150998864, 5741.024025915604, 5777.133429985536, 972.0959507657946, 985.8274801909637, 1008.0121480948565, 1043.994780026095, 1080.357187473452, 3740.8129593520757, 3781.9432708509394, 3787.9242415152094, 3920.3923391874305, 3923.5684074751753, 9773.364731292444, 10004.399736015717, 10076.0, 10122.190224782, 10128.392296462236, 10070.798584028278, 10074.44590547527, 10076.546555405024, 10084.49577521121, 10088.49557522121, 7656.846863062708, 7762.262585054411, 7771.222877712184, 7935.682572697027, 7949.682012719427, 5435.945640543544, 5479.178123281539, 5513.696746678811, 5656.095024796013, 5768.3078030634915, 9144.862827057466, 9241.815163696823, 9313.674021409219, 9331.113544213289, 9413.905860941302, 9362.157405833508, 9376.437413755197, 9465.148136667733, 9486.430814151174, 9530.1899338557, 6266.905996409966, 6333.968330158504, 6465.870682586416, 6483.448906842783, 6760.01979712929, 7732.961335193288, 7905.723299684713, 7905.841883162419, 7911.248431399008, 7939.047314322318, 6175.104609831639, 6434.742610295536, 6931.445484361138, 7045.225025247116, 7173.461990350849, 6345.1434056401795, 6980.546264492995, 6993.615351155735, 7049.718011279491, 7051.5063945523325, 6527.0, 6585.341465853377, 6621.106150669791, 6703.631300278336, 6708.932910671026, 4782.37829082231, 4808.110499557593, 4850.981293928174, 4904.141775189399, 4955.603551715926, 4590.563896429834, 4795.9280610790165, 4850.902981940271, 4953.2570114483115, 5064.41759197697], "value": 4426.793743045664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.72218836482074, 311.9438501069807, 313.3075902256014, 325.8729095652696, 327.52181814550784, 4845.394325709286, 5179.922301165486, 5314.229436731681, 5359.169328754039, 5375.467991622389, 4798.304245884345, 5237.528622423981, 5265.262863199146, 5284.191385838887, 5294.708791016493, 4075.510938687347, 4096.3855421686685, 4099.975006248438, 4122.340425531916, 4154.626083652471, 3420.4698271767916, 3911.2568611963634, 3934.9606503935024, 4125.019990404608, 4149.64727998119, 3827.8086095695244, 4079.2453396121664, 4085.9387109193385, 4096.713230073896, 4132.2768515509815, 3551.4850346699714, 4053.432519447265, 4055.5944405559503, 4062.4921884764403, 4107.849802055429, 3584.301061293049, 3592.2995015971633, 3609.9458508122398, 3610.7833529988284, 3616.7829930204007, 4963.553280204763, 5088.872778180538, 5207.765650545697, 5215.0873597120735, 5262.894742105136, 3798.4872042274214, 4659.906801863977, 4661.254199328091, 4720.952790472085, 4724.173269677793, 5460.372057213432, 5509.283793106871, 5546.63946843458, 5557.360903496069, 5566.721663916788, 3288.2765791525826, 3709.8330575124182, 3917.6865850731874, 3934.7998860347584, 3942.980285098585, 5516.834494965157, 5798.4344227058455, 5803.4330730702895, 5807.680577568232, 5818.330891947396, 3524.8942531724088, 3930.6762561182472, 3944.1322908959983, 3991.960080399217, 4051.171642797587, 3603.94594081089, 3812.1422679897355, 4082.4692789937117, 4090.775007374623, 4092.2020206059533, 4116.300228961084, 4471.0, 4483.55164483549, 4509.842155524607, 4549.475925564972, 4568.657350698711, 5452.591055670761, 5504.0, 5514.944850551524, 5532.972335138379, 1123.8258069999163, 1200.9399530023463, 1237.2390979547513, 1246.4827096754927, 1264.134068163311, 787.1656044592636, 787.9645415956296, 826.2316046077086, 858.4377232912452, 864.5374724522351, 4428.671398580477, 4847.079054979543, 4861.683990540603, 4882.462929077798, 4883.8290659826735, 4710.4347478302825, 5120.948790512121, 5297.496737809902, 5298.867528311823, 5309.840644816328, 4314.633256173198, 4852.296417019513, 4866.977934633695, 4904.60763138948, 4916.819963208804, 2485.0, 2652.8938842446087, 2797.8041537092613, 2819.7744180465515, 2902.708294808832, 5250.2411692082815, 5632.859178520488, 5702.315722113373, 5774.68239246837, 5782.739776709974, 4898.975505122452, 5018.372703412074, 5079.5428411443145, 5194.714290713971, 5689.070128883628, 4977.875553111129, 5267.023397334988, 5268.841934741964, 5465.918011229915, 5530.870614813326, 4882.707037577757, 5141.38303403594, 5463.617546771847, 5531.9723401382735, 5548.9722551386985, 5244.112119637004, 5435.776950186335, 5458.4792808639, 5616.03438796418, 5644.407337229532, 5985.348937148423, 6009.175687426902, 6025.698715064142, 6033.668148251888, 6043.576949613484, 4067.349224124126, 4088.918221635491, 4094.9385759214233, 4115.526714427879, 4121.0, 5642.745896729449, 5676.517496012885, 5718.541771848152, 5754.597178197486, 5770.855728606818, 5022.874428139326, 5345.423100185377, 5529.889402212014, 5532.806351777668, 5538.944610553843, 5348.171033489815, 5493.505584497414, 5519.420460851713, 5668.603197776116, 5670.914936276042, 4643.141018911512, 5357.7301402218245, 5559.749811258584, 5610.579206559442, 5611.943880561305, 4894.6682186266125, 5191.351081114861, 5242.397124330599, 5651.85870353228, 5673.347565030074, 4828.396450443694, 5343.679379237258, 5510.586705996986, 5552.417560995097, 5558.666480011212], "value": 4049.898545803084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.1229980973494, 710.1407297170424, 768.7501561992352, 769.99615001925, 770.653206057274, 14019.228942408163, 15198.468053618126, 15200.467983620576, 15231.162286074275, 15253.23733813309, 13539.323033848317, 13715.451381944735, 13735.931320343409, 13750.0, 13788.379522921468, 717.3113810741668, 743.0117943135643, 743.22704387437, 845.9365547583925, 864.5158711121792, 738.6860584251698, 740.3669862267765, 740.3928778401713, 863.3309185381316, 893.964241430342, 944.3908678902104, 949.0082863407755, 954.3939598355059, 957.3920560444134, 962.451402700461, 950.6815216902346, 953.4612943686794, 954.7708549947962, 958.0515289863055, 959.1128206409079, 708.7979925721145, 709.3296834491408, 709.4714437743862, 709.7090193020888, 711.7224282529818, 13504.459821607124, 13863.098898571561, 13869.167849929037, 13872.861271387257, 14564.92717536416, 13658.248796316198, 13752.0, 13822.447102115902, 13883.236421996786, 14183.361748721332, 11231.708353539367, 11328.207025508218, 11465.598704045318, 11740.589079382265, 12137.635870923887, 3701.648343407372, 3706.2031663192274, 3774.1319496515957, 3835.5589107252745, 3924.529056513208, 79486.0, 79962.0, 80019.5999020007, 80486.0, 81000.0, 10640.627578034731, 10714.196435267386, 10814.0, 10844.511996959998, 10855.348679079281, 20991.790082098985, 21024.474388140112, 21263.36209913705, 21285.46786330354, 21332.0, 7503.5873026982945, 7598.278163574562, 7640.503367281109, 7787.415943804124, 7820.882686759704, 3534.5228394166975, 4232.746035237896, 4233.767142807175, 4282.721623094489, 4362.149380870763, 2946.6316710411197, 3322.069820450278, 3377.5778027746533, 3378.1048022274117, 3463.480477928331, 620.9130721698966, 625.3215261441296, 636.898096304589, 638.3680156644888, 647.0649910878735, 561.7163332517134, 646.3181343682367, 660.9966950165218, 679.9864002719918, 694.4513834071028, 8963.910360896438, 9140.771480713036, 9152.81694366109, 9213.0, 9636.132748052569, 559.6921693068796, 581.2937281203358, 640.9775657851952, 669.3908543225641, 673.1585518102372, 4195.496540415109, 4234.978825105916, 4449.310356894686, 4453.821847126143, 4459.821607135678, 68549.0, 94165.0, 107091.46454267678, 109956.45021775, 111407.0, 97031.02968970362, 100661.0, 102502.48748756209, 103779.0, 105962.0, 77556.61221693855, 91552.54223728839, 92532.0, 93206.0, 94527.52736236274, 8596.527191004305, 8602.354823388147, 8686.739397818075, 8704.651813927625, 8806.691765788166, 55836.88326233534, 56177.43822561722, 56390.59023524445, 58382.4161758377, 59057.0, 74502.25497744953, 78997.0, 81610.59194703988, 81860.59069704614, 82974.0, 11081.0, 11087.057600103759, 11484.770304594029, 11829.408529573659, 11874.940625296818, 12045.0, 12219.45012474423, 12400.75198496007, 12470.937645311715, 12547.560835370718, 11479.483423246142, 11527.193096483166, 11799.410029498318, 11850.229735067192, 12283.75432491363, 11544.191906566795, 11671.59149429766, 11740.0, 11926.821097683369, 12496.312702801433, 8587.828243434971, 12339.197952133083, 12883.935580322039, 13023.869761302265, 13249.602511924657, 10184.267289691526, 10495.959656124085, 10510.474476276002, 10919.344839309666, 11242.550297988317, 10685.198610104118, 10882.0, 11058.39996817429, 11128.777424451628, 11164.609238676607], "value": 7270.412913021484, "unit": "score"}], "name": "dromaeo_css", "value": 7233.260744853963, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 112.0, 113.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 108.0, 143.0, 108.0, 108.0, 108.0, 107.0, 137.0, 107.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 185.0, 183.0, 183.0, 184.0, 182.0, 183.0, 180.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 77.0, 112.0, 86.0, 59.0, 58.0, 57.0, 81.0, 59.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 92.0, 68.0, 67.0, 69.0, 89.0, 67.0, 69.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 87.0, 80.0, 113.0, 135.0, 87.0, 89.0, 85.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 108.0, 129.0, 93.0, 93.0, 101.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 79.0, 83.0, 83.0, 80.0, 85.0, 83.0, 85.0, 83.0], "value": 82.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 50.0, 51.0, 52.0, 56.0, 58.0, 57.0, 57.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 79.0, 75.0, 70.0, 68.0, 68.0, 69.0, 68.0, 70.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 83.0, 84.0, 81.0, 85.0, 81.0, 81.0, 88.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 160.0, 145.0, 142.0, 137.0, 139.0, 138.0, 138.0, 186.0, 136.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 158.0, 167.0, 162.0, 159.0, 160.0, 162.0, 159.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 64.0, 65.0, 63.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1420.1, "alertThreshold": 2.0}]} 12:15:09 INFO - Return code: 0 12:15:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:09 INFO - # TBPL SUCCESS # 12:15:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:10 INFO - 2017-02-22 12:15:10.004 screenresolution[1940:15961] starting screenresolution argv=screenresolution get 12:15:10 INFO - 2017-02-22 12:15:10.007 screenresolution[1940:15961] Display 0: 1600x1200x32@60 12:15:10 INFO - 2017-02-22 12:15:10.013 screenresolution[1941:15964] starting screenresolution argv=screenresolution list 12:15:10 INFO - Available Modes on Display 0 12:15:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:10 INFO - Intel Iris: 12:15:10 INFO - Chipset Model: Intel Iris 12:15:10 INFO - Type: GPU 12:15:10 INFO - Bus: Built-In 12:15:10 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:10 INFO - Vendor: Intel (0x8086) 12:15:10 INFO - Device ID: 0x0a2e 12:15:10 INFO - Revision ID: 0x0009 12:15:10 INFO - Displays: 12:15:10 INFO - Display: 12:15:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:10 INFO - Display Serial Number: 1600x1200 60 12:15:10 INFO - Main Display: Yes 12:15:10 INFO - Mirror: Off 12:15:10 INFO - Online: Yes 12:15:10 INFO - Rotation: Supported 12:15:10 INFO - Return code: 0 12:15:10 INFO - Running post-action listener: _resource_record_post_action 12:15:10 INFO - [mozharness: 2017-02-22 20:15:10.254242Z] Finished run-tests step (success) 12:15:10 INFO - Running post-run listener: _resource_record_post_run 12:15:10 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 929792; Write bytes: 494116352; Read time: 13; Write time: 1604 12:15:10 INFO - TinderboxPrint: CPU usage
53.5% 12:15:10 INFO - TinderboxPrint: I/O read bytes / time
929,792 / 13 12:15:10 INFO - TinderboxPrint: I/O write bytes / time
494,116,352 / 1,604 12:15:10 INFO - TinderboxPrint: CPU idle
2,228.0 (46.5%) 12:15:10 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 12:15:10 INFO - TinderboxPrint: CPU user
1,606.4 (33.5%) 12:15:10 INFO - TinderboxPrint: Swap in / out
192,593,920 / 0 12:15:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186888704; Write bytes: 186503168; Read time: 17095; Write time: 441 12:15:10 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 929792; Write bytes: 299177472; Read time: 13; Write time: 1117 12:15:10 INFO - Running post-run listener: _upload_blobber_files 12:15:10 INFO - Blob upload gear active. 12:15:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:10 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 12:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:15:11 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:12 INFO - (blobuploader) - INFO - Done attempting. 12:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:13 INFO - (blobuploader) - INFO - Done attempting. 12:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:15 INFO - (blobuploader) - INFO - Done attempting. 12:15:15 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:15 INFO - Return code: 0 12:15:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c48a1b500ee0c9bd90d83c1b37c419508231e36dd7b1a55738dd06efd8c21d64781e25711354ed6feba315d29e5d71d84111d63ed5096d581cb1d872deb1cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c74b2687c1eef94a97f83c7748f7f07e48a78a8f52ae8a5007dd69cff6f8e1e74caefeff6fcff12c3f43c54aee62e819421ba0bbd3f219f46aac07584268872", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4474b40503df4b56494f847f30e42a2674bc3164e317267ba3fd480550f9f9888807f97e0179f9ab1a8dc12d6155e6bb438b889cacf033a6b7aadbeb406cd8af"} 12:15:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:15 INFO - Contents: 12:15:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c48a1b500ee0c9bd90d83c1b37c419508231e36dd7b1a55738dd06efd8c21d64781e25711354ed6feba315d29e5d71d84111d63ed5096d581cb1d872deb1cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c74b2687c1eef94a97f83c7748f7f07e48a78a8f52ae8a5007dd69cff6f8e1e74caefeff6fcff12c3f43c54aee62e819421ba0bbd3f219f46aac07584268872", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4474b40503df4b56494f847f30e42a2674bc3164e317267ba3fd480550f9f9888807f97e0179f9ab1a8dc12d6155e6bb438b889cacf033a6b7aadbeb406cd8af"} 12:15:15 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:15 INFO - Copying logs to upload dir... 12:15:15 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.823612 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-22 12:15:15.497629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 12:15:15.500977) ========= 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.y42fbNHcij/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.cwJCNEnN8K/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c48a1b500ee0c9bd90d83c1b37c419508231e36dd7b1a55738dd06efd8c21d64781e25711354ed6feba315d29e5d71d84111d63ed5096d581cb1d872deb1cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c74b2687c1eef94a97f83c7748f7f07e48a78a8f52ae8a5007dd69cff6f8e1e74caefeff6fcff12c3f43c54aee62e819421ba0bbd3f219f46aac07584268872", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4474b40503df4b56494f847f30e42a2674bc3164e317267ba3fd480550f9f9888807f97e0179f9ab1a8dc12d6155e6bb438b889cacf033a6b7aadbeb406cd8af"} build_url:https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010355 build_url: 'https://queue.taskcluster.net/v1/task/a0oPctEkSimC0ukNEdaKqA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c48a1b500ee0c9bd90d83c1b37c419508231e36dd7b1a55738dd06efd8c21d64781e25711354ed6feba315d29e5d71d84111d63ed5096d581cb1d872deb1cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c74b2687c1eef94a97f83c7748f7f07e48a78a8f52ae8a5007dd69cff6f8e1e74caefeff6fcff12c3f43c54aee62e819421ba0bbd3f219f46aac07584268872", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4474b40503df4b56494f847f30e42a2674bc3164e317267ba3fd480550f9f9888807f97e0179f9ab1a8dc12d6155e6bb438b889cacf033a6b7aadbeb406cd8af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 12:15:15.532049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:15:15.532438) ========= 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.y42fbNHcij/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.cwJCNEnN8K/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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.005335 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:15:15.581195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 12:15:15.581485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 12:15:15.581785) ========= ========= Total master_lag: 0.18 =========