builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0094 starttime: 1486589907.48 results: success (0) buildid: 20170208111920 builduid: 262059b612b0416482097ef9afc71f46 revision: cbe7e2f489d353e69a51e3aaea71b3024cf58d09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.478352) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.478824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.479133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.505712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.506084) ========= 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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-08 13:38:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.6M=0.001s 2017-02-08 13:38:27 (12.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.186274 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.816855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.817210) ========= 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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.026652 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:27.866527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 13:38:27.866877) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cbe7e2f489d353e69a51e3aaea71b3024cf58d09 --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 cbe7e2f489d353e69a51e3aaea71b3024cf58d09 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DEkp9qoWwD/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.NTKqxBGvXR/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-08 13:38:27,990 truncating revision to first 12 chars 2017-02-08 13:38:27,990 Setting DEBUG logging. 2017-02-08 13:38:27,990 attempt 1/10 2017-02-08 13:38:27,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cbe7e2f489d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 13:38:28,990 unpacking tar archive at: mozilla-beta-cbe7e2f489d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.293704 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 13:38:29.184595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:29.184947) ========= script_repo_revision: cbe7e2f489d353e69a51e3aaea71b3024cf58d09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:29.185391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:29.185668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 13:38:29.205526) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-08 13:38:29.205804) ========= /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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:38:29 INFO - MultiFileLogger online at 20170208 13:38:29 in /builds/slave/test 13:38:29 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 13:38:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:38:29 INFO - {'append_to_log': False, 13:38:29 INFO - 'base_work_dir': '/builds/slave/test', 13:38:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:38:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:38:29 INFO - 'branch': 'Mozilla-Beta', 13:38:29 INFO - 'buildbot_json_path': 'buildprops.json', 13:38:29 INFO - 'config_files': ('talos/mac_config.py',), 13:38:29 INFO - 'default_actions': ('clobber', 13:38:29 INFO - 'read-buildbot-config', 13:38:29 INFO - 'download-and-extract', 13:38:29 INFO - 'populate-webroot', 13:38:29 INFO - 'create-virtualenv', 13:38:29 INFO - 'install', 13:38:29 INFO - 'run-tests'), 13:38:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:38:29 INFO - 'download_minidump_stackwalk': True, 13:38:29 INFO - 'download_symbols': 'ondemand', 13:38:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:38:29 INFO - 'tooltool.py': '/tools/tooltool.py', 13:38:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:38:29 INFO - '/tools/misc-python/virtualenv.py')}, 13:38:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:38:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:38:29 INFO - 'installer_path': 'installer.exe', 13:38:29 INFO - 'log_level': 'info', 13:38:29 INFO - 'log_name': 'talos', 13:38:29 INFO - 'log_to_console': True, 13:38:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:38:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:38:29 INFO - 'opt_config_files': (), 13:38:29 INFO - 'pip_index': False, 13:38:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:38:29 INFO - 'cmd': ('bash', 13:38:29 INFO - '-c', 13:38:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:38:29 INFO - 'enabled': True, 13:38:29 INFO - 'halt_on_failure': False, 13:38:29 INFO - 'name': 'check_screen_resolution'},), 13:38:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:38:29 INFO - 'cmd': ('bash', 13:38:29 INFO - '-c', 13:38:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:38:29 INFO - 'enabled': True, 13:38:29 INFO - 'halt_on_failure': False, 13:38:29 INFO - 'name': 'check_screen_resolution'},), 13:38:29 INFO - 'run_cmd_checks_enabled': True, 13:38:29 INFO - 'sps_profile': False, 13:38:29 INFO - 'sps_profile_interval': 0, 13:38:29 INFO - 'suite': 'dromaeojs', 13:38:29 INFO - 'system_bits': '32', 13:38:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:38:29 INFO - 'title': 't-yosemite-r7-0094', 13:38:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:38:29 INFO - 'use_talos_json': True, 13:38:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:38:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:38:29 INFO - 'work_dir': 'build'} 13:38:29 INFO - [mozharness: 2017-02-08 21:38:29.414963Z] Running clobber step. 13:38:29 INFO - Running pre-action listener: _resource_record_pre_action 13:38:29 INFO - Running main action method: clobber 13:38:29 INFO - rmtree: /builds/slave/test/build 13:38:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:38:31 INFO - Running post-action listener: _resource_record_post_action 13:38:31 INFO - [mozharness: 2017-02-08 21:38:31.859924Z] Finished clobber step (success) 13:38:31 INFO - [mozharness: 2017-02-08 21:38:31.860066Z] Running read-buildbot-config step. 13:38:31 INFO - Running pre-action listener: _resource_record_pre_action 13:38:31 INFO - Running main action method: read_buildbot_config 13:38:31 INFO - Using buildbot properties: 13:38:31 INFO - { 13:38:31 INFO - "project": "", 13:38:31 INFO - "product": "firefox", 13:38:31 INFO - "script_repo_revision": "production", 13:38:31 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:38:31 INFO - "repository": "", 13:38:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:38:31 INFO - "buildid": "20170208111920", 13:38:31 INFO - "pgo_build": "False", 13:38:31 INFO - "basedir": "/builds/slave/test", 13:38:31 INFO - "buildnumber": 3, 13:38:31 INFO - "slavename": "t-yosemite-r7-0094", 13:38:31 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:38:31 INFO - "platform": "yosemite_r7", 13:38:31 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:38:31 INFO - "branch": "mozilla-beta", 13:38:31 INFO - "repo_path": "releases/mozilla-beta", 13:38:31 INFO - "revision": "cbe7e2f489d353e69a51e3aaea71b3024cf58d09", 13:38:31 INFO - "stage_platform": "macosx64", 13:38:31 INFO - "builduid": "262059b612b0416482097ef9afc71f46", 13:38:31 INFO - "slavebuilddir": "test" 13:38:31 INFO - } 13:38:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:38:31 INFO - Running post-action listener: _resource_record_post_action 13:38:31 INFO - [mozharness: 2017-02-08 21:38:31.863696Z] Finished read-buildbot-config step (success) 13:38:31 INFO - [mozharness: 2017-02-08 21:38:31.863905Z] Running download-and-extract step. 13:38:31 INFO - Running pre-action listener: _resource_record_pre_action 13:38:31 INFO - Running main action method: download_and_extract 13:38:31 INFO - mkdir: /builds/slave/test/build/tests 13:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:31 INFO - trying https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:38:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/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 13:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/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 13:38:32 INFO - Downloaded 1165 bytes. 13:38:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:38:32 INFO - Using the following test package requirements: 13:38:32 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:38:32 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:38:32 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:38:32 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:38:32 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:38:32 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:38:32 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:38:32 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:38:32 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:38:32 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:38:32 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:38:32 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:38:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:38:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:38:32 INFO - Fetch https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:38:33 INFO - Http code: 200 13:38:33 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 13:38:33 INFO - x-amz-cf-id: LKit_eC4Lh1hwNWn6wEsW-l1dX9G8LcJQo1vp_GLfEpKHHkHuqs0YA== 13:38:33 INFO - x-amz-version-id: N3MZDaq5eYbT5Cbr1BxGt694OZbZCwaQ 13:38:33 INFO - Expected file size: 16093687 13:38:33 INFO - Obtained file size: 16093687 13:38:40 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 13:38:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:38:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:38:40 INFO - Fetch https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:38:40 INFO - Http code: 200 13:38:40 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 13:38:40 INFO - x-amz-cf-id: jypycN0skVwWrU2bwvTk9ThbykyODJaDzjwAbzKhh6hnuPe0KCg_Qw== 13:38:40 INFO - x-amz-version-id: N3MZDaq5eYbT5Cbr1BxGt694OZbZCwaQ 13:38:41 INFO - Expected file size: 16093687 13:38:41 INFO - Obtained file size: 16093687 13:38:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:38:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:38:47 INFO - Fetch https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:38:48 INFO - Http code: 200 13:38:48 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 13:38:48 INFO - x-amz-cf-id: gl2k8cVzzXNTAzXLff6IHlUyADQT242lHLx5zMRMzfn19ubwJiRIag== 13:38:48 INFO - x-amz-version-id: 033qqzXvrNy_p9QJkMtklNoZOzlSfwnN 13:38:48 INFO - Expected file size: 14403005 13:38:48 INFO - Obtained file size: 14403005 13:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:49 INFO - trying https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:38:49 INFO - Downloading https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/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 13:38:51 INFO - Downloaded 82146327 bytes. 13:38:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:38:51 INFO - mkdir: /builds/slave/test/properties 13:38:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:38:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:38:51 INFO - Contents: 13:38:51 INFO - build_url:https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:38:52 INFO - Running post-action listener: _resource_record_post_action 13:38:52 INFO - Running post-action listener: set_extra_try_arguments 13:38:52 INFO - [mozharness: 2017-02-08 21:38:52.234949Z] Finished download-and-extract step (success) 13:38:52 INFO - [mozharness: 2017-02-08 21:38:52.235096Z] Running populate-webroot step. 13:38:52 INFO - Running pre-action listener: _resource_record_pre_action 13:38:52 INFO - Running main action method: populate_webroot 13:38:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:38:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:38:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:38:52 INFO - '--tppagecycles', 13:38:52 INFO - '7'], 13:38:52 INFO - 'tests': ['tsvgm']}}, 13:38:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:38:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:38:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:38:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:38:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['damp', 'tps']}, 13:38:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'tests': ['damp', 'tps']}, 13:38:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['dromaeo_dom']}, 13:38:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:38:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['basic_compositor_video']}, 13:38:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:38:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['a11yr', 13:38:52 INFO - 'ts_paint', 13:38:52 INFO - 'tpaint', 13:38:52 INFO - 'sessionrestore', 13:38:52 INFO - 'sessionrestore_no_auto_restore', 13:38:52 INFO - 'tabpaint']}, 13:38:52 INFO - 'other-e10s': {'tests': ['a11yr', 13:38:52 INFO - 'ts_paint', 13:38:52 INFO - 'tpaint', 13:38:52 INFO - 'sessionrestore', 13:38:52 INFO - 'sessionrestore_no_auto_restore', 13:38:52 INFO - 'tabpaint']}, 13:38:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:38:52 INFO - 'ts_paint', 13:38:52 INFO - 'tpaint', 13:38:52 INFO - 'sessionrestore', 13:38:52 INFO - 'sessionrestore_no_auto_restore', 13:38:52 INFO - 'tabpaint']}, 13:38:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:38:52 INFO - 'ts_paint', 13:38:52 INFO - 'tpaint', 13:38:52 INFO - 'sessionrestore', 13:38:52 INFO - 'sessionrestore_no_auto_restore', 13:38:52 INFO - 'tabpaint']}, 13:38:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['a11yr', 13:38:52 INFO - 'ts_paint', 13:38:52 INFO - 'tpaint', 13:38:52 INFO - 'sessionrestore', 13:38:52 INFO - 'sessionrestore_no_auto_restore', 13:38:52 INFO - 'tabpaint']}, 13:38:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['a11yr', 13:38:52 INFO - 'ts_paint', 13:38:52 INFO - 'tpaint', 13:38:52 INFO - 'sessionrestore', 13:38:52 INFO - 'sessionrestore_no_auto_restore', 13:38:52 INFO - 'tabpaint']}, 13:38:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['tsvgx', 13:38:52 INFO - 'tsvgr_opacity', 13:38:52 INFO - 'tart', 13:38:52 INFO - 'tscrollx', 13:38:52 INFO - 'cart']}, 13:38:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:38:52 INFO - 'tsvgr_opacity', 13:38:52 INFO - 'tart', 13:38:52 INFO - 'tscrollx', 13:38:52 INFO - 'cart']}, 13:38:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'talos_options': ['--disable-e10s'], 13:38:52 INFO - 'tests': ['tp5o']}, 13:38:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'tests': ['tp5o']}, 13:38:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'talos_options': ['--disable-e10s', 13:38:52 INFO - '--xperf_path', 13:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:52 INFO - 'tests': ['tp5n']}, 13:38:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:52 INFO - 'talos_options': ['--xperf_path', 13:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:52 INFO - 'tests': ['tp5n']}}, 13:38:52 INFO - 'talos.zip': {'path': '', 13:38:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:38:52 INFO - Running post-action listener: _resource_record_post_action 13:38:52 INFO - [mozharness: 2017-02-08 21:38:52.254075Z] Finished populate-webroot step (success) 13:38:52 INFO - [mozharness: 2017-02-08 21:38:52.254213Z] Running create-virtualenv step. 13:38:52 INFO - Running pre-action listener: _resource_record_pre_action 13:38:52 INFO - Running main action method: create_virtualenv 13:38:52 INFO - Creating virtualenv /builds/slave/test/build/venv 13:38:52 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 13:38:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:38:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:38:52 INFO - Using real prefix '/tools/python27' 13:38:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:38:53 INFO - Installing distribute.............................................................................................................................................................................................done. 13:38:55 INFO - Installing pip.................done. 13:38:55 INFO - Return code: 0 13:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:38:56 INFO - Reading from file tmpfile_stdout 13:38:56 INFO - Output received: 13:38:56 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) 13:38:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:56 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:38:56 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 13:38:56 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 13:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:56 INFO - 'HOME': '/Users/cltbld', 13:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:56 INFO - 'LOGNAME': 'cltbld', 13:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:56 INFO - 'MOZ_NO_REMOTE': '1', 13:38:56 INFO - 'NO_EM_RESTART': '1', 13:38:56 INFO - 'PAGER': '/bin/cat', 13:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:56 INFO - 'PWD': '/builds/slave/test', 13:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:56 INFO - 'SHELL': '/bin/bash', 13:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:38:56 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:56 INFO - 'USER': 'cltbld', 13:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:56 INFO - 'XPC_FLAGS': '0x0', 13:38:56 INFO - 'XPC_SERVICE_NAME': '0', 13:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:56 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 13:38:56 INFO - Cleaning up... 13:38:56 INFO - Return code: 0 13:38:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:56 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:38:56 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 13:38:56 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 13:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:56 INFO - 'HOME': '/Users/cltbld', 13:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:56 INFO - 'LOGNAME': 'cltbld', 13:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:56 INFO - 'MOZ_NO_REMOTE': '1', 13:38:56 INFO - 'NO_EM_RESTART': '1', 13:38:56 INFO - 'PAGER': '/bin/cat', 13:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:56 INFO - 'PWD': '/builds/slave/test', 13:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:56 INFO - 'SHELL': '/bin/bash', 13:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:38:56 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:56 INFO - 'USER': 'cltbld', 13:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:56 INFO - 'XPC_FLAGS': '0x0', 13:38:56 INFO - 'XPC_SERVICE_NAME': '0', 13:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:56 INFO - Downloading/unpacking psutil>=3.1.1 13:38:56 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 13:38:56 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 13:38:56 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 13:38:56 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 13:38:56 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 13:38:56 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 13:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:39:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:00 INFO - Installing collected packages: psutil 13:39:00 INFO - Running setup.py install for psutil 13:39:00 INFO - building 'psutil._psutil_osx' extension 13:39:00 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 13:39:00 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 13:39:00 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 13:39:01 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 13:39:01 INFO - building 'psutil._psutil_posix' extension 13:39:01 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 13:39:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:39:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:39:01 INFO - ^ 13:39:01 INFO - 1 warning generated. 13:39:01 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 13:39:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:01 INFO - Successfully installed psutil 13:39:01 INFO - Cleaning up... 13:39:01 INFO - Return code: 0 13:39:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:39:01 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')]} 13:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:01 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')]} 13:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:01 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:01 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 13:39:01 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 13:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:01 INFO - 'HOME': '/Users/cltbld', 13:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:01 INFO - 'LOGNAME': 'cltbld', 13:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:01 INFO - 'MOZ_NO_REMOTE': '1', 13:39:01 INFO - 'NO_EM_RESTART': '1', 13:39:01 INFO - 'PAGER': '/bin/cat', 13:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:01 INFO - 'PWD': '/builds/slave/test', 13:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:01 INFO - 'SHELL': '/bin/bash', 13:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:01 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:01 INFO - 'USER': 'cltbld', 13:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:01 INFO - 'XPC_FLAGS': '0x0', 13:39:01 INFO - 'XPC_SERVICE_NAME': '0', 13:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:39:04 INFO - Installing collected packages: mozsystemmonitor 13:39:04 INFO - Running setup.py install for mozsystemmonitor 13:39:04 INFO - Successfully installed mozsystemmonitor 13:39:04 INFO - Cleaning up... 13:39:04 INFO - Return code: 0 13:39:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:04 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:04 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 13:39:04 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 13:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:04 INFO - 'HOME': '/Users/cltbld', 13:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:04 INFO - 'LOGNAME': 'cltbld', 13:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:04 INFO - 'MOZ_NO_REMOTE': '1', 13:39:04 INFO - 'NO_EM_RESTART': '1', 13:39:04 INFO - 'PAGER': '/bin/cat', 13:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:04 INFO - 'PWD': '/builds/slave/test', 13:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:04 INFO - 'SHELL': '/bin/bash', 13:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:04 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:04 INFO - 'USER': 'cltbld', 13:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:04 INFO - 'XPC_FLAGS': '0x0', 13:39:04 INFO - 'XPC_SERVICE_NAME': '0', 13:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:05 INFO - Downloading/unpacking jsonschema==2.5.1 13:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:08 INFO - warning: no files found matching '*.txt' 13:39:08 INFO - no previously-included directories found matching 'build' 13:39:08 INFO - no previously-included directories found matching 'dist' 13:39:08 INFO - no previously-included directories found matching '.git*' 13:39:08 INFO - Installing collected packages: jsonschema, functools32 13:39:08 INFO - Running setup.py install for functools32 13:39:08 INFO - warning: no files found matching '*.txt' 13:39:08 INFO - no previously-included directories found matching 'build' 13:39:08 INFO - no previously-included directories found matching 'dist' 13:39:08 INFO - no previously-included directories found matching '.git*' 13:39:08 INFO - Successfully installed jsonschema functools32 13:39:08 INFO - Cleaning up... 13:39:08 INFO - Return code: 0 13:39:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:39:08 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')]} 13:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:08 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')]} 13:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:08 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:08 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 13:39:08 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 13:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:08 INFO - 'HOME': '/Users/cltbld', 13:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:08 INFO - 'LOGNAME': 'cltbld', 13:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:08 INFO - 'MOZ_NO_REMOTE': '1', 13:39:08 INFO - 'NO_EM_RESTART': '1', 13:39:08 INFO - 'PAGER': '/bin/cat', 13:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:08 INFO - 'PWD': '/builds/slave/test', 13:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:08 INFO - 'SHELL': '/bin/bash', 13:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:08 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:08 INFO - 'USER': 'cltbld', 13:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:08 INFO - 'XPC_FLAGS': '0x0', 13:39:08 INFO - 'XPC_SERVICE_NAME': '0', 13:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:39:08 INFO - Cleaning up... 13:39:08 INFO - Return code: 0 13:39:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39:08 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')]} 13:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:08 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')]} 13:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:08 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:08 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 13:39:08 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 13:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:08 INFO - 'HOME': '/Users/cltbld', 13:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:08 INFO - 'LOGNAME': 'cltbld', 13:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:08 INFO - 'MOZ_NO_REMOTE': '1', 13:39:08 INFO - 'NO_EM_RESTART': '1', 13:39:08 INFO - 'PAGER': '/bin/cat', 13:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:08 INFO - 'PWD': '/builds/slave/test', 13:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:08 INFO - 'SHELL': '/bin/bash', 13:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:08 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:08 INFO - 'USER': 'cltbld', 13:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:08 INFO - 'XPC_FLAGS': '0x0', 13:39:08 INFO - 'XPC_SERVICE_NAME': '0', 13:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:09 INFO - Downloading/unpacking blobuploader==1.2.4 13:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:11 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39:11 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 13:39:11 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 13:39:11 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 13:39:11 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 13:39:11 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 13:39:11 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 13:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39:12 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 13:39:12 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 13:39:12 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 13:39:12 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 13:39:12 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 13:39:12 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 13:39:12 INFO - Downloading docopt-0.6.1.tar.gz 13:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:12 INFO - Running setup.py install for blobuploader 13:39:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:13 INFO - Running setup.py install for requests 13:39:13 INFO - Running setup.py install for docopt 13:39:13 INFO - Successfully installed blobuploader requests docopt 13:39:13 INFO - Cleaning up... 13:39:13 INFO - Return code: 0 13:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:13 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')]} 13:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:13 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')]} 13:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:13 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:13 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 13:39:13 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 13:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:13 INFO - 'HOME': '/Users/cltbld', 13:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:13 INFO - 'LOGNAME': 'cltbld', 13:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:13 INFO - 'MOZ_NO_REMOTE': '1', 13:39:13 INFO - 'NO_EM_RESTART': '1', 13:39:13 INFO - 'PAGER': '/bin/cat', 13:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:13 INFO - 'PWD': '/builds/slave/test', 13:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:13 INFO - 'SHELL': '/bin/bash', 13:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:13 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:13 INFO - 'USER': 'cltbld', 13:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:13 INFO - 'XPC_FLAGS': '0x0', 13:39:13 INFO - 'XPC_SERVICE_NAME': '0', 13:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-DnNN4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8gTT_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-UpvyEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-LMVR2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-_6IyWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-sD9xgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-YdOon4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fVZY9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-93km_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-zXpl2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-AmKyiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ZVL0Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fkHV89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-TaUMcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-C2YWeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0LrZPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-2QuUeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:15 INFO - Running setup.py install for manifestparser 13:39:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:16 INFO - Running setup.py install for mozcrash 13:39:16 INFO - Running setup.py install for mozdebug 13:39:16 INFO - Running setup.py install for mozdevice 13:39:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:16 INFO - Running setup.py install for mozfile 13:39:16 INFO - Running setup.py install for mozhttpd 13:39:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:16 INFO - Running setup.py install for mozinfo 13:39:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:16 INFO - Running setup.py install for mozInstall 13:39:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Running setup.py install for mozleak 13:39:17 INFO - Running setup.py install for mozlog 13:39:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Running setup.py install for moznetwork 13:39:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Running setup.py install for mozprocess 13:39:17 INFO - Running setup.py install for mozprofile 13:39:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Running setup.py install for mozrunner 13:39:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:17 INFO - Running setup.py install for mozscreenshot 13:39:18 INFO - Running setup.py install for moztest 13:39:18 INFO - Running setup.py install for mozversion 13:39:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:18 INFO - Cleaning up... 13:39:18 INFO - Return code: 0 13:39:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:18 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')]} 13:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:18 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')]} 13:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:18 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:18 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 13:39:18 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 13:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:18 INFO - 'HOME': '/Users/cltbld', 13:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:18 INFO - 'LOGNAME': 'cltbld', 13:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:18 INFO - 'MOZ_NO_REMOTE': '1', 13:39:18 INFO - 'NO_EM_RESTART': '1', 13:39:18 INFO - 'PAGER': '/bin/cat', 13:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:18 INFO - 'PWD': '/builds/slave/test', 13:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:18 INFO - 'SHELL': '/bin/bash', 13:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:18 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:18 INFO - 'USER': 'cltbld', 13:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:18 INFO - 'XPC_FLAGS': '0x0', 13:39:18 INFO - 'XPC_SERVICE_NAME': '0', 13:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:18 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-V2Qb0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:18 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)) 13:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:18 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-3TjAAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:18 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)) 13:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:18 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-lI5aYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-dWyAcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-IR19qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-RnYJFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-B4TH53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-TOrxz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-E932xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-iS0RZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vvrZLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-hLV6ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:19 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)) 13:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:19 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-oBw8ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:20 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)) 13:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:20 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-FhzlX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:20 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)) 13:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:20 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-mkpIHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:20 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)) 13:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:20 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-m3ktdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:20 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)) 13:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:20 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-lNkVCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:20 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)) 13:39:20 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)) 13:39:20 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)) 13:39:20 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)) 13:39:20 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)) 13:39:20 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)) 13:39:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:20 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 13:39:20 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 13:39:20 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 13:39:20 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 13:39:20 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 13:39:20 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 13:39:23 INFO - Downloading blessings-1.6.tar.gz 13:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:23 INFO - Installing collected packages: blessings 13:39:23 INFO - Running setup.py install for blessings 13:39:23 INFO - Successfully installed blessings 13:39:23 INFO - Cleaning up... 13:39:23 INFO - Return code: 0 13:39:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:23 INFO - Reading from file tmpfile_stdout 13:39:23 INFO - Current package versions: 13:39:23 INFO - blessings == 1.6 13:39:23 INFO - blobuploader == 1.2.4 13:39:23 INFO - docopt == 0.6.1 13:39:23 INFO - functools32 == 3.2.3-2 13:39:23 INFO - jsonschema == 2.5.1 13:39:23 INFO - manifestparser == 1.1 13:39:23 INFO - mozInstall == 1.12 13:39:23 INFO - mozcrash == 1.0 13:39:23 INFO - mozdebug == 0.1 13:39:23 INFO - mozdevice == 0.48 13:39:23 INFO - mozfile == 1.2 13:39:23 INFO - mozhttpd == 0.7 13:39:23 INFO - mozinfo == 0.9 13:39:23 INFO - mozleak == 0.1 13:39:23 INFO - mozlog == 3.4 13:39:23 INFO - moznetwork == 0.27 13:39:23 INFO - mozprocess == 0.23 13:39:23 INFO - mozprofile == 0.28 13:39:23 INFO - mozrunner == 6.13 13:39:23 INFO - mozscreenshot == 0.1 13:39:23 INFO - mozsystemmonitor == 0.3 13:39:23 INFO - moztest == 0.8 13:39:23 INFO - mozversion == 1.4 13:39:23 INFO - psutil == 3.1.1 13:39:23 INFO - requests == 1.2.3 13:39:23 INFO - wsgiref == 0.1.2 13:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:23 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')]} 13:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:24 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 13:39:24 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 13:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:24 INFO - 'HOME': '/Users/cltbld', 13:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:24 INFO - 'LOGNAME': 'cltbld', 13:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:24 INFO - 'MOZ_NO_REMOTE': '1', 13:39:24 INFO - 'NO_EM_RESTART': '1', 13:39:24 INFO - 'PAGER': '/bin/cat', 13:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:24 INFO - 'PWD': '/builds/slave/test', 13:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:24 INFO - 'SHELL': '/bin/bash', 13:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:24 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:24 INFO - 'USER': 'cltbld', 13:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:24 INFO - 'XPC_FLAGS': '0x0', 13:39:24 INFO - 'XPC_SERVICE_NAME': '0', 13:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 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)) 13:39:24 INFO - Cleaning up... 13:39:24 INFO - Return code: 0 13:39:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:25 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 0x10dff0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa59259b0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, '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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 13:39:25 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 13:39:25 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 13:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:25 INFO - 'HOME': '/Users/cltbld', 13:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:25 INFO - 'LOGNAME': 'cltbld', 13:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:25 INFO - 'MOZ_NO_REMOTE': '1', 13:39:25 INFO - 'NO_EM_RESTART': '1', 13:39:25 INFO - 'PAGER': '/bin/cat', 13:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:25 INFO - 'PWD': '/builds/slave/test', 13:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:25 INFO - 'SHELL': '/bin/bash', 13:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:25 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:25 INFO - 'USER': 'cltbld', 13:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:25 INFO - 'XPC_FLAGS': '0x0', 13:39:25 INFO - 'XPC_SERVICE_NAME': '0', 13:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:39:25 INFO - Cleaning up... 13:39:25 INFO - Return code: 0 13:39:25 INFO - Running post-action listener: _resource_record_post_action 13:39:25 INFO - Running post-action listener: _start_resource_monitoring 13:39:25 INFO - Starting resource monitoring. 13:39:25 INFO - [mozharness: 2017-02-08 21:39:25.328140Z] Finished create-virtualenv step (success) 13:39:25 INFO - [mozharness: 2017-02-08 21:39:25.329123Z] Running install step. 13:39:25 INFO - Running pre-action listener: _resource_record_pre_action 13:39:25 INFO - Running main action method: install 13:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:25 INFO - Reading from file tmpfile_stdout 13:39:25 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:25 INFO - Reading from file tmpfile_stdout 13:39:25 INFO - Output received: 13:39:25 INFO - Usage: mozinstall [options] installer 13:39:25 INFO - Options: 13:39:25 INFO - -h, --help show this help message and exit 13:39:25 INFO - -d DEST, --destination=DEST 13:39:25 INFO - Directory to install application into. [default: 13:39:25 INFO - "/builds/slave/test"] 13:39:25 INFO - --app=APP Application being installed. [default: firefox] 13:39:25 INFO - mkdir: /builds/slave/test/build/application 13:39:25 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'] 13:39:25 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 13:39:46 INFO - Reading from file tmpfile_stdout 13:39:46 INFO - Output received: 13:39:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:39:46 INFO - Running post-action listener: _resource_record_post_action 13:39:46 INFO - [mozharness: 2017-02-08 21:39:46.656905Z] Finished install step (success) 13:39:46 INFO - [mozharness: 2017-02-08 21:39:46.657031Z] Running run-tests step. 13:39:46 INFO - Running pre-action listener: _resource_record_pre_action 13:39:46 INFO - Running main action method: run_tests 13:39:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:39:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:39:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:39:46 INFO - 2017-02-08 13:39:46.671 screenresolution[1622:7360] starting screenresolution argv=screenresolution get 13:39:46 INFO - 2017-02-08 13:39:46.674 screenresolution[1622:7360] Display 0: 1600x1200x32@60 13:39:46 INFO - 2017-02-08 13:39:46.679 screenresolution[1623:7362] starting screenresolution argv=screenresolution list 13:39:46 INFO - Available Modes on Display 0 13:39:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:39:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:39:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:39:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:39:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:39:46 INFO - Intel Iris: 13:39:46 INFO - Chipset Model: Intel Iris 13:39:46 INFO - Type: GPU 13:39:46 INFO - Bus: Built-In 13:39:46 INFO - VRAM (Dynamic, Max): 1536 MB 13:39:46 INFO - Vendor: Intel (0x8086) 13:39:46 INFO - Device ID: 0x0a2e 13:39:46 INFO - Revision ID: 0x0009 13:39:46 INFO - Displays: 13:39:46 INFO - Display: 13:39:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:39:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:39:46 INFO - Display Serial Number: 1600x1200 60 13:39:46 INFO - Main Display: Yes 13:39:46 INFO - Mirror: Off 13:39:46 INFO - Online: Yes 13:39:46 INFO - Rotation: Supported 13:39:46 INFO - Return code: 0 13:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:39:46 INFO - Python 2.7.3 13:39:46 INFO - Return code: 0 13:39:46 INFO - grabbing minidump binary from tooltool 13:39:46 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')]} 13:39:46 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 0x10de04d30>, '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 0x10dc6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:39:46 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 13:39:46 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 13:39:46 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 13:39:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:39:47 INFO - Return code: 0 13:39:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:39:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:39:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:39:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:39:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:39:47 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/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 13:39:47 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/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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 13:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DEkp9qoWwD/Render', 13:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:39:47 INFO - 'HOME': '/Users/cltbld', 13:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:39:47 INFO - 'LOGNAME': 'cltbld', 13:39:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:39:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:47 INFO - 'MOZ_NO_REMOTE': '1', 13:39:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:39:47 INFO - 'NO_EM_RESTART': '1', 13:39:47 INFO - 'PAGER': '/bin/cat', 13:39:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:47 INFO - 'PWD': '/builds/slave/test', 13:39:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:39:47 INFO - 'SHELL': '/bin/bash', 13:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NTKqxBGvXR/Listeners', 13:39:47 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 13:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:39:47 INFO - 'USER': 'cltbld', 13:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:47 INFO - 'XPC_FLAGS': '0x0', 13:39:47 INFO - 'XPC_SERVICE_NAME': '0', 13:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:39:47 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/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 13:39:47 INFO - mozversion application_buildid: 20170208111920 13:39:47 INFO - mozversion application_changeset: cbe7e2f489d353e69a51e3aaea71b3024cf58d09 13:39:47 INFO - mozversion application_display_name: Firefox 13:39:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:39:47 INFO - mozversion application_name: Firefox 13:39:47 INFO - mozversion application_remotingname: firefox 13:39:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:39:47 INFO - mozversion application_vendor: Mozilla 13:39:47 INFO - mozversion application_version: 52.0 13:39:47 INFO - mozversion platform_buildid: 20170208111920 13:39:47 INFO - mozversion platform_changeset: cbe7e2f489d353e69a51e3aaea71b3024cf58d09 13:39:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:39:47 INFO - mozversion platform_version: 52.0 13:39:47 INFO - using testdate: 1486589987 13:39:47 INFO - actual date: 1486589987 13:39:47 INFO - starting webserver on 'localhost:49240' 13:39:47 INFO - SUITE-START | Running 2 tests 13:39:47 INFO - TEST-START | dromaeo_css 13:39:47 INFO - operating with platform_type : mac_ 13:39:47 INFO - Initialising browser for dromaeo_css test... 13:39:47 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmprzMmo_/profile http://localhost:49240/getInfo.html) 13:39:49 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 13:39:49 INFO - PROCESS | 1633 | colorDepth:24 13:39:49 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 13:39:49 INFO - PROCESS | 1633 | __metrics 13:39:49 INFO - PROCESS | 1633 | 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" 13:39:49 INFO - PROCESS | 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:39:50 INFO - TEST-INFO | 1633: exit 0 13:39:50 INFO - Browser initialized. 13:39:50 INFO - Running cycle 1/1 for dromaeo_css test... 13:39:50 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmprzMmo_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:02 INFO - PROCESS | 1636 | RSS: Main: 167346176 13:40:02 INFO - PROCESS | 1636 | 13:43:06 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:43:08 INFO - PROCESS | 1636 | RSS: Main: 272531456 13:43:08 INFO - PROCESS | 1636 | 13:46:10 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:46:11 INFO - PROCESS | 1636 | RSS: Main: 298602496 13:46:11 INFO - PROCESS | 1636 | 13:49:13 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:49:14 INFO - PROCESS | 1636 | RSS: Main: 267202560 13:49:14 INFO - PROCESS | 1636 | 13:52:16 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:52:17 INFO - PROCESS | 1636 | RSS: Main: 267853824 13:52:17 INFO - PROCESS | 1636 | 13:55:20 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:55:21 INFO - PROCESS | 1636 | RSS: Main: 257003520 13:55:21 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:58:24 INFO - PROCESS | 1636 | RSS: Main: 401575936 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | __start_tp_report 13:58:24 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 13:58:24 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 13:58:24 INFO - PROCESS | 1636 | |i|pagename|runs| 13:58:24 INFO - PROCESS | 1636 | |0;dojo.html;3492.2840817632386;3493.144179675978;3517.6130625631185;3523.242502861884;3548.716102711783;5820.126980952854;5894.823155305337;5911.763529458827;5923.7630494780215;5968.40315968403;5871.677057761822;5942.732577034033;5951;5951.137085122666;5982.461578457938;5325.174597937316;5332.626716129853;5390.326209223847;5394;5498.092814685572;5178.223266510035;5311.681299122046;5316.255724198596;5324.334458192726;5450.836474905759;5334.973325133369;5396.298481197439;5396.325459317585;5399.163129714881;5413.756380962866;5384.246205531229;5428.321459817523;5460.31746031746;5463.453654634544;5470.343558772933;5243.449437809013;5319.813806516753;5366.382865970424;5375.731213439312;5459.672419654833;5815.09865970771;5821.126830975345;5829.154772557998;5836.97081514594;5847.44449277318;6195.28754193269;6200.751969921243;6231.158793562901;6241.87516249677;6251.0310901809835;6372.3946225109;6374.713137908805;6380.840478988016;6387;6397.488200943913;5850.795222167247;5952.880942381128;5976.252968378953;6032.939670603326;6053.122297266872;6433.581817181868;6468.870622587522;6477.578957367756;6493.123428337209;6493.805185844432;6213.565050446516;6217.502599792006;6229.595076320024;6234.75060997555;6236.282827474898;6164.537659675452;6215.409536094064;6218.502519798405;6271.9686401568615;6285.622862628165;6187.81436556904;6225.844353891189;6241.563090583615;6257.843553911189;6267.122602835607;6213.720382582795;6247.312795592481;6247.562670613104;6262.718177682015;6263.154474145932;4986.252062190701;4987.226979818061;4987.351644286219;4997.200447928314;5088.872778180576;4534.591886730144;4540.205464043779;4559.224931761609;4583.610393116623;4611;5994.220751302303;6015.037593984942;6018.337982821886;6026.126211699279;6031.035034394476;6059.151718759377;6219.595726277777;6334.049892516067;6349.746010159634;6359.17330747;5960.523158147338;5962.284525856839;6011.218541589653;6017.458428741435;6053.031514957585;5478.096114141202;5546.55627549795;5551.750171242223;5553.4724201200825;5555.805546805843;6520.608763474207;6520.706568204348;6527.771527996498;6528.608283503005;6557.114789503356;6133.059244992972;6139.386061393825;6216.844578885564;6240.563160578898;6282.8429289266305;6559.180102487189;6559.508036897157;6560.8359791005605;6574.112494813139;6579.967100164468;6210.782622608187;6242.438180563771;6249.625022498664;6251.812445626639;6273.435390814849;6147.508199343953;6148.739508400857;6174.783882564088;6179.660118693515;6303.527235457267;6018.277806663228;6147.600405973598;6156.1381406604005;6156.876862462816;6160.291566469913;6146.473175810604;6156.445919867055;6157.922363586444;6165.784197553064;6181.5363847710705;6018.337982821974;6083.6349819011;6098.9390106100145;6113.17472141273;6143.047827586731;6116.082587611716;6135.1717518136265;6179.969100154471;6182.196314479269;6187.288461826767;6111.022236442148;6130.325664177026;6138.81758342749;6154.5384096192065;6158.661273629993 13:58:24 INFO - PROCESS | 1636 | |1;ext.html;474.0944795440708;529.2431822493835;531.5800517591103;533.5118366694475;560.5795653260055;32229.51655725163;34165.316693666115;36189.45715814265;42689.57310426895;42822.71531854042;45850.77074614631;46047.079058418814;46092.76953615227;46130.538694613046;46150.76924615372;9716.805663886737;9869.851952220723;9873.259505537078;9900.950495247514;9902.801943961153;9752.512374381287;9859.359141655805;9878;9884.258680598983;9892.653757118502;9831.508424578742;9878.012198780101;9880.604775808959;9884.406935583853;9891.90108098917;9799.90200097997;9836.655717049869;9844.80310393788;9846.015398460167;9874.703758887208;9055.777470041592;9241.768955776091;9746.90253097467;9845.212383009342;9860.704178874645;42736.35895461571;43148.784256078834;43163;43194.784026079986;43251.78374108141;3371.7471189660873;3434.1242983039415;3446.7070299024613;3679.2089700714473;4104.220198162339;31239.375212495852;31626.367472650418;31650.683493165005;31969;32574.837125814218;3131.2015436063884;3199.0722690419752;3203.679632036801;3218.951715724266;3219.8390080496115;533773;534152.3292383552;539820;679605;681327.999999995;65939.67030164914;66658;66836.6658166706;66841;66887.99668004984;36890.077748056516;71275;71689;71757.64121179361;71967.2803271971;16695.248713807665;17133.914330428517;17142.742858857127;17246.965182089116;17340.566485837953;13079.215247085014;13079.934600326937;13090.14914030585;13095.017873659513;13121.343932803322;20027.29904453337;20122.993850307426;20157.899210503852;20201.696974545393;20231;7662.4253181011645;7687.5387476751575;7736.92263077362;7754.844903101906;7791.727289544839;864.4597126795753;1015.7252647926953;1061.8141825180717;1062.3997441445558;1096.4846522134585;29763.702362976524;30964.535531967038;31068.689313107032;31075.844620776752;31396;921.5162039928957;1003.7490627343165;1047.486731501574;1100.070440477795;1100.9944950275196;12580.748385032248;15946;16078.035317880964;16233.18834058316;16369.754453683205;683636;684386;685363;687917;688379;62855;63565.046524302175;63633.40916477125;63764;63780;1204.7108693913397;1354.464986330394;1391.749485092693;1392.8398234202994;1399.5871217990716;29255.51328137132;29753.10740677783;30279.848600757738;30354.84822575873;30837.383252334377;54088.729556351966;54168.72915635397;54333.45666543284;54372.18441723298;54904.72547637236;598904;601404;602375;603110;603503;25618.719064047094;26143;27897.581536276568;28227;28284.85857570699;48942.51057489379;48985.75507122442;49193.10016276957;50206;50810.23784643159;38846.864851361475;39934.60065399309;40121.59878401179;41175.76472705824;41579.584204157574;38968.41547376735;39390.606093938695;39439.60560394359;40111.39832902567;40679.79660101799;33988.660113399535;34581.82709086438;37557.41637532541;39792.403113952736;39913.401298981116;24254.757452425954;32551.837240813646;34994.300113998084;35990.8200458996;37226.441603376516;24467.632985504875;24579.771011449;24633.442813079637;24938.251852444457;25015 13:58:24 INFO - PROCESS | 1636 | |2;jquery.html;367.5240563470306;382.7779887665154;387.88945150632077;395.65577947185955;417.3385184482595;15377.923110384447;15554.766678499818;17775.55561110973;20159.59680806383;20333.898330508364;20548.89725551374;20900.059497322618;21161.470963225926;21318.14727410902;21453.356399308006;5932.584719069667;5965.761369545213;6118.418750218744;6234.345393733661;6236.407541283571;4390.253656878338;6052.334243233241;6142.232220972379;6156.784512542062;6158.815235542941;4580.106879158566;6420.5505614607;6721.49588780841;6759.155105611799;6833.111695479581;6560.901586476207;6785.694643741043;6806.829829254283;6822.317768223213;6834.726610935557;5967.850803729898;5975.701214939236;5981.102834574848;5984.192134061889;5986.820395388146;22864.08543658268;23900.40248993772;24633;25441.109561165456;25475.108371207105;2346.4485845826216;2356.658284548731;2359.0327965534048;2365.1840115160244;3106.2544989202656;13718.873574595953;15002.24988750558;15307.617309567238;15614.219289035504;15835.445759398366;1821.317006122704;1886.6604011277964;1889.6598612249788;1941.679622862226;1984.1765667248076;116708.41645791802;118226.22660660098;118532.40733796362;118564;119185;10650.680479585624;10805.621803236849;10862;11148.275362101438;11272.99808567963;14153.646158846112;14158.362873670709;14191.574252772434;14196.787048194285;14200.147991120566;8686.695965641173;8719.520426376483;8733.503901878805;8823.602937867812;8876.778080548038;7924.20757924203;8890.511021893857;8933;9090.409123406956;9107.681231156877;5817.680027598522;6417.7753778617525;6547.934520654828;6770.458363330922;6779.593224406552;1626.495491670224;1832.5052235896233;1882.7834798998017;1891.4892978895896;1912.4453908366418;720.5546387563197;864.4726716702806;898.645035211101;937.864009718587;996.3175224970918;21154.682679759815;22294.55410891773;22355.66466503004;22384.55230895373;22397.66403503949;883.8630012348096;937.6483818568037;967.1827305926481;984.9409035457895;1098.593520397458;11477.909598588121;11590.246633968765;11739.47172377245;11947.641570752892;12251.142420030512;502066;506532;508173;577613.2238677643;586650;77122.22877771263;77401.6129919358;132012;132355;140151;866.9293422623056;897.9820403592022;1017.4963393120305;1073.7154654016692;1073.7154654016692;18286.902785832892;19656.606867862847;19856.70214946806;19884.403467895987;19920;50972;54190;54607;56902.43097568971;58371;79080.60459697896;79628;84234.57882710548;84281.15718842733;85057.57471212605;7971.441999060242;8054.23484768946;8068.7175948841505;8144.348452123697;8152.429329946846;8772.254358379609;10103.89896101059;11896.22674526153;12635;12676.936615316865;10426.895731042592;10669;11127.276727012719;11389.829152562885;11450.198486105892;8877.289816814768;10732.892671073501;10879.782404352027;10957.452127393439;11250.099992000783;10856.611545459986;11298.548058077586;11346.60286889988;11414.771704565695;11712.765744685228;5769.798057067983;6898.517103802887;7058.470614703815;8142.267195952392;8152.796180095545;9377.156055954723;10573.682789516326;10691.786164276826;11168.497417616389;11359.432028398713 13:58:24 INFO - PROCESS | 1636 | |3;mootools.html;1392.136875137415;1493.4175671488115;1644.6792875389297;1820.6540757256112;1824.4253060286;7275.417966562675;8100.189981001897;8545.743627691163;8547.401681882271;8548.016978047526;7467.439942004345;7761.495502792314;8107.229813167754;8334;8350.83298334033;2349.89425475854;2377.215518878766;2378.286514045788;2379.1910750344878;2379.809615230786;2367.609344458171;2396.4128788446856;2410.6745589345387;2411.0476361837063;2415.4202991282054;2345.155743932183;2348.8942997565064;2368.6210206366986;2377.1917548033666;2381.0832829360647;2335.2760644200266;2338.543983923136;2361.031976889467;2363.3500787283465;2366.1363602285214;2355.1286024170995;2357.4342157882156;2383.475635360218;2384.4158181245534;2388.8566685998894;8338.999320081568;8385.329173666092;8451.985761708573;8452.366072544584;8472.661093556251;5128.5640720538795;5285.471452854684;5298.470152984709;5299.867503312409;5302.443243459458;2751.6697996240378;3285.3100848821778;3285.4743241081314;3285.704286614216;3461.567304086989;1067.311584028305;1075.5160177919968;1084.9620263290826;1096.3015972408577;1100.0594491709553;10829;10942.343459392461;10953.507092180871;10962.56149754009;10964.396958167297;4523.751193684379;4557.931631025537;4705.623550115983;4711.481737008926;4729.290606409066;9482.857757133648;9501.14489695917;9516.286278529138;9522.95238523803;9550.617975280911;5241.344831896013;5250.422453530108;5258.316418865599;5258.631895767336;5275.314209152785;4340.370646256275;4378.671599630041;4754.096721622881;4813.7593120343845;4876.463589005207;3157.905262842118;3775.867844625425;3809.2571948470336;3873.535175778868;3902.35611124167;1264.4752427742385;1273.9808902866464;1275.515304184404;1292.1471828593083;1294;769.926856948589;869.5608717597572;897.210454799772;899.8470260055806;903.1555495611624;4439.356293337448;5502.367227768777;5622.32532096151;5624.268845050199;5850.180974663551;901.1709227510706;903.2683526343683;933.7945651956559;938.3572253006712;942.2414955960518;3135.6550779414247;3667.2848794485353;3746.4193050077283;3764.887053388403;3911.9217615647526;9896.406215627085;10127.949360253151;10247.948760256151;10250.794984100276;10253.692389228336;9657;10073.798524029478;10088.44513551747;10218.642347517802;10222.437765922945;7750.92249077502;7968.840623187504;7990.800229994296;7993.400494962785;8005.079415867133;5435.130379139318;5439.456054394529;5614.88770224585;5619.8198378339375;5745.052066408995;9199.034101419255;9359.391639543408;9359.438433694;9365;9392.859107113536;9185;9598.472084035446;9623.470709111067;9699.224062074876;9716.3198576099;6647.401733843977;6856.931430685829;7044.295570442915;7146.178189508273;7316.597587132759;7783.766487005399;8001.719939802079;8015.318697910743;8039.15588863161;8040.075391330072;7139.750108746169;7196.10048743907;7227.638618069181;7278.890816637649;7357.77926662201;6001.969990150022;7043.190033146254;7054.470914681317;7076.504644674823;7144.4998850082075;6653.268140504444;6678.83302917431;6751.358620931003;6760.18877734675;6767.323267673193;4527.524609915911;4574.679772415899;4815.398075240595;4873.4639189689815;4901.436334821541;4747.216709242936;4764.737939413366;4779.641526885428;4974.801007959786;4992.350994370709 13:58:24 INFO - PROCESS | 1636 | |4;prototype.html;306.96316442026955;310.4055733270785;316.17636058068723;321.4503199528806;323.92225865792216;5157.845264642062;5247.973760131199;5274.2879711238975;5278.868028299295;5321.36143662761;4518.909621807562;4983.18450075707;5040.546350828425;5131.486851314867;5189.42916279209;3545.4327307630783;3855.51806024247;4028.315186418316;4039.394090886361;4080.489938757655;3372.966270337302;4019.5779443158485;4042.070323825522;4043.5349934757437;4052.29084910141;3536.770109942858;3540.6636369544854;3715.5912849586525;4027.5166979962446;4040.393940908858;3528.947065794028;4013.969453062948;4027;4043.9191216175514;4082.4284600156;3019.7131272529073;3059.3269480714207;3410.454327307644;3469.5774732359864;3527.664871837171;4792.976035119802;5092.210707340369;5115.411727651331;5122.897542049138;5130.511701824612;4373.693841431101;4598.206699387241;4690.366800481926;4693.78877950493;4713.976430117862;5490.945090549083;5515.352630737269;5543.085390910495;5549.833504994856;5556.582886444369;3270.8878981146286;3800.1449673823167;3890.649841514249;3892.299386110499;3924.469456911807;5146.327443580813;5385.434529374398;5816.662167701453;5838.649681019152;5861.9706901465215;3259.6414394416597;3833.463315135883;3840.116773142193;3851.4030325299623;3869.342211823997;3285.5235990781202;3883.728139030241;3907;3907.7530420008607;3918.4318273850704;3980.8407663693706;4255.744655320691;4505.144022635689;4539.954600453953;4555.703879247838;4916.926246106311;5030.496950304941;5567.443255674481;5620.70481061214;5646.85882852932;1211.7697637448857;1261.4197469164103;1285.4986555243463;1288.1193457551892;1307.7515272098271;818.5457071325471;835.5529791561486;845.446232717571;862.1895418306772;876.8071024374627;4023.5372932112596;4315.050688848449;4640.723800954765;4661.696989695659;4686.133065382915;4359.106383191438;4444.955550444519;4929.630277729185;5254.530370725753;5386.949544838797;4206.663466922639;4838.2016967200725;4859.441164266154;4900.142475066849;5369.301990741179;2540.5808041673286;2729.372244383803;2832.405194909051;2862.6545523603872;2873.7126287371098;4848.927266091011;5448.37343705471;5655.915161272585;5663.801766938137;5675.460831221028;5247.737613119329;5545.279113715191;5577;5589.8323050307745;5592.832215033555;4792.880177995508;4941.283513890466;5580.935054029954;5616;5642.858928526902;4247.023184667482;5128.974205159057;5360.383555890967;5446.311643390562;5450.264214331015;5237.947620523899;5475.315585551806;5625.437456254505;5756.30924289088;5789.189513468202;5782.595218334676;5987.71878107138;5996.580239383201;6032.8793424132145;6092.573519853568;3774.4527043577978;3873.7288389812443;3897.2595206910596;3925.842966281431;3965.4448377227786;4877.195612522884;5750.769969201185;5759.337676167294;5766.423357664368;5794.333651630117;4721.551452611996;5521.245553023821;5605.4114317997655;5639.082711877981;5662.377138514677;5302.515295717205;5578.689008083016;5601.831945041656;5622.144692251629;5664.34649650981;4633.6524760642415;4636.165490211794;5027.597792176544;5030.99380123984;5239.738013099406;5331.760070796901;5521.475459831309;5577;5609.120944483644;5669.897092616678;5118.923216151835;5194.714290714047;5448.937457195809;5466.043442397644;5525.336959564878 13:58:24 INFO - PROCESS | 1636 | |5;yui.html;726.9454790890683;738.2617382617386;741.384650739886;773.8645736996028;776.440962506995;14412.06321589096;15350.616234594141;15371.231438428089;16373.672526549462;17258.2233799479;15345.92578519504;15936.521904342888;16248.268827902742;16255.593610159753;16296.103714295708;860.475110182788;861.2507118806647;865.26020252684;869.430523007428;872.7469033980138;707.8088915992679;729.7993051910714;732.0848938826467;889.1908363389317;892.7589550821274;762.4167511853436;764.9732259370924;922.557172557173;956.3114557518576;956.6747305915987;941.1153515695258;944.3861490031466;947.3179310896144;947.3794664494698;950.909663581962;699.9965000174966;703.4688809948507;704.1972151747012;707.0878566649068;707.8938159276098;14505.27473626325;14748.70502589953;14793.630159246104;14797.40810367584;15395.307211175412;14314.212718300489;14577.70844583113;14662.926685366612;14768.335424905905;14869.405223791035;11738;11793.410329483577;11793.650951759582;11939.223950443193;11957.402129893471;3769.6795772359383;3773.5094437723196;3804.2962052020466;3949.9012524686827;3971.0866500705;87702;89719.55140224322;90661.54669226611;92513.53743231308;93422.53288733581;10836.783264334668;11115.55537778496;11160.939710727467;11198.160137989684;11415.20093593457;20571.633187946856;21561.137554497956;22307.330780076623;22437.775622243895;22488.887555562444;7664.616769161519;7703.614819259126;7755.7673269802;7778.377729781604;7874.133845277015;4317.438732964694;4346.36977638247;4522.706024108423;4547.795349209294;4691.81232750693;3354.26206234628;3448.8620455181513;3476.5480487536456;3477.0264325988765;3481.7562770605814;668.7191379620571;670.5004771445305;673.3838537737915;673.8584897171551;693.3517161454057;603.9335673075958;635.7043974551763;642.1427394428397;655.7540922154192;701.1901254051579;8872.112788721077;8874.911250887537;8902.59938302765;8919.464832110094;9429.952850235704;533.1948757376313;585.3999650358331;674.2953613473932;686.2005763285716;698.552926127279;4062.7156099073372;4498.977505112453;4502.369668246448;4524.09518096382;4635.188841952712;98160;105203;107130;110626.89373106328;119392.82988561812;99527.50236248918;103962;104228.95771042345;104388.47805761074;104581;88150.11849881547;88728.11271887328;92247;92520.61219081719;93183;7052.682629281592;8827.514486703292;8877.822443551222;8906.643734250816;8918.777030574287;57516.99999999833;58894;59729;60615.69692151511;62100.06849897346;54911.72544137254;72029;86930;88943.55528222576;89426;10960.890391095987;11542.711432214262;11841.703957401134;11882.28706277626;12144.878551214375;12088.758224835277;12776.936115319364;12780.488780448677;12938;13342.399592018577;10201.591936322464;11595.8260626089;12210.328431935974;12372.81440778407;12625.494980200689;11381.146414018816;11811.291322520676;12059.276443413073;12249.265044097383;12665.366731663196;11491.597794077166;11867.821982670439;11902.247475123124;12123.939380303042;12260.448279827251;9491.38306010107;9541.284403669613;10083.092521673085;10125.051230020445;10157.339772914736;8411.13617770295;10268.691939241835;10418.843717344398;10439.376947040499;10487.94756026215 13:58:24 INFO - PROCESS | 1636 | __end_tp_report 13:58:24 INFO - PROCESS | 1636 | __start_cc_report 13:58:24 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1172 13:58:24 INFO - PROCESS | 1636 | __end_cc_report 13:58:24 INFO - PROCESS | 1636 | __startTimestamp1486591104479__endTimestamp 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | ------- Summary: start ------- 13:58:24 INFO - PROCESS | 1636 | Number of tests: 6 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5875.14 Median:6116.08 stddev:617.69 (10.1%) stddev-sans-first:590.62 13:58:24 INFO - PROCESS | 1636 | Values: 3492.3 3493.1 3517.6 3523.2 3548.7 5820.1 5894.8 5911.8 5923.8 5968.4 5871.7 5942.7 5951.0 5951.1 5982.5 5325.2 5332.6 5390.3 5394.0 5498.1 5178.2 5311.7 5316.3 5324.3 5450.8 5335.0 5396.3 5396.3 5399.2 5413.8 5384.2 5428.3 5460.3 5463.5 5470.3 5243.4 5319.8 5366.4 5375.7 5459.7 5815.1 5821.1 5829.2 5837.0 5847.4 6195.3 6200.8 6231.2 6241.9 6251.0 6372.4 6374.7 6380.8 6387.0 6397.5 5850.8 5952.9 5976.3 6032.9 6053.1 6433.6 6468.9 6477.6 6493.1 6493.8 6213.6 6217.5 6229.6 6234.8 6236.3 6164.5 6215.4 6218.5 6272.0 6285.6 6187.8 6225.8 6241.6 6257.8 6267.1 6213.7 6247.3 6247.6 6262.7 6263.2 4986.3 4987.2 4987.4 4997.2 5088.9 4534.6 4540.2 4559.2 4583.6 4611.0 5994.2 6015.0 6018.3 6026.1 6031.0 6059.2 6219.6 6334.0 6349.7 6359.2 5960.5 5962.3 6011.2 6017.5 6053.0 5478.1 5546.6 5551.8 5553.5 5555.8 6520.6 6520.7 6527.8 6528.6 6557.1 6133.1 6139.4 6216.8 6240.6 6282.8 6559.2 6559.5 6560.8 6574.1 6580.0 6210.8 6242.4 6249.6 6251.8 6273.4 6147.5 6148.7 6174.8 6179.7 6303.5 6018.3 6147.6 6156.1 6156.9 6160.3 6146.5 6156.4 6157.9 6165.8 6181.5 6018.3 6083.6 6098.9 6113.2 6143.0 6116.1 6135.2 6180.0 6182.2 6187.3 6111.0 6130.3 6138.8 6154.5 6158.7 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:75981.62 Median:41377.67 stddev:168608.48 (407.5%) stddev-sans-first:168986.16 13:58:24 INFO - PROCESS | 1636 | Values: 474.1 529.2 531.6 533.5 560.6 32229.5 34165.3 36189.5 42689.6 42822.7 45850.8 46047.1 46092.8 46130.5 46150.8 9716.8 9869.9 9873.3 9901.0 9902.8 9752.5 9859.4 9878.0 9884.3 9892.7 9831.5 9878.0 9880.6 9884.4 9891.9 9799.9 9836.7 9844.8 9846.0 9874.7 9055.8 9241.8 9746.9 9845.2 9860.7 42736.4 43148.8 43163.0 43194.8 43251.8 3371.7 3434.1 3446.7 3679.2 4104.2 31239.4 31626.4 31650.7 31969.0 32574.8 3131.2 3199.1 3203.7 3219.0 3219.8 533773.0 534152.3 539820.0 679605.0 681328.0 65939.7 66658.0 66836.7 66841.0 66888.0 36890.1 71275.0 71689.0 71757.6 71967.3 16695.2 17133.9 17142.7 17247.0 17340.6 13079.2 13079.9 13090.1 13095.0 13121.3 20027.3 20123.0 20157.9 20201.7 20231.0 7662.4 7687.5 7736.9 7754.8 7791.7 864.5 1015.7 1061.8 1062.4 1096.5 29763.7 30964.5 31068.7 31075.8 31396.0 921.5 1003.7 1047.5 1100.1 1101.0 12580.7 15946.0 16078.0 16233.2 16369.8 683636.0 684386.0 685363.0 687917.0 688379.0 62855.0 63565.0 63633.4 63764.0 63780.0 1204.7 1354.5 1391.7 1392.8 1399.6 29255.5 29753.1 30279.8 30354.8 30837.4 54088.7 54168.7 54333.5 54372.2 54904.7 598904.0 601404.0 602375.0 603110.0 603503.0 25618.7 26143.0 27897.6 28227.0 28284.9 48942.5 48985.8 49193.1 50206.0 50810.2 38846.9 39934.6 40121.6 41175.8 41579.6 38968.4 39390.6 39439.6 40111.4 40679.8 33988.7 34581.8 37557.4 39792.4 39913.4 24254.8 32551.8 34994.3 35990.8 37226.4 24467.6 24579.8 24633.4 24938.3 25015.0 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:33198.83 Median:25037.05 stddev:90070.73 (359.7%) stddev-sans-first:90289.67 13:58:24 INFO - PROCESS | 1636 | Values: 367.5 382.8 387.9 395.7 417.3 15377.9 15554.8 17775.6 20159.6 20333.9 20548.9 20900.1 21161.5 21318.1 21453.4 5932.6 5965.8 6118.4 6234.3 6236.4 4390.3 6052.3 6142.2 6156.8 6158.8 4580.1 6420.6 6721.5 6759.2 6833.1 6560.9 6785.7 6806.8 6822.3 6834.7 5967.9 5975.7 5981.1 5984.2 5986.8 22864.1 23900.4 24633.0 25441.1 25475.1 2346.4 2356.7 2359.0 2365.2 3106.3 13718.9 15002.2 15307.6 15614.2 15835.4 1821.3 1886.7 1889.7 1941.7 1984.2 116708.4 118226.2 118532.4 118564.0 119185.0 10650.7 10805.6 10862.0 11148.3 11273.0 14153.6 14158.4 14191.6 14196.8 14200.1 8686.7 8719.5 8733.5 8823.6 8876.8 7924.2 8890.5 8933.0 9090.4 9107.7 5817.7 6417.8 6547.9 6770.5 6779.6 1626.5 1832.5 1882.8 1891.5 1912.4 720.6 864.5 898.6 937.9 996.3 21154.7 22294.6 22355.7 22384.6 22397.7 883.9 937.6 967.2 984.9 1098.6 11477.9 11590.2 11739.5 11947.6 12251.1 502066.0 506532.0 508173.0 577613.2 586650.0 77122.2 77401.6 132012.0 132355.0 140151.0 866.9 898.0 1017.5 1073.7 1073.7 18286.9 19656.6 19856.7 19884.4 19920.0 50972.0 54190.0 54607.0 56902.4 58371.0 79080.6 79628.0 84234.6 84281.2 85057.6 7971.4 8054.2 8068.7 8144.3 8152.4 8772.3 10103.9 11896.2 12635.0 12676.9 10426.9 10669.0 11127.3 11389.8 11450.2 8877.3 10732.9 10879.8 10957.5 11250.1 10856.6 11298.5 11346.6 11414.8 11712.8 5769.8 6898.5 7058.5 8142.3 8152.8 9377.2 10573.7 10691.8 11168.5 11359.4 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5458.67 Median:5245.88 stddev:2996.21 (57.1%) stddev-sans-first:2989.03 13:58:24 INFO - PROCESS | 1636 | Values: 1392.1 1493.4 1644.7 1820.7 1824.4 7275.4 8100.2 8545.7 8547.4 8548.0 7467.4 7761.5 8107.2 8334.0 8350.8 2349.9 2377.2 2378.3 2379.2 2379.8 2367.6 2396.4 2410.7 2411.0 2415.4 2345.2 2348.9 2368.6 2377.2 2381.1 2335.3 2338.5 2361.0 2363.4 2366.1 2355.1 2357.4 2383.5 2384.4 2388.9 8339.0 8385.3 8452.0 8452.4 8472.7 5128.6 5285.5 5298.5 5299.9 5302.4 2751.7 3285.3 3285.5 3285.7 3461.6 1067.3 1075.5 1085.0 1096.3 1100.1 10829.0 10942.3 10953.5 10962.6 10964.4 4523.8 4557.9 4705.6 4711.5 4729.3 9482.9 9501.1 9516.3 9523.0 9550.6 5241.3 5250.4 5258.3 5258.6 5275.3 4340.4 4378.7 4754.1 4813.8 4876.5 3157.9 3775.9 3809.3 3873.5 3902.4 1264.5 1274.0 1275.5 1292.1 1294.0 769.9 869.6 897.2 899.8 903.2 4439.4 5502.4 5622.3 5624.3 5850.2 901.2 903.3 933.8 938.4 942.2 3135.7 3667.3 3746.4 3764.9 3911.9 9896.4 10127.9 10247.9 10250.8 10253.7 9657.0 10073.8 10088.4 10218.6 10222.4 7750.9 7968.8 7990.8 7993.4 8005.1 5435.1 5439.5 5614.9 5619.8 5745.1 9199.0 9359.4 9359.4 9365.0 9392.9 9185.0 9598.5 9623.5 9699.2 9716.3 6647.4 6856.9 7044.3 7146.2 7316.6 7783.8 8001.7 8015.3 8039.2 8040.1 7139.8 7196.1 7227.6 7278.9 7357.8 6002.0 7043.2 7054.5 7076.5 7144.5 6653.3 6678.8 6751.4 6760.2 6767.3 4527.5 4574.7 4815.4 4873.5 4901.4 4747.2 4764.7 4779.6 4974.8 4992.4 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4429.45 Median:4923.28 stddev:1368.58 (27.8%) stddev-sans-first:1336.98 13:58:24 INFO - PROCESS | 1636 | Values: 307.0 310.4 316.2 321.5 323.9 5157.8 5248.0 5274.3 5278.9 5321.4 4518.9 4983.2 5040.5 5131.5 5189.4 3545.4 3855.5 4028.3 4039.4 4080.5 3373.0 4019.6 4042.1 4043.5 4052.3 3536.8 3540.7 3715.6 4027.5 4040.4 3528.9 4014.0 4027.0 4043.9 4082.4 3019.7 3059.3 3410.5 3469.6 3527.7 4793.0 5092.2 5115.4 5122.9 5130.5 4373.7 4598.2 4690.4 4693.8 4714.0 5490.9 5515.4 5543.1 5549.8 5556.6 3270.9 3800.1 3890.6 3892.3 3924.5 5146.3 5385.4 5816.7 5838.6 5862.0 3259.6 3833.5 3840.1 3851.4 3869.3 3285.5 3883.7 3907.0 3907.8 3918.4 3980.8 4255.7 4505.1 4540.0 4555.7 4916.9 5030.5 5567.4 5620.7 5646.9 1211.8 1261.4 1285.5 1288.1 1307.8 818.5 835.6 845.4 862.2 876.8 4023.5 4315.1 4640.7 4661.7 4686.1 4359.1 4445.0 4929.6 5254.5 5386.9 4206.7 4838.2 4859.4 4900.1 5369.3 2540.6 2729.4 2832.4 2862.7 2873.7 4848.9 5448.4 5655.9 5663.8 5675.5 5247.7 5545.3 5577.0 5589.8 5592.8 4792.9 4941.3 5580.9 5616.0 5642.9 4247.0 5129.0 5360.4 5446.3 5450.3 5237.9 5475.3 5625.4 5756.3 5789.2 5782.6 5987.7 5996.6 6032.9 6092.6 3774.5 3873.7 3897.3 3925.8 3965.4 4877.2 5750.8 5759.3 5766.4 5794.3 4721.6 5521.2 5605.4 5639.1 5662.4 5302.5 5578.7 5601.8 5622.1 5664.3 4633.7 4636.2 5027.6 5031.0 5239.7 5331.8 5521.5 5577.0 5609.1 5669.9 5118.9 5194.7 5448.9 5466.0 5525.3 13:58:24 INFO - PROCESS | 1636 | 13:58:24 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21279.16 Median:4523.40 stddev:31467.67 (695.7%) stddev-sans-first:31518.11 13:58:24 INFO - PROCESS | 1636 | Values: 726.9 738.3 741.4 773.9 776.4 14412.1 15350.6 15371.2 16373.7 17258.2 15345.9 15936.5 16248.3 16255.6 16296.1 860.5 861.3 865.3 869.4 872.7 707.8 729.8 732.1 889.2 892.8 762.4 765.0 922.6 956.3 956.7 941.1 944.4 947.3 947.4 950.9 700.0 703.5 704.2 707.1 707.9 14505.3 14748.7 14793.6 14797.4 15395.3 14314.2 14577.7 14662.9 14768.3 14869.4 11738.0 11793.4 11793.7 11939.2 11957.4 3769.7 3773.5 3804.3 3949.9 3971.1 87702.0 89719.6 90661.5 92513.5 93422.5 10836.8 11115.6 11160.9 11198.2 11415.2 20571.6 21561.1 22307.3 22437.8 22488.9 7664.6 7703.6 7755.8 7778.4 7874.1 4317.4 4346.4 4522.7 4547.8 4691.8 3354.3 3448.9 3476.5 3477.0 3481.8 668.7 670.5 673.4 673.9 693.4 603.9 635.7 642.1 655.8 701.2 8872.1 8874.9 8902.6 8919.5 9430.0 533.2 585.4 674.3 686.2 698.6 4062.7 4499.0 4502.4 4524.1 4635.2 98160.0 105203.0 107130.0 110626.9 119392.8 99527.5 103962.0 104229.0 104388.5 104581.0 88150.1 88728.1 92247.0 92520.6 93183.0 7052.7 8827.5 8877.8 8906.6 8918.8 57517.0 58894.0 59729.0 60615.7 62100.1 54911.7 72029.0 86930.0 88943.6 89426.0 10960.9 11542.7 11841.7 11882.3 12144.9 12088.8 12776.9 12780.5 12938.0 13342.4 10201.6 11595.8 12210.3 12372.8 12625.5 11381.1 11811.3 12059.3 12249.3 12665.4 11491.6 11867.8 11902.2 12123.9 12260.4 9491.4 9541.3 10083.1 10125.1 10157.3 8411.1 10268.7 10418.8 10439.4 10487.9 13:58:24 INFO - PROCESS | 1636 | -------- Summary: end -------- 13:58:24 INFO - PROCESS | 1636 | 13:58:25 INFO - TEST-INFO | 1636: exit 0 13:58:25 INFO - TEST-OK | dromaeo_css | took 1117865ms 13:58:25 INFO - TEST-START | kraken 13:58:25 INFO - operating with platform_type : mac_ 13:58:25 INFO - Initialising browser for kraken test... 13:58:25 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpEpi34e/profile http://localhost:49240/getInfo.html) 13:58:27 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 13:58:27 INFO - PROCESS | 1646 | colorDepth:24 13:58:27 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 13:58:27 INFO - PROCESS | 1646 | __metrics 13:58:27 INFO - PROCESS | 1646 | 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" 13:58:27 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:28 INFO - TEST-INFO | 1646: exit 0 13:58:28 INFO - Browser initialized. 13:58:28 INFO - Running cycle 1/1 for kraken test... 13:58:28 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpEpi34e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:40 INFO - PROCESS | 1648 | RSS: Main: 167428096 13:58:40 INFO - PROCESS | 1648 | 13:58:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:58:44 INFO - PROCESS | 1648 | RSS: Main: 218083328 13:58:44 INFO - PROCESS | 1648 | 13:58:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:58:47 INFO - PROCESS | 1648 | RSS: Main: 231477248 13:58:47 INFO - PROCESS | 1648 | 13:58:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:58:51 INFO - PROCESS | 1648 | RSS: Main: 327688192 13:58:51 INFO - PROCESS | 1648 | 13:58:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:58:53 INFO - PROCESS | 1648 | RSS: Main: 231596032 13:58:53 INFO - PROCESS | 1648 | 13:58:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:58:56 INFO - PROCESS | 1648 | RSS: Main: 234221568 13:58:56 INFO - PROCESS | 1648 | 13:58:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:58:59 INFO - PROCESS | 1648 | RSS: Main: 274206720 13:58:59 INFO - PROCESS | 1648 | 13:59:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:59:03 INFO - PROCESS | 1648 | RSS: Main: 272814080 13:59:03 INFO - PROCESS | 1648 | 13:59:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:59:06 INFO - PROCESS | 1648 | RSS: Main: 272171008 13:59:06 INFO - PROCESS | 1648 | 13:59:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:09 INFO - PROCESS | 1648 | RSS: Main: 248643584 13:59:09 INFO - PROCESS | 1648 | 13:59:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:11 INFO - PROCESS | 1648 | RSS: Main: 250900480 13:59:11 INFO - PROCESS | 1648 | 13:59:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:14 INFO - PROCESS | 1648 | RSS: Main: 252227584 13:59:14 INFO - PROCESS | 1648 | 13:59:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:18 INFO - PROCESS | 1648 | RSS: Main: 269336576 13:59:18 INFO - PROCESS | 1648 | 13:59:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:21 INFO - PROCESS | 1648 | RSS: Main: 262758400 13:59:21 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:59:23 INFO - PROCESS | 1648 | RSS: Main: 306532352 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | __start_tp_report 13:59:23 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 13:59:23 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 13:59:23 INFO - PROCESS | 1648 | |i|pagename|runs| 13:59:23 INFO - PROCESS | 1648 | |0;ai-astar;103;113;114;114;115;115;116;113;115;114 13:59:23 INFO - PROCESS | 1648 | |1;audio-beat-detection;144;129;139;155;110;130;143;125;163;137 13:59:23 INFO - PROCESS | 1648 | |2;audio-dft;181;184;181;184;183;187;181;182;184;183 13:59:23 INFO - PROCESS | 1648 | |3;audio-fft;79;58;58;88;61;60;58;58;82;59 13:59:23 INFO - PROCESS | 1648 | |4;audio-oscillator;87;71;94;69;69;96;123;96;68;92 13:59:23 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;86;84;86;90;88;83;94;83;87;83 13:59:23 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;93;93;93;92;92;102;150;130;93 13:59:23 INFO - PROCESS | 1648 | |7;imaging-desaturate;83;84;81;79;97;125;139;82;83;82 13:59:23 INFO - PROCESS | 1648 | |8;json-parse-financial;56;53;51;51;53;57;54;53;55;73 13:59:23 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;64;72;65;78;73;69;68;69;68;70 13:59:23 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;83;81;82;83;84;82;84;82;84;82 13:59:23 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;138;139;135;155;144;151;138;141;180;145 13:59:23 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;163;173;162;159;219;218;161;161;162;163 13:59:23 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;67;68;61;58;71;58;69;81;82;83 13:59:23 INFO - PROCESS | 1648 | __end_tp_report 13:59:23 INFO - PROCESS | 1648 | __start_cc_report 13:59:23 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1903 13:59:23 INFO - PROCESS | 1648 | __end_cc_report 13:59:23 INFO - PROCESS | 1648 | __startTimestamp1486591163585__endTimestamp 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | ------- Summary: start ------- 13:59:23 INFO - PROCESS | 1648 | Number of tests: 14 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.71 (3.2%) stddev-sans-first:1.00 13:59:23 INFO - PROCESS | 1648 | Values: 103.0 113.0 114.0 114.0 115.0 115.0 116.0 113.0 115.0 114.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:141.00 stddev:15.17 (10.8%) stddev-sans-first:15.91 13:59:23 INFO - PROCESS | 1648 | Values: 144.0 129.0 139.0 155.0 110.0 130.0 143.0 125.0 163.0 137.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.89 (1.0%) stddev-sans-first:1.86 13:59:23 INFO - PROCESS | 1648 | Values: 181.0 184.0 181.0 184.0 183.0 187.0 181.0 182.0 184.0 183.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:11.90 (19.7%) stddev-sans-first:11.67 13:59:23 INFO - PROCESS | 1648 | Values: 79.0 58.0 58.0 88.0 61.0 60.0 58.0 58.0 82.0 59.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:89.50 stddev:17.62 (19.7%) stddev-sans-first:18.69 13:59:23 INFO - PROCESS | 1648 | Values: 87.0 71.0 94.0 69.0 69.0 96.0 123.0 96.0 68.0 92.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.50 stddev:3.57 (4.1%) stddev-sans-first:3.78 13:59:23 INFO - PROCESS | 1648 | Values: 86.0 84.0 86.0 90.0 88.0 83.0 94.0 83.0 87.0 83.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:93.00 stddev:20.22 (21.7%) stddev-sans-first:21.12 13:59:23 INFO - PROCESS | 1648 | Values: 93.0 93.0 93.0 93.0 92.0 92.0 102.0 150.0 130.0 93.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:82.50 stddev:21.13 (25.6%) stddev-sans-first:22.06 13:59:23 INFO - PROCESS | 1648 | Values: 83.0 84.0 81.0 79.0 97.0 125.0 139.0 82.0 83.0 82.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.50 stddev:6.42 (11.8%) stddev-sans-first:6.80 13:59:23 INFO - PROCESS | 1648 | Values: 56.0 53.0 51.0 51.0 53.0 57.0 54.0 53.0 55.0 73.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:4.03 (5.8%) stddev-sans-first:3.73 13:59:23 INFO - PROCESS | 1648 | Values: 64.0 72.0 65.0 78.0 73.0 69.0 68.0 69.0 68.0 70.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 13:59:23 INFO - PROCESS | 1648 | Values: 83.0 81.0 82.0 83.0 84.0 82.0 84.0 82.0 84.0 82.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:144.50 stddev:13.28 (9.2%) stddev-sans-first:13.71 13:59:23 INFO - PROCESS | 1648 | Values: 138.0 139.0 135.0 155.0 144.0 151.0 138.0 141.0 180.0 145.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:163.00 stddev:23.70 (14.5%) stddev-sans-first:24.79 13:59:23 INFO - PROCESS | 1648 | Values: 163.0 173.0 162.0 159.0 219.0 218.0 161.0 161.0 162.0 163.0 13:59:23 INFO - PROCESS | 1648 | 13:59:23 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:9.53 (13.6%) stddev-sans-first:10.06 13:59:23 INFO - PROCESS | 1648 | Values: 67.0 68.0 61.0 58.0 71.0 58.0 69.0 81.0 82.0 83.0 13:59:23 INFO - PROCESS | 1648 | -------- Summary: end -------- 13:59:23 INFO - PROCESS | 1648 | 13:59:24 INFO - TEST-INFO | 1648: exit 0 13:59:24 INFO - TEST-OK | kraken | took 59480ms 13:59:24 INFO - SUITE-END | took 1177s 13:59:24 INFO - Completed test suite (00:19:37) 13:59:24 INFO - javascript benchmark 13:59:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3492.2840817632386, 3493.144179675978, 3517.6130625631185, 3523.242502861884, 3548.716102711783, 5820.126980952854, 5894.823155305337, 5911.763529458827, 5923.7630494780215, 5968.40315968403, 5871.677057761822, 5942.732577034033, 5951.0, 5951.137085122666, 5982.461578457938, 5325.174597937316, 5332.626716129853, 5390.326209223847, 5394.0, 5498.092814685572, 5178.223266510035, 5311.681299122046, 5316.255724198596, 5324.334458192726, 5450.836474905759, 5334.973325133369, 5396.298481197439, 5396.325459317585, 5399.163129714881, 5413.756380962866, 5384.246205531229, 5428.321459817523, 5460.31746031746, 5463.453654634544, 5470.343558772933, 5243.449437809013, 5319.813806516753, 5366.382865970424, 5375.731213439312, 5459.672419654833, 5815.09865970771, 5821.126830975345, 5829.154772557998, 5836.97081514594, 5847.44449277318, 6195.28754193269, 6200.751969921243, 6231.158793562901, 6241.87516249677, 6251.0310901809835, 6372.3946225109, 6374.713137908805, 6380.840478988016, 6387.0, 6397.488200943913, 5850.795222167247, 5952.880942381128, 5976.252968378953, 6032.939670603326, 6053.122297266872, 6433.581817181868, 6468.870622587522, 6477.578957367756, 6493.123428337209, 6493.805185844432, 6213.565050446516, 6217.502599792006, 6229.595076320024, 6234.75060997555, 6236.282827474898, 6164.537659675452, 6215.409536094064, 6218.502519798405, 6271.9686401568615, 6285.622862628165, 6187.81436556904, 6225.844353891189, 6241.563090583615, 6257.843553911189, 6267.122602835607, 6213.720382582795, 6247.312795592481, 6247.562670613104, 6262.718177682015, 6263.154474145932, 4986.252062190701, 4987.226979818061, 4987.351644286219, 4997.200447928314, 5088.872778180576, 4534.591886730144, 4540.205464043779, 4559.224931761609, 4583.610393116623, 4611.0, 5994.220751302303, 6015.037593984942, 6018.337982821886, 6026.126211699279, 6031.035034394476, 6059.151718759377, 6219.595726277777, 6334.049892516067, 6349.746010159634, 6359.17330747, 5960.523158147338, 5962.284525856839, 6011.218541589653, 6017.458428741435, 6053.031514957585, 5478.096114141202, 5546.55627549795, 5551.750171242223, 5553.4724201200825, 5555.805546805843, 6520.608763474207, 6520.706568204348, 6527.771527996498, 6528.608283503005, 6557.114789503356, 6133.059244992972, 6139.386061393825, 6216.844578885564, 6240.563160578898, 6282.8429289266305, 6559.180102487189, 6559.508036897157, 6560.8359791005605, 6574.112494813139, 6579.967100164468, 6210.782622608187, 6242.438180563771, 6249.625022498664, 6251.812445626639, 6273.435390814849, 6147.508199343953, 6148.739508400857, 6174.783882564088, 6179.660118693515, 6303.527235457267, 6018.277806663228, 6147.600405973598, 6156.1381406604005, 6156.876862462816, 6160.291566469913, 6146.473175810604, 6156.445919867055, 6157.922363586444, 6165.784197553064, 6181.5363847710705, 6018.337982821974, 6083.6349819011, 6098.9390106100145, 6113.17472141273, 6143.047827586731, 6116.082587611716, 6135.1717518136265, 6179.969100154471, 6182.196314479269, 6187.288461826767, 6111.022236442148, 6130.325664177026, 6138.81758342749, 6154.5384096192065, 6158.661273629993], "value": 5836.7813910051755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.0944795440708, 529.2431822493835, 531.5800517591103, 533.5118366694475, 560.5795653260055, 32229.51655725163, 34165.316693666115, 36189.45715814265, 42689.57310426895, 42822.71531854042, 45850.77074614631, 46047.079058418814, 46092.76953615227, 46130.538694613046, 46150.76924615372, 9716.805663886737, 9869.851952220723, 9873.259505537078, 9900.950495247514, 9902.801943961153, 9752.512374381287, 9859.359141655805, 9878.0, 9884.258680598983, 9892.653757118502, 9831.508424578742, 9878.012198780101, 9880.604775808959, 9884.406935583853, 9891.90108098917, 9799.90200097997, 9836.655717049869, 9844.80310393788, 9846.015398460167, 9874.703758887208, 9055.777470041592, 9241.768955776091, 9746.90253097467, 9845.212383009342, 9860.704178874645, 42736.35895461571, 43148.784256078834, 43163.0, 43194.784026079986, 43251.78374108141, 3371.7471189660873, 3434.1242983039415, 3446.7070299024613, 3679.2089700714473, 4104.220198162339, 31239.375212495852, 31626.367472650418, 31650.683493165005, 31969.0, 32574.837125814218, 3131.2015436063884, 3199.0722690419752, 3203.679632036801, 3218.951715724266, 3219.8390080496115, 533773.0, 534152.3292383552, 539820.0, 679605.0, 681327.999999995, 65939.67030164914, 66658.0, 66836.6658166706, 66841.0, 66887.99668004984, 36890.077748056516, 71275.0, 71689.0, 71757.64121179361, 71967.2803271971, 16695.248713807665, 17133.914330428517, 17142.742858857127, 17246.965182089116, 17340.566485837953, 13079.215247085014, 13079.934600326937, 13090.14914030585, 13095.017873659513, 13121.343932803322, 20027.29904453337, 20122.993850307426, 20157.899210503852, 20201.696974545393, 20231.0, 7662.4253181011645, 7687.5387476751575, 7736.92263077362, 7754.844903101906, 7791.727289544839, 864.4597126795753, 1015.7252647926953, 1061.8141825180717, 1062.3997441445558, 1096.4846522134585, 29763.702362976524, 30964.535531967038, 31068.689313107032, 31075.844620776752, 31396.0, 921.5162039928957, 1003.7490627343165, 1047.486731501574, 1100.070440477795, 1100.9944950275196, 12580.748385032248, 15946.0, 16078.035317880964, 16233.18834058316, 16369.754453683205, 683636.0, 684386.0, 685363.0, 687917.0, 688379.0, 62855.0, 63565.046524302175, 63633.40916477125, 63764.0, 63780.0, 1204.7108693913397, 1354.464986330394, 1391.749485092693, 1392.8398234202994, 1399.5871217990716, 29255.51328137132, 29753.10740677783, 30279.848600757738, 30354.84822575873, 30837.383252334377, 54088.729556351966, 54168.72915635397, 54333.45666543284, 54372.18441723298, 54904.72547637236, 598904.0, 601404.0, 602375.0, 603110.0, 603503.0, 25618.719064047094, 26143.0, 27897.581536276568, 28227.0, 28284.85857570699, 48942.51057489379, 48985.75507122442, 49193.10016276957, 50206.0, 50810.23784643159, 38846.864851361475, 39934.60065399309, 40121.59878401179, 41175.76472705824, 41579.584204157574, 38968.41547376735, 39390.606093938695, 39439.60560394359, 40111.39832902567, 40679.79660101799, 33988.660113399535, 34581.82709086438, 37557.41637532541, 39792.403113952736, 39913.401298981116, 24254.757452425954, 32551.837240813646, 34994.300113998084, 35990.8200458996, 37226.441603376516, 24467.632985504875, 24579.771011449, 24633.442813079637, 24938.251852444457, 25015.0], "value": 20663.126821028305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5240563470306, 382.7779887665154, 387.88945150632077, 395.65577947185955, 417.3385184482595, 15377.923110384447, 15554.766678499818, 17775.55561110973, 20159.59680806383, 20333.898330508364, 20548.89725551374, 20900.059497322618, 21161.470963225926, 21318.14727410902, 21453.356399308006, 5932.584719069667, 5965.761369545213, 6118.418750218744, 6234.345393733661, 6236.407541283571, 4390.253656878338, 6052.334243233241, 6142.232220972379, 6156.784512542062, 6158.815235542941, 4580.106879158566, 6420.5505614607, 6721.49588780841, 6759.155105611799, 6833.111695479581, 6560.901586476207, 6785.694643741043, 6806.829829254283, 6822.317768223213, 6834.726610935557, 5967.850803729898, 5975.701214939236, 5981.102834574848, 5984.192134061889, 5986.820395388146, 22864.08543658268, 23900.40248993772, 24633.0, 25441.109561165456, 25475.108371207105, 2346.4485845826216, 2356.658284548731, 2359.0327965534048, 2365.1840115160244, 3106.2544989202656, 13718.873574595953, 15002.24988750558, 15307.617309567238, 15614.219289035504, 15835.445759398366, 1821.317006122704, 1886.6604011277964, 1889.6598612249788, 1941.679622862226, 1984.1765667248076, 116708.41645791802, 118226.22660660098, 118532.40733796362, 118564.0, 119185.0, 10650.680479585624, 10805.621803236849, 10862.0, 11148.275362101438, 11272.99808567963, 14153.646158846112, 14158.362873670709, 14191.574252772434, 14196.787048194285, 14200.147991120566, 8686.695965641173, 8719.520426376483, 8733.503901878805, 8823.602937867812, 8876.778080548038, 7924.20757924203, 8890.511021893857, 8933.0, 9090.409123406956, 9107.681231156877, 5817.680027598522, 6417.7753778617525, 6547.934520654828, 6770.458363330922, 6779.593224406552, 1626.495491670224, 1832.5052235896233, 1882.7834798998017, 1891.4892978895896, 1912.4453908366418, 720.5546387563197, 864.4726716702806, 898.645035211101, 937.864009718587, 996.3175224970918, 21154.682679759815, 22294.55410891773, 22355.66466503004, 22384.55230895373, 22397.66403503949, 883.8630012348096, 937.6483818568037, 967.1827305926481, 984.9409035457895, 1098.593520397458, 11477.909598588121, 11590.246633968765, 11739.47172377245, 11947.641570752892, 12251.142420030512, 502066.0, 506532.0, 508173.0, 577613.2238677643, 586650.0, 77122.22877771263, 77401.6129919358, 132012.0, 132355.0, 140151.0, 866.9293422623056, 897.9820403592022, 1017.4963393120305, 1073.7154654016692, 1073.7154654016692, 18286.902785832892, 19656.606867862847, 19856.70214946806, 19884.403467895987, 19920.0, 50972.0, 54190.0, 54607.0, 56902.43097568971, 58371.0, 79080.60459697896, 79628.0, 84234.57882710548, 84281.15718842733, 85057.57471212605, 7971.441999060242, 8054.23484768946, 8068.7175948841505, 8144.348452123697, 8152.429329946846, 8772.254358379609, 10103.89896101059, 11896.22674526153, 12635.0, 12676.936615316865, 10426.895731042592, 10669.0, 11127.276727012719, 11389.829152562885, 11450.198486105892, 8877.289816814768, 10732.892671073501, 10879.782404352027, 10957.452127393439, 11250.099992000783, 10856.611545459986, 11298.548058077586, 11346.60286889988, 11414.771704565695, 11712.765744685228, 5769.798057067983, 6898.517103802887, 7058.470614703815, 8142.267195952392, 8152.796180095545, 9377.156055954723, 10573.682789516326, 10691.786164276826, 11168.497417616389, 11359.432028398713], "value": 9760.088824975644, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.136875137415, 1493.4175671488115, 1644.6792875389297, 1820.6540757256112, 1824.4253060286, 7275.417966562675, 8100.189981001897, 8545.743627691163, 8547.401681882271, 8548.016978047526, 7467.439942004345, 7761.495502792314, 8107.229813167754, 8334.0, 8350.83298334033, 2349.89425475854, 2377.215518878766, 2378.286514045788, 2379.1910750344878, 2379.809615230786, 2367.609344458171, 2396.4128788446856, 2410.6745589345387, 2411.0476361837063, 2415.4202991282054, 2345.155743932183, 2348.8942997565064, 2368.6210206366986, 2377.1917548033666, 2381.0832829360647, 2335.2760644200266, 2338.543983923136, 2361.031976889467, 2363.3500787283465, 2366.1363602285214, 2355.1286024170995, 2357.4342157882156, 2383.475635360218, 2384.4158181245534, 2388.8566685998894, 8338.999320081568, 8385.329173666092, 8451.985761708573, 8452.366072544584, 8472.661093556251, 5128.5640720538795, 5285.471452854684, 5298.470152984709, 5299.867503312409, 5302.443243459458, 2751.6697996240378, 3285.3100848821778, 3285.4743241081314, 3285.704286614216, 3461.567304086989, 1067.311584028305, 1075.5160177919968, 1084.9620263290826, 1096.3015972408577, 1100.0594491709553, 10829.0, 10942.343459392461, 10953.507092180871, 10962.56149754009, 10964.396958167297, 4523.751193684379, 4557.931631025537, 4705.623550115983, 4711.481737008926, 4729.290606409066, 9482.857757133648, 9501.14489695917, 9516.286278529138, 9522.95238523803, 9550.617975280911, 5241.344831896013, 5250.422453530108, 5258.316418865599, 5258.631895767336, 5275.314209152785, 4340.370646256275, 4378.671599630041, 4754.096721622881, 4813.7593120343845, 4876.463589005207, 3157.905262842118, 3775.867844625425, 3809.2571948470336, 3873.535175778868, 3902.35611124167, 1264.4752427742385, 1273.9808902866464, 1275.515304184404, 1292.1471828593083, 1294.0, 769.926856948589, 869.5608717597572, 897.210454799772, 899.8470260055806, 903.1555495611624, 4439.356293337448, 5502.367227768777, 5622.32532096151, 5624.268845050199, 5850.180974663551, 901.1709227510706, 903.2683526343683, 933.7945651956559, 938.3572253006712, 942.2414955960518, 3135.6550779414247, 3667.2848794485353, 3746.4193050077283, 3764.887053388403, 3911.9217615647526, 9896.406215627085, 10127.949360253151, 10247.948760256151, 10250.794984100276, 10253.692389228336, 9657.0, 10073.798524029478, 10088.44513551747, 10218.642347517802, 10222.437765922945, 7750.92249077502, 7968.840623187504, 7990.800229994296, 7993.400494962785, 8005.079415867133, 5435.130379139318, 5439.456054394529, 5614.88770224585, 5619.8198378339375, 5745.052066408995, 9199.034101419255, 9359.391639543408, 9359.438433694, 9365.0, 9392.859107113536, 9185.0, 9598.472084035446, 9623.470709111067, 9699.224062074876, 9716.3198576099, 6647.401733843977, 6856.931430685829, 7044.295570442915, 7146.178189508273, 7316.597587132759, 7783.766487005399, 8001.719939802079, 8015.318697910743, 8039.15588863161, 8040.075391330072, 7139.750108746169, 7196.10048743907, 7227.638618069181, 7278.890816637649, 7357.77926662201, 6001.969990150022, 7043.190033146254, 7054.470914681317, 7076.504644674823, 7144.4998850082075, 6653.268140504444, 6678.83302917431, 6751.358620931003, 6760.18877734675, 6767.323267673193, 4527.524609915911, 4574.679772415899, 4815.398075240595, 4873.4639189689815, 4901.436334821541, 4747.216709242936, 4764.737939413366, 4779.641526885428, 4974.801007959786, 4992.350994370709], "value": 4432.833952003127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.96316442026955, 310.4055733270785, 316.17636058068723, 321.4503199528806, 323.92225865792216, 5157.845264642062, 5247.973760131199, 5274.2879711238975, 5278.868028299295, 5321.36143662761, 4518.909621807562, 4983.18450075707, 5040.546350828425, 5131.486851314867, 5189.42916279209, 3545.4327307630783, 3855.51806024247, 4028.315186418316, 4039.394090886361, 4080.489938757655, 3372.966270337302, 4019.5779443158485, 4042.070323825522, 4043.5349934757437, 4052.29084910141, 3536.770109942858, 3540.6636369544854, 3715.5912849586525, 4027.5166979962446, 4040.393940908858, 3528.947065794028, 4013.969453062948, 4027.0, 4043.9191216175514, 4082.4284600156, 3019.7131272529073, 3059.3269480714207, 3410.454327307644, 3469.5774732359864, 3527.664871837171, 4792.976035119802, 5092.210707340369, 5115.411727651331, 5122.897542049138, 5130.511701824612, 4373.693841431101, 4598.206699387241, 4690.366800481926, 4693.78877950493, 4713.976430117862, 5490.945090549083, 5515.352630737269, 5543.085390910495, 5549.833504994856, 5556.582886444369, 3270.8878981146286, 3800.1449673823167, 3890.649841514249, 3892.299386110499, 3924.469456911807, 5146.327443580813, 5385.434529374398, 5816.662167701453, 5838.649681019152, 5861.9706901465215, 3259.6414394416597, 3833.463315135883, 3840.116773142193, 3851.4030325299623, 3869.342211823997, 3285.5235990781202, 3883.728139030241, 3907.0, 3907.7530420008607, 3918.4318273850704, 3980.8407663693706, 4255.744655320691, 4505.144022635689, 4539.954600453953, 4555.703879247838, 4916.926246106311, 5030.496950304941, 5567.443255674481, 5620.70481061214, 5646.85882852932, 1211.7697637448857, 1261.4197469164103, 1285.4986555243463, 1288.1193457551892, 1307.7515272098271, 818.5457071325471, 835.5529791561486, 845.446232717571, 862.1895418306772, 876.8071024374627, 4023.5372932112596, 4315.050688848449, 4640.723800954765, 4661.696989695659, 4686.133065382915, 4359.106383191438, 4444.955550444519, 4929.630277729185, 5254.530370725753, 5386.949544838797, 4206.663466922639, 4838.2016967200725, 4859.441164266154, 4900.142475066849, 5369.301990741179, 2540.5808041673286, 2729.372244383803, 2832.405194909051, 2862.6545523603872, 2873.7126287371098, 4848.927266091011, 5448.37343705471, 5655.915161272585, 5663.801766938137, 5675.460831221028, 5247.737613119329, 5545.279113715191, 5577.0, 5589.8323050307745, 5592.832215033555, 4792.880177995508, 4941.283513890466, 5580.935054029954, 5616.0, 5642.858928526902, 4247.023184667482, 5128.974205159057, 5360.383555890967, 5446.311643390562, 5450.264214331015, 5237.947620523899, 5475.315585551806, 5625.437456254505, 5756.30924289088, 5789.189513468202, 5782.595218334676, 5987.71878107138, 5996.580239383201, 6032.8793424132145, 6092.573519853568, 3774.4527043577978, 3873.7288389812443, 3897.2595206910596, 3925.842966281431, 3965.4448377227786, 4877.195612522884, 5750.769969201185, 5759.337676167294, 5766.423357664368, 5794.333651630117, 4721.551452611996, 5521.245553023821, 5605.4114317997655, 5639.082711877981, 5662.377138514677, 5302.515295717205, 5578.689008083016, 5601.831945041656, 5622.144692251629, 5664.34649650981, 4633.6524760642415, 4636.165490211794, 5027.597792176544, 5030.99380123984, 5239.738013099406, 5331.760070796901, 5521.475459831309, 5577.0, 5609.120944483644, 5669.897092616678, 5118.923216151835, 5194.714290714047, 5448.937457195809, 5466.043442397644, 5525.336959564878], "value": 3995.7819620993955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9454790890683, 738.2617382617386, 741.384650739886, 773.8645736996028, 776.440962506995, 14412.06321589096, 15350.616234594141, 15371.231438428089, 16373.672526549462, 17258.2233799479, 15345.92578519504, 15936.521904342888, 16248.268827902742, 16255.593610159753, 16296.103714295708, 860.475110182788, 861.2507118806647, 865.26020252684, 869.430523007428, 872.7469033980138, 707.8088915992679, 729.7993051910714, 732.0848938826467, 889.1908363389317, 892.7589550821274, 762.4167511853436, 764.9732259370924, 922.557172557173, 956.3114557518576, 956.6747305915987, 941.1153515695258, 944.3861490031466, 947.3179310896144, 947.3794664494698, 950.909663581962, 699.9965000174966, 703.4688809948507, 704.1972151747012, 707.0878566649068, 707.8938159276098, 14505.27473626325, 14748.70502589953, 14793.630159246104, 14797.40810367584, 15395.307211175412, 14314.212718300489, 14577.70844583113, 14662.926685366612, 14768.335424905905, 14869.405223791035, 11738.0, 11793.410329483577, 11793.650951759582, 11939.223950443193, 11957.402129893471, 3769.6795772359383, 3773.5094437723196, 3804.2962052020466, 3949.9012524686827, 3971.0866500705, 87702.0, 89719.55140224322, 90661.54669226611, 92513.53743231308, 93422.53288733581, 10836.783264334668, 11115.55537778496, 11160.939710727467, 11198.160137989684, 11415.20093593457, 20571.633187946856, 21561.137554497956, 22307.330780076623, 22437.775622243895, 22488.887555562444, 7664.616769161519, 7703.614819259126, 7755.7673269802, 7778.377729781604, 7874.133845277015, 4317.438732964694, 4346.36977638247, 4522.706024108423, 4547.795349209294, 4691.81232750693, 3354.26206234628, 3448.8620455181513, 3476.5480487536456, 3477.0264325988765, 3481.7562770605814, 668.7191379620571, 670.5004771445305, 673.3838537737915, 673.8584897171551, 693.3517161454057, 603.9335673075958, 635.7043974551763, 642.1427394428397, 655.7540922154192, 701.1901254051579, 8872.112788721077, 8874.911250887537, 8902.59938302765, 8919.464832110094, 9429.952850235704, 533.1948757376313, 585.3999650358331, 674.2953613473932, 686.2005763285716, 698.552926127279, 4062.7156099073372, 4498.977505112453, 4502.369668246448, 4524.09518096382, 4635.188841952712, 98160.0, 105203.0, 107130.0, 110626.89373106328, 119392.82988561812, 99527.50236248918, 103962.0, 104228.95771042345, 104388.47805761074, 104581.0, 88150.11849881547, 88728.11271887328, 92247.0, 92520.61219081719, 93183.0, 7052.682629281592, 8827.514486703292, 8877.822443551222, 8906.643734250816, 8918.777030574287, 57516.99999999833, 58894.0, 59729.0, 60615.69692151511, 62100.06849897346, 54911.72544137254, 72029.0, 86930.0, 88943.55528222576, 89426.0, 10960.890391095987, 11542.711432214262, 11841.703957401134, 11882.28706277626, 12144.878551214375, 12088.758224835277, 12776.936115319364, 12780.488780448677, 12938.0, 13342.399592018577, 10201.591936322464, 11595.8260626089, 12210.328431935974, 12372.81440778407, 12625.494980200689, 11381.146414018816, 11811.291322520676, 12059.276443413073, 12249.265044097383, 12665.366731663196, 11491.597794077166, 11867.821982670439, 11902.247475123124, 12123.939380303042, 12260.448279827251, 9491.38306010107, 9541.284403669613, 10083.092521673085, 10125.051230020445, 10157.339772914736, 8411.13617770295, 10268.691939241835, 10418.843717344398, 10439.376947040499, 10487.94756026215], "value": 7429.8068982454015, "unit": "score"}], "name": "dromaeo_css", "value": 7328.6207068489875, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 114.0, 115.0, 115.0, 116.0, 113.0, 115.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 129.0, 139.0, 155.0, 110.0, 130.0, 143.0, 125.0, 163.0, 137.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 181.0, 184.0, 183.0, 187.0, 181.0, 182.0, 184.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 88.0, 61.0, 60.0, 58.0, 58.0, 82.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 94.0, 69.0, 69.0, 96.0, 123.0, 96.0, 68.0, 92.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 90.0, 88.0, 83.0, 94.0, 83.0, 87.0, 83.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 92.0, 102.0, 150.0, 130.0, 93.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 79.0, 97.0, 125.0, 139.0, 82.0, 83.0, 82.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 51.0, 51.0, 53.0, 57.0, 54.0, 53.0, 55.0, 73.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 65.0, 78.0, 73.0, 69.0, 68.0, 69.0, 68.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 83.0, 84.0, 82.0, 84.0, 82.0, 84.0, 82.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 135.0, 155.0, 144.0, 151.0, 138.0, 141.0, 180.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 173.0, 162.0, 159.0, 219.0, 218.0, 161.0, 161.0, 162.0, 163.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 61.0, 58.0, 71.0, 58.0, 69.0, 81.0, 82.0, 83.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1467.6999999999998, "alertThreshold": 2.0}]} 13:59:24 INFO - Return code: 0 13:59:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:59:24 INFO - # TBPL SUCCESS # 13:59:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:59:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:59:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:59:24 INFO - 2017-02-08 13:59:24.861 screenresolution[1652:9787] starting screenresolution argv=screenresolution get 13:59:24 INFO - 2017-02-08 13:59:24.864 screenresolution[1652:9787] Display 0: 1600x1200x32@60 13:59:24 INFO - 2017-02-08 13:59:24.870 screenresolution[1653:9790] starting screenresolution argv=screenresolution list 13:59:24 INFO - Available Modes on Display 0 13:59:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:59:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:59:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:59:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:59:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:59:25 INFO - Intel Iris: 13:59:25 INFO - Chipset Model: Intel Iris 13:59:25 INFO - Type: GPU 13:59:25 INFO - Bus: Built-In 13:59:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:59:25 INFO - Vendor: Intel (0x8086) 13:59:25 INFO - Device ID: 0x0a2e 13:59:25 INFO - Revision ID: 0x0009 13:59:25 INFO - Displays: 13:59:25 INFO - Display: 13:59:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:59:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:59:25 INFO - Display Serial Number: 1600x1200 60 13:59:25 INFO - Main Display: Yes 13:59:25 INFO - Mirror: Off 13:59:25 INFO - Online: Yes 13:59:25 INFO - Rotation: Supported 13:59:25 INFO - Return code: 0 13:59:25 INFO - Running post-action listener: _resource_record_post_action 13:59:25 INFO - [mozharness: 2017-02-08 21:59:25.113714Z] Finished run-tests step (success) 13:59:25 INFO - Running post-run listener: _resource_record_post_run 13:59:25 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 39396352; Write bytes: 500534784; Read time: 383; Write time: 1615 13:59:25 INFO - TinderboxPrint: CPU usage
53.3% 13:59:25 INFO - TinderboxPrint: I/O read bytes / time
39,396,352 / 383 13:59:25 INFO - TinderboxPrint: I/O write bytes / time
500,534,784 / 1,615 13:59:25 INFO - TinderboxPrint: CPU idle
2,239.9 (46.7%) 13:59:25 INFO - TinderboxPrint: CPU system
959.1 (20.0%) 13:59:25 INFO - TinderboxPrint: CPU user
1,598.7 (33.3%) 13:59:25 INFO - TinderboxPrint: Swap in / out
230,535,168 / 0 13:59:25 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 188623360; Write bytes: 187705344; Read time: 16776; Write time: 403 13:59:25 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37282816; Write bytes: 305649152; Read time: 360; Write time: 1183 13:59:25 INFO - Running post-run listener: _upload_blobber_files 13:59:25 INFO - Blob upload gear active. 13:59:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:25 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 13:59:25 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'] 13:59:25 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 13:59:26 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:59:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:59:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:27 INFO - (blobuploader) - INFO - Done attempting. 13:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:28 INFO - (blobuploader) - INFO - Done attempting. 13:59:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:59:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:30 INFO - (blobuploader) - INFO - Done attempting. 13:59:30 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:30 INFO - Return code: 0 13:59:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/067330ba20bacd17a69392ee2e7fb42e6c1a7ef77eb224f3dcaa7259dfbe0c1cf1eefbe6219e144718827b1ffe49780a1bce993c29ab7b972607f0e02e1ad7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27e4ce97c9c469f49ed38a56b13c0f5ca9efdd6406d21eff120c9f48e7df60eaa4c4fb5d20e55d7925ce323ae4e92ca3abc5df4de39b3f087bfc586350ce87e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa39bda83a7b80a0af837068f0d68986fec13cb6967f0808629a7b551bd350c2c374668bb9ba68a524c5e53ad0ab2691ab09411f94d756db3ec6ac5b9bcf8d8"} 13:59:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:30 INFO - Contents: 13:59:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/067330ba20bacd17a69392ee2e7fb42e6c1a7ef77eb224f3dcaa7259dfbe0c1cf1eefbe6219e144718827b1ffe49780a1bce993c29ab7b972607f0e02e1ad7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27e4ce97c9c469f49ed38a56b13c0f5ca9efdd6406d21eff120c9f48e7df60eaa4c4fb5d20e55d7925ce323ae4e92ca3abc5df4de39b3f087bfc586350ce87e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa39bda83a7b80a0af837068f0d68986fec13cb6967f0808629a7b551bd350c2c374668bb9ba68a524c5e53ad0ab2691ab09411f94d756db3ec6ac5b9bcf8d8"} 13:59:30 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:30 INFO - Copying logs to upload dir... 13:59:30 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.416577 ========= master_lag: 3.39 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-08 13:59:34.012582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-02-08 13:59:34.017436) ========= 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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/067330ba20bacd17a69392ee2e7fb42e6c1a7ef77eb224f3dcaa7259dfbe0c1cf1eefbe6219e144718827b1ffe49780a1bce993c29ab7b972607f0e02e1ad7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27e4ce97c9c469f49ed38a56b13c0f5ca9efdd6406d21eff120c9f48e7df60eaa4c4fb5d20e55d7925ce323ae4e92ca3abc5df4de39b3f087bfc586350ce87e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa39bda83a7b80a0af837068f0d68986fec13cb6967f0808629a7b551bd350c2c374668bb9ba68a524c5e53ad0ab2691ab09411f94d756db3ec6ac5b9bcf8d8"} build_url:https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/PuswHjImTeyijjT6IpwCiQ/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/067330ba20bacd17a69392ee2e7fb42e6c1a7ef77eb224f3dcaa7259dfbe0c1cf1eefbe6219e144718827b1ffe49780a1bce993c29ab7b972607f0e02e1ad7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27e4ce97c9c469f49ed38a56b13c0f5ca9efdd6406d21eff120c9f48e7df60eaa4c4fb5d20e55d7925ce323ae4e92ca3abc5df4de39b3f087bfc586350ce87e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa39bda83a7b80a0af837068f0d68986fec13cb6967f0808629a7b551bd350c2c374668bb9ba68a524c5e53ad0ab2691ab09411f94d756db3ec6ac5b9bcf8d8"}' ========= master_lag: 3.87 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-02-08 13:59:37.903132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 13:59:37.903464) ========= 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.DEkp9qoWwD/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.NTKqxBGvXR/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005056 ========= master_lag: 0.54 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 13:59:38.451617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 13:59:38.451962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 13:59:38.704802) ========= ========= Total master_lag: 7.98 =========