builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0241 starttime: 1476481379.46 results: success (0) buildid: 20161014113435 builduid: 75916f184960469db5485af04577c845 revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.456840) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.457275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.457551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.481046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.481329) ========= 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.7aSXIIbAYe/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.WlKty2qnrG/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-14 14:42:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 76.9M=0s 2016-10-14 14:42:59 (76.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.683730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.684066) ========= 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.7aSXIIbAYe/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.WlKty2qnrG/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.030490 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:42:59.734678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 14:42:59.735039) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7aSXIIbAYe/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.WlKty2qnrG/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-14 14:42:59,813 truncating revision to first 12 chars 2016-10-14 14:42:59,813 Setting DEBUG logging. 2016-10-14 14:42:59,813 attempt 1/10 2016-10-14 14:42:59,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e412b386433b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 14:43:00,925 unpacking tar archive at: fx-team-e412b386433b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 14:43:01.133875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 14:43:01.134214) ========= script_repo_revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 14:43:01.134600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 14:43:01.134872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 14:43:01.152272) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-14 14:43:01.152553) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7aSXIIbAYe/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.WlKty2qnrG/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:01 INFO - MultiFileLogger online at 20161014 14:43:01 in /builds/slave/test 14:43:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:43:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:43:01 INFO - {'append_to_log': False, 14:43:01 INFO - 'base_work_dir': '/builds/slave/test', 14:43:01 INFO - 'blob_upload_branch': 'Fx-Team', 14:43:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:43:01 INFO - 'branch': 'Fx-Team', 14:43:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:43:01 INFO - 'config_files': ('talos/mac_config.py',), 14:43:01 INFO - 'default_actions': ('clobber', 14:43:01 INFO - 'read-buildbot-config', 14:43:01 INFO - 'download-and-extract', 14:43:01 INFO - 'populate-webroot', 14:43:01 INFO - 'create-virtualenv', 14:43:01 INFO - 'install', 14:43:01 INFO - 'run-tests'), 14:43:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:43:01 INFO - 'download_minidump_stackwalk': True, 14:43:01 INFO - 'download_symbols': 'ondemand', 14:43:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:43:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:43:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:43:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:43:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:43:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:43:01 INFO - 'installer_path': 'installer.exe', 14:43:01 INFO - 'log_level': 'info', 14:43:01 INFO - 'log_name': 'talos', 14:43:01 INFO - 'log_to_console': True, 14:43:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:43:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:43:01 INFO - 'opt_config_files': (), 14:43:01 INFO - 'pip_index': False, 14:43:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:43:01 INFO - 'cmd': ('bash', 14:43:01 INFO - '-c', 14:43:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:43:01 INFO - 'enabled': True, 14:43:01 INFO - 'halt_on_failure': False, 14:43:01 INFO - 'name': 'check_screen_resolution'},), 14:43:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:43:01 INFO - 'cmd': ('bash', 14:43:01 INFO - '-c', 14:43:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:43:01 INFO - 'enabled': True, 14:43:01 INFO - 'halt_on_failure': False, 14:43:01 INFO - 'name': 'check_screen_resolution'},), 14:43:01 INFO - 'run_cmd_checks_enabled': True, 14:43:01 INFO - 'sps_profile': False, 14:43:01 INFO - 'sps_profile_interval': 0, 14:43:01 INFO - 'suite': 'dromaeojs', 14:43:01 INFO - 'system_bits': '32', 14:43:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:43:01 INFO - 'title': 't-yosemite-r7-0241', 14:43:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:43:01 INFO - 'use_talos_json': True, 14:43:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:43:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:43:01 INFO - 'work_dir': 'build'} 14:43:01 INFO - [mozharness: 2016-10-14 21:43:01.351968Z] Running clobber step. 14:43:01 INFO - Running pre-action listener: _resource_record_pre_action 14:43:01 INFO - Running main action method: clobber 14:43:01 INFO - rmtree: /builds/slave/test/build 14:43:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:43:03 INFO - Running post-action listener: _resource_record_post_action 14:43:03 INFO - [mozharness: 2016-10-14 21:43:03.516224Z] Finished clobber step (success) 14:43:03 INFO - [mozharness: 2016-10-14 21:43:03.516351Z] Running read-buildbot-config step. 14:43:03 INFO - Running pre-action listener: _resource_record_pre_action 14:43:03 INFO - Running main action method: read_buildbot_config 14:43:03 INFO - Using buildbot properties: 14:43:03 INFO - { 14:43:03 INFO - "project": "", 14:43:03 INFO - "product": "firefox", 14:43:03 INFO - "script_repo_revision": "production", 14:43:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:43:03 INFO - "repository": "", 14:43:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:43:03 INFO - "buildid": "20161014113435", 14:43:03 INFO - "pgo_build": "False", 14:43:03 INFO - "basedir": "/builds/slave/test", 14:43:03 INFO - "buildnumber": 6, 14:43:03 INFO - "slavename": "t-yosemite-r7-0241", 14:43:03 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:43:03 INFO - "platform": "yosemite_r7", 14:43:03 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:43:03 INFO - "branch": "fx-team", 14:43:03 INFO - "repo_path": "integration/fx-team", 14:43:03 INFO - "revision": "e412b386433b8c8ba83a28a1df310d9ad0b20285", 14:43:03 INFO - "stage_platform": "macosx64", 14:43:03 INFO - "builduid": "75916f184960469db5485af04577c845", 14:43:03 INFO - "slavebuilddir": "test" 14:43:03 INFO - } 14:43:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:43:03 INFO - Running post-action listener: _resource_record_post_action 14:43:03 INFO - [mozharness: 2016-10-14 21:43:03.519511Z] Finished read-buildbot-config step (success) 14:43:03 INFO - [mozharness: 2016-10-14 21:43:03.519616Z] Running download-and-extract step. 14:43:03 INFO - Running pre-action listener: _resource_record_pre_action 14:43:03 INFO - Running main action method: download_and_extract 14:43:03 INFO - mkdir: /builds/slave/test/build/tests 14:43:03 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')]} 14:43:03 INFO - trying https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:43:03 INFO - Downloading https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:43:04 INFO - Downloaded 1199 bytes. 14:43:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:43:04 INFO - Using the following test package requirements: 14:43:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:43:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:43:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:43:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'jsshell-mac.zip'], 14:43:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:43:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:43:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:43:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:43:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:43:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:43:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:43:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:43:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:43:04 INFO - Fetch https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:43:05 INFO - Http code: 200 14:43:05 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 14:43:05 INFO - x-amz-cf-id: RM0BMynZHJL1fb6LU-hFfRw-Jtaig8r8iydV0MGJN4HfuzuAlN19uw== 14:43:05 INFO - x-amz-version-id: h5Snv4xcH1aJMhl7BCFWvSuEfLqR.Zs3 14:43:05 INFO - Expected file size: 16516949 14:43:05 INFO - Obtained file size: 16516949 14:43:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:43:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:43:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:43:12 INFO - Fetch https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:43:13 INFO - Http code: 200 14:43:13 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:43:13 INFO - x-amz-cf-id: k7ngJNJLaubsJrGdtBnffXAOVj_4L0KpotNfgNv-AOOyMxJddtuQ7Q== 14:43:13 INFO - x-amz-version-id: h5Snv4xcH1aJMhl7BCFWvSuEfLqR.Zs3 14:43:13 INFO - Expected file size: 16516949 14:43:13 INFO - Obtained file size: 16516949 14:43:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:43:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:43:19 INFO - Fetch https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:43:20 INFO - Http code: 200 14:43:20 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 14:43:20 INFO - x-amz-cf-id: dU23-I0PE0MzEJNhi2IJoBHrlGCJRfzjVxqI9DlaI9hRjpkQWQnFTg== 14:43:20 INFO - x-amz-version-id: gQg885wke6I6oJxK8TovlYZqRf9.Ggyx 14:43:21 INFO - Expected file size: 14409006 14:43:21 INFO - Obtained file size: 14409006 14:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:21 INFO - trying https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:43:21 INFO - Downloading https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:43:24 INFO - Downloaded 111919021 bytes. 14:43:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:43:24 INFO - mkdir: /builds/slave/test/properties 14:43:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:43:24 INFO - Writing to file /builds/slave/test/properties/build_url 14:43:24 INFO - Contents: 14:43:24 INFO - build_url:https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:43:24 INFO - Running post-action listener: _resource_record_post_action 14:43:24 INFO - Running post-action listener: set_extra_try_arguments 14:43:24 INFO - [mozharness: 2016-10-14 21:43:24.783418Z] Finished download-and-extract step (success) 14:43:24 INFO - [mozharness: 2016-10-14 21:43:24.783541Z] Running populate-webroot step. 14:43:24 INFO - Running pre-action listener: _resource_record_pre_action 14:43:24 INFO - Running main action method: populate_webroot 14:43:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:43:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:43:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:43:24 INFO - '--tppagecycles', 14:43:24 INFO - '7'], 14:43:24 INFO - 'tests': ['tsvgm']}}, 14:43:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:43:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:43:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:43:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:43:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['damp', 'tps']}, 14:43:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'tests': ['damp', 'tps']}, 14:43:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['dromaeo_dom']}, 14:43:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:43:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['basic_compositor_video']}, 14:43:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:43:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['a11yr', 14:43:24 INFO - 'ts_paint', 14:43:24 INFO - 'tpaint', 14:43:24 INFO - 'sessionrestore', 14:43:24 INFO - 'sessionrestore_no_auto_restore', 14:43:24 INFO - 'tabpaint']}, 14:43:24 INFO - 'other-e10s': {'tests': ['a11yr', 14:43:24 INFO - 'ts_paint', 14:43:24 INFO - 'tpaint', 14:43:24 INFO - 'sessionrestore', 14:43:24 INFO - 'sessionrestore_no_auto_restore', 14:43:24 INFO - 'tabpaint']}, 14:43:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:43:24 INFO - 'ts_paint', 14:43:24 INFO - 'tpaint', 14:43:24 INFO - 'sessionrestore', 14:43:24 INFO - 'sessionrestore_no_auto_restore', 14:43:24 INFO - 'tabpaint']}, 14:43:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:43:24 INFO - 'ts_paint', 14:43:24 INFO - 'tpaint', 14:43:24 INFO - 'sessionrestore', 14:43:24 INFO - 'sessionrestore_no_auto_restore', 14:43:24 INFO - 'tabpaint']}, 14:43:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['a11yr', 14:43:24 INFO - 'ts_paint', 14:43:24 INFO - 'tpaint', 14:43:24 INFO - 'sessionrestore', 14:43:24 INFO - 'sessionrestore_no_auto_restore', 14:43:24 INFO - 'tabpaint']}, 14:43:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['a11yr', 14:43:24 INFO - 'ts_paint', 14:43:24 INFO - 'tpaint', 14:43:24 INFO - 'sessionrestore', 14:43:24 INFO - 'sessionrestore_no_auto_restore', 14:43:24 INFO - 'tabpaint']}, 14:43:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['tsvgx', 14:43:24 INFO - 'tsvgr_opacity', 14:43:24 INFO - 'tart', 14:43:24 INFO - 'tscrollx', 14:43:24 INFO - 'cart']}, 14:43:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:43:24 INFO - 'tsvgr_opacity', 14:43:24 INFO - 'tart', 14:43:24 INFO - 'tscrollx', 14:43:24 INFO - 'cart']}, 14:43:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'talos_options': ['--disable-e10s'], 14:43:24 INFO - 'tests': ['tp5o']}, 14:43:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'tests': ['tp5o']}, 14:43:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'talos_options': ['--disable-e10s', 14:43:24 INFO - '--xperf_path', 14:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:24 INFO - 'tests': ['tp5n']}, 14:43:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:24 INFO - 'talos_options': ['--xperf_path', 14:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:24 INFO - 'tests': ['tp5n']}}, 14:43:24 INFO - 'talos.zip': {'path': '', 14:43:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:43:24 INFO - Running post-action listener: _resource_record_post_action 14:43:24 INFO - [mozharness: 2016-10-14 21:43:24.802022Z] Finished populate-webroot step (success) 14:43:24 INFO - [mozharness: 2016-10-14 21:43:24.802154Z] Running create-virtualenv step. 14:43:24 INFO - Running pre-action listener: _resource_record_pre_action 14:43:24 INFO - Running main action method: create_virtualenv 14:43:24 INFO - Creating virtualenv /builds/slave/test/build/venv 14:43:24 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 14:43:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:43:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:43:24 INFO - Using real prefix '/tools/python27' 14:43:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:43:25 INFO - Installing distribute.............................................................................................................................................................................................done. 14:43:28 INFO - Installing pip.................done. 14:43:28 INFO - Return code: 0 14:43:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:43:28 INFO - Reading from file tmpfile_stdout 14:43:28 INFO - Output received: 14:43:28 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) 14:43:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:43:28 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')]} 14:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:28 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')]} 14:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:28 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:28 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 14:43:28 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 14:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:28 INFO - 'HOME': '/Users/cltbld', 14:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:28 INFO - 'LOGNAME': 'cltbld', 14:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:28 INFO - 'MOZ_NO_REMOTE': '1', 14:43:28 INFO - 'NO_EM_RESTART': '1', 14:43:28 INFO - 'PAGER': '/bin/cat', 14:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:28 INFO - 'PWD': '/builds/slave/test', 14:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:28 INFO - 'SHELL': '/bin/bash', 14:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:28 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:28 INFO - 'USER': 'cltbld', 14:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:28 INFO - 'XPC_FLAGS': '0x0', 14:43:28 INFO - 'XPC_SERVICE_NAME': '0', 14:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:29 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 14:43:29 INFO - Cleaning up... 14:43:29 INFO - Return code: 0 14:43:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:29 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:29 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 14:43:29 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 14:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:29 INFO - 'HOME': '/Users/cltbld', 14:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:29 INFO - 'LOGNAME': 'cltbld', 14:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:29 INFO - 'MOZ_NO_REMOTE': '1', 14:43:29 INFO - 'NO_EM_RESTART': '1', 14:43:29 INFO - 'PAGER': '/bin/cat', 14:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:29 INFO - 'PWD': '/builds/slave/test', 14:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:29 INFO - 'SHELL': '/bin/bash', 14:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:29 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:29 INFO - 'USER': 'cltbld', 14:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:29 INFO - 'XPC_FLAGS': '0x0', 14:43:29 INFO - 'XPC_SERVICE_NAME': '0', 14:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:29 INFO - Downloading/unpacking psutil>=3.1.1 14:43:29 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 14:43:29 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 14:43:29 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 14:43:29 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 14:43:29 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 14:43:29 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 14:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:43:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:32 INFO - Installing collected packages: psutil 14:43:32 INFO - Running setup.py install for psutil 14:43:32 INFO - building 'psutil._psutil_osx' extension 14:43:32 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 14:43:33 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 14:43:33 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 14:43:33 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 14:43:33 INFO - building 'psutil._psutil_posix' extension 14:43:33 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 14:43:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:43:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:43:33 INFO - ^ 14:43:33 INFO - 1 warning generated. 14:43:33 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 14:43:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:33 INFO - Successfully installed psutil 14:43:33 INFO - Cleaning up... 14:43:33 INFO - Return code: 0 14:43:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:43:33 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')]} 14:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:33 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')]} 14:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:33 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:33 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 14:43:33 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 14:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:33 INFO - 'HOME': '/Users/cltbld', 14:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:33 INFO - 'LOGNAME': 'cltbld', 14:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:33 INFO - 'MOZ_NO_REMOTE': '1', 14:43:33 INFO - 'NO_EM_RESTART': '1', 14:43:33 INFO - 'PAGER': '/bin/cat', 14:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:33 INFO - 'PWD': '/builds/slave/test', 14:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:33 INFO - 'SHELL': '/bin/bash', 14:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:33 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:33 INFO - 'USER': 'cltbld', 14:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:33 INFO - 'XPC_FLAGS': '0x0', 14:43:33 INFO - 'XPC_SERVICE_NAME': '0', 14:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:43:36 INFO - Installing collected packages: mozsystemmonitor 14:43:36 INFO - Running setup.py install for mozsystemmonitor 14:43:36 INFO - Successfully installed mozsystemmonitor 14:43:36 INFO - Cleaning up... 14:43:36 INFO - Return code: 0 14:43:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:43:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:37 INFO - 'HOME': '/Users/cltbld', 14:43:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:37 INFO - 'LOGNAME': 'cltbld', 14:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:37 INFO - 'MOZ_NO_REMOTE': '1', 14:43:37 INFO - 'NO_EM_RESTART': '1', 14:43:37 INFO - 'PAGER': '/bin/cat', 14:43:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:37 INFO - 'PWD': '/builds/slave/test', 14:43:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:37 INFO - 'SHELL': '/bin/bash', 14:43:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:37 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:37 INFO - 'USER': 'cltbld', 14:43:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:37 INFO - 'XPC_FLAGS': '0x0', 14:43:37 INFO - 'XPC_SERVICE_NAME': '0', 14:43:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:37 INFO - Downloading/unpacking jsonschema==2.5.1 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:43:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:43:40 INFO - warning: no files found matching '*.txt' 14:43:40 INFO - no previously-included directories found matching 'build' 14:43:40 INFO - no previously-included directories found matching 'dist' 14:43:40 INFO - no previously-included directories found matching '.git*' 14:43:40 INFO - Installing collected packages: jsonschema, functools32 14:43:40 INFO - Running setup.py install for functools32 14:43:40 INFO - warning: no files found matching '*.txt' 14:43:40 INFO - no previously-included directories found matching 'build' 14:43:40 INFO - no previously-included directories found matching 'dist' 14:43:40 INFO - no previously-included directories found matching '.git*' 14:43:40 INFO - Successfully installed jsonschema functools32 14:43:40 INFO - Cleaning up... 14:43:40 INFO - Return code: 0 14:43:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:40 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:40 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 14:43:40 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 14:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:40 INFO - 'HOME': '/Users/cltbld', 14:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:40 INFO - 'LOGNAME': 'cltbld', 14:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:40 INFO - 'MOZ_NO_REMOTE': '1', 14:43:40 INFO - 'NO_EM_RESTART': '1', 14:43:40 INFO - 'PAGER': '/bin/cat', 14:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:40 INFO - 'PWD': '/builds/slave/test', 14:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:40 INFO - 'SHELL': '/bin/bash', 14:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:40 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:40 INFO - 'USER': 'cltbld', 14:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:40 INFO - 'XPC_FLAGS': '0x0', 14:43:40 INFO - 'XPC_SERVICE_NAME': '0', 14:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:43:40 INFO - Cleaning up... 14:43:40 INFO - Return code: 0 14:43:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:40 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:40 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 14:43:40 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 14:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:40 INFO - 'HOME': '/Users/cltbld', 14:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:40 INFO - 'LOGNAME': 'cltbld', 14:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:40 INFO - 'MOZ_NO_REMOTE': '1', 14:43:40 INFO - 'NO_EM_RESTART': '1', 14:43:40 INFO - 'PAGER': '/bin/cat', 14:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:40 INFO - 'PWD': '/builds/slave/test', 14:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:40 INFO - 'SHELL': '/bin/bash', 14:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:40 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:40 INFO - 'USER': 'cltbld', 14:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:40 INFO - 'XPC_FLAGS': '0x0', 14:43:40 INFO - 'XPC_SERVICE_NAME': '0', 14:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:40 INFO - Downloading/unpacking blobuploader==1.2.4 14:43:40 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 14:43:40 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 14:43:40 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 14:43:40 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 14:43:40 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 14:43:40 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 14:43:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:43:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:43:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:43:44 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 14:43:44 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 14:43:44 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 14:43:44 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 14:43:44 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 14:43:44 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 14:43:44 INFO - Downloading docopt-0.6.1.tar.gz 14:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:43:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:43:44 INFO - Running setup.py install for blobuploader 14:43:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:43:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:43:45 INFO - Running setup.py install for requests 14:43:45 INFO - Running setup.py install for docopt 14:43:45 INFO - Successfully installed blobuploader requests docopt 14:43:45 INFO - Cleaning up... 14:43:45 INFO - Return code: 0 14:43:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:45 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:45 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 14:43:45 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 14:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:45 INFO - 'HOME': '/Users/cltbld', 14:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:45 INFO - 'LOGNAME': 'cltbld', 14:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:45 INFO - 'MOZ_NO_REMOTE': '1', 14:43:45 INFO - 'NO_EM_RESTART': '1', 14:43:45 INFO - 'PAGER': '/bin/cat', 14:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:45 INFO - 'PWD': '/builds/slave/test', 14:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:45 INFO - 'SHELL': '/bin/bash', 14:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:45 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:45 INFO - 'USER': 'cltbld', 14:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:45 INFO - 'XPC_FLAGS': '0x0', 14:43:45 INFO - 'XPC_SERVICE_NAME': '0', 14:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-4pHVoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-6cwGJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-TNDp64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-7l9jBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-iZNoJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ldazH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-yU4B3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-JFladY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pSUsNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-UP7viJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pXyZmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-yRxYiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-6cP6Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-6CsspR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-3TDJGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-FUywvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pzkR7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:43:47 INFO - Running setup.py install for manifestparser 14:43:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:43:47 INFO - Running setup.py install for mozcrash 14:43:48 INFO - Running setup.py install for mozdebug 14:43:48 INFO - Running setup.py install for mozdevice 14:43:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Running setup.py install for mozfile 14:43:48 INFO - Running setup.py install for mozhttpd 14:43:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Running setup.py install for mozinfo 14:43:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Running setup.py install for mozInstall 14:43:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:43:48 INFO - Running setup.py install for mozleak 14:43:49 INFO - Running setup.py install for mozlog 14:43:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:43:49 INFO - Running setup.py install for moznetwork 14:43:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:43:49 INFO - Running setup.py install for mozprocess 14:43:49 INFO - Running setup.py install for mozprofile 14:43:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:43:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:43:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:43:49 INFO - Running setup.py install for mozrunner 14:43:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:43:49 INFO - Running setup.py install for mozscreenshot 14:43:50 INFO - Running setup.py install for moztest 14:43:50 INFO - Running setup.py install for mozversion 14:43:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:43:50 INFO - Cleaning up... 14:43:50 INFO - Return code: 0 14:43:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:50 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:50 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 14:43:50 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 14:43:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:50 INFO - 'HOME': '/Users/cltbld', 14:43:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:50 INFO - 'LOGNAME': 'cltbld', 14:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:50 INFO - 'MOZ_NO_REMOTE': '1', 14:43:50 INFO - 'NO_EM_RESTART': '1', 14:43:50 INFO - 'PAGER': '/bin/cat', 14:43:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:50 INFO - 'PWD': '/builds/slave/test', 14:43:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:50 INFO - 'SHELL': '/bin/bash', 14:43:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:50 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:50 INFO - 'USER': 'cltbld', 14:43:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:50 INFO - 'XPC_FLAGS': '0x0', 14:43:50 INFO - 'XPC_SERVICE_NAME': '0', 14:43:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-eIlww4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:50 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)) 14:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Fj8qib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-iYlxIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:50 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)) 14:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pKtdDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-MMQ4vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-NUIC3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-AVGXV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-hTTwfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-bw70Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-0ZvCiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-SS7k3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-cId1pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:51 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)) 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-LViWJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:52 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)) 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-gWXAPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-G7dbkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:52 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)) 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-78OXrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-MdPvLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:52 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)) 14:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:43:52 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)) 14:43:52 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)) 14:43:52 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)) 14:43:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:54 INFO - Downloading blessings-1.6.tar.gz 14:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:43:55 INFO - Installing collected packages: blessings 14:43:55 INFO - Running setup.py install for blessings 14:43:55 INFO - Successfully installed blessings 14:43:55 INFO - Cleaning up... 14:43:55 INFO - Return code: 0 14:43:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:55 INFO - Reading from file tmpfile_stdout 14:43:55 INFO - Current package versions: 14:43:55 INFO - blessings == 1.6 14:43:55 INFO - blobuploader == 1.2.4 14:43:55 INFO - docopt == 0.6.1 14:43:55 INFO - functools32 == 3.2.3-2 14:43:55 INFO - jsonschema == 2.5.1 14:43:55 INFO - manifestparser == 1.1 14:43:55 INFO - mozInstall == 1.12 14:43:55 INFO - mozcrash == 0.17 14:43:55 INFO - mozdebug == 0.1 14:43:55 INFO - mozdevice == 0.48 14:43:55 INFO - mozfile == 1.2 14:43:55 INFO - mozhttpd == 0.7 14:43:55 INFO - mozinfo == 0.9 14:43:55 INFO - mozleak == 0.1 14:43:55 INFO - mozlog == 3.4 14:43:55 INFO - moznetwork == 0.27 14:43:55 INFO - mozprocess == 0.23 14:43:55 INFO - mozprofile == 0.28 14:43:55 INFO - mozrunner == 6.12 14:43:55 INFO - mozscreenshot == 0.1 14:43:55 INFO - mozsystemmonitor == 0.3 14:43:55 INFO - moztest == 0.7 14:43:55 INFO - mozversion == 1.4 14:43:55 INFO - psutil == 3.1.1 14:43:55 INFO - requests == 1.2.3 14:43:55 INFO - wsgiref == 0.1.2 14:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 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 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:55 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 14:43:55 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 14:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:55 INFO - 'HOME': '/Users/cltbld', 14:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:55 INFO - 'LOGNAME': 'cltbld', 14:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:55 INFO - 'MOZ_NO_REMOTE': '1', 14:43:55 INFO - 'NO_EM_RESTART': '1', 14:43:55 INFO - 'PAGER': '/bin/cat', 14:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:55 INFO - 'PWD': '/builds/slave/test', 14:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:55 INFO - 'SHELL': '/bin/bash', 14:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:55 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:55 INFO - 'USER': 'cltbld', 14:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:55 INFO - 'XPC_FLAGS': '0x0', 14:43:55 INFO - 'XPC_SERVICE_NAME': '0', 14:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 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)) 14:43:55 INFO - Cleaning up... 14:43:55 INFO - Return code: 0 14:43:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5a57e6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, '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.7aSXIIbAYe/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.WlKty2qnrG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 14:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:55 INFO - 'HOME': '/Users/cltbld', 14:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:55 INFO - 'LOGNAME': 'cltbld', 14:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:55 INFO - 'MOZ_NO_REMOTE': '1', 14:43:55 INFO - 'NO_EM_RESTART': '1', 14:43:55 INFO - 'PAGER': '/bin/cat', 14:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:55 INFO - 'PWD': '/builds/slave/test', 14:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:55 INFO - 'SHELL': '/bin/bash', 14:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:43:55 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:55 INFO - 'USER': 'cltbld', 14:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:55 INFO - 'XPC_FLAGS': '0x0', 14:43:55 INFO - 'XPC_SERVICE_NAME': '0', 14:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:43:56 INFO - Cleaning up... 14:43:56 INFO - Return code: 0 14:43:56 INFO - Running post-action listener: _resource_record_post_action 14:43:56 INFO - Running post-action listener: _start_resource_monitoring 14:43:56 INFO - Starting resource monitoring. 14:43:56 INFO - [mozharness: 2016-10-14 21:43:56.126733Z] Finished create-virtualenv step (success) 14:43:56 INFO - [mozharness: 2016-10-14 21:43:56.127718Z] Running install step. 14:43:56 INFO - Running pre-action listener: _resource_record_pre_action 14:43:56 INFO - Running main action method: install 14:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:56 INFO - Reading from file tmpfile_stdout 14:43:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:43:56 INFO - Reading from file tmpfile_stdout 14:43:56 INFO - Output received: 14:43:56 INFO - Usage: mozinstall [options] installer 14:43:56 INFO - Options: 14:43:56 INFO - -h, --help show this help message and exit 14:43:56 INFO - -d DEST, --destination=DEST 14:43:56 INFO - Directory to install application into. [default: 14:43:56 INFO - "/builds/slave/test"] 14:43:56 INFO - --app=APP Application being installed. [default: firefox] 14:43:56 INFO - mkdir: /builds/slave/test/build/application 14:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:44:31 INFO - Reading from file tmpfile_stdout 14:44:31 INFO - Output received: 14:44:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:44:31 INFO - Running post-action listener: _resource_record_post_action 14:44:31 INFO - [mozharness: 2016-10-14 21:44:31.255804Z] Finished install step (success) 14:44:31 INFO - [mozharness: 2016-10-14 21:44:31.255926Z] Running run-tests step. 14:44:31 INFO - Running pre-action listener: _resource_record_pre_action 14:44:31 INFO - Running main action method: run_tests 14:44:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:31 INFO - 2016-10-14 14:44:31.268 screenresolution[1639:7442] starting screenresolution argv=screenresolution get 14:44:31 INFO - 2016-10-14 14:44:31.270 screenresolution[1639:7442] Display 0: 1600x1200x32@60 14:44:31 INFO - 2016-10-14 14:44:31.275 screenresolution[1640:7444] starting screenresolution argv=screenresolution list 14:44:31 INFO - Available Modes on Display 0 14:44:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:31 INFO - Intel Iris: 14:44:31 INFO - Chipset Model: Intel Iris 14:44:31 INFO - Type: GPU 14:44:31 INFO - Bus: Built-In 14:44:31 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:31 INFO - Vendor: Intel (0x8086) 14:44:31 INFO - Device ID: 0x0a2e 14:44:31 INFO - Revision ID: 0x0009 14:44:31 INFO - Displays: 14:44:31 INFO - Display: 14:44:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:31 INFO - Display Serial Number: 1600x1200 60 14:44:31 INFO - Main Display: Yes 14:44:31 INFO - Mirror: Off 14:44:31 INFO - Online: Yes 14:44:31 INFO - Rotation: Supported 14:44:31 INFO - Return code: 0 14:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:44:31 INFO - Python 2.7.3 14:44:31 INFO - Return code: 0 14:44:31 INFO - grabbing minidump binary from tooltool 14:44: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')]} 14:44:31 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 0x10d9c0d30>, '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 0x10d7e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:44:31 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 14:44:31 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 14:44:31 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 14:44:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:44:31 INFO - Return code: 0 14:44:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:44:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:44:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:44:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:44:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 14:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0241 --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 14:44:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aSXIIbAYe/Render', 14:44:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:31 INFO - 'HOME': '/Users/cltbld', 14:44:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:31 INFO - 'LOGNAME': 'cltbld', 14:44:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:44:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:31 INFO - 'MOZ_NO_REMOTE': '1', 14:44:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:44:31 INFO - 'NO_EM_RESTART': '1', 14:44:31 INFO - 'PAGER': '/bin/cat', 14:44:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:31 INFO - 'PWD': '/builds/slave/test', 14:44:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:44:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:31 INFO - 'SHELL': '/bin/bash', 14:44:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WlKty2qnrG/Listeners', 14:44:31 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 14:44:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:31 INFO - 'USER': 'cltbld', 14:44:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:31 INFO - 'XPC_FLAGS': '0x0', 14:44:31 INFO - 'XPC_SERVICE_NAME': '0', 14:44:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 14:44:31 INFO - mozversion application_buildid: 20161014113435 14:44:31 INFO - mozversion application_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 14:44:31 INFO - mozversion application_display_name: Nightly 14:44:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:44:31 INFO - mozversion application_name: Firefox 14:44:31 INFO - mozversion application_remotingname: firefox 14:44:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:44:31 INFO - mozversion application_vendor: Mozilla 14:44:31 INFO - mozversion application_version: 52.0a1 14:44:31 INFO - mozversion platform_buildid: 20161014113435 14:44:31 INFO - mozversion platform_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 14:44:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:44:31 INFO - mozversion platform_version: 52.0a1 14:44:31 INFO - using testdate: 1476481471 14:44:31 INFO - actual date: 1476481471 14:44:31 INFO - starting webserver on 'localhost:49271' 14:44:31 INFO - SUITE-START | Running 2 tests 14:44:31 INFO - TEST-START | dromaeo_css 14:44:31 INFO - operating with platform_type : mac_ 14:44:31 INFO - Initialising browser for dromaeo_css test... 14:44:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpiZRUqo/profile http://localhost:49271/getInfo.html) 14:44:34 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 14:44:34 INFO - PROCESS | 1650 | colorDepth:24 14:44:34 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 14:44:34 INFO - PROCESS | 1650 | __metrics 14:44:34 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:44:34 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:44:35 INFO - TEST-INFO | 1650: exit 0 14:44:35 INFO - Browser initialized. 14:44:35 INFO - Running cycle 1/1 for dromaeo_css test... 14:44:35 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpiZRUqo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:47 INFO - PROCESS | 1652 | RSS: Main: 231706624 14:44:47 INFO - PROCESS | 1652 | 14:45:38 INFO - PROCESS | 1652 | 1476481538487 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:47:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 14:47:53 INFO - PROCESS | 1652 | RSS: Main: 361766912 14:47:53 INFO - PROCESS | 1652 | 14:50:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 14:50:57 INFO - PROCESS | 1652 | RSS: Main: 369881088 14:50:57 INFO - PROCESS | 1652 | 14:54:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 14:54:00 INFO - PROCESS | 1652 | RSS: Main: 359563264 14:54:00 INFO - PROCESS | 1652 | 14:57:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 14:57:03 INFO - PROCESS | 1652 | RSS: Main: 330547200 14:57:03 INFO - PROCESS | 1652 | 15:00:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 15:00:07 INFO - PROCESS | 1652 | RSS: Main: 324968448 15:00:07 INFO - PROCESS | 1652 | 15:03:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 15:03:10 INFO - PROCESS | 1652 | RSS: Main: 487727104 15:03:10 INFO - PROCESS | 1652 | 15:03:10 INFO - PROCESS | 1652 | __start_tp_report 15:03:10 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 15:03:10 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 15:03:10 INFO - PROCESS | 1652 | |i|pagename|runs| 15:03:10 INFO - PROCESS | 1652 | |0;dojo.html;2915.7375836174747;3333.0334203081106;3345.481450375192;3371.32573485303;3394.3381040697072;5565.41563135871;5627.6904770237625;5672.120821272704;5674.801381951633;5691.971540142299;5625.156226566007;5644.858878528039;5756.453136951994;5776.989026920293;5786.913196302048;4817.90364192716;5065.594752419816;5147.691138531682;5169.896602067956;5211.166213405856;4845.612351011928;5277.102892508283;5296;5298.947010529884;5340.305760251182;5255.05409026377;5275.366955965271;5283.973580132113;5299.708516031616;5361.303030606015;5073.213651883964;5121.718305493197;5163.5352818246165;5173.63784535079;5186.7147306898105;5111.309973153651;5132.461091585367;5147.794088236466;5182.274481572583;5191.454897235812;5634.6337488063145;5671.234383358235;5674.2623458950075;5679.914801277984;5762.711864406805;6034.24571928509;6077.24034495688;6117.541184411142;6167.54140686136;6224.37756224374;4630.675852690313;6168.136460895478;6266.310705822356;6271.404216599416;6323.20959880015;5723.799667011676;5727.169560413717;5730.484256416942;5735.885282294331;5790.623609465456;6140.6929653517145;6231.189945307172;6297.685115744194;6321.494280457552;6326.557141000086;6010.3088144863905;6019.247594050744;6060.2424696912885;6060.545459090586;6125.693326622233;6218.875622487615;6232.781852635136;6232.844178895564;6237.1891654084675;6253.062040693932;6105.725242364104;6111.96944015277;6153.2000839891425;6189.442950134419;6207.937920620736;6081.239845019372;6104.420065188057;6125.907024958055;6169.691515424211;6170.5372097092895;4186.623203911662;4911.901761964741;4946.802127914915;4980.427250866197;4992.400911890596;4399.318105693623;4401.22978478765;4401.965538098544;4408.316710909814;4434.5343738907595;5710.914336284959;5778.595498315078;5793.768249270066;5811.360750317462;5812.912806307909;6110.163888792202;6189.195404597373;6195.690215489208;6206.472449841724;6241.687915604292;5831.9708401458565;5833.38749431312;5841.299044114733;5853.239078919713;5874.942510348093;5421.593380496479;5429.457054294539;5437.728113594305;5441.075017247077;5451.6728996261145;6211.65835879031;6232.626042437287;6240;6267;6296.748130074746;5454.781808727606;6116;6208.689565521796;6309.589876658002;6315.242170939517;6221.4683064335795;6250.937490625218;6263.592866463665;6280.434760871361;6288.842778930563;6072;6098.038923863867;6164.969175154096;6217.4715149212825;6236.18929539157;6200.286966998853;6201.193844800147;6246.250449946036;6304.369563043842;6322.905156422749;6094.39056094387;6158.7228574715145;6162.352952939877;6166.81499555014;6188.133661287513;5263.947210557827;5895.322037965689;5912.911306330322;5980.491658209101;6149.907751383644;5837.270341207349;5868.38381969887;5930.555208359304;5948.315943666361;6027.276726792637;6110.480609148272;6121.143039974496;6127.264728232641;6134.04922237054;6138.508919286357;5770.365259821332;5818.0981947798155;5831.854203644773;5897.439743224387;5917.556183286185 15:03:10 INFO - PROCESS | 1652 | |1;ext.html;476.852175825494;487.3274880664682;492.19526074867593;493.38327091136057;500.78466259508394;22731.772682273193;30459;40061.99845003873;40850.38724419136;40962.180756384856;33613.83193084037;39839.40240896389;41338.58661413385;41477.37783933243;41685.58314416855;9306.441613503195;9477.715668529956;9483.715488535356;9494.240460763156;9499.097585729345;8536.487810731345;8743.519106449143;9335.719928402159;11537.884621153808;11564.306141631487;11293.265937714063;11384.772304553904;11392.601258955938;11419.942900285487;11560.942195289012;8539.530325832076;11305.660830175108;11375.601853935073;11377.1467139964;11378.431078446045;8485.915140848574;11279.774404511863;11562.53749850005;11571.974904391782;11572.264160375928;39533;39873.202535949116;39919.60080399188;39945.400818987735;39985.600143998476;3388.9322213555592;3390.4744764561533;3429.777064490825;3453.637368076341;3722.3113723961155;30048.849755751082;31103;31122.688773112204;31239.531407028913;31422.842885785652;3008.39832033592;3060.9540856887165;3149.4173577887937;3192.584963954671;3251.869925202989;459228;461026;461626;464302;471816.6409167932;61177.694111529156;61343;61632;61789.073163902576;61812.381876181564;64929;65063;65104.67447662731;65110.67444662746;65157;14437.494687685881;16065.277062532214;16645.6670866582;16699.165041747863;16703.749443758352;11389.886101138882;11610;12646.241225526497;12684.936575317064;12726.872731272753;16330.67338653244;19172.71240931387;19177.232910683415;19275.4217373479;19427.90286048589;6720.966395167993;7803.765887023398;7863;7926.8810967835525;7984.600769961478;849.7450764770545;937.4188003437775;962.9277804164716;1008.5864795433837;1022.3011250299216;27538;29776.10671679853;30009;30488.69511304903;30581;972.2756546372856;1035.994820025895;1061.3207547169818;1072.485207100596;1185.7391373897728;14592.343344549521;14893.404263829325;15116.533646478108;15219.619509512351;15462.994905331117;631388.6861131422;633989;635123;635921;636602;56651.71674141685;56845;56862;57003.714981424826;57214.14178787322;1054.3568423261804;1274.1908887856093;1342.1074985134776;1347.2186132043587;1366.6241783509615;29104.27239319034;30485.54271685882;30643.846780765954;30899.691003090582;31131.53302700416;49179.508204917496;49618.50381496139;49769.502304976486;49869.00261994812;50080.749596251786;523823;528853;528901;529566;529606;24984.875075625234;26391.60412593774;26508.469830603666;26938.730612693624;27068.32329191786;46654.53345466502;46917.53082469132;47152.528474716186;47359;47866;30727.539086913268;37874;37998.62001380062;38648.613513865625;38993.83018509449;38172.427413588266;38865.41701874418;39939.80030099831;40051.79974100111;40487.1902561953;36350.09124771902;36676.44985325169;37422.8128859354;37444.25111497809;37613.435798462495;26075.60886586665;32493.512597310586;34282.828585856914;34355.484667729506;34467;24516.50966980686;24578;24797.62803557984;25072.78490446015;25149.24552263435 15:03:10 INFO - PROCESS | 1652 | |2;jquery.html;340.63041599864147;360.92781443711254;363.9763415378;366.78543052314393;389.2293259346494;12155;15628.513270567018;17472.21375038125;20232.797672023276;21624;20174.697379539317;21041.84269865157;21102.261420850275;21352.35942921711;21477.785222147813;5662.801801936933;5967.462928336449;6017.819465416044;6027.156198132265;6032.69836508175;5664.26364572605;5860.853478663025;5994;5996.160537524728;5996.370381109986;6064.666443345636;6072.7874524391655;6079.908801367983;6088.726007329681;6091.025435930252;5844.1818145459665;6023.36754640763;6076.6961651917445;6098.390160983866;6119.2350956130485;5848.5321174305955;5848.561357898175;5857.619254748471;5858.2677165354335;5858.355580886099;12292.323922184276;12403;12709.74580508394;12713.618591442271;12890.484380624765;1907.4754442528415;2137.1771867830844;2149.387424583986;2410.9758902410927;2808.90452723438;9497.810043799085;9958.302918795687;10116.291859569834;10404.68785936423;10541;1862.245790454868;1867.3090956346239;1870.8971006594631;1894.2612381171355;1970.5270735023491;114915.85084149135;115181.42409287984;115437.42281288625;117932.41033794776;118976;11256.943715281535;11427.942860285646;11576.189666723249;11669.708257293636;11693.941530292293;12364.072694547946;13604.727905441836;14481.203533805741;14490.275486225646;14492.565223043326;7389.630518474055;7872.567008814455;7952;8395.70615028471;8470.280026197719;6956.5478243913985;8141.674333026613;8263.95868020656;8271.669133234724;8415.621297041647;3395.6774106459848;3738.869139580156;4504.391907092566;4557.931631025537;4575.794089265991;1546.6597348583293;1805.2591388796316;1814.8911065335858;1884.8020957799508;1948.1817636592666;863.5164307987548;881.1496905486108;895.2345744388584;917.9449233046039;950.2065775077749;20794.48013799637;21516.677249841265;21534.353969380943;21628.891855540936;21652.783472165076;931.5761328595473;940.4592359393239;953.6185525789601;956.7225504603587;957.9425234485954;9801.215902727907;10664;11442.656720298404;11454.770904581861;11489.827652585218;487481.1251887436;490477;569115;585815;587024;75091.24908750952;121992;130747;131448.3427582856;133703.33148334196;968.1238479176357;972.5963725054023;995.8904520502739;995.9004099589984;996.6661168508485;18350.541236469195;19510.512237194183;19576.21695132179;19631.411057668294;19631.60736785285;47377.76311118422;49569.50430495649;50372.992540149724;50739.74630126826;51549.7422512885;76201.23798762163;77330.6133469329;78643;79799.80300295616;79815.80276295744;7963.92036079655;9868.506574671093;10946.616868409887;11551.653450396501;11998.700032499257;9332.95333523328;12980.026498012498;13180.538681146114;13557.525486607921;13567;10699.304545204848;11873.287602743863;11957.162998590014;11962.58130965412;12013.219140755822;11310.491027903929;11546.769064618493;11740.70648233801;11883.102965292986;12052.939735301617;9398.34211605181;10760;11845.822312665488;12059.939700301793;12117.27296362221;10011.24915631316;12229.388530573613;12373.010159187423;12445.688857778629;12501.624951251477;11472.713182170179;11505.654830355103;11924.642260732191;12051.638450846489;12121 15:03:10 INFO - PROCESS | 1652 | |3;mootools.html;1350.5813197908647;1519.1340935666667;1685.6123091688912;1852.2776117314258;1894.7915729269778;6099.664518451489;8668.133186681329;8671.30629549636;8682.782930426734;8687.348448866345;7561.886571701429;7796.259355361246;7830.9216907830905;8194.098649148604;8439.240468357846;2307.3885420363617;2350.9177178798745;2356.8703721295324;2362.751911049341;2363.905443782255;2327.674125622414;2351.1183306260154;2365.44412063165;2378.6194208926577;2380.2978121454125;2330.8368414211013;2334.062727935809;2345.366750977235;2345.472268739537;2378.1319818266293;2319.860808351504;2334.684817549626;2340.414896275931;2342.61346877765;2342.906283748648;2330.97669023311;2331.8950647220745;2334.2880421471446;2340.7710951750296;2347.9882600587057;8558.186972237627;8618.870716939251;8663.306935445149;8704.390692651517;8738.038815730264;4568.2462393705;5082.3138876251605;5249.868753281198;5252.317198764136;5253.343332083489;3340.5991281046186;3441.7934923904395;3553.4492153716214;3565.180008598011;3586.2468881534646;978.7748817771952;984.5864736810485;993.7664648807524;1000.5397517142123;1005.3766664667953;11261.605843795427;11321.20751547392;11326.546938122465;11334.263272887236;11361.488733006952;3868.3423817951016;4496.258117410591;4542.977285113553;4612.377329060534;4704.976475117671;8360.247577718035;9390.5304734763;9586.424814511012;9619.086186812241;9681.70954871355;5228.08508511009;5240.4759524047295;5241.73791310433;5253.264542963988;5260.395054568774;4099;4119.340905455173;4157.8336866525;4824;4835.274708793639;3806.314863324573;3817.84728610858;3904.882853514399;3939.2318497893207;3957.149212919236;1248.494359784289;1254.974900502003;1262.715888925003;1271.2309053022973;1276.5978716704394;827.2885318625977;847.9236868681849;860.0195776814437;918.8897332320164;964.9035096490435;5571.498565129158;5656.61970156347;5811.9709401453565;5875.9118613220835;5953.523718102541;908.1100521488846;920.1580553793204;920.9493477858648;943.1134733350628;981.097390400833;3767.416050512175;3876.9224615507533;3916.6475017248586;4029.6373326400767;4035.1526179502634;9929.801403972024;10461.058504734458;10477.952204779613;10494.527746251437;10510.579576816994;10378.584856605803;10395.896041039645;10406.063454288998;10415.479226038668;10454.738631534272;7479.439042071866;7835.804104897423;7909.762707118795;7920.960395198103;8006.919930800617;5685.715714214355;5836.920169768607;5856.385079566755;5989.760409583742;6044.395560443921;8224.835503289782;8954;9447.905520944703;9654.469004204837;9689.660861869801;9521.761955951157;9790.902090979;9791.510424478605;9861.901380986385;9887.604495820087;6799.558028728117;6826.590404575742;7096.822579435556;7290.927090729237;7486.513376630502;8199.754007379788;8251.216134467217;8298.377621678277;8342.708005219789;8355.41512094172;7334.339909408179;7396.704131834666;7397.112346518452;7456.701731930662;7585.355244804254;6971;7176.7488137914925;7202.171750248788;7242.094738157731;7303.671334790053;6791.7283308669075;6827.863442731217;6918.965405172942;6924.376806087476;6928.341807528277;4419.983403817076;4816.325714399917;4867.9269810952155;4909.803607855789;4983.601311895112;4222.957770422379;4772.976135119302;4791.52084791532;4911.011040528591;4973.900521989613 15:03:11 INFO - PROCESS | 1652 | |4;prototype.html;290.56560442138993;295.4032853635656;304.74293539151;309.2901790391052;310.13472411970605;5027.346444962154;5458.263134476854;5485.478879506445;5490.725463726808;5520.4944860013875;4701.388819453475;4805.90388192236;5134.435212126672;5242.842714718565;5311.442298558644;3418.316336732651;4059.7158198926086;4080.9387859182134;4083.7549747015273;4092.7721683494833;4083.9183216335655;4106.219818234541;4111.342185250361;4120.773357465338;4138.834446622147;3764.6988240940796;3986.4418981342637;4036.7577945323374;4042.151148258869;4053.250148722496;3318.933621327572;3452.7410444216534;3807;3890.085829830002;4019.090931807368;3467.9479807802904;3481.9129521761906;3486.2156014896445;3501.9824900875587;3504.3341765064556;5016.144026710104;5160.483951604847;5233.790648374099;5240.68555886648;5278.865044015555;3827.502424684801;4365.9126817463475;4500.954990450086;4559.544045595414;4624.884377890546;4843.515648435164;5437.9939711153565;5580.162975553659;5581.553475721932;5591.580631452657;3314.850831712579;3732.9532889402326;3783.50814394127;3787.753796003251;3788.7456963106906;5419.672180315809;5670.801521946753;5924.229850119457;5947.9702601486715;5950.732217050243;3164.493681011073;3334.549835772188;3378.3750006248924;3721.7580857244193;3768.792716400624;3305.3389322135667;3312.38720836646;3842.8270727817317;3875.147467557133;3961.8811435656976;3995.400689896481;4379.255526560492;4560.133574620878;4621.792019359137;4625.814967401334;5606.439356064442;5670.659760414388;5682.977064128497;5684.857878552986;5698.544116470673;1029.9330543514648;1301.804729290614;1309.260267948606;1337.157590717861;1341.8322709661293;837.5435387713588;853.8036251662153;857.6697971281102;858.5921687198655;866.0646501778065;3762.811859407019;3802.5550290889287;4263.2307592348825;4314.482262128565;4420.4307470848025;4778;4862.294967229732;4888.608911287089;4935.629827762932;4954.810845397079;4066.6340029397497;4173.1862286854375;4387.824487020547;4680.976595117003;5413.9729301353245;2748.4640495103263;2764.6267753853376;3017.3060196155006;3053.557234201028;3078.7844850860674;4997.925031124536;5290.867728306746;6044.516438684895;6062.696865156725;6138.83362161188;5280.1815718563685;5330.307060082242;5823.563232757476;6017.127516510169;6061.151438798572;5784.508316793035;6042.848928776816;6081.114854395151;6089.69551522431;6097.207363042865;5508.614396992172;5804.477597016289;5830.62100963436;5875.941240587539;5877.147813567094;4788.401449818773;4817.470078291315;5758.3223800932765;5760.510356619734;5784.834918858415;6030.798758453046;6039.396060393926;6057.969710151421;6067.694276175025;6068.575199735976;3379.341028499419;3831.2912111259507;3873.74820636669;3876.1666241758157;3887.222555488857;5828.329742079715;5844.707764611838;5851.385604511465;5858.326292476419;5877.911831322619;5348.545373643128;5706.830099829608;5716.28546431696;5720;5733.31200255972;4466.665000124939;5632.9436705632415;5656.85857853557;5674.304705264966;5680.233168522197;5236.895262094813;5526.806561770319;5535.837474130478;5556.361018482926;5566.805161819317;4923.359963204761;5104.208847628475;5567.359753628222;5583.246261754611;5683.2895888014;4949.529794669501;5191.636585438983;5286.127788914786;5555.555555555465;5558.777648893999 15:03:11 INFO - PROCESS | 1652 | |5;yui.html;715.602840423565;738.501511479751;742.8217227865313;785.9292663660272;810.8054067023916;15095.547133585982;15203.543893683207;15237.84762152378;15273.618159546017;15302.923485382586;14454.638634034129;14540.563783086498;14553;14578.708425831477;14591.635209119777;689.8585789913055;713.2582114600809;715.5420530860254;862.4954401675028;874.4971641306242;715.6314498033516;877.9517126558069;883.4875772052227;895.274827389813;900.6667533012794;958.5399008475936;959.2326139088736;959.5154447004288;960.927930405219;961.0581630002566;952.3714348529937;952.8094381123803;953.5661274120328;953.7234202081388;955.7276176289724;545.7516829842413;560.9074502707049;681.0703389872838;701.2741812224324;706.0151089230546;15062.849371506254;15112.244387780567;15126.546203613909;15129.47046853355;15148.545543633709;13274.535391261259;13586;13761.862381376159;13820.101693389897;13847.792283115661;10095.192384609214;11859.27841743138;12194.634160975185;12209.450574724158;12461.563845265462;4394.209042372372;4437.9112417751785;4445.977770111161;4470.195364834329;4481.865544033684;100978.72128369902;102209.48895255476;102229;102413.4879325606;102564.48717756438;10647.733806654896;10647.787044259227;10767.461626918623;10798.136149108053;10817.945910270399;21017.68473472899;21034.158633654788;21074.894625526773;21117.89441052785;21402.464938376666;7747.147813740484;7752.379809615217;7823.335016523545;7871.606419678993;7915.970923779987;4212.347086201644;4285.442892424027;4296.484421869396;4409.933850992237;4437.179121862466;3249.3014001989213;3359.1434184282853;3359.5296658467832;3359.9664003360144;3372.780769249991;624.9343818899041;629.222909706512;636.9044643303541;654.5810681164058;663.3366633366634;545.4245770711937;609.6403122157948;617.6911544227886;631.0975305313355;637.85648229149;7661.387089032864;8304.003519577689;8578.742637720878;8874.677381656946;9061.184493395625;523.3275241314892;560.2632538212238;585.023011570678;597.8057131432302;632.8955722305768;4152.584741525884;4343.326784348431;4344.196323680129;4357;4364.672649551297;151378;157602.21198893932;158050;161006;161175.38824611838;81309;82902.17097828945;129097;134293;136783.31608341893;109771;110043.89956100336;110543.89456105336;114582;116204.41897790288;7213.927860721536;8286.875696864432;8392.4544904581;8529.402941794015;8728.214460698568;43996;53540.732296339826;54031;55669.72165139148;57120.71439642775;57198;57782.422175777705;76328.23671763434;78763;82889;12535.67804531818;13183.736325273632;13213.471461141831;13470.057096003186;13714.794278086036;14527.636809079857;15092.924535377253;15113.848861511244;15121.546353609408;15164.317605707549;13305.866941330463;13377.464901404224;13409.128406653535;13649.658758531115;13821.792673110112;13275.468981240641;13709.245991470565;13716.382762775898;13724.382402792098;13733.381997809922;12945.935270323587;13096.541621043218;13171.802422963854;13223.534553834814;13693.931530342285;11047.779044419227;11178.422904670428;11258.549658013915;11275.32348059119;11396.259243149168;10267.640632577824;11116.22186446941;11290.661280161608;11349.829752553553;11402.20184587071 15:03:11 INFO - PROCESS | 1652 | __end_tp_report 15:03:11 INFO - PROCESS | 1652 | __start_cc_report 15:03:11 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1420 15:03:11 INFO - PROCESS | 1652 | __end_cc_report 15:03:11 INFO - PROCESS | 1652 | __startTimestamp1476482590986__endTimestamp 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | ------- Summary: start ------- 15:03:11 INFO - PROCESS | 1652 | Number of tests: 6 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5703.12 Median:5874.94 stddev:654.76 (11.1%) stddev-sans-first:619.18 15:03:11 INFO - PROCESS | 1652 | Values: 2915.7 3333.0 3345.5 3371.3 3394.3 5565.4 5627.7 5672.1 5674.8 5692.0 5625.2 5644.9 5756.5 5777.0 5786.9 4817.9 5065.6 5147.7 5169.9 5211.2 4845.6 5277.1 5296.0 5298.9 5340.3 5255.1 5275.4 5284.0 5299.7 5361.3 5073.2 5121.7 5163.5 5173.6 5186.7 5111.3 5132.5 5147.8 5182.3 5191.5 5634.6 5671.2 5674.3 5679.9 5762.7 6034.2 6077.2 6117.5 6167.5 6224.4 4630.7 6168.1 6266.3 6271.4 6323.2 5723.8 5727.2 5730.5 5735.9 5790.6 6140.7 6231.2 6297.7 6321.5 6326.6 6010.3 6019.2 6060.2 6060.5 6125.7 6218.9 6232.8 6232.8 6237.2 6253.1 6105.7 6112.0 6153.2 6189.4 6207.9 6081.2 6104.4 6125.9 6169.7 6170.5 4186.6 4911.9 4946.8 4980.4 4992.4 4399.3 4401.2 4402.0 4408.3 4434.5 5710.9 5778.6 5793.8 5811.4 5812.9 6110.2 6189.2 6195.7 6206.5 6241.7 5832.0 5833.4 5841.3 5853.2 5874.9 5421.6 5429.5 5437.7 5441.1 5451.7 6211.7 6232.6 6240.0 6267.0 6296.7 5454.8 6116.0 6208.7 6309.6 6315.2 6221.5 6250.9 6263.6 6280.4 6288.8 6072.0 6098.0 6165.0 6217.5 6236.2 6200.3 6201.2 6246.3 6304.4 6322.9 6094.4 6158.7 6162.4 6166.8 6188.1 5263.9 5895.3 5912.9 5980.5 6149.9 5837.3 5868.4 5930.6 5948.3 6027.3 6110.5 6121.1 6127.3 6134.0 6138.5 5770.4 5818.1 5831.9 5897.4 5917.6 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:67832.23 Median:20199.38 stddev:145936.80 (722.5%) stddev-sans-first:146258.57 15:03:11 INFO - PROCESS | 1652 | Values: 476.9 487.3 492.2 493.4 500.8 22731.8 30459.0 40062.0 40850.4 40962.2 33613.8 39839.4 41338.6 41477.4 41685.6 9306.4 9477.7 9483.7 9494.2 9499.1 8536.5 8743.5 9335.7 11537.9 11564.3 11293.3 11384.8 11392.6 11419.9 11560.9 8539.5 11305.7 11375.6 11377.1 11378.4 8485.9 11279.8 11562.5 11572.0 11572.3 39533.0 39873.2 39919.6 39945.4 39985.6 3388.9 3390.5 3429.8 3453.6 3722.3 30048.8 31103.0 31122.7 31239.5 31422.8 3008.4 3061.0 3149.4 3192.6 3251.9 459228.0 461026.0 461626.0 464302.0 471816.6 61177.7 61343.0 61632.0 61789.1 61812.4 64929.0 65063.0 65104.7 65110.7 65157.0 14437.5 16065.3 16645.7 16699.2 16703.7 11389.9 11610.0 12646.2 12684.9 12726.9 16330.7 19172.7 19177.2 19275.4 19427.9 6721.0 7803.8 7863.0 7926.9 7984.6 849.7 937.4 962.9 1008.6 1022.3 27538.0 29776.1 30009.0 30488.7 30581.0 972.3 1036.0 1061.3 1072.5 1185.7 14592.3 14893.4 15116.5 15219.6 15463.0 631388.7 633989.0 635123.0 635921.0 636602.0 56651.7 56845.0 56862.0 57003.7 57214.1 1054.4 1274.2 1342.1 1347.2 1366.6 29104.3 30485.5 30643.8 30899.7 31131.5 49179.5 49618.5 49769.5 49869.0 50080.7 523823.0 528853.0 528901.0 529566.0 529606.0 24984.9 26391.6 26508.5 26938.7 27068.3 46654.5 46917.5 47152.5 47359.0 47866.0 30727.5 37874.0 37998.6 38648.6 38993.8 38172.4 38865.4 39939.8 40051.8 40487.2 36350.1 36676.4 37422.8 37444.3 37613.4 26075.6 32493.5 34282.8 34355.5 34467.0 24516.5 24578.0 24797.6 25072.8 25149.2 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:32949.44 Median:21525.52 stddev:91426.74 (424.7%) stddev-sans-first:91650.43 15:03:11 INFO - PROCESS | 1652 | Values: 340.6 360.9 364.0 366.8 389.2 12155.0 15628.5 17472.2 20232.8 21624.0 20174.7 21041.8 21102.3 21352.4 21477.8 5662.8 5967.5 6017.8 6027.2 6032.7 5664.3 5860.9 5994.0 5996.2 5996.4 6064.7 6072.8 6079.9 6088.7 6091.0 5844.2 6023.4 6076.7 6098.4 6119.2 5848.5 5848.6 5857.6 5858.3 5858.4 12292.3 12403.0 12709.7 12713.6 12890.5 1907.5 2137.2 2149.4 2411.0 2808.9 9497.8 9958.3 10116.3 10404.7 10541.0 1862.2 1867.3 1870.9 1894.3 1970.5 114915.9 115181.4 115437.4 117932.4 118976.0 11256.9 11427.9 11576.2 11669.7 11693.9 12364.1 13604.7 14481.2 14490.3 14492.6 7389.6 7872.6 7952.0 8395.7 8470.3 6956.5 8141.7 8264.0 8271.7 8415.6 3395.7 3738.9 4504.4 4557.9 4575.8 1546.7 1805.3 1814.9 1884.8 1948.2 863.5 881.1 895.2 917.9 950.2 20794.5 21516.7 21534.4 21628.9 21652.8 931.6 940.5 953.6 956.7 957.9 9801.2 10664.0 11442.7 11454.8 11489.8 487481.1 490477.0 569115.0 585815.0 587024.0 75091.2 121992.0 130747.0 131448.3 133703.3 968.1 972.6 995.9 995.9 996.7 18350.5 19510.5 19576.2 19631.4 19631.6 47377.8 49569.5 50373.0 50739.7 51549.7 76201.2 77330.6 78643.0 79799.8 79815.8 7963.9 9868.5 10946.6 11551.7 11998.7 9333.0 12980.0 13180.5 13557.5 13567.0 10699.3 11873.3 11957.2 11962.6 12013.2 11310.5 11546.8 11740.7 11883.1 12052.9 9398.3 10760.0 11845.8 12059.9 12117.3 10011.2 12229.4 12373.0 12445.7 12501.6 11472.7 11505.7 11924.6 12051.6 12121.0 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5528.69 Median:5245.80 stddev:3063.01 (58.4%) stddev-sans-first:3055.50 15:03:11 INFO - PROCESS | 1652 | Values: 1350.6 1519.1 1685.6 1852.3 1894.8 6099.7 8668.1 8671.3 8682.8 8687.3 7561.9 7796.3 7830.9 8194.1 8439.2 2307.4 2350.9 2356.9 2362.8 2363.9 2327.7 2351.1 2365.4 2378.6 2380.3 2330.8 2334.1 2345.4 2345.5 2378.1 2319.9 2334.7 2340.4 2342.6 2342.9 2331.0 2331.9 2334.3 2340.8 2348.0 8558.2 8618.9 8663.3 8704.4 8738.0 4568.2 5082.3 5249.9 5252.3 5253.3 3340.6 3441.8 3553.4 3565.2 3586.2 978.8 984.6 993.8 1000.5 1005.4 11261.6 11321.2 11326.5 11334.3 11361.5 3868.3 4496.3 4543.0 4612.4 4705.0 8360.2 9390.5 9586.4 9619.1 9681.7 5228.1 5240.5 5241.7 5253.3 5260.4 4099.0 4119.3 4157.8 4824.0 4835.3 3806.3 3817.8 3904.9 3939.2 3957.1 1248.5 1255.0 1262.7 1271.2 1276.6 827.3 847.9 860.0 918.9 964.9 5571.5 5656.6 5812.0 5875.9 5953.5 908.1 920.2 920.9 943.1 981.1 3767.4 3876.9 3916.6 4029.6 4035.2 9929.8 10461.1 10478.0 10494.5 10510.6 10378.6 10395.9 10406.1 10415.5 10454.7 7479.4 7835.8 7909.8 7921.0 8006.9 5685.7 5836.9 5856.4 5989.8 6044.4 8224.8 8954.0 9447.9 9654.5 9689.7 9521.8 9790.9 9791.5 9861.9 9887.6 6799.6 6826.6 7096.8 7290.9 7486.5 8199.8 8251.2 8298.4 8342.7 8355.4 7334.3 7396.7 7397.1 7456.7 7585.4 6971.0 7176.7 7202.2 7242.1 7303.7 6791.7 6827.9 6919.0 6924.4 6928.3 4420.0 4816.3 4867.9 4909.8 4983.6 4223.0 4773.0 4791.5 4911.0 4973.9 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4492.22 Median:4952.17 stddev:1431.92 (28.9%) stddev-sans-first:1400.78 15:03:11 INFO - PROCESS | 1652 | Values: 290.6 295.4 304.7 309.3 310.1 5027.3 5458.3 5485.5 5490.7 5520.5 4701.4 4805.9 5134.4 5242.8 5311.4 3418.3 4059.7 4080.9 4083.8 4092.8 4083.9 4106.2 4111.3 4120.8 4138.8 3764.7 3986.4 4036.8 4042.2 4053.3 3318.9 3452.7 3807.0 3890.1 4019.1 3467.9 3481.9 3486.2 3502.0 3504.3 5016.1 5160.5 5233.8 5240.7 5278.9 3827.5 4365.9 4501.0 4559.5 4624.9 4843.5 5438.0 5580.2 5581.6 5591.6 3314.9 3733.0 3783.5 3787.8 3788.7 5419.7 5670.8 5924.2 5948.0 5950.7 3164.5 3334.5 3378.4 3721.8 3768.8 3305.3 3312.4 3842.8 3875.1 3961.9 3995.4 4379.3 4560.1 4621.8 4625.8 5606.4 5670.7 5683.0 5684.9 5698.5 1029.9 1301.8 1309.3 1337.2 1341.8 837.5 853.8 857.7 858.6 866.1 3762.8 3802.6 4263.2 4314.5 4420.4 4778.0 4862.3 4888.6 4935.6 4954.8 4066.6 4173.2 4387.8 4681.0 5414.0 2748.5 2764.6 3017.3 3053.6 3078.8 4997.9 5290.9 6044.5 6062.7 6138.8 5280.2 5330.3 5823.6 6017.1 6061.2 5784.5 6042.8 6081.1 6089.7 6097.2 5508.6 5804.5 5830.6 5875.9 5877.1 4788.4 4817.5 5758.3 5760.5 5784.8 6030.8 6039.4 6058.0 6067.7 6068.6 3379.3 3831.3 3873.7 3876.2 3887.2 5828.3 5844.7 5851.4 5858.3 5877.9 5348.5 5706.8 5716.3 5720.0 5733.3 4466.7 5632.9 5656.9 5674.3 5680.2 5236.9 5526.8 5535.8 5556.4 5566.8 4923.4 5104.2 5567.4 5583.2 5683.3 4949.5 5191.6 5286.1 5555.6 5558.8 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:23592.16 Median:3359.75 stddev:38198.73 (1137.0%) stddev-sans-first:38267.27 15:03:11 INFO - PROCESS | 1652 | Values: 715.6 738.5 742.8 785.9 810.8 15095.5 15203.5 15237.8 15273.6 15302.9 14454.6 14540.6 14553.0 14578.7 14591.6 689.9 713.3 715.5 862.5 874.5 715.6 878.0 883.5 895.3 900.7 958.5 959.2 959.5 960.9 961.1 952.4 952.8 953.6 953.7 955.7 545.8 560.9 681.1 701.3 706.0 15062.8 15112.2 15126.5 15129.5 15148.5 13274.5 13586.0 13761.9 13820.1 13847.8 10095.2 11859.3 12194.6 12209.5 12461.6 4394.2 4437.9 4446.0 4470.2 4481.9 100978.7 102209.5 102229.0 102413.5 102564.5 10647.7 10647.8 10767.5 10798.1 10817.9 21017.7 21034.2 21074.9 21117.9 21402.5 7747.1 7752.4 7823.3 7871.6 7916.0 4212.3 4285.4 4296.5 4409.9 4437.2 3249.3 3359.1 3359.5 3360.0 3372.8 624.9 629.2 636.9 654.6 663.3 545.4 609.6 617.7 631.1 637.9 7661.4 8304.0 8578.7 8874.7 9061.2 523.3 560.3 585.0 597.8 632.9 4152.6 4343.3 4344.2 4357.0 4364.7 151378.0 157602.2 158050.0 161006.0 161175.4 81309.0 82902.2 129097.0 134293.0 136783.3 109771.0 110043.9 110543.9 114582.0 116204.4 7213.9 8286.9 8392.5 8529.4 8728.2 43996.0 53540.7 54031.0 55669.7 57120.7 57198.0 57782.4 76328.2 78763.0 82889.0 12535.7 13183.7 13213.5 13470.1 13714.8 14527.6 15092.9 15113.8 15121.5 15164.3 13305.9 13377.5 13409.1 13649.7 13821.8 13275.5 13709.2 13716.4 13724.4 13733.4 12945.9 13096.5 13171.8 13223.5 13693.9 11047.8 11178.4 11258.5 11275.3 11396.3 10267.6 11116.2 11290.7 11349.8 11402.2 15:03:11 INFO - PROCESS | 1652 | -------- Summary: end -------- 15:03:11 INFO - PROCESS | 1652 | 15:03:11 INFO - TEST-INFO | 1652: exit 0 15:03:11 INFO - TEST-OK | dromaeo_css | took 1119914ms 15:03:11 INFO - TEST-START | kraken 15:03:11 INFO - operating with platform_type : mac_ 15:03:11 INFO - Initialising browser for kraken test... 15:03:11 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpt4O8rC/profile http://localhost:49271/getInfo.html) 15:03:14 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 15:03:14 INFO - PROCESS | 1661 | colorDepth:24 15:03:14 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 15:03:14 INFO - PROCESS | 1661 | __metrics 15:03:14 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:03:14 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:03:15 INFO - TEST-INFO | 1661: exit 0 15:03:15 INFO - Browser initialized. 15:03:15 INFO - Running cycle 1/1 for kraken test... 15:03:15 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpt4O8rC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:26 INFO - PROCESS | 1662 | RSS: Main: 231714816 15:03:26 INFO - PROCESS | 1662 | 15:03:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 15:03:30 INFO - PROCESS | 1662 | RSS: Main: 290185216 15:03:30 INFO - PROCESS | 1662 | 15:03:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 15:03:33 INFO - PROCESS | 1662 | RSS: Main: 291360768 15:03:33 INFO - PROCESS | 1662 | 15:03:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 15:03:37 INFO - PROCESS | 1662 | RSS: Main: 386084864 15:03:37 INFO - PROCESS | 1662 | 15:03:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 15:03:40 INFO - PROCESS | 1662 | RSS: Main: 289656832 15:03:40 INFO - PROCESS | 1662 | 15:03:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:03:43 INFO - PROCESS | 1662 | RSS: Main: 291258368 15:03:43 INFO - PROCESS | 1662 | 15:03:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 15:03:46 INFO - PROCESS | 1662 | RSS: Main: 328564736 15:03:46 INFO - PROCESS | 1662 | 15:03:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 15:03:49 INFO - PROCESS | 1662 | RSS: Main: 329613312 15:03:49 INFO - PROCESS | 1662 | 15:03:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 15:03:53 INFO - PROCESS | 1662 | RSS: Main: 328073216 15:03:53 INFO - PROCESS | 1662 | 15:03:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:03:55 INFO - PROCESS | 1662 | RSS: Main: 302587904 15:03:55 INFO - PROCESS | 1662 | 15:03:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:03:57 INFO - PROCESS | 1662 | RSS: Main: 306610176 15:03:57 INFO - PROCESS | 1662 | 15:04:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:04:00 INFO - PROCESS | 1662 | RSS: Main: 308600832 15:04:00 INFO - PROCESS | 1662 | 15:04:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:04:04 INFO - PROCESS | 1662 | RSS: Main: 317935616 15:04:04 INFO - PROCESS | 1662 | 15:04:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:04:08 INFO - PROCESS | 1662 | RSS: Main: 318074880 15:04:08 INFO - PROCESS | 1662 | 15:04:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 15:04:10 INFO - PROCESS | 1662 | RSS: Main: 361787392 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | __start_tp_report 15:04:10 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 15:04:10 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 15:04:10 INFO - PROCESS | 1662 | |i|pagename|runs| 15:04:10 INFO - PROCESS | 1662 | |0;ai-astar;104;114;115;112;116;115;114;115;113;114 15:04:10 INFO - PROCESS | 1662 | |1;audio-beat-detection;146;114;115;150;114;113;114;110;141;112 15:04:10 INFO - PROCESS | 1662 | |2;audio-dft;185;186;181;185;183;183;181;182;181;181 15:04:10 INFO - PROCESS | 1662 | |3;audio-fft;79;59;59;88;62;77;81;80;85;58 15:04:10 INFO - PROCESS | 1662 | |4;audio-oscillator;87;70;94;69;67;68;91;67;69;89 15:04:10 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;87;89;87;90;84;89;86;89;86 15:04:10 INFO - PROCESS | 1662 | |6;imaging-darkroom;94;95;94;95;95;94;94;94;95;94 15:04:10 INFO - PROCESS | 1662 | |7;imaging-desaturate;124;82;79;79;83;82;84;83;82;81 15:04:10 INFO - PROCESS | 1662 | |8;json-parse-financial;57;55;57;55;55;55;57;56;56;54 15:04:10 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;69;66;79;74;72;68;70;70;71 15:04:10 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;86;91;106;85;86;86;85;90;87;88 15:04:10 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;143;144;146;140;143;144;147;150;173;148 15:04:10 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;172;172;172;169;225;229;171;170;171;170 15:04:10 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;69;68;69;71;74;86;69;67;67;66 15:04:10 INFO - PROCESS | 1662 | __end_tp_report 15:04:10 INFO - PROCESS | 1662 | __start_cc_report 15:04:10 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2023 15:04:10 INFO - PROCESS | 1662 | __end_cc_report 15:04:10 INFO - PROCESS | 1662 | __startTimestamp1476482650098__endTimestamp 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | ------- Summary: start ------- 15:04:10 INFO - PROCESS | 1662 | Number of tests: 14 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.43 (3.0%) stddev-sans-first:1.20 15:04:10 INFO - PROCESS | 1662 | Values: 104.0 114.0 115.0 112.0 116.0 115.0 114.0 115.0 113.0 114.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:114.50 stddev:15.91 (13.9%) stddev-sans-first:14.52 15:04:10 INFO - PROCESS | 1662 | Values: 146.0 114.0 115.0 150.0 114.0 113.0 114.0 110.0 141.0 112.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.93 (1.1%) stddev-sans-first:1.88 15:04:10 INFO - PROCESS | 1662 | Values: 185.0 186.0 181.0 185.0 183.0 183.0 181.0 182.0 181.0 181.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:72.80 Median:79.50 stddev:11.89 (15.0%) stddev-sans-first:12.39 15:04:10 INFO - PROCESS | 1662 | Values: 79.0 59.0 59.0 88.0 62.0 77.0 81.0 80.0 85.0 58.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.50 stddev:11.48 (14.6%) stddev-sans-first:11.61 15:04:10 INFO - PROCESS | 1662 | Values: 87.0 70.0 94.0 69.0 67.0 68.0 91.0 67.0 69.0 89.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:2.00 (2.3%) stddev-sans-first:1.94 15:04:10 INFO - PROCESS | 1662 | Values: 90.0 87.0 89.0 87.0 90.0 84.0 89.0 86.0 89.0 86.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:04:10 INFO - PROCESS | 1662 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:82.00 stddev:13.49 (16.4%) stddev-sans-first:1.73 15:04:10 INFO - PROCESS | 1662 | Values: 124.0 82.0 79.0 79.0 83.0 82.0 84.0 83.0 82.0 81.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 15:04:10 INFO - PROCESS | 1662 | Values: 57.0 55.0 57.0 55.0 55.0 55.0 57.0 56.0 56.0 54.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:4.03 (5.7%) stddev-sans-first:3.77 15:04:10 INFO - PROCESS | 1662 | Values: 65.0 69.0 66.0 79.0 74.0 72.0 68.0 70.0 70.0 71.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:86.50 stddev:6.31 (7.3%) stddev-sans-first:6.60 15:04:10 INFO - PROCESS | 1662 | Values: 86.0 91.0 106.0 85.0 86.0 86.0 85.0 90.0 87.0 88.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:146.50 stddev:9.31 (6.4%) stddev-sans-first:9.71 15:04:10 INFO - PROCESS | 1662 | Values: 143.0 144.0 146.0 140.0 143.0 144.0 147.0 150.0 173.0 148.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:172.00 stddev:23.70 (13.8%) stddev-sans-first:24.86 15:04:10 INFO - PROCESS | 1662 | Values: 172.0 172.0 172.0 169.0 225.0 229.0 171.0 170.0 171.0 170.0 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:69.00 stddev:5.87 (8.5%) stddev-sans-first:6.20 15:04:10 INFO - PROCESS | 1662 | Values: 69.0 68.0 69.0 71.0 74.0 86.0 69.0 67.0 67.0 66.0 15:04:10 INFO - PROCESS | 1662 | -------- Summary: end -------- 15:04:10 INFO - PROCESS | 1662 | 15:04:10 INFO - TEST-INFO | 1662: exit 0 15:04:11 INFO - TEST-OK | kraken | took 59259ms 15:04:11 INFO - SUITE-END | took 1179s 15:04:11 INFO - Completed test suite (00:19:39) 15:04:11 INFO - javascript benchmark 15:04:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.7375836174747, 3333.0334203081106, 3345.481450375192, 3371.32573485303, 3394.3381040697072, 5565.41563135871, 5627.6904770237625, 5672.120821272704, 5674.801381951633, 5691.971540142299, 5625.156226566007, 5644.858878528039, 5756.453136951994, 5776.989026920293, 5786.913196302048, 4817.90364192716, 5065.594752419816, 5147.691138531682, 5169.896602067956, 5211.166213405856, 4845.612351011928, 5277.102892508283, 5296.0, 5298.947010529884, 5340.305760251182, 5255.05409026377, 5275.366955965271, 5283.973580132113, 5299.708516031616, 5361.303030606015, 5073.213651883964, 5121.718305493197, 5163.5352818246165, 5173.63784535079, 5186.7147306898105, 5111.309973153651, 5132.461091585367, 5147.794088236466, 5182.274481572583, 5191.454897235812, 5634.6337488063145, 5671.234383358235, 5674.2623458950075, 5679.914801277984, 5762.711864406805, 6034.24571928509, 6077.24034495688, 6117.541184411142, 6167.54140686136, 6224.37756224374, 4630.675852690313, 6168.136460895478, 6266.310705822356, 6271.404216599416, 6323.20959880015, 5723.799667011676, 5727.169560413717, 5730.484256416942, 5735.885282294331, 5790.623609465456, 6140.6929653517145, 6231.189945307172, 6297.685115744194, 6321.494280457552, 6326.557141000086, 6010.3088144863905, 6019.247594050744, 6060.2424696912885, 6060.545459090586, 6125.693326622233, 6218.875622487615, 6232.781852635136, 6232.844178895564, 6237.1891654084675, 6253.062040693932, 6105.725242364104, 6111.96944015277, 6153.2000839891425, 6189.442950134419, 6207.937920620736, 6081.239845019372, 6104.420065188057, 6125.907024958055, 6169.691515424211, 6170.5372097092895, 4186.623203911662, 4911.901761964741, 4946.802127914915, 4980.427250866197, 4992.400911890596, 4399.318105693623, 4401.22978478765, 4401.965538098544, 4408.316710909814, 4434.5343738907595, 5710.914336284959, 5778.595498315078, 5793.768249270066, 5811.360750317462, 5812.912806307909, 6110.163888792202, 6189.195404597373, 6195.690215489208, 6206.472449841724, 6241.687915604292, 5831.9708401458565, 5833.38749431312, 5841.299044114733, 5853.239078919713, 5874.942510348093, 5421.593380496479, 5429.457054294539, 5437.728113594305, 5441.075017247077, 5451.6728996261145, 6211.65835879031, 6232.626042437287, 6240.0, 6267.0, 6296.748130074746, 5454.781808727606, 6116.0, 6208.689565521796, 6309.589876658002, 6315.242170939517, 6221.4683064335795, 6250.937490625218, 6263.592866463665, 6280.434760871361, 6288.842778930563, 6072.0, 6098.038923863867, 6164.969175154096, 6217.4715149212825, 6236.18929539157, 6200.286966998853, 6201.193844800147, 6246.250449946036, 6304.369563043842, 6322.905156422749, 6094.39056094387, 6158.7228574715145, 6162.352952939877, 6166.81499555014, 6188.133661287513, 5263.947210557827, 5895.322037965689, 5912.911306330322, 5980.491658209101, 6149.907751383644, 5837.270341207349, 5868.38381969887, 5930.555208359304, 5948.315943666361, 6027.276726792637, 6110.480609148272, 6121.143039974496, 6127.264728232641, 6134.04922237054, 6138.508919286357, 5770.365259821332, 5818.0981947798155, 5831.854203644773, 5897.439743224387, 5917.556183286185], "value": 5660.670236401551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.852175825494, 487.3274880664682, 492.19526074867593, 493.38327091136057, 500.78466259508394, 22731.772682273193, 30459.0, 40061.99845003873, 40850.38724419136, 40962.180756384856, 33613.83193084037, 39839.40240896389, 41338.58661413385, 41477.37783933243, 41685.58314416855, 9306.441613503195, 9477.715668529956, 9483.715488535356, 9494.240460763156, 9499.097585729345, 8536.487810731345, 8743.519106449143, 9335.719928402159, 11537.884621153808, 11564.306141631487, 11293.265937714063, 11384.772304553904, 11392.601258955938, 11419.942900285487, 11560.942195289012, 8539.530325832076, 11305.660830175108, 11375.601853935073, 11377.1467139964, 11378.431078446045, 8485.915140848574, 11279.774404511863, 11562.53749850005, 11571.974904391782, 11572.264160375928, 39533.0, 39873.202535949116, 39919.60080399188, 39945.400818987735, 39985.600143998476, 3388.9322213555592, 3390.4744764561533, 3429.777064490825, 3453.637368076341, 3722.3113723961155, 30048.849755751082, 31103.0, 31122.688773112204, 31239.531407028913, 31422.842885785652, 3008.39832033592, 3060.9540856887165, 3149.4173577887937, 3192.584963954671, 3251.869925202989, 459228.0, 461026.0, 461626.0, 464302.0, 471816.6409167932, 61177.694111529156, 61343.0, 61632.0, 61789.073163902576, 61812.381876181564, 64929.0, 65063.0, 65104.67447662731, 65110.67444662746, 65157.0, 14437.494687685881, 16065.277062532214, 16645.6670866582, 16699.165041747863, 16703.749443758352, 11389.886101138882, 11610.0, 12646.241225526497, 12684.936575317064, 12726.872731272753, 16330.67338653244, 19172.71240931387, 19177.232910683415, 19275.4217373479, 19427.90286048589, 6720.966395167993, 7803.765887023398, 7863.0, 7926.8810967835525, 7984.600769961478, 849.7450764770545, 937.4188003437775, 962.9277804164716, 1008.5864795433837, 1022.3011250299216, 27538.0, 29776.10671679853, 30009.0, 30488.69511304903, 30581.0, 972.2756546372856, 1035.994820025895, 1061.3207547169818, 1072.485207100596, 1185.7391373897728, 14592.343344549521, 14893.404263829325, 15116.533646478108, 15219.619509512351, 15462.994905331117, 631388.6861131422, 633989.0, 635123.0, 635921.0, 636602.0, 56651.71674141685, 56845.0, 56862.0, 57003.714981424826, 57214.14178787322, 1054.3568423261804, 1274.1908887856093, 1342.1074985134776, 1347.2186132043587, 1366.6241783509615, 29104.27239319034, 30485.54271685882, 30643.846780765954, 30899.691003090582, 31131.53302700416, 49179.508204917496, 49618.50381496139, 49769.502304976486, 49869.00261994812, 50080.749596251786, 523823.0, 528853.0, 528901.0, 529566.0, 529606.0, 24984.875075625234, 26391.60412593774, 26508.469830603666, 26938.730612693624, 27068.32329191786, 46654.53345466502, 46917.53082469132, 47152.528474716186, 47359.0, 47866.0, 30727.539086913268, 37874.0, 37998.62001380062, 38648.613513865625, 38993.83018509449, 38172.427413588266, 38865.41701874418, 39939.80030099831, 40051.79974100111, 40487.1902561953, 36350.09124771902, 36676.44985325169, 37422.8128859354, 37444.25111497809, 37613.435798462495, 26075.60886586665, 32493.512597310586, 34282.828585856914, 34355.484667729506, 34467.0, 24516.50966980686, 24578.0, 24797.62803557984, 25072.78490446015, 25149.24552263435], "value": 19874.969078217327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.63041599864147, 360.92781443711254, 363.9763415378, 366.78543052314393, 389.2293259346494, 12155.0, 15628.513270567018, 17472.21375038125, 20232.797672023276, 21624.0, 20174.697379539317, 21041.84269865157, 21102.261420850275, 21352.35942921711, 21477.785222147813, 5662.801801936933, 5967.462928336449, 6017.819465416044, 6027.156198132265, 6032.69836508175, 5664.26364572605, 5860.853478663025, 5994.0, 5996.160537524728, 5996.370381109986, 6064.666443345636, 6072.7874524391655, 6079.908801367983, 6088.726007329681, 6091.025435930252, 5844.1818145459665, 6023.36754640763, 6076.6961651917445, 6098.390160983866, 6119.2350956130485, 5848.5321174305955, 5848.561357898175, 5857.619254748471, 5858.2677165354335, 5858.355580886099, 12292.323922184276, 12403.0, 12709.74580508394, 12713.618591442271, 12890.484380624765, 1907.4754442528415, 2137.1771867830844, 2149.387424583986, 2410.9758902410927, 2808.90452723438, 9497.810043799085, 9958.302918795687, 10116.291859569834, 10404.68785936423, 10541.0, 1862.245790454868, 1867.3090956346239, 1870.8971006594631, 1894.2612381171355, 1970.5270735023491, 114915.85084149135, 115181.42409287984, 115437.42281288625, 117932.41033794776, 118976.0, 11256.943715281535, 11427.942860285646, 11576.189666723249, 11669.708257293636, 11693.941530292293, 12364.072694547946, 13604.727905441836, 14481.203533805741, 14490.275486225646, 14492.565223043326, 7389.630518474055, 7872.567008814455, 7952.0, 8395.70615028471, 8470.280026197719, 6956.5478243913985, 8141.674333026613, 8263.95868020656, 8271.669133234724, 8415.621297041647, 3395.6774106459848, 3738.869139580156, 4504.391907092566, 4557.931631025537, 4575.794089265991, 1546.6597348583293, 1805.2591388796316, 1814.8911065335858, 1884.8020957799508, 1948.1817636592666, 863.5164307987548, 881.1496905486108, 895.2345744388584, 917.9449233046039, 950.2065775077749, 20794.48013799637, 21516.677249841265, 21534.353969380943, 21628.891855540936, 21652.783472165076, 931.5761328595473, 940.4592359393239, 953.6185525789601, 956.7225504603587, 957.9425234485954, 9801.215902727907, 10664.0, 11442.656720298404, 11454.770904581861, 11489.827652585218, 487481.1251887436, 490477.0, 569115.0, 585815.0, 587024.0, 75091.24908750952, 121992.0, 130747.0, 131448.3427582856, 133703.33148334196, 968.1238479176357, 972.5963725054023, 995.8904520502739, 995.9004099589984, 996.6661168508485, 18350.541236469195, 19510.512237194183, 19576.21695132179, 19631.411057668294, 19631.60736785285, 47377.76311118422, 49569.50430495649, 50372.992540149724, 50739.74630126826, 51549.7422512885, 76201.23798762163, 77330.6133469329, 78643.0, 79799.80300295616, 79815.80276295744, 7963.92036079655, 9868.506574671093, 10946.616868409887, 11551.653450396501, 11998.700032499257, 9332.95333523328, 12980.026498012498, 13180.538681146114, 13557.525486607921, 13567.0, 10699.304545204848, 11873.287602743863, 11957.162998590014, 11962.58130965412, 12013.219140755822, 11310.491027903929, 11546.769064618493, 11740.70648233801, 11883.102965292986, 12052.939735301617, 9398.34211605181, 10760.0, 11845.822312665488, 12059.939700301793, 12117.27296362221, 10011.24915631316, 12229.388530573613, 12373.010159187423, 12445.688857778629, 12501.624951251477, 11472.713182170179, 11505.654830355103, 11924.642260732191, 12051.638450846489, 12121.0], "value": 9462.272064351271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.5813197908647, 1519.1340935666667, 1685.6123091688912, 1852.2776117314258, 1894.7915729269778, 6099.664518451489, 8668.133186681329, 8671.30629549636, 8682.782930426734, 8687.348448866345, 7561.886571701429, 7796.259355361246, 7830.9216907830905, 8194.098649148604, 8439.240468357846, 2307.3885420363617, 2350.9177178798745, 2356.8703721295324, 2362.751911049341, 2363.905443782255, 2327.674125622414, 2351.1183306260154, 2365.44412063165, 2378.6194208926577, 2380.2978121454125, 2330.8368414211013, 2334.062727935809, 2345.366750977235, 2345.472268739537, 2378.1319818266293, 2319.860808351504, 2334.684817549626, 2340.414896275931, 2342.61346877765, 2342.906283748648, 2330.97669023311, 2331.8950647220745, 2334.2880421471446, 2340.7710951750296, 2347.9882600587057, 8558.186972237627, 8618.870716939251, 8663.306935445149, 8704.390692651517, 8738.038815730264, 4568.2462393705, 5082.3138876251605, 5249.868753281198, 5252.317198764136, 5253.343332083489, 3340.5991281046186, 3441.7934923904395, 3553.4492153716214, 3565.180008598011, 3586.2468881534646, 978.7748817771952, 984.5864736810485, 993.7664648807524, 1000.5397517142123, 1005.3766664667953, 11261.605843795427, 11321.20751547392, 11326.546938122465, 11334.263272887236, 11361.488733006952, 3868.3423817951016, 4496.258117410591, 4542.977285113553, 4612.377329060534, 4704.976475117671, 8360.247577718035, 9390.5304734763, 9586.424814511012, 9619.086186812241, 9681.70954871355, 5228.08508511009, 5240.4759524047295, 5241.73791310433, 5253.264542963988, 5260.395054568774, 4099.0, 4119.340905455173, 4157.8336866525, 4824.0, 4835.274708793639, 3806.314863324573, 3817.84728610858, 3904.882853514399, 3939.2318497893207, 3957.149212919236, 1248.494359784289, 1254.974900502003, 1262.715888925003, 1271.2309053022973, 1276.5978716704394, 827.2885318625977, 847.9236868681849, 860.0195776814437, 918.8897332320164, 964.9035096490435, 5571.498565129158, 5656.61970156347, 5811.9709401453565, 5875.9118613220835, 5953.523718102541, 908.1100521488846, 920.1580553793204, 920.9493477858648, 943.1134733350628, 981.097390400833, 3767.416050512175, 3876.9224615507533, 3916.6475017248586, 4029.6373326400767, 4035.1526179502634, 9929.801403972024, 10461.058504734458, 10477.952204779613, 10494.527746251437, 10510.579576816994, 10378.584856605803, 10395.896041039645, 10406.063454288998, 10415.479226038668, 10454.738631534272, 7479.439042071866, 7835.804104897423, 7909.762707118795, 7920.960395198103, 8006.919930800617, 5685.715714214355, 5836.920169768607, 5856.385079566755, 5989.760409583742, 6044.395560443921, 8224.835503289782, 8954.0, 9447.905520944703, 9654.469004204837, 9689.660861869801, 9521.761955951157, 9790.902090979, 9791.510424478605, 9861.901380986385, 9887.604495820087, 6799.558028728117, 6826.590404575742, 7096.822579435556, 7290.927090729237, 7486.513376630502, 8199.754007379788, 8251.216134467217, 8298.377621678277, 8342.708005219789, 8355.41512094172, 7334.339909408179, 7396.704131834666, 7397.112346518452, 7456.701731930662, 7585.355244804254, 6971.0, 7176.7488137914925, 7202.171750248788, 7242.094738157731, 7303.671334790053, 6791.7283308669075, 6827.863442731217, 6918.965405172942, 6924.376806087476, 6928.341807528277, 4419.983403817076, 4816.325714399917, 4867.9269810952155, 4909.803607855789, 4983.601311895112, 4222.957770422379, 4772.976135119302, 4791.52084791532, 4911.011040528591, 4973.900521989613], "value": 4469.544806531526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.56560442138993, 295.4032853635656, 304.74293539151, 309.2901790391052, 310.13472411970605, 5027.346444962154, 5458.263134476854, 5485.478879506445, 5490.725463726808, 5520.4944860013875, 4701.388819453475, 4805.90388192236, 5134.435212126672, 5242.842714718565, 5311.442298558644, 3418.316336732651, 4059.7158198926086, 4080.9387859182134, 4083.7549747015273, 4092.7721683494833, 4083.9183216335655, 4106.219818234541, 4111.342185250361, 4120.773357465338, 4138.834446622147, 3764.6988240940796, 3986.4418981342637, 4036.7577945323374, 4042.151148258869, 4053.250148722496, 3318.933621327572, 3452.7410444216534, 3807.0, 3890.085829830002, 4019.090931807368, 3467.9479807802904, 3481.9129521761906, 3486.2156014896445, 3501.9824900875587, 3504.3341765064556, 5016.144026710104, 5160.483951604847, 5233.790648374099, 5240.68555886648, 5278.865044015555, 3827.502424684801, 4365.9126817463475, 4500.954990450086, 4559.544045595414, 4624.884377890546, 4843.515648435164, 5437.9939711153565, 5580.162975553659, 5581.553475721932, 5591.580631452657, 3314.850831712579, 3732.9532889402326, 3783.50814394127, 3787.753796003251, 3788.7456963106906, 5419.672180315809, 5670.801521946753, 5924.229850119457, 5947.9702601486715, 5950.732217050243, 3164.493681011073, 3334.549835772188, 3378.3750006248924, 3721.7580857244193, 3768.792716400624, 3305.3389322135667, 3312.38720836646, 3842.8270727817317, 3875.147467557133, 3961.8811435656976, 3995.400689896481, 4379.255526560492, 4560.133574620878, 4621.792019359137, 4625.814967401334, 5606.439356064442, 5670.659760414388, 5682.977064128497, 5684.857878552986, 5698.544116470673, 1029.9330543514648, 1301.804729290614, 1309.260267948606, 1337.157590717861, 1341.8322709661293, 837.5435387713588, 853.8036251662153, 857.6697971281102, 858.5921687198655, 866.0646501778065, 3762.811859407019, 3802.5550290889287, 4263.2307592348825, 4314.482262128565, 4420.4307470848025, 4778.0, 4862.294967229732, 4888.608911287089, 4935.629827762932, 4954.810845397079, 4066.6340029397497, 4173.1862286854375, 4387.824487020547, 4680.976595117003, 5413.9729301353245, 2748.4640495103263, 2764.6267753853376, 3017.3060196155006, 3053.557234201028, 3078.7844850860674, 4997.925031124536, 5290.867728306746, 6044.516438684895, 6062.696865156725, 6138.83362161188, 5280.1815718563685, 5330.307060082242, 5823.563232757476, 6017.127516510169, 6061.151438798572, 5784.508316793035, 6042.848928776816, 6081.114854395151, 6089.69551522431, 6097.207363042865, 5508.614396992172, 5804.477597016289, 5830.62100963436, 5875.941240587539, 5877.147813567094, 4788.401449818773, 4817.470078291315, 5758.3223800932765, 5760.510356619734, 5784.834918858415, 6030.798758453046, 6039.396060393926, 6057.969710151421, 6067.694276175025, 6068.575199735976, 3379.341028499419, 3831.2912111259507, 3873.74820636669, 3876.1666241758157, 3887.222555488857, 5828.329742079715, 5844.707764611838, 5851.385604511465, 5858.326292476419, 5877.911831322619, 5348.545373643128, 5706.830099829608, 5716.28546431696, 5720.0, 5733.31200255972, 4466.665000124939, 5632.9436705632415, 5656.85857853557, 5674.304705264966, 5680.233168522197, 5236.895262094813, 5526.806561770319, 5535.837474130478, 5556.361018482926, 5566.805161819317, 4923.359963204761, 5104.208847628475, 5567.359753628222, 5583.246261754611, 5683.2895888014, 4949.529794669501, 5191.636585438983, 5286.127788914786, 5555.555555555465, 5558.777648893999], "value": 4034.865049440295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.602840423565, 738.501511479751, 742.8217227865313, 785.9292663660272, 810.8054067023916, 15095.547133585982, 15203.543893683207, 15237.84762152378, 15273.618159546017, 15302.923485382586, 14454.638634034129, 14540.563783086498, 14553.0, 14578.708425831477, 14591.635209119777, 689.8585789913055, 713.2582114600809, 715.5420530860254, 862.4954401675028, 874.4971641306242, 715.6314498033516, 877.9517126558069, 883.4875772052227, 895.274827389813, 900.6667533012794, 958.5399008475936, 959.2326139088736, 959.5154447004288, 960.927930405219, 961.0581630002566, 952.3714348529937, 952.8094381123803, 953.5661274120328, 953.7234202081388, 955.7276176289724, 545.7516829842413, 560.9074502707049, 681.0703389872838, 701.2741812224324, 706.0151089230546, 15062.849371506254, 15112.244387780567, 15126.546203613909, 15129.47046853355, 15148.545543633709, 13274.535391261259, 13586.0, 13761.862381376159, 13820.101693389897, 13847.792283115661, 10095.192384609214, 11859.27841743138, 12194.634160975185, 12209.450574724158, 12461.563845265462, 4394.209042372372, 4437.9112417751785, 4445.977770111161, 4470.195364834329, 4481.865544033684, 100978.72128369902, 102209.48895255476, 102229.0, 102413.4879325606, 102564.48717756438, 10647.733806654896, 10647.787044259227, 10767.461626918623, 10798.136149108053, 10817.945910270399, 21017.68473472899, 21034.158633654788, 21074.894625526773, 21117.89441052785, 21402.464938376666, 7747.147813740484, 7752.379809615217, 7823.335016523545, 7871.606419678993, 7915.970923779987, 4212.347086201644, 4285.442892424027, 4296.484421869396, 4409.933850992237, 4437.179121862466, 3249.3014001989213, 3359.1434184282853, 3359.5296658467832, 3359.9664003360144, 3372.780769249991, 624.9343818899041, 629.222909706512, 636.9044643303541, 654.5810681164058, 663.3366633366634, 545.4245770711937, 609.6403122157948, 617.6911544227886, 631.0975305313355, 637.85648229149, 7661.387089032864, 8304.003519577689, 8578.742637720878, 8874.677381656946, 9061.184493395625, 523.3275241314892, 560.2632538212238, 585.023011570678, 597.8057131432302, 632.8955722305768, 4152.584741525884, 4343.326784348431, 4344.196323680129, 4357.0, 4364.672649551297, 151378.0, 157602.21198893932, 158050.0, 161006.0, 161175.38824611838, 81309.0, 82902.17097828945, 129097.0, 134293.0, 136783.31608341893, 109771.0, 110043.89956100336, 110543.89456105336, 114582.0, 116204.41897790288, 7213.927860721536, 8286.875696864432, 8392.4544904581, 8529.402941794015, 8728.214460698568, 43996.0, 53540.732296339826, 54031.0, 55669.72165139148, 57120.71439642775, 57198.0, 57782.422175777705, 76328.23671763434, 78763.0, 82889.0, 12535.67804531818, 13183.736325273632, 13213.471461141831, 13470.057096003186, 13714.794278086036, 14527.636809079857, 15092.924535377253, 15113.848861511244, 15121.546353609408, 15164.317605707549, 13305.866941330463, 13377.464901404224, 13409.128406653535, 13649.658758531115, 13821.792673110112, 13275.468981240641, 13709.245991470565, 13716.382762775898, 13724.382402792098, 13733.381997809922, 12945.935270323587, 13096.541621043218, 13171.802422963854, 13223.534553834814, 13693.931530342285, 11047.779044419227, 11178.422904670428, 11258.549658013915, 11275.32348059119, 11396.259243149168, 10267.640632577824, 11116.22186446941, 11290.661280161608, 11349.829752553553, 11402.20184587071], "value": 7621.5858864027505, "unit": "score"}], "name": "dromaeo_css", "value": 7259.261619124798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 112.0, 116.0, 115.0, 114.0, 115.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 115.0, 150.0, 114.0, 113.0, 114.0, 110.0, 141.0, 112.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 181.0, 185.0, 183.0, 183.0, 181.0, 182.0, 181.0, 181.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 62.0, 77.0, 81.0, 80.0, 85.0, 58.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 69.0, 67.0, 68.0, 91.0, 67.0, 69.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 90.0, 84.0, 89.0, 86.0, 89.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 82.0, 79.0, 79.0, 83.0, 82.0, 84.0, 83.0, 82.0, 81.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 55.0, 55.0, 55.0, 57.0, 56.0, 56.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 79.0, 74.0, 72.0, 68.0, 70.0, 70.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 106.0, 85.0, 86.0, 86.0, 85.0, 90.0, 87.0, 88.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 146.0, 140.0, 143.0, 144.0, 147.0, 150.0, 173.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 172.0, 169.0, 225.0, 229.0, 171.0, 170.0, 171.0, 170.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 71.0, 74.0, 86.0, 69.0, 67.0, 67.0, 66.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1452.3999999999999, "alertThreshold": 2.0}]} 15:04:11 INFO - Return code: 0 15:04:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:04:11 INFO - # TBPL SUCCESS # 15:04:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:04:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:04:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:04:11 INFO - 2016-10-14 15:04:11.432 screenresolution[1666:9719] starting screenresolution argv=screenresolution get 15:04:11 INFO - 2016-10-14 15:04:11.435 screenresolution[1666:9719] Display 0: 1600x1200x32@60 15:04:11 INFO - 2016-10-14 15:04:11.441 screenresolution[1667:9722] starting screenresolution argv=screenresolution list 15:04:11 INFO - Available Modes on Display 0 15:04:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:04:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:04:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:04:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:04:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:04:11 INFO - Intel Iris: 15:04:11 INFO - Chipset Model: Intel Iris 15:04:11 INFO - Type: GPU 15:04:11 INFO - Bus: Built-In 15:04:11 INFO - VRAM (Dynamic, Max): 1536 MB 15:04:11 INFO - Vendor: Intel (0x8086) 15:04:11 INFO - Device ID: 0x0a2e 15:04:11 INFO - Revision ID: 0x0009 15:04:11 INFO - Displays: 15:04:11 INFO - Display: 15:04:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:04:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:04:11 INFO - Display Serial Number: 1600x1200 60 15:04:11 INFO - Main Display: Yes 15:04:11 INFO - Mirror: Off 15:04:11 INFO - Online: Yes 15:04:11 INFO - Rotation: Supported 15:04:11 INFO - Return code: 0 15:04:11 INFO - Running post-action listener: _resource_record_post_action 15:04:11 INFO - [mozharness: 2016-10-14 22:04:11.676146Z] Finished run-tests step (success) 15:04:11 INFO - Running post-run listener: _resource_record_post_run 15:04:11 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 37360640; Write bytes: 708563456; Read time: 249; Write time: 1949 15:04:11 INFO - TinderboxPrint: CPU usage
53.5% 15:04:11 INFO - TinderboxPrint: I/O read bytes / time
37,360,640 / 249 15:04:11 INFO - TinderboxPrint: I/O write bytes / time
708,563,456 / 1,949 15:04:11 INFO - TinderboxPrint: CPU idle
2,260.9 (46.5%) 15:04:11 INFO - TinderboxPrint: CPU system
971.5 (20.0%) 15:04:11 INFO - TinderboxPrint: CPU user
1,629.3 (33.5%) 15:04:11 INFO - TinderboxPrint: Swap in / out
445,263,872 / 0 15:04:11 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 409006592; Write bytes: 411019264; Read time: 30882; Write time: 851 15:04:11 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 34391040; Write bytes: 296065536; Read time: 216; Write time: 1091 15:04:12 INFO - Running post-run listener: _upload_blobber_files 15:04:12 INFO - Blob upload gear active. 15:04:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:04:12 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 15:04:12 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:04:12 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:04:12 INFO - (blobuploader) - INFO - Open directory for files ... 15:04:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:04:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:04:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:13 INFO - (blobuploader) - INFO - Done attempting. 15:04:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:04:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:14 INFO - (blobuploader) - INFO - Done attempting. 15:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:04:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:19 INFO - (blobuploader) - INFO - Done attempting. 15:04:19 INFO - (blobuploader) - INFO - Iteration through files over. 15:04:19 INFO - Return code: 0 15:04:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:04:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:04:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db9683b1a3ff33dc1eca089f68d9b1e29f9b89c0c696982470c44ab4d5ccc88e99b0b0f5368d4d1f5a3287c3c11a5ac888fcd43e832507454b285fe1fd40068", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61a9197a1a63b5367becd1dde2456768b20f7746cd1b37b6e5ab72d9e85e5aa1bd890e666bce0ca3462670caa4697b145509aec2625b96b5aa619595b15a5d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f337e852f8fa1c37e47135638abaa440ea9c0e4dea1e511dcd2749e6197e81225273b9596653004882f36ab77010423948a627ee6dc0e19e8a749ceba4ffb1"} 15:04:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:04:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:04:19 INFO - Contents: 15:04:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db9683b1a3ff33dc1eca089f68d9b1e29f9b89c0c696982470c44ab4d5ccc88e99b0b0f5368d4d1f5a3287c3c11a5ac888fcd43e832507454b285fe1fd40068", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61a9197a1a63b5367becd1dde2456768b20f7746cd1b37b6e5ab72d9e85e5aa1bd890e666bce0ca3462670caa4697b145509aec2625b96b5aa619595b15a5d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f337e852f8fa1c37e47135638abaa440ea9c0e4dea1e511dcd2749e6197e81225273b9596653004882f36ab77010423948a627ee6dc0e19e8a749ceba4ffb1"} 15:04:19 INFO - Running post-run listener: copy_logs_to_upload_dir 15:04:19 INFO - Copying logs to upload dir... 15:04:19 INFO - mkdir: /builds/slave/test/build/upload/logs 15:04:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.606036 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-14 15:04:19.794973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:04:19.798487) ========= 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.7aSXIIbAYe/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.WlKty2qnrG/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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/Fx-Team/sha512/6db9683b1a3ff33dc1eca089f68d9b1e29f9b89c0c696982470c44ab4d5ccc88e99b0b0f5368d4d1f5a3287c3c11a5ac888fcd43e832507454b285fe1fd40068", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61a9197a1a63b5367becd1dde2456768b20f7746cd1b37b6e5ab72d9e85e5aa1bd890e666bce0ca3462670caa4697b145509aec2625b96b5aa619595b15a5d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f337e852f8fa1c37e47135638abaa440ea9c0e4dea1e511dcd2749e6197e81225273b9596653004882f36ab77010423948a627ee6dc0e19e8a749ceba4ffb1"} build_url:https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011076 build_url: 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6db9683b1a3ff33dc1eca089f68d9b1e29f9b89c0c696982470c44ab4d5ccc88e99b0b0f5368d4d1f5a3287c3c11a5ac888fcd43e832507454b285fe1fd40068", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61a9197a1a63b5367becd1dde2456768b20f7746cd1b37b6e5ab72d9e85e5aa1bd890e666bce0ca3462670caa4697b145509aec2625b96b5aa619595b15a5d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f337e852f8fa1c37e47135638abaa440ea9c0e4dea1e511dcd2749e6197e81225273b9596653004882f36ab77010423948a627ee6dc0e19e8a749ceba4ffb1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:04:19.833237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:04:19.833784) ========= 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.7aSXIIbAYe/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.WlKty2qnrG/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.005007 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:04:19.885422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:04:19.885996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:04:19.886591) ========= ========= Total master_lag: 0.17 =========